/var/tmp/bins/dsc create --encrypted --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.18217313 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.011659489 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.01119429 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 access at:127.0.0.1:9998 start ds: 8820 start ds: 8830 Starting downstairs at port 8810 Starting downstairs at port 8830 Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" 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/8810 port 8810 PID:Some(1137) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1136) Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1138) [8810][0] initial start wait reports Running [8830][2] initial start wait reports Running [8820][1] initial start wait reports Running All downstairs are running Sep 18 03:27:55.075 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Sep 18 03:28:00.088 INFO accepted connection, remote_addr: 127.0.0.1:55992, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.090 INFO request completed, latency_us: 492, response_code: 200, uri: /state/cid/0, method: GET, req_id: bf979564-705e-41c5-98cc-206fcfe01dcd, remote_addr: 127.0.0.1:55992, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.105 INFO accepted connection, remote_addr: 127.0.0.1:42272, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.105 INFO request completed, latency_us: 75, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5bc60d78-44e1-4b29-a9f4-e7a4890c5e3f, remote_addr: 127.0.0.1:42272, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.119 INFO accepted connection, remote_addr: 127.0.0.1:50130, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.120 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/2, method: GET, req_id: 98e2f4f2-3b06-4c80-8297-54398eaf0bb0, remote_addr: 127.0.0.1:50130, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.133 INFO accepted connection, remote_addr: 127.0.0.1:40039, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Sep 18 03:28:00.134 INFO request completed, latency_us: 93, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 73e3c428-66fa-406f-8ab8-f8584ff4a3b5, remote_addr: 127.0.0.1:40039, local_addr: 127.0.0.[8820] Disable keep_running 1:9998 [8810] Disable keep_running [8830] Disable keep_running Sep 18 03:28:00.197 INFO accepted connection, remote_addr: 127.0.0.1:53275, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.197 INFO request completed, latency_us: 261, response_code: 200, uri: /regioninfo, method: GET, req_id: 57117b86-2472-449c-8fa4-521de9bbd446, remote_addr: 127.0.0.1:53275, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.199 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: ba1cad6f-fafb-4e1a-9457-374b955a27a8, remote_addr: 127.0.0.1:53275, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.200 INFO request completed, latency_us: 145, response_code: 200, uri: /port/cid/0, method: GET, req_id: 925fb7a2-df5f-4cb7-a57f-d332754c2e6f, remote_addr: 127.0.0.1:53275, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.200 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/1, method: GET, req_id: f60ce116-ad01-458a-99e3-bd3b9efa5d6c, remote_addr: 127.0.0.1:53275, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.201 INFO request completed, latency_us: 60, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1550d85a-d55b-4f3d-9c21-9b00e6a753a7, remote_addr: 127.0.0.1:53275, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.254 INFO accepted connection, remote_addr: 127.0.0.1:65520, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.255 INFO request completed, latency_us: 204, response_code: 200, uri: /regioninfo, method: GET, req_id: 285512ca-8fba-46c2-a47e-30b2dc2e754d, remote_addr: 127.0.0.1:65520, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.256 INFO request completed, latency_us: 48, response_code: 200, uri: /regioncount, method: GET, req_id: 8c501e7e-49e7-4f4f-8825-7da379aa46b6, remote_addr: 127.0.0.1:65520, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.256 INFO request completed, latency_us: 79, response_code: 200, uri: /port/cid/0, method: GET, req_id: b8a95857-aa8f-4a4e-8204-e2dae6e501b1, remote_addr: 127.0.0.1:65520, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.257 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/1, method: GET, req_id: e25f09de-aa2b-4cbe-b336-f1cedd53e0e0, remote_addr: 127.0.0.1:65520, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.257 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/2, method: GET, req_id: 597e17b3-3025-4a70-88f2-ab5aa77bb64c, remote_addr: 127.0.0.1:65520, local_addr: 127.0.0.1:9998 Sep 18 03:28:18.445 INFO accepted connection, remote_addr: 127.0.0.1:61434, local_addr: 127.0.0.1:9998 Sep 18 03:28:18.446 INFO request completed, latency_us: 145, response_code: 200, uri: /regioninfo, method: GET, req_id: 36d3e54a-a236-4f38-8b49-fe00870418e6, remote_addr: 127.0.0.1:61434, local_addr: 127.0.0.1:9998 Sep 18 03:28:18.447 INFO request completed, latency_us: 35, response_code: 200, uri: /regioncount, method: GET, req_id: e7c1a19d-08e8-46e3-9a7e-1e5b16e1c8d0, remote_addr: 127.0.0.1:61434, local_addr: 127.0.0.1:9998 Sep 18 03:28:18.447 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: da379dc6-b155-4073-bccd-d31fc102181b, remote_addr: 127.0.0.1:61434, local_addr: 127.0.0.1:9998 Sep 18 03:28:18.447 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/1, method: GET, req_id: 847f7f40-b941-4a2c-8c8f-d281d3f07b1b, remote_addr: 127.0.0.1:61434, local_addr: 127.0.0.1:9998 Sep 18 03:28:18.447 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: dd84a85d-670c-4663-9488-e2bfa9b6e42c, remote_addr: 127.0.0.1:61434, local_addr: 127.0.0.1:9998 Sep 18 03:28:55.753 INFO accepted connection, remote_addr: 127.0.0.1:62862, local_addr: 127.0.0.1:9998 Sep 18 03:28:55.753 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: d2bce4cf-603d-454d-b8af-9f4385868b2e, remote_addr: 127.0.0.1:62862, local_addr: 127.0.0.1:9998 Sep 18 03:28:55.754 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: fd077a5f-b6f8-473a-9f81-d83de39395fe, remote_addr: 127.0.0.1:62862, local_addr: 127.0.0.1:9998 Sep 18 03:28:55.755 INFO request completed, latency_us: 83, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5aab2e97-f785-4e4e-8124-d7cd0d636acb, remote_addr: 127.0.0.1:62862, local_addr: 127.0.0.1:9998 Sep 18 03:28:55.755 INFO request completed, latency_us: 39, response_code: 200, uri: /port/cid/1, method: GET, req_id: 40bda34a-aed3-44d9-8948-43917de08b97, remote_addr: 127.0.0.1:62862, local_addr: 127.0.0.1:9998 Sep 18 03:28:55.755 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4136dc64-6c75-4ff8-90b0-7ab5a5001565, remote_addr: 127.0.0.1:62862, local_addr: 127.0.0.1:9998 Sep 18 03:29:26.953 INFO accepted connection, remote_addr: 127.0.0.1:39720, local_addr: 127.0.0.1:9998 Sep 18 03:29:26.953 INFO request completed, latency_us: 207, response_code: 200, uri: /regioninfo, method: GET, req_id: 22cacef6-a31a-44de-94c9-dc7b36c44600, remote_addr: 127.0.0.1:39720, local_addr: 127.0.0.1:9998 Sep 18 03:29:26.954 INFO request completed, latency_us: 56, response_code: 200, uri: /regioncount, method: GET, req_id: 71210511-0bd0-42af-ac7b-b96e0d436d85, remote_addr: 127.0.0.1:39720, local_addr: 127.0.0.1:9998 Sep 18 03:29:26.955 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/0, method: GET, req_id: c361c57c-b26a-4034-9b71-5b9712cea79d, remote_addr: 127.0.0.1:39720, local_addr: 127.0.0.1:9998 Sep 18 03:29:26.955 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/1, method: GET, req_id: cdea069c-4918-4d82-a256-365bc4e93878, remote_addr: 127.0.0.1:39720, local_addr: 127.0.0.1:9998 Sep 18 03:29:26.955 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/2, method: GET, req_id: eac308c7-1d84-41ef-8832-7797f299dd74, remote_addr: 127.0.0.1:39720, local_addr: 127.0.0.1:9998 Sep 18 03:29:43.562 INFO accepted connection, remote_addr: 127.0.0.1:44172, local_addr: 127.0.0.1:9998 Sep 18 03:29:43.562 INFO request completed, latency_us: 157, response_code: 200, uri: /regioninfo, method: GET, req_id: 43177835-8398-4e2a-91dc-b1edd0a95588, remote_addr: 127.0.0.1:44172, local_addr: 127.0.0.1:9998 Sep 18 03:29:43.563 INFO request completed, latency_us: 64, response_code: 200, uri: /regioncount, method: GET, req_id: 0de9cd76-53d8-49ed-af9e-f05fdabbb7d0, remote_addr: 127.0.0.1:44172, local_addr: 127.0.0.1:9998 Sep 18 03:29:43.563 INFO request completed, latency_us: 68, response_code: 200, uri: /port/cid/0, method: GET, req_id: cef2000c-0d6e-4489-addb-42fbcfe9e8f8, remote_addr: 127.0.0.1:44172, local_addr: 127.0.0.1:9998 Sep 18 03:29:43.563 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/1, method: GET, req_id: bc01d088-888c-44fd-a84c-8525fb7c0282, remote_addr: 127.0.0.1:44172, local_addr: 127.0.0.1:9998 Sep 18 03:29:43.564 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1056e182-340a-4df9-adfe-2b4145efbad4, remote_addr: 127.0.0.1:44172, local_addr: 127.0.0.1:9998 Sep 18 03:29:47.648 INFO accepted connection, remote_addr: 127.0.0.1:61053, local_addr: 127.0.0.1:9998 Sep 18 03:29:47.649 INFO request completed, latency_us: 154, response_code: 200, uri: /regioninfo, method: GET, req_id: 8fd04fb2-8cd0-4b18-8792-ab6ec93f2a27, remote_addr: 127.0.0.1:61053, local_addr: 127.0.0.1:9998 Sep 18 03:29:47.650 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: 66391132-6e4d-4cff-8f30-70ca8ea61863, remote_addr: 127.0.0.1:61053, local_addr: 127.0.0.1:9998 Sep 18 03:29:47.650 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/0, method: GET, req_id: bba640c9-3c70-42ab-a07f-b9e80b8c3d78, remote_addr: 127.0.0.1:61053, local_addr: 127.0.0.1:9998 Sep 18 03:29:47.651 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: e21c15a8-de49-421e-8a7e-fbc6a43aa833, remote_addr: 127.0.0.1:61053, local_addr: 127.0.0.1:9998 Sep 18 03:29:47.651 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 67179f89-eb5d-4d2f-b725-4e7e7e05fc9c, remote_addr: 127.0.0.1:61053, local_addr: 127.0.0.1:9998 Sep 18 03:29:51.724 INFO accepted connection, remote_addr: 127.0.0.1:44565, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Sep 18 03:29:51.724 INFO request completed, latency_us: 132, response_code: 204, uri: /disablerestart/all, method: POST, req_id: a7828ac9-9100-46d9-a250-9cee17eab938, remote_addr: 127.0.0.1:44565, local_addr: 127.0.0.[8810] Disable keep_running 1:9998 [8830] Disable keep_running [8820] Disable keep_running Sep 18 03:29:51.737 INFO accepted connection, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998 Main task has work to do, go find it Sep 18 03:29:51.737 INFO request completed, latency_us: 98, response_code:got dsc Stop(2) stop 2 204, uri: /stop/cid/2, method: POST, req_id: 28d461f9-b922-4355-8430-208652b452a6, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998 [8830] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Sep 18 03:29:51.751 INFO accepted connection, remote_addr: 127.0.0.1:44235, local_addr: 127.0.0.1:9998 Sep 18 03:29:51.751 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/2, method: GET, req_id: f5bb02cc-9641-412d-9191-d56c1029130b, remote_addr: 127.0.0.1:44235, local_addr: 127.0.0.1:9998 Sep 18 03:29:51.767 INFO accepted connection, remote_addr: 127.0.0.1:45696, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Sep 18 03:29:51.767 INFO request completed, latency_us: 79, response_code: 204, uri: /start/cid/2, method: POST, req_id: 1b7b2509-f3f2-42a0-be27-655a9ea4ce53, remote_addr: 127.0.0.1:45696, local_addr: 127.0.0.1:9998 Sep 18 03:29:52.047 INFO accepted connection, remote_addr: 127.0.0.1:32896, local_addr: 127.0.0.1:9998 Sep 18 03:29:52.047 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: 81552863-269c-4891-b286-5505c7d77e4b, remote_addr: 127.0.0.1:32896, local_addr: 127.0.0.1:9998 Sep 18 03:29:52.048 INFO request completed, latency_us: 71, response_code: 200, uri: /regioncount, method: GET, req_id: 64c94d66-8683-4c8d-9db3-661e5e43a562, remote_addr: 127.0.0.1:32896, local_addr: 127.0.0.1:9998 Sep 18 03:29:52.049 INFO request completed, latency_us: 77, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1a154591-deeb-447d-898c-be6b0e43f1dc, remote_addr: 127.0.0.1:32896, local_addr: 127.0.0.1:9998 Sep 18 03:29:52.049 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/1, method: GET, req_id: d36d6638-efb3-46a9-bae0-e48eeaa9d254, remote_addr: 127.0.0.1:32896, local_addr: 127.0.0.1:9998 Sep 18 03:29:52.049 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/2, method: GET, req_id: 14f555cb-6d68-4b43-a1e8-543016d6d8d0, remote_addr: 127.0.0.1:32896, 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(1189) [8830][2] reports Running Sep 18 03:30:16.171 INFO accepted connection, remote_addr: 127.0.0.1:42532, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Sep 18 03:30:16.172 INFO request completed, latency_us: 127, response_code[8810] Disable keep_running : 204, uri: /shutdown, method[8810] Got stop action so:false kr:false : POST, req_id: 4048d07d-bbab-4cbe-b6bf-8a56fa06b5d2, remote_addr: 127.0.0.[8820] Disable keep_running 1[8820] Got stop action so:false kr:false :42532, local_addr: 127.0.0.1:9998 [8830] Disable keep_running [8830] 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 --encrypted --cleanup --region-count 4 --extent-count 400 --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.030731587 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.028230133 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.028049868 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.025892656 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: 400 }) 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 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 Starting downstairs at port 8840 [8830][2] initial start wait reports Starting 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(1206) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1205) Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1203) [8810][0] initial start wait reports Running [8830][2] initial start wait reports Running [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1204) [8840][3] initial start wait reports Running All downstairs are running Sep 18 03:30:21.306 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Sep 18 03:30:26.319 INFO accepted connection, remote_addr: 127.0.0.1:60238, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.321 INFO request completed, latency_us: 300, response_code: 200, uri: /state/cid/0, method: GET, req_id: 27e3e8f8-2a0b-4bef-86f0-5b8396ae021e, remote_addr: 127.0.0.1:60238, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.335 INFO accepted connection, remote_addr: 127.0.0.1:62080, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.335 INFO request completed, latency_us: 132, response_code: 200, uri: /state/cid/1, method: GET, req_id: d717dc40-6c6f-46fc-beaf-271809a77fa9, remote_addr: 127.0.0.1:62080, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.349 INFO accepted connection, remote_addr: 127.0.0.1:62070, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.349 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/2, method: GET, req_id: 227292b7-0621-4a68-8f53-303421a8830e, remote_addr: 127.0.0.1:62070, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.363 INFO accepted connection, remote_addr: 127.0.0.1:42170, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.363 INFO request completed, latency_us: 70, response_code: 200, uri: /state/cid/3, method: GET, req_id: a82c7aca-ad54-4809-986a-0db26713c64e, remote_addr: 127.0.0.1:42170, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.376 INFO accepted connection, remote_addr: 127.0.0.1:58010, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.377 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/3, method: GET, req_id: ef16c21e-384c-4ecf-919d-17d280143547, remote_addr: 127.0.0.1:58010, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.396 INFO accepted connection, remote_addr: 127.0.0.1:55437, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.396 INFO request completed, latency_us: 98, response_code: 200, uri: /regioninfo, method: GET, req_id: 68cf7fa9-93bd-4171-87e5-46a7d0e641bb, remote_addr: 127.0.0.1:55437, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.397 INFO request completed, latency_us: 44, response_code: 200, uri: /regioncount, method: GET, req_id: edabc6bc-8561-4545-b603-c44ea6f83bec, remote_addr: 127.0.0.1:55437, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.397 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/0, method: GET, req_id: e03aeec2-42e8-4545-a0a4-4e3bc1e2bdda, remote_addr: 127.0.0.1:55437, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.397 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/1, method: GET, req_id: b44e7745-1806-4288-a641-bf3b2b5f6ba1, remote_addr: 127.0.0.1:55437, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.398 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/2, method: GET, req_id: 11dd8a09-b85b-40cf-b039-91b0588fb4b9, remote_addr: 127.0.0.1:55437, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.409 INFO accepted connection, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.410 INFO request completed, latency_us: 60, response_code: 200, uri: /regioncount, method: GET, req_id: 2bc0fd5f-02b2-4424-834a-1dfd3810dfc3, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:30:26.607 INFO [8810] Got stop action so:false kr:false request completed, latency_us: 230, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 4703f7f3-98c5-43f9-a074-7645cc62ad7e, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:30:26.607 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6a679730-6fa7-43ef-a202-8452dd7dcb36, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:30:30.610 INFO request completed, latency_us: 308, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3546cee8-a71e-402d-b6de-02d2cd05a305, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:30:30.812 INFO request completed, latency_us: 224, response_code: 204, uri: /start/cid/0, method: POST, req_id: 61db554c-5d5b-4621-93c0-ba6e02230c45, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:30:30.812 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/0, method: GET, req_id: e92614c1-ec3f-44fc-9818-cc9b3f674052, remote_addr: 127.0.0.1:49912, 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(1214) [8810][0] reports Running Sep 18 03:30:34.815 INFO request completed, latency_us: 265, response_code: 200, uri: /state/cid/0, method: GET, req_id: 54e980f2-7a08-495f-bd4a-cc5d355fbcb6, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:30:41.016 [8810] Got stop action so:false kr:false INFO request completed, latency_us: 241, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 4072c737-4219-4166-be8d-c50268929ee5, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:30:41.017 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: a718fc00-8c7e-47c0-9789-b06ca7419578, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:30:45.019 INFO request completed, latency_us: 279, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0f202ef8-b7b3-4b8e-a8bc-778f0f430e23, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:30:45.230 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: e17f9731-1767-44b6-ac4f-54ad547f44c5, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:30:45.230 INFO request completed, latency_us: 49, response_code: 200, uri: /state/cid/0, method: GET, req_id: 54ffcce7-ee36-46ed-b640-066493758fd1, remote_addr: 127.0.0.1:49912, 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(1215) [8810][0] reports Running Sep 18 03:30:49.232 INFO request completed, latency_us: 269, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2ab80bc2-96b5-47b3-9e64-13417e52a3c0, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:30:54.431 INFO [8810] Got stop action so:false kr:false request completed, latency_us: 223, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 8ee9e5ce-1c8e-4118-ade6-7cc08363424a, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:30:54.432 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/0, method: GET, req_id: 81f54e02-f066-45f4-a0df-25fccc15b49c, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:30:58.435 INFO request completed, latency_us: 343, response_code: 200, uri: /state/cid/0, method: GET, req_id: 001adf7d-5cce-4af2-86ea-6470339d6d9f, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:30:58.649 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/0, method: POST, req_id: eef00dd3-89ad-4391-bfac-6fba29c3e672, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:30:58.650 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4dc9b4e7-d17c-4c88-bd4d-f9fed6a681be, remote_addr: 127.0.0.1:49912, 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(1216) [8810][0] reports Running Sep 18 03:31:02.652 INFO request completed, latency_us: 270, response_code: 200, uri: /state/cid/0, method: GET, req_id: 964c5377-e450-4052-a030-8549660ae4ab, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:31:06.862[8810] Got stop action so:false kr:false INFO request completed, latency_us: 249, response_code: 204, uri: /stop/cid/0, method: POST, req_id: ca23ac06-b802-4e50-84e3-252ca7818683, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:31:06.863 INFO request completed, latency_us: 78, response_code: 200, uri: /state/cid/0, method: GET, req_id: 01ba750a-8149-43d7-83f0-1bd063be1905, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:31:10.865 INFO request completed, latency_us: 288, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1faca873-0225-4793-8b63-c353a968e6d7, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:31:11.097 INFO request completed, latency_us: 222, response_code: 204, uri: /start/cid/0, method: POST, req_id: bc00290e-72c0-4627-b739-b415b06e974f, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:31:11.097 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/0, method: GET, req_id: 200fb48b-c0bb-4bc7-9d75-1c374fff852d, remote_addr: 127.0.0.1:49912, 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(1217) [8810][0] reports Running Sep 18 03:31:15.099 INFO request completed, latency_us: 273, response_code: 200, uri: /state/cid/0, method: GET, req_id: 35ae41f0-ee08-4117-ac10-a17b530d177f, remote_addr: 127.0.0.1:49912, 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 Sep 18 03:31:18.301 INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 6651eba2-2fa6-4ae3-89de-da341f4fbcf6, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:31:18.302 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: aa18e18a-7003-46b8-b438-401f673a4b78, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:31:22.304 INFO request completed, latency_us: 223, response_code: 200, uri: /state/cid/0, method: GET, req_id: b34fb15f-8053-40e1-8ea0-5137a1509c67, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:31:22.516 INFO request completed, latency_us: 163, response_code: 204, uri: /start/cid/0, method: POST, req_id: 759f12ea-a598-4c9e-932a-bbcfbe5211e3, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:31:22.516 INFO request completed, latency_us: 69, response_code: 200, uri: /state/cid/0, method: GET, req_id: 463167f8-98a1-444a-b48b-ea74b24427e0, remote_addr: 127.0.0.1:49912, 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(1218) [8810][0] reports Running Sep 18 03:31:26.518 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/0, method: GET, req_id: eb95f147-68ec-4d2e-94fe-c240579bf5f7, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:31:28.719 INFO request completed[8810] Got stop action so:false kr:false , latency_us: 222, response_code: 204, uri: /stop/cid/0, method: POST, req_id: f4dd337d-bdae-4a53-a120-4337d9f3aad1, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:31:28.719 INFO request completed, latency_us: 87, response_code: 200, uri: /state/cid/0, method: GET, req_id: f41a93c1-c3dc-4b7b-9406-10754434e009, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:31:32.721 INFO request completed, latency_us: 270, response_code: 200, uri: /state/cid/0, method: GET, req_id: e87f3cf0-24d5-4550-a5ce-a4469ca1c3c9, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:31:32.932 INFO request completed, latency_us: 155, response_code: 204, uri: /start/cid/0, method: POST, req_id: aab0ebc1-bc59-43b9-b391-5651c3f0906a, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:31:32.932 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: f329e2bf-ae51-4b80-9c14-fc0a7a1ec22a, remote_addr: 127.0.0.1:49912, 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(1219) [8810][0] reports Running Sep 18 03:31:36.934 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/0, method: GET, req_id: d55d56c6-53d0-4939-a6c8-903e1552d76f, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Sep 18 03:32:03.204 INFO request completed, latency_us: 217, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 97e8f21f-46ae-43f5-a8b9-c104cfb04138, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Sep 18 03:32:03.221 INFO request completed, latency_us: 116, response_code: 200, uri: /state/cid/1, method: GET, req_id: 85c639f0-1eac-424a-8f37-61df8e0534b3, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Sep 18 03:32:03.432 INFO request completed, latency_us: 108, response_code: 204, uri: /start/cid/1, method: POST, req_id: d069e89e-d890-43b6-bfdc-35d1175ed513, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:32:03.433 INFO request completed, latency_us: 38, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3205b970-3e4a-4c28-9cba-a8644702bfef, remote_addr: 127.0.0.1:49912, 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(1220) [8820][1] reports Running Sep 18 03:32:07.435 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8a6664bc-5c8f-4595-91be-bb2c19cf09fb, remote_addr: 127.0.0.1:49912, 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 Sep 18 03:32:33.761 INFO request completed, latency_us: 210, response_code: 204, uri: /stop/cid/2, method: POST, req_id: caa74440-b8e1-4ac2-ab84-3511736c1a11, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:32:33.762 INFO request completed, latency_us: 88, response_code: 200, uri: /state/cid/2, method: GET, req_id: 140b625a-805c-417a-8046-8a2b0884eed2, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Sep 18 03:32:37.764 INFO request completed, latency_us: 259, response_code: 200, uri: /state/cid/2, method: GET, req_id: bfc902e1-cd25-4b18-abc8-fbcbf5d1313e, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Sep 18 03:32:37.974 INFO request completed, latency_us: 172, response_code: 204, uri: /start/cid/2, method: POST, req_id: 2d9163f4-8cab-485b-a239-651f12650d2e, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:32:37.974 INFO request completed, latency_us: 75, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7818925c-97a3-49e3-af22-35d1dff94f69, remote_addr: 127.0.0.1:49912, 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(1221) [8830][2] reports Running Sep 18 03:32:41.976 INFO request completed, latency_us: 227, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1c0101d6-8f59-4f34-9fab-182e1b8710c4, remote_addr: 127.0.0.1:49912, 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 Sep 18 03:33:08.420 INFO request completed, latency_us: 206, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 3e947c1d-36d3-403e-bf49-4cc813938452, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:33:08.420 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/3, method: GET, req_id: b7a2e7b5-8f77-45fb-837a-6e36951ca249, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Sep 18 03:33:12.422 INFO request completed, latency_us: 237, response_code: 200, uri: /state/cid/3, method: GET, req_id: 90882891-f7a3-4623-a56b-433bb02d0bf9, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Sep 18 03:33:12.631 INFO request completed, latency_us: 122, response_code: 204, uri: /start/cid/3, method: POST, req_id: 29694ce7-028a-4903-9457-38f013578386, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:33:12.631 INFO request completed, latency_us: 80, response_code: 200, uri: /state/cid/3, method: GET, req_id: 9274f8cc-c6b4-4ffb-b865-b331e416a42e, remote_addr: 127.0.0.1:49912, 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(1222) [8840][3] reports Running Sep 18 03:33:16.633 INFO request completed, latency_us: 255, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7ca9dcc8-b64f-4e02-a5e9-71758fcebfad, remote_addr: 127.0.0.1:49912, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.038 INFO accepted connection, remote_addr: 127.0.0.1:47018, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.039 INFO request completed, latency_us: 162, response_code: 200, uri: /regioninfo, method: GET, req_id: 394beeb1-05c1-4c30-8a28-bf3e89a3e947, remote_addr: 127.0.0.1:47018, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.040 INFO request completed, latency_us: 81, response_code: 200, uri: /regioncount, method: GET, req_id: 93c96ddb-3372-48b2-8ac9-f6e42c3daeff, remote_addr: 127.0.0.1:47018, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.040 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/0, method: GET, req_id: 268c958e-2623-45c5-b0e7-9927f0f01957, remote_addr: 127.0.0.1:47018, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.040 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7e8ac0c1-ad38-4e1f-964c-b452857317a1, remote_addr: 127.0.0.1:47018, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.041 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/2, method: GET, req_id: b2a18bef-9b10-4e20-a1dc-2eccf5a2da6c, remote_addr: 127.0.0.1:47018, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.052 INFO accepted connection, remote_addr: 127.0.0.1:53756, local_addr: 127.0.0.1:9998 Sep 18 03:33:43.052 INFO request completed, latency_us: 54, response_code: 200, uri: /regioncount, method: GET, req_id: c5c5bf92-cfe9-4346-b6d7-31e365c37cc3, remote_addr: 127.0.0.1:53756, 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 Sep 18 03:33:46.023 INFO request completed, latency_us: 226, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 7f3d873d-53a8-4580-b8a1-899b6fb21e05, remote_addr: 127.0.0.1:53756, local_addr: 127.0.0.1:9998 Sep 18 03:33:46.024 INFO request completed, latency_us: 151, response_code: 200, uri: /state/cid/0, method: GET, req_id: 70d14405-10d2-46ee-9c53-594bd5b0b239, remote_addr: 127.0.0.1:53756, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:33:50.027 INFO request completed, latency_us: 240, response_code: 200, uri: /state/cid/0, method: GET, req_id: 88240cc8-df49-42f7-990b-a337e7c9ff8d, remote_addr: 127.0.0.1:53756, local_addr: 127.0.0.1:9998 Sep 18 03:34:20.886 INFO accepted connection, remote_addr: 127.0.0.1:60975, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:34:20.887 INFO request completed, latency_us: 166, response_code: 204, uri: /start/cid/0, method: POST, req_id: 919d4c8f-5a97-4f98-875a-29056e9dbf45, remote_addr: 127.0.0.1:60975, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Sep 18 03:34:25.093 INFO request completed, latency_us: 200, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 5e74c947-cec2-4384-8f15-bf837a803cb3, remote_addr: 127.0.0.1:60975, local_addr: 127.0.0.1:9998 Sep 18 03:34:25.093 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3bb9e51b-fe83-4898-8fe4-beb9c8461ff3, remote_addr: 127.0.0.1:60975, 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(1224) [8810][0] reports Running Sep 18 03:34:29.095 INFO request completed, latency_us: 276, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0527e643-0fee-4367-b481-ec950ebfba05, remote_addr: 127.0.0.1:60975, local_addr: 127.0.0.1:9998 Sep 18 03:35:00.244 INFO accepted connection, remote_addr: 127.0.0.1:52054, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Sep 18 03:35:00.244 INFO request completed, latency_us: 209, response_code: 204, uri: /start/cid/1, method: POST, req_id: 565162e3-3628-44a3-9481-45fedd9c2045, remote_addr: 127.0.0.1:52054, 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(1225) [8820][1] reports Running Main task has work to do, go find it got dsc Stop(2) stop 2 Sep 18 03:35:04.455[8830] Got stop action so:false kr:false INFO request completed, latency_us: 223, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 9ab56cf8-5bf9-4802-8d61-6988e13760f1, remote_addr: 127.0.0.1:52054, local_addr: 127.0.0.1:9998 Sep 18 03:35:04.456 INFO request completed, latency_us: 55, response_code: 200, uri: /state/cid/2, method: GET, req_id: b637dd3a-081a-4983-88b9-75da6e3e7b57, remote_addr: 127.0.0.1:52054, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Sep 18 03:35:08.458 INFO request completed, latency_us: 280, response_code: 200, uri: /state/cid/2, method: GET, req_id: afe143dd-3f86-447d-99cc-d89875d8d911, remote_addr: 127.0.0.1:52054, local_addr: 127.0.0.1:9998 Sep 18 03:35:39.505 INFO accepted connection, remote_addr: 127.0.0.1:49579, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Sep 18 03:35:39.506 INFO request completed, latency_us: 178, response_code: 204, uri: /start/cid/2, method: POST, req_id: 44ea3a8e-5371-4e87-841b-86ec0ede2994, remote_addr: 127.0.0.1:49579, 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(1226) [8830][2] reports Running Main task has work to do, go find it got dsc Stop(3) stop 3 [8840] Got stop action so:false kr:false Sep 18 03:35:43.725 INFO request completed, latency_us: 213, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 2a4ac08c-78ee-4f8e-bc58-350c615e9237, remote_addr: 127.0.0.1:49579, local_addr: 127.0.0.1:9998 Sep 18 03:35:43.726 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/3, method: GET, req_id: cc2fb042-ab3f-4508-8983-55cc2e6f1992, remote_addr: 127.0.0.1:49579, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Sep 18 03:35:47.728 INFO request completed, latency_us: 237, response_code: 200, uri: /state/cid/3, method: GET, req_id: 9ab0581b-5a59-4548-ae3d-10c1b4dc4d39, remote_addr: 127.0.0.1:49579, local_addr: 127.0.0.1:9998 Sep 18 03:36:18.599 INFO accepted connection, remote_addr: 127.0.0.1:54027, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Sep 18 03:36:18.599 INFO request completed, latency_us: 166, response_code: 204, uri: /start/cid/3, method: POST, req_id: 8c5246a4-4539-4570-9ba6-5dc0850be282, remote_addr: 127.0.0.1:54027, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:36:22.891[8810] Got stop action so:false kr:false INFO request completed, latency_us: 217, response_code: 204, uri: /stop/cid/0, method: POST, req_id: a06ec36a-b829-488a-a2a4-ab1e334d8771, remote_addr: 127.0.0.1:54027, local_addr: 127.0.0.1:9998 Sep 18 03:36:22.892 INFO request completed, latency_us: 96, response_code: 200, uri: /state/cid/0, method: GET, req_id: 908ae17b-8401-429e-921c-9014de99d46d, remote_addr: 127.0.0.1:54027, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:36:26.894 INFO request completed, latency_us: 234, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8f2c901c-d0f6-4539-93b5-db5362f3a0f3, remote_addr: 127.0.0.1:54027, 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(1227) [8840][3] reports Running Sep 18 03:36:58.118 INFO accepted connection, remote_addr: 127.0.0.1:34095, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:36:58.119 INFO request completed, latency_us: 173, response_code: 204, uri: /start/cid/0, method: POST, req_id: a4806bc1-20a5-4de6-8902-b946cf9b311b, remote_addr: 127.0.0.1:34095, local_addr: 127.0.0.1:9998 Sep 18 03:37:02.160 INFO accepted connection, remote_addr: 127.0.0.1:38366, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Sep 18 03:37:02.161 INFO request completed, latency_us[8820] Disable keep_running :[8820] Got stop action so:false kr:false 145, response_code: 204, uri: /shutdown, method: [8840] Disable keep_running POST, req_id: fba5081f-3b9f-4eb5-8ffa-80cfb6f7b43e, remote_addr: 127.0.0.1:38366, local_addr: 127.0.0.1:9998 [8840] Got stop action so:false kr:false [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Exited with: ExitStatus(unix_wait_status(9)) [8820] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8820][1] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit