/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.2633199 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018586678 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017557207 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 8820 Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8820][1] initial start wait reports Starting [8810][0] initial start wait reports Starting [8830][2] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1188) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1189) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1190) [8830][2] initial start wait reports Running All downstairs are running Dec 09 15:07:47.077 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Dec 09 15:07:52.117 INFO accepted connection, remote_addr: 127.0.0.1:37518, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.119 INFO request completed, latency_us: 426, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6519fc65-6844-44fc-8ee6-26b4e6e8deb7, remote_addr: 127.0.0.1:37518, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.175 INFO accepted connection, remote_addr: 127.0.0.1:57460, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.175 INFO request completed, latency_us: 194, response_code: 200, uri: /state/cid/1, method: GET, req_id: ca907eb1-4260-4fe4-930c-4fad42b67ae3, remote_addr: 127.0.0.1:57460, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.233 INFO accepted connection, remote_addr: 127.0.0.1:35982, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.233 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/2, method: GET, req_id: 04a5fdfe-0ac9-4207-bb10-0e140bb5ba7c, remote_addr: 127.0.0.1:35982, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.287 INFO accepted connection, remote_addr: 127.0.0.1:59912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Dec 09 15:07:52.288 INFO request completed, latency_us: 154, response_code: 204, uri: /disablerestart/all, method: POST, req_id: ce51e220-1586-42d4-80e7-73117dcb27de, remote_addr: 127.0.0.1:59912, [8810] Disable keep_running local_addr: 127.0.0.1:9998[8820] Disable keep_running [8830] Disable keep_running Dec 09 15:07:52.403 INFO accepted connection, remote_addr: 127.0.0.1:52374, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.404 INFO request completed, latency_us: 283, response_code: 200, uri: /regioninfo, method: GET, req_id: 2fb0753c-4aef-46bb-8d81-6600b0b042c4, remote_addr: 127.0.0.1:52374, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.406 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: 0617b9af-f76f-4fd6-af26-aaf5a6b7f15e, remote_addr: 127.0.0.1:52374, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.407 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/0, method: GET, req_id: 55a70633-100b-489e-9d53-cb8f59e950a4, remote_addr: 127.0.0.1:52374, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.407 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/1, method: GET, req_id: 90c3cb70-0cf2-43c7-b34d-d66f68f53d74, remote_addr: 127.0.0.1:52374, local_addr: 127.0.0.1:9998 Dec 09 15:07:52.408 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: ccd49b3a-e239-41c5-96a4-1274a40272e7, remote_addr: 127.0.0.1:52374, local_addr: 127.0.0.1:9998 Dec 09 15:08:01.537 INFO accepted connection, remote_addr: 127.0.0.1:35349, local_addr: 127.0.0.1:9998 Dec 09 15:08:01.538 INFO request completed, latency_us: 164, response_code: 200, uri: /regioninfo, method: GET, req_id: 338a24ff-3897-472b-a38b-2f9cd0bb7ce3, remote_addr: 127.0.0.1:35349, local_addr: 127.0.0.1:9998 Dec 09 15:08:01.539 INFO request completed, latency_us: 97, response_code: 200, uri: /regioncount, method: GET, req_id: d2d33d1a-9a36-441f-ae27-4657a9379022, remote_addr: 127.0.0.1:35349, local_addr: 127.0.0.1:9998 Dec 09 15:08:01.540 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 54b70830-3eb5-4d86-b596-a0cff562a164, remote_addr: 127.0.0.1:35349, local_addr: 127.0.0.1:9998 Dec 09 15:08:01.540 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/1, method: GET, req_id: 654eb29b-d160-40b2-acaa-f851f0242e1e, remote_addr: 127.0.0.1:35349, local_addr: 127.0.0.1:9998 Dec 09 15:08:01.541 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: a60370bf-cd61-4d3f-83ca-41883f2ea372, remote_addr: 127.0.0.1:35349, local_addr: 127.0.0.1:9998 Dec 09 15:08:10.721 INFO accepted connection, remote_addr: 127.0.0.1:63954, local_addr: 127.0.0.1:9998 Dec 09 15:08:10.722 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: b206f2e8-bc3e-489b-ae92-68dff6f0f285, remote_addr: 127.0.0.1:63954, local_addr: 127.0.0.1:9998 Dec 09 15:08:10.723 INFO request completed, latency_us: 109, response_code: 200, uri: /regioncount, method: GET, req_id: 61bba0d6-5763-452e-9709-03ce29e8526f, remote_addr: 127.0.0.1:63954, local_addr: 127.0.0.1:9998 Dec 09 15:08:10.724 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 30ff5ba5-29ab-42d0-ae45-2a5c6fbb6214, remote_addr: 127.0.0.1:63954, local_addr: 127.0.0.1:9998 Dec 09 15:08:10.724 INFO request completed, latency_us: 113, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6a1f58fd-7885-4e6c-83a0-70be8fd1d8d2, remote_addr: 127.0.0.1:63954, local_addr: 127.0.0.1:9998 Dec 09 15:08:10.725 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4c34da04-fe4f-411f-a545-62e691eeb339, remote_addr: 127.0.0.1:63954, local_addr: 127.0.0.1:9998 Dec 09 15:08:28.373 INFO accepted connection, remote_addr: 127.0.0.1:46657, local_addr: 127.0.0.1:9998 Dec 09 15:08:28.374 INFO request completed, latency_us: 158, response_code: 200, uri: /regioninfo, method: GET, req_id: 154a9813-1b11-4d43-ab0a-9e63b2acadba, remote_addr: 127.0.0.1:46657, local_addr: 127.0.0.1:9998 Dec 09 15:08:28.375 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: bb862e82-8f37-42a3-9369-2c7bba5bbc7b, remote_addr: 127.0.0.1:46657, local_addr: 127.0.0.1:9998 Dec 09 15:08:28.376 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0311fe0a-d2af-4f83-bfd4-e19dba64de6c, remote_addr: 127.0.0.1:46657, local_addr: 127.0.0.1:9998 Dec 09 15:08:28.376 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/1, method: GET, req_id: 34a07540-19c1-4e26-956c-31aed987be6c, remote_addr: 127.0.0.1:46657, local_addr: 127.0.0.1:9998 Dec 09 15:08:28.377 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: e8e491d0-521d-4c65-a889-2fc02239c17a, remote_addr: 127.0.0.1:46657, local_addr: 127.0.0.1:9998 Dec 09 15:08:43.050 INFO accepted connection, remote_addr: 127.0.0.1:60657, local_addr: 127.0.0.1:9998 Dec 09 15:08:43.051 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: a5fae67e-81f6-4bb9-9130-a4d99901ae87, remote_addr: 127.0.0.1:60657, local_addr: 127.0.0.1:9998 Dec 09 15:08:43.052 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: ef6ef0f8-f288-4323-bed2-56870a20c12e, remote_addr: 127.0.0.1:60657, local_addr: 127.0.0.1:9998 Dec 09 15:08:43.052 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 000469fb-7736-46d7-96cb-14abaa12d2ab, remote_addr: 127.0.0.1:60657, local_addr: 127.0.0.1:9998 Dec 09 15:08:43.053 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/1, method: GET, req_id: 8e9cb42a-f2af-4fbd-a454-185948540669, remote_addr: 127.0.0.1:60657, local_addr: 127.0.0.1:9998 Dec 09 15:08:43.053 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 97091415-0caa-4035-845d-12e034a0d24b, remote_addr: 127.0.0.1:60657, local_addr: 127.0.0.1:9998 Dec 09 15:09:45.449 INFO accepted connection, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998 Dec 09 15:09:45.449 INFO request completed, latency_us: 175, response_code: 200, uri: /regioninfo, method: GET, req_id: c1fac587-489d-4e15-a41c-9e54f42c144d, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998 Dec 09 15:09:45.450 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: a365ae48-49ad-423d-9860-0e9d6abeaf5a, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998 Dec 09 15:09:45.451 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/0, method: GET, req_id: 39378214-abe6-4bed-aa34-0ad36aa0c9e3, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998 Dec 09 15:09:45.451 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/1, method: GET, req_id: 516a10b4-7850-4db1-889a-a7d491e16ec0, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998 Dec 09 15:09:45.452 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 74263248-cdcb-4eec-b3da-55d4f441bfd1, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998 Dec 09 15:09:49.575 INFO accepted connection, remote_addr: 127.0.0.1:61665, local_addr: 127.0.0.1:9998 Dec 09 15:09:49.575 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: fed2741d-09f3-4076-847d-2f2e78ef7b76, remote_addr: 127.0.0.1:61665, local_addr: 127.0.0.1:9998 Dec 09 15:09:49.576 INFO request completed, latency_us: 101, response_code: 200, uri: /regioncount, method: GET, req_id: 63481cfe-7422-42f3-81e7-6a449cf1fcb9, remote_addr: 127.0.0.1:61665, local_addr: 127.0.0.1:9998 Dec 09 15:09:49.577 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5e602e39-af3b-435b-ac2a-f4b001e5d04c, remote_addr: 127.0.0.1:61665, local_addr: 127.0.0.1:9998 Dec 09 15:09:49.577 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/1, method: GET, req_id: 83f93d19-7c14-4c7e-90fc-a7e3f64a67fe, remote_addr: 127.0.0.1:61665, local_addr: 127.0.0.1:9998 Dec 09 15:09:49.578 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 54bb94ba-07ee-45a6-b093-ce71db4b8b4c, remote_addr: 127.0.0.1:61665, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.686 INFO accepted connection, remote_addr: 127.0.0.1:62929, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Dec 09 15:09:53.687 INFO request completed, latency_us: 172, response_code: 204, uri:[8810] Disable keep_running /disablerestart/all, method: POST, req_id: bf013431-b680-4a04-8852-f9fa6a040ad9[8830] Disable keep_running , [8820] Disable keep_running remote_addr: 127.0.0.1:62929, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.743 INFO accepted connection, remote_addr: 127.0.0.1:33696, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Dec 09 15:09:53.744 INFO request completed, latency_us: 199, response_code: 204, uri: /stop/cid/2, method:[8830] Got stop action so:false kr:false POST, req_id: 6bf5f87b-6135-43e7-b1a5-03b41ae895ca, remote_addr: 127.0.0.1:33696, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Dec 09 15:09:53.799 INFO accepted connection, remote_addr: 127.0.0.1:57574, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.800 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/2, method: GET, req_id: a975c059-b70c-4828-bb2a-f59548cd82c2, remote_addr: 127.0.0.1:57574, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.857 INFO accepted connection, remote_addr: 127.0.0.1:33704, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Dec 09 15:09:53.857 INFO request completed, latency_us: 176, response_code: 204, uri: /start/cid/2, method: POST, req_id: 482efa32-7e26-4323-834b-d77f8f86d0d6, remote_addr: 127.0.0.1:33704, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.939 INFO accepted connection, remote_addr: 127.0.0.1:61175, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.940 INFO request completed, latency_us: 182, response_code: 200, uri: /regioninfo, method: GET, req_id: 5d4d23cd-8eb2-45ca-9000-19eeeb9841c7, remote_addr: 127.0.0.1:61175, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.941 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: f78055f8-a23e-49fb-b1cd-360a3cbfd3b5, remote_addr: 127.0.0.1:61175, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.941 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/0, method: GET, req_id: 76c2eb3d-8786-49d2-b1c3-f04e6568b53d, remote_addr: 127.0.0.1:61175, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.942 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 25e3a9d6-6bd6-4d35-b211-06d90e0d2b1f, remote_addr: 127.0.0.1:61175, local_addr: 127.0.0.1:9998 Dec 09 15:09:53.942 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 8f78049a-f3f8-4a77-96aa-8a0867c9d5c8, remote_addr: 127.0.0.1:61175, 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 Dec 09 15:10:08.141 INFO accepted connection, remote_addr: 127.0.0.1:36860, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Dec 09 15:10:08.141 INFO request completed, latency_us: 229, response_code: 204, [8810] Disable keep_running uri[8810] Got stop action so:false kr:false : /shutdown, method: [8820] Disable keep_running POST, req_id: 4778cd91-e1cc-4ba6-bf7b-8064e71289c3, remote_addr: 127.0.0.1:36860, local_addr: 127.0.0.1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8820] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [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.025398212 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.023013026 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.022376245 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.022419648 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 access at:127.0.0.1:9998 start ds: 8820 start ds: 8830 start ds: 8840 Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] initial start wait reports Starting Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] initial start wait reports Starting Starting downstairs at port 8830 Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] initial start wait reports Starting [8840][3] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1252) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1253) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1254) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1255) [8810][0] initial start wait reports Running All downstairs are running Dec 09 15:10:13.280 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Dec 09 15:10:18.319 INFO accepted connection, remote_addr: 127.0.0.1:40719, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.321 INFO request completed, latency_us: 368, response_code: 200, uri: /state/cid/0, method: GET, req_id: d3d493f1-621e-42f0-891c-53af04e5c628, remote_addr: 127.0.0.1:40719, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.378 INFO accepted connection, remote_addr: 127.0.0.1:49460, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.378 INFO request completed, latency_us: 157, response_code: 200, uri: /state/cid/1, method: GET, req_id: e8cd3e70-df92-4ed6-99dc-88e98c741412, remote_addr: 127.0.0.1:49460, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.432 INFO accepted connection, remote_addr: 127.0.0.1:40714, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.432 INFO request completed, latency_us: 129, response_code: 200, uri: /state/cid/2, method: GET, req_id: 160693f1-44bb-4c76-8e8f-aaac58c919e6, remote_addr: 127.0.0.1:40714, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.490 INFO accepted connection, remote_addr: 127.0.0.1:57140, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.491 INFO request completed, latency_us: 166, response_code: 200, uri: /state/cid/3, method: GET, req_id: 23d6bd84-8827-43e4-adda-c21a9b65322d, remote_addr: 127.0.0.1:57140, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.549 INFO accepted connection, remote_addr: 127.0.0.1:50760, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.550 INFO request completed, latency_us: 183, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5778a446-b126-43b7-b1c5-bf1315ab24af, remote_addr: 127.0.0.1:50760, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.613 INFO accepted connection, remote_addr: 127.0.0.1:57175, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.614 INFO request completed, latency_us: 202, response_code: 200, uri: /regioninfo, method: GET, req_id: 9e4cc759-1f93-4805-8ea3-4783796ef326, remote_addr: 127.0.0.1:57175, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.615 INFO request completed, latency_us: 111, response_code: 200, uri: /regioncount, method: GET, req_id: 0fc6789a-a2fa-4620-a7e1-0042111770cf, remote_addr: 127.0.0.1:57175, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.615 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 17251fc6-9283-486c-a5eb-cdc0368a3063, remote_addr: 127.0.0.1:57175, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.616 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/1, method: GET, req_id: 4d1546b2-7e9c-486b-b252-475bfd9ff449, remote_addr: 127.0.0.1:57175, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.616 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/2, method: GET, req_id: aaa854af-54d3-4847-bd0e-c1af4325e7a3, remote_addr: 127.0.0.1:57175, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.686 INFO accepted connection, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.686 INFO request completed, latency_us: 149, response_code: 200, uri: /regioncount, method: GET, req_id: 3b23068d-76f1-4214-b5de-ef37acfd1474, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Dec 09 15:10:18.710 INFO request completed, latency_us: 213, response_code: 204, uri: /stop/cid/0, method: POST, req_id[8810] Got stop action so:false kr:false : 0475a5b8-bbcc-4d6d-8d07-f78af1f15d6c, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:10:18.711 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/0, method: GET, req_id: 77a15f90-3818-479b-a2ef-1940b125b233, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Dec 09 15:10:22.713 INFO request completed, latency_us: 202, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8154c870-f9e2-42b9-a292-a50f089bbfff, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Dec 09 15:10:22.736 INFO request completed, latency_us: 183, response_code: 204, uri: /start/cid/0, method: POST, req_id: f8dd815a-ee1c-4ac5-bbef-57046410bdc8, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:10:22.736 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/0, method: GET, req_id: e7ae878c-5c56-4961-9282-3bd925860d9b, remote_addr: 127.0.0.1:51542, 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 Dec 09 15:10:26.738 INFO request completed, latency_us: 361, response_code: 200, uri: /state/cid/0, method: GET, req_id: 36111ef9-9149-49e1-b3ed-0857d8569f7f, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Dec 09 15:10:57.030 INFO request completed, latency_us: [8820] Got stop action so:false kr:false 254, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 32519f81-cd94-48bb-87e0-a3d111e5b77f, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:10:57.031 INFO request completed, latency_us: 365, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8fd15a59-c89d-407d-ab16-533e8367cecc, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Dec 09 15:11:01.033 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/1, method: GET, req_id: fea54e19-8644-41dc-afcc-a202995dfca2, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Dec 09 15:11:01.057 INFO request completed, latency_us: 155, response_code: 204, uri: /start/cid/1, method: POST, req_id: cfe0517f-7e1a-4969-b422-586fee3cf160, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:11:01.058 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/1, method: GET, req_id: 78984ce8-d8b8-427b-80a4-09ded3ef10eb, remote_addr: 127.0.0.1:51542, 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 Dec 09 15:11:05.060 INFO request completed, latency_us: 365, response_code: 200, uri: /state/cid/1, method: GET, req_id: e01f541a-3125-49ce-83c5-d22e584fa1d6, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Dec 09 15:11:35.348 INFO request completed, latency_us: [8830] Got stop action so:false kr:false 223, response_code: 204, uri: /stop/cid/2, method: POST, req_id: b9c451e4-b8a0-4b74-b0dc-36e972586d2d, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:11:35.349 INFO request completed, latency_us: 183, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3c2e9588-ce3e-4455-9b65-5175f2b17fa0, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Dec 09 15:11:39.351 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1d748dff-ae44-41c6-9f62-f18852088e53, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Dec 09 15:11:39.375 INFO request completed, latency_us: 288, response_code: 204, uri: /start/cid/2, method: POST, req_id: bc234c22-da44-43d5-91f8-02bcc3c8ca8c, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:11:39.375 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/2, method: GET, req_id: 45dc452b-c429-4704-969d-798dbe7e14f9, remote_addr: 127.0.0.1:51542, 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 Dec 09 15:11:43.377 INFO request completed, latency_us: 281, response_code: 200, uri: /state/cid/2, method: GET, req_id: 077a60f7-6243-43bc-a244-4e9c8bc71b84, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Dec 09 15:12:13.667 INFO request completed, latency_us: 240, response_code: 204, uri: /stop/cid/3, method: POST, req_id: d98a9ff8-9506-4068-9a5e-12cc44816a16, remote_addr[8840] Got stop action so:false kr:false : 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:12:13.668 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/3, method: GET, req_id: bad73511-4782-4a50-b76c-4c6b01136d1f, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Dec 09 15:12:17.670 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5e9d5007-c160-44dd-9476-1d28a6d1c644, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Dec 09 15:12:17.693 INFO request completed, latency_us: 211, response_code: 204, uri: /start/cid/3, method: POST, req_id: 5433844e-9dbb-4885-8942-896c8cd2b121, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:12:17.694 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/3, method: GET, req_id: bbdb5098-43fc-4d37-9e65-f78facc2fd28, remote_addr: 127.0.0.1:51542, 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 Dec 09 15:12:21.696 INFO request completed, latency_us: 518, response_code: 200, uri: /state/cid/3, method: GET, req_id: 86f92ebe-81a3-4c28-b241-91c697947592, remote_addr: 127.0.0.1:51542, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.038 INFO accepted connection, remote_addr: 127.0.0.1:56079, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.038 INFO request completed, latency_us: 172, response_code: 200, uri: /regioninfo, method: GET, req_id: 3bd8abe5-9eeb-4ebd-8e29-d341dafc478e, remote_addr: 127.0.0.1:56079, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.039 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: f9b10600-1398-4e75-b31f-6daeea2208d4, remote_addr: 127.0.0.1:56079, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.040 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 68344e6c-a9f2-4bde-8171-09b36183cf8e, remote_addr: 127.0.0.1:56079, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.040 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: 02a2e4b1-1571-4a96-be2e-3251945a2063, remote_addr: 127.0.0.1:56079, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.041 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5e884094-b06d-42be-a13f-711ed5880f8c, remote_addr: 127.0.0.1:56079, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.109 INFO accepted connection, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.109 INFO request completed, latency_us: 166, response_code: 200, uri: /regioncount, method: GET, req_id: 00177f63-ad4f-47d9-8b82-87afbebf5425, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Dec 09 15:12:52.536 INFO request completed, latency_us: 239, response_code: 204, uri: /stop/cid/0, [8810] Got stop action so:false kr:false method: POST, req_id: 4cc41838-d94d-4b14-b4b4-6f0aa51078e8, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Dec 09 15:12:52.536 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0e45e9a1-b3c0-4b1f-ba05-3704e0947f8e, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Dec 09 15:12:56.538 INFO request completed, latency_us: 219, response_code: 200, uri: /state/cid/0, method: GET, req_id: 77ec0f12-6969-4aee-add4-a92dbc4b1642, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Dec 09 15:13:21.325 INFO request completed, latency_us: 220, response_code: 204, uri: /start/cid/0, method: POST, req_id: 11486120-f82b-48ff-88ed-0d22f0f9807a, remote_addr: 127.0.0.1:62594, 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(1268) [8810][0] reports Running Main task has work to do, go find it got dsc Stop(1) stop 1 Dec 09 15:13:25.351[8820] Got stop action so:false kr:false INFO request completed, latency_us: 320, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 52813786-89ad-4233-92c5-89d3f6b22ac5, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Dec 09 15:13:25.352 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/1, method: GET, req_id: d99cca08-6f4a-4fa3-aba9-d3001b8ddbbe, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Dec 09 15:13:29.354 INFO request completed, latency_us: 237, response_code: 200, uri: /state/cid/1, method: GET, req_id: 450f8ccf-7a2e-4198-9648-08ca4f45d421, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Dec 09 15:13:54.140 INFO request completed, latency_us: 235, response_code: 204, uri: /start/cid/1, method: POST, req_id: 4e79a345-daa1-4f03-bc7e-2a036a3079ae, remote_addr: 127.0.0.1:62594, 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 Dec 09 15:13:58.167 INFO request completed, latency_us: 468, response_code: 204, uri: /stop/cid/2, method: POST, req_id: [8830] Got stop action so:false kr:false f4886685-8626-414b-84c1-558b86658fae, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Dec 09 15:13:58.167 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/2, method: GET, req_id: c5006af1-a119-47a0-83be-787bf619b333, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Dec 09 15:14:02.169 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/2, method: GET, req_id: bce1ccf6-59aa-4511-a808-956dec0e69b0, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Dec 09 15:14:26.960 INFO request completed, latency_us: 237, response_code: 204, uri: /start/cid/2, method: POST, req_id: 1f1ddacc-bbd4-4980-81a0-b51b54c1b872, remote_addr: 127.0.0.1:62594, 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(1270) [8830][2] reports Running Main task has work to do, go find it got dsc Stop(3) stop 3 Dec 09 15:14:30.989 INFO request completed, latency_us: [8840] Got stop action so:false kr:false 380, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 31d29e9e-23c2-457b-aad2-3904c7a9be0e, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Dec 09 15:14:30.990 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/3, method: GET, req_id: c2bea4aa-f8c3-4329-b03b-f9653b7b73bc, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Dec 09 15:14:34.992 INFO request completed, latency_us: 236, response_code: 200, uri: /state/cid/3, method: GET, req_id: 42b92652-a626-4209-8298-6a136aa4c223, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Dec 09 15:14:59.779 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/3, method: POST, req_id: cfe1fe31-e97f-4e52-b945-0ef3c5e7ddf7, remote_addr: 127.0.0.1:62594, 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 Dec 09 15:15:03.814 INFO request completed, latency_us: 419, response_code[8810] Got stop action so:false kr:false : 204, uri: /stop/cid/0, method: POST, req_id: c24f34cd-03ed-4217-b27b-77cae105969c, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Dec 09 15:15:03.815 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/0, method: GET, req_id: e1f6bd73-fb56-438e-bb37-5bc7550848db, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Dec 09 15:15:07.817 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/0, method: GET, req_id: 10787043-c94e-4e0e-8563-19d31731438d, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Dec 09 15:15:32.595 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/0, method: POST, req_id: 3460bca2-7131-4642-bd49-ab5274dc21d5, remote_addr: 127.0.0.1:62594, local_addr: 127.0.0.1:9998 Dec 09 15:15:36.662 INFO accepted connection, remote_addr: 127.0.0.1:38350, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Dec 09 15:15:36.663 INFO request completed, latency_us: 149[8830] Disable keep_running , [8820] Disable keep_running response_code[8840] Disable keep_running : 204, uri: /shutdown, method: POST, req_id: 1c4eee80-b21e-4216-8246-547124871fd4, [8840] Got stop action so:false kr:false remote_addr[8820] Got stop action so:false kr:false : 127.0.0.1:38350, local_addr: 127.0.0.1:9998 [8830] Got stop action so:false kr:false [8820] Exited with: ExitStatus(unix_wait_status(9)) [8840] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8840][3] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit