/var/tmp/bins/dsc create --cleanup --region-count 3 --extent-size 10 --extent-count 5 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Removing existing dsc directory "/tmp/test_up-build/dsc" Creating region directory at: /var/tmp/test_up-build Creating dsc directory at: /tmp/test_up-build/dsc Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.25823712 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018649038 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017199343 Created 3 regions /var/tmp/bins/dsc start --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build --region-count 3 Using existing output directory "/tmp/test_up-build/dsc" Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 }) start ds: 8810 start ds: 8820 start ds: 8830 start access at:127.0.0.1:9998 Starting downstairs at port 8810 Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8810][0] initial start wait reports Starting [8830][2] initial start wait reports Starting [8820][1] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1188) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1189) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1190) [8820][1] initial start wait reports Running All downstairs are running Jan 27 19:36:41.464 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jan 27 19:36:46.506 INFO accepted connection, remote_addr: 127.0.0.1:46280, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.508 INFO request completed, latency_us: 435, response_code: 200, uri: /state/cid/0, method: GET, req_id: b8dd786f-b707-45aa-b575-fded9cd80102, remote_addr: 127.0.0.1:46280, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.561 INFO accepted connection, remote_addr: 127.0.0.1:54402, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.562 INFO request completed, latency_us: 114, response_code: 200, uri: /state/cid/1, method: GET, req_id: 9ee08aa2-4f95-4b12-b22c-f720449dab24, remote_addr: 127.0.0.1:54402, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.614 INFO accepted connection, remote_addr: 127.0.0.1:37186, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.614 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1019060b-78ae-4252-aa0f-cd821fcc9c76, remote_addr: 127.0.0.1:37186, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.666 INFO accepted connection, remote_addr: 127.0.0.1:36189, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Jan 27 19:36:46.667 INFO request completed, latency_us: 137, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 0822339e-6763-406a-849e-562fab807fe4, remote_addr: 127.0.0.1:36189, local_addr: 127.0.0.1:9998[8810] Disable keep_running [8820] Disable keep_running [8830] Disable keep_running Jan 27 19:36:46.747 INFO accepted connection, remote_addr: 127.0.0.1:38959, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.748 INFO request completed, latency_us: 239, response_code: 200, uri: /regioninfo, method: GET, req_id: ffb1bcc8-a497-4c02-a5eb-76a96e735d1d, remote_addr: 127.0.0.1:38959, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.750 INFO request completed, latency_us: 110, response_code: 200, uri: /regioncount, method: GET, req_id: 0644c6c7-4879-4b83-939e-8ae381c11f44, remote_addr: 127.0.0.1:38959, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.750 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1d695564-1dc9-4389-ac25-f5585e9cc6d7, remote_addr: 127.0.0.1:38959, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.751 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/1, method: GET, req_id: e397c212-88da-4e4c-823a-eb18cb384c5f, remote_addr: 127.0.0.1:38959, local_addr: 127.0.0.1:9998 Jan 27 19:36:46.751 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 888e928a-cfd1-49c4-baee-895dcb3394c8, remote_addr: 127.0.0.1:38959, local_addr: 127.0.0.1:9998 Jan 27 19:36:55.839 INFO accepted connection, remote_addr: 127.0.0.1:43596, local_addr: 127.0.0.1:9998 Jan 27 19:36:55.840 INFO request completed, latency_us: 160, response_code: 200, uri: /regioninfo, method: GET, req_id: 977ad582-709b-4d72-925c-251f3cd5cdc6, remote_addr: 127.0.0.1:43596, local_addr: 127.0.0.1:9998 Jan 27 19:36:55.841 INFO request completed, latency_us: 106, response_code: 200, uri: /regioncount, method: GET, req_id: 9f9d734d-e325-4119-bc98-d5c3be8a5317, remote_addr: 127.0.0.1:43596, local_addr: 127.0.0.1:9998 Jan 27 19:36:55.842 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: bc472528-085e-4b04-805a-e2188e1bd90a, remote_addr: 127.0.0.1:43596, local_addr: 127.0.0.1:9998 Jan 27 19:36:55.842 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/1, method: GET, req_id: a908258d-69d3-47f8-b891-25f0eef48c01, remote_addr: 127.0.0.1:43596, local_addr: 127.0.0.1:9998 Jan 27 19:36:55.843 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: f9e6096a-f973-4213-8260-88a684450614, remote_addr: 127.0.0.1:43596, local_addr: 127.0.0.1:9998 Jan 27 19:37:04.988 INFO accepted connection, remote_addr: 127.0.0.1:55886, local_addr: 127.0.0.1:9998 Jan 27 19:37:04.989 INFO request completed, latency_us: 156, response_code: 200, uri: /regioninfo, method: GET, req_id: 8e22d6b9-af25-4db6-bc62-fb4a89b47de7, remote_addr: 127.0.0.1:55886, local_addr: 127.0.0.1:9998 Jan 27 19:37:04.990 INFO request completed, latency_us: 131, response_code: 200, uri: /regioncount, method: GET, req_id: 43f0764c-8072-47c4-aaf0-d621581dbf87, remote_addr: 127.0.0.1:55886, local_addr: 127.0.0.1:9998 Jan 27 19:37:04.990 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/0, method: GET, req_id: b9cb695e-292c-4dba-915b-e1bbce65707c, remote_addr: 127.0.0.1:55886, local_addr: 127.0.0.1:9998 Jan 27 19:37:04.991 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: ac49d750-7092-44b2-8b85-7afaced2b39b, remote_addr: 127.0.0.1:55886, local_addr: 127.0.0.1:9998 Jan 27 19:37:04.991 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: a053caaf-6ae2-4ede-be0b-de1fe2757d22, remote_addr: 127.0.0.1:55886, local_addr: 127.0.0.1:9998 Jan 27 19:37:22.770 INFO accepted connection, remote_addr: 127.0.0.1:53625, local_addr: 127.0.0.1:9998 Jan 27 19:37:22.771 INFO request completed, latency_us: 178, response_code: 200, uri: /regioninfo, method: GET, req_id: 0f3eba52-c0be-4ea2-a1b3-0a4ba1b733bf, remote_addr: 127.0.0.1:53625, local_addr: 127.0.0.1:9998 Jan 27 19:37:22.772 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: d5d4fc35-abe6-438e-b918-a0066f65da2c, remote_addr: 127.0.0.1:53625, local_addr: 127.0.0.1:9998 Jan 27 19:37:22.772 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/0, method: GET, req_id: 745f076d-019f-4fd4-9080-bb62e2cc244f, remote_addr: 127.0.0.1:53625, local_addr: 127.0.0.1:9998 Jan 27 19:37:22.773 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7c916e48-2b79-4fcc-92ad-6bf98c8d4d03, remote_addr: 127.0.0.1:53625, local_addr: 127.0.0.1:9998 Jan 27 19:37:22.774 INFO request completed, latency_us: 132, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3a9c671c-f0bc-4aad-8250-96d5dbe2244a, remote_addr: 127.0.0.1:53625, local_addr: 127.0.0.1:9998 Jan 27 19:37:37.461 INFO accepted connection, remote_addr: 127.0.0.1:34064, local_addr: 127.0.0.1:9998 Jan 27 19:37:37.461 INFO request completed, latency_us: 163, response_code: 200, uri: /regioninfo, method: GET, req_id: 73eb2f6a-44a0-439d-aa06-995fe3688bee, remote_addr: 127.0.0.1:34064, local_addr: 127.0.0.1:9998 Jan 27 19:37:37.462 INFO request completed, latency_us: 102, response_code: 200, uri: /regioncount, method: GET, req_id: 712bf49d-c2fc-4046-b554-c50f3a01347e, remote_addr: 127.0.0.1:34064, local_addr: 127.0.0.1:9998 Jan 27 19:37:37.463 INFO request completed, latency_us: 129, response_code: 200, uri: /port/cid/0, method: GET, req_id: b063761f-d0a1-4c19-a33e-3a610311d9d9, remote_addr: 127.0.0.1:34064, local_addr: 127.0.0.1:9998 Jan 27 19:37:37.463 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/1, method: GET, req_id: a9dd7423-8f27-4a05-8d16-38f60315cb8e, remote_addr: 127.0.0.1:34064, local_addr: 127.0.0.1:9998 Jan 27 19:37:37.464 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/2, method: GET, req_id: 900a02c6-26c8-4087-9444-4b9b6e73cd06, remote_addr: 127.0.0.1:34064, local_addr: 127.0.0.1:9998 Jan 27 19:38:39.583 INFO accepted connection, remote_addr: 127.0.0.1:64050, local_addr: 127.0.0.1:9998 Jan 27 19:38:39.584 INFO request completed, latency_us: 147, response_code: 200, uri: /regioninfo, method: GET, req_id: 5fb47926-3e06-4f51-8fb1-509e9a2c02b7, remote_addr: 127.0.0.1:64050, local_addr: 127.0.0.1:9998 Jan 27 19:38:39.585 INFO request completed, latency_us: 108, response_code: 200, uri: /regioncount, method: GET, req_id: 82e96391-32b9-4187-87bd-133aa4fb1a78, remote_addr: 127.0.0.1:64050, local_addr: 127.0.0.1:9998 Jan 27 19:38:39.585 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4e994114-d555-4bca-b51f-d12a3e44b3c9, remote_addr: 127.0.0.1:64050, local_addr: 127.0.0.1:9998 Jan 27 19:38:39.586 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 26b775ac-81d1-4633-b8ad-ad8e8465a68f, remote_addr: 127.0.0.1:64050, local_addr: 127.0.0.1:9998 Jan 27 19:38:39.586 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 0014b440-d214-497d-bd6b-17151cd9b6fb, remote_addr: 127.0.0.1:64050, local_addr: 127.0.0.1:9998 Jan 27 19:38:43.680 INFO accepted connection, remote_addr: 127.0.0.1:35734, local_addr: 127.0.0.1:9998 Jan 27 19:38:43.681 INFO request completed, latency_us: 183, response_code: 200, uri: /regioninfo, method: GET, req_id: ef5ff393-cec5-4de6-99c7-7b15ca396861, remote_addr: 127.0.0.1:35734, local_addr: 127.0.0.1:9998 Jan 27 19:38:43.682 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: 4fc699f4-8d8b-4126-8d0d-e208637b5b76, remote_addr: 127.0.0.1:35734, local_addr: 127.0.0.1:9998 Jan 27 19:38:43.682 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 25e8f379-e52a-41ab-a761-e07c3dd4caa9, remote_addr: 127.0.0.1:35734, local_addr: 127.0.0.1:9998 Jan 27 19:38:43.683 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7183794e-830b-46af-9b9e-f72e6f2425af, remote_addr: 127.0.0.1:35734, local_addr: 127.0.0.1:9998 Jan 27 19:38:43.683 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: b120e5d7-a642-4768-91ef-404990e14dd5, remote_addr: 127.0.0.1:35734, local_addr: 127.0.0.1:9998 Jan 27 19:38:47.758 INFO accepted connection, remote_addr: 127.0.0.1:43720, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Jan 27 19:38:47.759 [8820] Disable keep_running INFO[8810] Disable keep_running [8830] Disable keep_running request completed, latency_us: 157, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 52c7452c-4d50-4520-a957-9d73e42dcdf4, remote_addr: 127.0.0.1:43720, local_addr: 127.0.0.1:9998 Jan 27 19:38:47.813 INFO accepted connection, remote_addr: 127.0.0.1:45792, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jan 27 19:38:47.813 INFO request completed, latency_us: 150, response_code: 204, [8830] Got stop action so:false kr:false uri: /stop/cid/2, method: POST, req_id: 776d5651-21aa-40db-990a-6c6114b792ab, remote_addr: 127.0.0.1:45792, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jan 27 19:38:47.868 INFO accepted connection, remote_addr: 127.0.0.1:48535, local_addr: 127.0.0.1:9998 Jan 27 19:38:47.868 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/2, method: GET, req_id: c9f2f6bf-420e-44ca-bba0-0de34d31cc2a, remote_addr: 127.0.0.1:48535, local_addr: 127.0.0.1:9998 Jan 27 19:38:47.925 INFO accepted connection, remote_addr: 127.0.0.1:33167, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 27 19:38:47.926 INFO request completed, latency_us: 166, response_code: 204, uri: /start/cid/2, method: POST, req_id: 28358f90-35f3-4dfb-b74b-4c2586e194b6, remote_addr: 127.0.0.1:33167, local_addr: 127.0.0.1:9998 Jan 27 19:38:48.224 INFO accepted connection, remote_addr: 127.0.0.1:41603, local_addr: 127.0.0.1:9998 Jan 27 19:38:48.225 INFO request completed, latency_us: 164, response_code: 200, uri: /regioninfo, method: GET, req_id: 097c744c-bb89-4781-92b0-500737f607c7, remote_addr: 127.0.0.1:41603, local_addr: 127.0.0.1:9998 Jan 27 19:38:48.226 INFO request completed, latency_us: 85, response_code: 200, uri: /regioncount, method: GET, req_id: d4e28da7-ced3-4bbb-858b-bc0a0213a3cf, remote_addr: 127.0.0.1:41603, local_addr: 127.0.0.1:9998 Jan 27 19:38:48.227 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: b5ebe161-3351-40d6-ad04-4da035fc4ae6, remote_addr: 127.0.0.1:41603, local_addr: 127.0.0.1:9998 Jan 27 19:38:48.227 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7fe59889-ca79-445b-a648-093e2b4700ff, remote_addr: 127.0.0.1:41603, local_addr: 127.0.0.1:9998 Jan 27 19:38:48.228 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: a0f61d5b-8279-44b0-babd-f7edacb39b1f, remote_addr: 127.0.0.1:41603, local_addr: 127.0.0.1:9998 [8830] got start action [8830] I am going to restart Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1238) [8830][2] reports Running Jan 27 19:39:02.397 INFO accepted connection, remote_addr: 127.0.0.1:65096, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Jan 27 19:39:02.398 INFO request completed, latency_us: [8810] Disable keep_running 208, [8810] Got stop action so:false kr:false response_code: 204, uri: /shutdown, method: POST, req_id: 716ec99f-0d65-491b-b78c-c228666f7884, remote_addr: 127.0.0.1:65096, local_addr: 127.0.0.1:9998 [8820] Disable keep_running [8830] Disable keep_running [8820] Got stop action so:false kr:false [8830] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8820] Exited with: ExitStatus(unix_wait_status(9)) [8810] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820][1] reports Exit [8810][0] reports Exit /var/tmp/bins/dsc create --cleanup --region-count 4 --extent-count 300 --block-size 4096 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Removing existing dsc directory "/tmp/test_up-build/dsc" Removing existing region "/var/tmp/test_up-build" Creating region directory at: /var/tmp/test_up-build Creating dsc directory at: /tmp/test_up-build/dsc Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.025812749 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.023242975 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.022727674 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.022786735 Created 4 regions /var/tmp/bins/dsc start --region-count 4 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Using existing output directory "/tmp/test_up-build/dsc" Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 100 }) start ds: 8810 start ds: 8820 start ds: 8830 start ds: 8840 start access at:127.0.0.1:9998 Starting downstairs at port 8810 Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Starting downstairs at port 8830 [8810][0] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8820][1] initial start wait reports Starting [8830][2] initial start wait reports Starting Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1252) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1253) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1254) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1255) [8830][2] initial start wait reports Running All downstairs are running Jan 27 19:39:07.537 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jan 27 19:39:12.576 INFO accepted connection, remote_addr: 127.0.0.1:63576, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.578 INFO request completed, latency_us: 341, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9412c346-3a46-4f7f-abd8-8548635f1071, remote_addr: 127.0.0.1:63576, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.633 INFO accepted connection, remote_addr: 127.0.0.1:47681, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.633 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/1, method: GET, req_id: a3cb9d37-bb8d-4e3a-a70a-c9c489e61f9e, remote_addr: 127.0.0.1:47681, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.687 INFO accepted connection, remote_addr: 127.0.0.1:35241, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.687 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2bc04cd9-28fa-4ee4-aebc-2088dd551d24, remote_addr: 127.0.0.1:35241, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.741 INFO accepted connection, remote_addr: 127.0.0.1:43936, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.741 INFO request completed, latency_us: 120, response_code: 200, uri: /state/cid/3, method: GET, req_id: 205f3781-ce33-4e77-988c-9ff98b057d0d, remote_addr: 127.0.0.1:43936, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.794 INFO accepted connection, remote_addr: 127.0.0.1:43766, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.794 INFO request completed, latency_us: 149, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5760e1bc-cad9-47ae-8455-595260e88901, remote_addr: 127.0.0.1:43766, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.853 INFO accepted connection, remote_addr: 127.0.0.1:39023, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.854 INFO request completed, latency_us: 166, response_code: 200, uri: /regioninfo, method: GET, req_id: 04db549f-e1bb-4eb5-a041-04772a247775, remote_addr: 127.0.0.1:39023, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.855 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: c0733551-f4ec-4c01-844e-de29881d36fe, remote_addr: 127.0.0.1:39023, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.855 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2a373cfe-8605-4c18-b0c6-c69d5aec99e5, remote_addr: 127.0.0.1:39023, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.856 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6acbb15a-8191-46c0-8ae3-70d9271931d4, remote_addr: 127.0.0.1:39023, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.856 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: fc1b93a7-ef9b-4770-a95e-876f03da446a, remote_addr: 127.0.0.1:39023, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.892 INFO accepted connection, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.892 INFO request completed, latency_us: 100, response_code: 200, uri: /regioncount, method: GET, req_id: d9583981-d619-4473-bd85-84cd12b5f414, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jan 27 19:39:12.915 INFO request completed, latency_us: 206[8810] Got stop action so:false kr:false , response_code: 204, uri: /stop/cid/0, method: POST, req_id: 8872848d-a5e1-4c6b-802e-0720ff3a2702, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:39:12.916 INFO request completed, latency_us: 185, response_code: 200, uri: /state/cid/0, method: GET, req_id: 47963013-348b-40e0-a05b-5c84171bd8c1, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 27 19:39:16.918 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/0, method: GET, req_id: 967e3a5c-93fd-4d62-95a8-a9830b0c4c6a, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 27 19:39:16.938 INFO request completed, latency_us: 162, response_code: 204, uri: /start/cid/0, method: POST, req_id: 7db8ea1d-334c-4010-88e2-185cb87a41f6, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:39:16.939 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/0, method: GET, req_id: 371b985d-12e4-44b6-8c25-25720060630b, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1263) [8810][0] reports Running Jan 27 19:39:20.942 INFO request completed, latency_us: 335, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7be54498-f48d-422c-8bae-da94806117d3, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Jan 27 19:39:51.223[8820] Got stop action so:false kr:false INFO request completed, latency_us: 202, response_code: 204, uri: /stop/cid/1, method: POST, req_id: a9c46ce4-4a5e-433d-a9ea-8f99a2cf078b, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:39:51.224 INFO request completed, latency_us: 177, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0a6a2015-1083-47b2-ab47-5e1aa0568d5c, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jan 27 19:39:55.226 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/1, method: GET, req_id: 79307688-abe7-4a45-b9c5-e137f14de30c, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jan 27 19:39:55.248 INFO request completed, latency_us: 135, response_code: 204, uri: /start/cid/1, method: POST, req_id: 85183cb3-a939-4c87-a9b8-41b0237fbe49, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:39:55.248 INFO request completed, latency_us: 94, response_code: 200, uri: /state/cid/1, method: GET, req_id: 66fde17d-4528-4da3-9333-157fabdeb747, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8820] got start action [8820] I am going to restart Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1264) [8820][1] reports Running Jan 27 19:39:59.251 INFO request completed, latency_us: 558, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7c275f01-8ce1-4c58-94cb-6d81853cd99d, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 [8830] Got stop action so:false kr:false Jan 27 19:40:29.525 INFO request completed, latency_us: 201, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 4bd90106-b2fb-4bed-88fa-1343e18663e8, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:40:29.526 INFO request completed, latency_us: 160, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3cadcecf-2d85-4772-9881-5eac800a82f4, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jan 27 19:40:33.528 INFO request completed, latency_us: 186, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6234969f-21a4-40f7-8168-e4af455c5b18, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 27 19:40:33.551 INFO request completed, latency_us: 126, response_code: 204, uri: /start/cid/2, method: POST, req_id: cafb30af-1967-40c3-98f3-37e674f47751, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:40:33.552 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/2, method: GET, req_id: 251dc2e7-1422-4ccd-937f-f04605a0e8cd, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8830] got start action [8830] I am going to restart Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1265) [8830][2] reports Running Jan 27 19:40:37.554 INFO request completed, latency_us: 322, response_code: 200, uri: /state/cid/2, method: GET, req_id: fe4c969b-0cb4-4236-a336-c40ef405cfd1, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 [8840] Got stop action so:false kr:false Jan 27 19:41:07.825 INFO request completed, latency_us: 207, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 35f5b8ae-16d1-4d1a-96d2-52bf41f6d0ad, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:41:07.826 INFO request completed, latency_us: 162, response_code: 200, uri: /state/cid/3, method: GET, req_id: fbe8ad19-9134-4b70-8fbf-c3dabd0b2128, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jan 27 19:41:11.829 INFO request completed, latency_us: 190, response_code: 200, uri: /state/cid/3, method: GET, req_id: b5fb92ef-2994-4afb-b751-5b4c1a9a7b66, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jan 27 19:41:11.851 INFO request completed, latency_us: 130, response_code: 204, uri: /start/cid/3, method: POST, req_id: aec1439a-f0dd-45c2-9dda-0d2ac0b23962, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:41:11.851 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/3, method: GET, req_id: c80ef2bc-d3ef-4e61-b9b7-ec2598e024aa, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 [8840] got start action [8840] I am going to restart Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] reports Starting Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1266) [8840][3] reports Running Jan 27 19:41:15.854 INFO request completed, latency_us: 456, response_code: 200, uri: /state/cid/3, method: GET, req_id: 60e54856-5ec2-4517-a800-19441de63065, remote_addr: 127.0.0.1:36017, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.174 INFO accepted connection, remote_addr: 127.0.0.1:38255, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.175 INFO request completed, latency_us: 142, response_code: 200, uri: /regioninfo, method: GET, req_id: 75c4f44e-4128-4aa5-8023-71ee00a5fb3d, remote_addr: 127.0.0.1:38255, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.176 INFO request completed, latency_us: 106, response_code: 200, uri: /regioncount, method: GET, req_id: 421613c8-ffb4-4fc7-8a79-d1700669f5d4, remote_addr: 127.0.0.1:38255, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.177 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: dcbd59f8-45fb-45b0-9098-27308d91ab69, remote_addr: 127.0.0.1:38255, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.177 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: b223ccbb-182b-4d1c-ab09-94cb28790e22, remote_addr: 127.0.0.1:38255, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.178 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 6a321af3-78ca-4a3d-8df1-beb619bd9d53, remote_addr: 127.0.0.1:38255, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.212 INFO accepted connection, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.213 INFO request completed, latency_us: 98, response_code: 200, uri: /regioncount, method: GET, req_id: ad8be619-be65-435d-9968-24faad48e1d8, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 [8810] Got stop action so:false kr:false Jan 27 19:41:46.662 INFO request completed, latency_us: 230, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 5f24abe1-f927-430c-9f47-fb4ada25113a, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Jan 27 19:41:46.663 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1d771580-6523-4d4d-b4a1-d671faa1fc21, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 27 19:41:50.665 INFO request completed, latency_us: 270, response_code: 200, uri: /state/cid/0, method: GET, req_id: dd5e73ec-21fb-4505-a300-8688cffc429c, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 27 19:42:15.449 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/0, method: POST, req_id: f9b15752-56b9-4c69-af61-27d1c68558e0, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Jan 27 19:42:19.474 INFO request completed, latency_us: 252, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 08c5e73e-9c6b-4843-aa31-cff07261ca0c, remote_addr: [8820] Got stop action so:false kr:false 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Jan 27 19:42:19.475 INFO request completed, latency_us: 120, response_code: 200, uri: /state/cid/1, method: GET, req_id: 72528799-c03e-4e53-a865-cedb88275f5d, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1268) [8810][0] reports Running Jan 27 19:42:23.478 INFO request completed, latency_us: 285, response_code: 200, uri: /state/cid/1, method: GET, req_id: c6379b5d-35a6-4003-a9e3-ab78b89edd53, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jan 27 19:42:48.254 INFO request completed, latency_us: 232, response_code: 204, uri: /start/cid/1, method: POST, req_id: 257b2384-c1ae-4409-a2dd-d214bbefb0c9, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8820] got start action [8820] I am going to restart Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1269) [8820][1] reports Running Main task has work to do, go find it got dsc Stop(2) stop 2 Jan 27 19:42:52.280 INFO[8830] Got stop action so:false kr:false request completed, latency_us: 331, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 1b7f50a4-9fbd-43be-9ab9-7b167321d765, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Jan 27 19:42:52.280 INFO request completed, latency_us: 136, response_code: 200, uri: /state/cid/2, method: GET, req_id: 62a52f14-7f58-439e-a0b4-4ac9641090f8, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jan 27 19:42:56.282 INFO request completed, latency_us: 188, response_code: 200, uri: /state/cid/2, method: GET, req_id: db439935-2195-45e8-84e5-4b37686b1907, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 27 19:43:21.066 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/2, method: POST, req_id: 26eafa6a-7ac6-4a54-9972-728ff4916dcf, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Jan 27 19:43:25.092 INFO request completed, latency_us: [8840] Got stop action so:false kr:false 224, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 59b4e204-b816-4af1-9299-f40b0916752d, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Jan 27 19:43:25.092 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/3, method: GET, req_id: 463d1997-6aee-40e3-8133-b8b3eb00a8fa, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830] got start action [8830] I am going to restart Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1270) [8830][2] reports Running Jan 27 19:43:29.096 INFO request completed, latency_us: 538, response_code: 200, uri: /state/cid/3, method: GET, req_id: 349f5caa-1d4d-4fc1-83b6-9129c1ff72db, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jan 27 19:43:53.877 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/3, method: POST, req_id: cb390479-f76b-436b-b76e-144007223c49, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8840] got start action [8840] I am going to restart Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] reports Starting Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1271) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(0) stop 0 Jan 27 19:43:57.912 INFO [8810] Got stop action so:false kr:false request completed, latency_us: 336, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 0e30df87-3769-497a-bc5d-9bfaba631c5a, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Jan 27 19:43:57.913 INFO request completed, latency_us: 147, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8aa2f7f8-504b-4ac8-9b9b-e375b3acf3b5, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 27 19:44:01.916 INFO request completed, latency_us: 186, response_code: 200, uri: /state/cid/0, method: GET, req_id: a725b053-bceb-4022-b732-2284abe5a319, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 27 19:44:26.701 INFO request completed, latency_us: 256, response_code: 204, uri: /start/cid/0, method: POST, req_id: 915f33c1-6ac1-4b6e-846d-a65167732726, remote_addr: 127.0.0.1:55009, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1272) [8810][0] reports Running Jan 27 19:44:30.770 INFO accepted connection, remote_addr: 127.0.0.1:51232, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Jan 27 19:44:30.771Shut it down INFO[8810] Disable keep_running [8810] Got stop action so:false kr:false request completed, latency_us: 191, response_code: 204, uri: /shutdown, method: POST, req_id: a895ff93-f94b-452f-98a4-694e00ba3306, remote_addr: 127.0.0.1:51232, local_addr: 127.0.0.1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8820] Disable keep_running [8820] Got stop action so:false kr:false [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit