/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.36772335 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.0201874 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017846216 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 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-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8810.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/8820 port 8820 PID:Some(1189) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1190) [8810][0] initial start wait reports Running All downstairs are running Jan 14 16:10:33.759 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jan 14 16:10:38.801 INFO accepted connection, remote_addr: 127.0.0.1:34108, local_addr: 127.0.0.1:9998 Jan 14 16:10:38.803 INFO request completed, latency_us: 488, response_code: 200, uri: /state/cid/0, method: GET, req_id: 530b9ecb-941e-45ec-9cf8-67efbad78ed1, remote_addr: 127.0.0.1:34108, local_addr: 127.0.0.1:9998 Jan 14 16:10:38.859 INFO accepted connection, remote_addr: 127.0.0.1:46315, local_addr: 127.0.0.1:9998 Jan 14 16:10:38.860 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/1, method: GET, req_id: bcf26e19-941d-49d2-bb50-3b1ae0cf6174, remote_addr: 127.0.0.1:46315, local_addr: 127.0.0.1:9998 Jan 14 16:10:38.916 INFO accepted connection, remote_addr: 127.0.0.1:56573, local_addr: 127.0.0.1:9998 Jan 14 16:10:38.916 INFO request completed, latency_us: 168, response_code: 200, uri: /state/cid/2, method: GET, req_id: ebfbb729-8ea6-4d5a-ba78-6e9960a9cc31, remote_addr: 127.0.0.1:56573, local_addr: 127.0.0.1:9998 Jan 14 16:10:38.973 INFO accepted connection, remote_addr: 127.0.0.1:64084, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 [8820] Disable keep_running Jan 14 16:10:38.974[8810] Disable keep_running [8830] Disable keep_running INFO request completed, latency_us: 184, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 5a22481b-068d-416b-9a26-767eb227b63d, remote_addr: 127.0.0.1:64084, local_addr: 127.0.0.1:9998 Jan 14 16:10:39.057 INFO accepted connection, remote_addr: 127.0.0.1:49105, local_addr: 127.0.0.1:9998 Jan 14 16:10:39.058 INFO request completed, latency_us: 237, response_code: 200, uri: /regioninfo, method: GET, req_id: 69d87a0a-70d3-4390-b57e-a5414f027d4c, remote_addr: 127.0.0.1:49105, local_addr: 127.0.0.1:9998 Jan 14 16:10:39.059 INFO request completed, latency_us: 127, response_code: 200, uri: /regioncount, method: GET, req_id: 7686097b-e4e5-477e-8079-248b4e2e6039, remote_addr: 127.0.0.1:49105, local_addr: 127.0.0.1:9998 Jan 14 16:10:39.060 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/0, method: GET, req_id: 30be01c0-595c-4c27-aca7-4d0eccc06486, remote_addr: 127.0.0.1:49105, local_addr: 127.0.0.1:9998 Jan 14 16:10:39.061 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: a7c9d695-5aa2-498c-85ae-2577e00a2060, remote_addr: 127.0.0.1:49105, local_addr: 127.0.0.1:9998 Jan 14 16:10:39.061 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 678b9e2d-bdf9-4f7c-a3a5-db1bc4cc294a, remote_addr: 127.0.0.1:49105, local_addr: 127.0.0.1:9998 Jan 14 16:10:48.150 INFO accepted connection, remote_addr: 127.0.0.1:54105, local_addr: 127.0.0.1:9998 Jan 14 16:10:48.150 INFO request completed, latency_us: 146, response_code: 200, uri: /regioninfo, method: GET, req_id: 98b6a839-19e9-4a60-ad8c-9cbda32650a8, remote_addr: 127.0.0.1:54105, local_addr: 127.0.0.1:9998 Jan 14 16:10:48.151 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: 49588c39-d6b2-41c7-b145-51fb6cb55993, remote_addr: 127.0.0.1:54105, local_addr: 127.0.0.1:9998 Jan 14 16:10:48.152 INFO request completed, latency_us: 139, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1815616e-5532-4f27-8406-b927baaf5734, remote_addr: 127.0.0.1:54105, local_addr: 127.0.0.1:9998 Jan 14 16:10:48.152 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3552cbb4-7cc3-4d1a-95d8-7dddd15bed63, remote_addr: 127.0.0.1:54105, local_addr: 127.0.0.1:9998 Jan 14 16:10:48.153 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4af1a742-5223-4961-9e91-1eaf26a91a3d, remote_addr: 127.0.0.1:54105, local_addr: 127.0.0.1:9998 Jan 14 16:10:57.300 INFO accepted connection, remote_addr: 127.0.0.1:54902, local_addr: 127.0.0.1:9998 Jan 14 16:10:57.301 INFO request completed, latency_us: 175, response_code: 200, uri: /regioninfo, method: GET, req_id: 8256cbcb-cfca-4d50-8379-0c1f2a927a99, remote_addr: 127.0.0.1:54902, local_addr: 127.0.0.1:9998 Jan 14 16:10:57.302 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: 06f264a8-6054-48df-8918-6030e111a58c, remote_addr: 127.0.0.1:54902, local_addr: 127.0.0.1:9998 Jan 14 16:10:57.303 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5f13a895-2e88-45c6-971e-17320d03ecf9, remote_addr: 127.0.0.1:54902, local_addr: 127.0.0.1:9998 Jan 14 16:10:57.303 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5a2601cb-c082-457f-8bbc-82dea20d4fa7, remote_addr: 127.0.0.1:54902, local_addr: 127.0.0.1:9998 Jan 14 16:10:57.304 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 41da33e7-2d23-4386-94cc-3b674de8d7b3, remote_addr: 127.0.0.1:54902, local_addr: 127.0.0.1:9998 Jan 14 16:11:15.024 INFO accepted connection, remote_addr: 127.0.0.1:33274, local_addr: 127.0.0.1:9998 Jan 14 16:11:15.025 INFO request completed, latency_us: 143, response_code: 200, uri: /regioninfo, method: GET, req_id: 2367ce60-3706-4d24-a9d8-783b32be4649, remote_addr: 127.0.0.1:33274, local_addr: 127.0.0.1:9998 Jan 14 16:11:15.026 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: 944ba8d3-94e3-4fd5-85eb-5b3a27f24e09, remote_addr: 127.0.0.1:33274, local_addr: 127.0.0.1:9998 Jan 14 16:11:15.027 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 95cc45ba-5878-4d37-8fb9-c765a414f498, remote_addr: 127.0.0.1:33274, local_addr: 127.0.0.1:9998 Jan 14 16:11:15.027 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 05e241a4-70c8-40dd-8041-caf0921b53fb, remote_addr: 127.0.0.1:33274, local_addr: 127.0.0.1:9998 Jan 14 16:11:15.028 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1f098061-451f-4fba-88e5-9b511cabc6cc, remote_addr: 127.0.0.1:33274, local_addr: 127.0.0.1:9998 Jan 14 16:11:29.603 INFO accepted connection, remote_addr: 127.0.0.1:47378, local_addr: 127.0.0.1:9998 Jan 14 16:11:29.604 INFO request completed, latency_us: 206, response_code: 200, uri: /regioninfo, method: GET, req_id: b8903fc5-f113-42b2-9ba8-107beac2f82e, remote_addr: 127.0.0.1:47378, local_addr: 127.0.0.1:9998 Jan 14 16:11:29.605 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: 9f50adff-0b6a-49e1-b386-6d8d095c0574, remote_addr: 127.0.0.1:47378, local_addr: 127.0.0.1:9998 Jan 14 16:11:29.605 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 7058ee5b-c7aa-4b56-9fa6-db9b78f76c18, remote_addr: 127.0.0.1:47378, local_addr: 127.0.0.1:9998 Jan 14 16:11:29.606 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2519b5a6-0493-4d99-86cf-e6dd0e01a3b8, remote_addr: 127.0.0.1:47378, local_addr: 127.0.0.1:9998 Jan 14 16:11:29.606 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: 19ad9cbe-7af8-43a7-aa4e-57d94881e5f3, remote_addr: 127.0.0.1:47378, local_addr: 127.0.0.1:9998 Jan 14 16:12:31.782 INFO accepted connection, remote_addr: 127.0.0.1:41226, local_addr: 127.0.0.1:9998 Jan 14 16:12:31.783 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: 44e1e328-ff4c-4b22-9bff-7dd5381b25c7, remote_addr: 127.0.0.1:41226, local_addr: 127.0.0.1:9998 Jan 14 16:12:31.784 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: e978d7fb-c5ae-483f-8635-8c2b3d1d0578, remote_addr: 127.0.0.1:41226, local_addr: 127.0.0.1:9998 Jan 14 16:12:31.784 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8f9f62d1-d668-42e1-9843-684ec6544dab, remote_addr: 127.0.0.1:41226, local_addr: 127.0.0.1:9998 Jan 14 16:12:31.785 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: c51454c0-487a-4e3d-b45a-d45f1bede513, remote_addr: 127.0.0.1:41226, local_addr: 127.0.0.1:9998 Jan 14 16:12:31.785 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: aca712ba-6458-4b78-bf51-f03ced3072f7, remote_addr: 127.0.0.1:41226, local_addr: 127.0.0.1:9998 Jan 14 16:12:35.877 INFO accepted connection, remote_addr: 127.0.0.1:44605, local_addr: 127.0.0.1:9998 Jan 14 16:12:35.878 INFO request completed, latency_us: 186, response_code: 200, uri: /regioninfo, method: GET, req_id: e757863c-609f-4cbb-8064-ba3f5ea0bb24, remote_addr: 127.0.0.1:44605, local_addr: 127.0.0.1:9998 Jan 14 16:12:35.879 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: e951e4bb-200b-45ed-8b6a-18b5fbb0deb1, remote_addr: 127.0.0.1:44605, local_addr: 127.0.0.1:9998 Jan 14 16:12:35.879 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 97c4723c-1ae2-4a9f-a441-ae872415968e, remote_addr: 127.0.0.1:44605, local_addr: 127.0.0.1:9998 Jan 14 16:12:35.880 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: a0375482-d7a6-4c86-9a27-867a0a6b8818, remote_addr: 127.0.0.1:44605, local_addr: 127.0.0.1:9998 Jan 14 16:12:35.880 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: 94422d02-e265-4b29-94da-3f06ad68220e, remote_addr: 127.0.0.1:44605, local_addr: 127.0.0.1:9998 Jan 14 16:12:39.957 INFO accepted connection, remote_addr: 127.0.0.1:38219, 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 14 16:12:39.958 INFO request completed, latency_us: 162, response_code: 204, uri: /disablerestart/all, method: POST, req_id[8820] Disable keep_running :[8810] Disable keep_running [8830] Disable keep_running 186278c6-0122-4ed4-a000-977bfe165ed6, remote_addr: 127.0.0.1:38219, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.014 INFO accepted connection, remote_addr: 127.0.0.1:34229, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jan 14 16:12:40.015 INFO request completed, latency_us: 192, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 8348e9e0-bf43-4bdc-956d-8d8e145bdde2, remote_addr: 127.0.0.1:34229, 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 Jan 14 16:12:40.070 INFO accepted connection, remote_addr: 127.0.0.1:54938, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.071 INFO request completed, latency_us: 175, response_code: 200, uri: /state/cid/2, method: GET, req_id: d8c467b7-8f11-4961-b230-9c15932d27cd, remote_addr: 127.0.0.1:54938, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.131 INFO accepted connection, remote_addr: 127.0.0.1:34730, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 14 16:12:40.131 INFO request completed, latency_us: 177, response_code: 204, uri: /start/cid/2, method: POST, req_id: 8f276b28-b0c6-4b69-8d85-80621498412b, remote_addr: 127.0.0.1:34730, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.434 INFO accepted connection, remote_addr: 127.0.0.1:33540, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.435 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: 52b6901a-162e-4bc3-86d8-e9334b670f5a, remote_addr: 127.0.0.1:33540, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.436 INFO request completed, latency_us: 123, response_code: 200, uri: /regioncount, method: GET, req_id: d69fb8e9-35d0-4f31-afa6-dcdaad52f049, remote_addr: 127.0.0.1:33540, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.436 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1134d6b5-aca8-4160-9c1c-83a11009fbde, remote_addr: 127.0.0.1:33540, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.437 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7f2cfbd2-25ed-499d-aada-a5a1689db652, remote_addr: 127.0.0.1:33540, local_addr: 127.0.0.1:9998 Jan 14 16:12:40.437 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: d7dcaec7-ac13-4134-9f10-99bb2854c313, remote_addr: 127.0.0.1:33540, 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 14 16:12:54.612 INFO accepted connection, remote_addr: 127.0.0.1:60362, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Jan 14 16:12:54.612 INFO request completed, latency_us[8810] Disable keep_running :[8810] Got stop action so:false kr:false 258, response_code: 204, uri: /shutdown, method: POST, req_id: 103d0e98-a0d9-4c37-a4ec-8af08f397c06, remote_addr: 127.0.0.1:60362, local_addr[8830] Disable keep_running [8830] Got stop action so:false kr:false [8820] Disable keep_running [8820] Got stop action so:false kr:false : 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] 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.026419925 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.024870837 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.026141532 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.025133211 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-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8810.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/8830 port 8830 PID:Some(1252) [8830][2] 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/8810 port 8810 PID:Some(1255) [8810][0] initial start wait reports Running All downstairs are running Jan 14 16:12:59.762 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jan 14 16:13:04.802 INFO accepted connection, remote_addr: 127.0.0.1:39917, local_addr: 127.0.0.1:9998 Jan 14 16:13:04.804 INFO request completed, latency_us: 326, response_code: 200, uri: /state/cid/0, method: GET, req_id: 790703aa-22d0-45de-88a6-f4619a7409c8, remote_addr: 127.0.0.1:39917, local_addr: 127.0.0.1:9998 Jan 14 16:13:04.860 INFO accepted connection, remote_addr: 127.0.0.1:59873, local_addr: 127.0.0.1:9998 Jan 14 16:13:04.860 INFO request completed, latency_us: 164, response_code: 200, uri: /state/cid/1, method: GET, req_id: cdf45c08-b10b-412f-a8ef-a3863c8348e3, remote_addr: 127.0.0.1:59873, local_addr: 127.0.0.1:9998 Jan 14 16:13:04.915 INFO accepted connection, remote_addr: 127.0.0.1:58082, local_addr: 127.0.0.1:9998 Jan 14 16:13:04.916 INFO request completed, latency_us: 151, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9fd3abe3-a477-45a4-96fa-b2d24f0029c7, remote_addr: 127.0.0.1:58082, local_addr: 127.0.0.1:9998 Jan 14 16:13:04.970 INFO accepted connection, remote_addr: 127.0.0.1:49525, local_addr: 127.0.0.1:9998 Jan 14 16:13:04.971 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/3, method: GET, req_id: 3ff45a37-fdc6-49d7-a113-82aa76d0f9b6, remote_addr: 127.0.0.1:49525, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.026 INFO accepted connection, remote_addr: 127.0.0.1:48760, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.027 INFO request completed, latency_us: 174, response_code: 200, uri: /port/cid/3, method: GET, req_id: 53149011-66b0-4e37-84f8-fca585b23ee1, remote_addr: 127.0.0.1:48760, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.088 INFO accepted connection, remote_addr: 127.0.0.1:36397, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.089 INFO request completed, latency_us: 186, response_code: 200, uri: /regioninfo, method: GET, req_id: cdf1d54f-dd1b-4d58-b622-2036c8c31f0e, remote_addr: 127.0.0.1:36397, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.090 INFO request completed, latency_us: 104, response_code: 200, uri: /regioncount, method: GET, req_id: 9ed44b63-e853-402c-b411-d338765bc78e, remote_addr: 127.0.0.1:36397, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.091 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1e6fef16-3509-4f06-ab18-f651a86755f6, remote_addr: 127.0.0.1:36397, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.091 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 01392efb-f3a3-4ec0-8ec7-382f9a7e5f66, remote_addr: 127.0.0.1:36397, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.092 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/2, method: GET, req_id: 468b0c80-fab5-4c1e-9f06-9bc613756836, remote_addr: 127.0.0.1:36397, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.128 INFO accepted connection, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.128 INFO request completed, latency_us: 125, response_code: 200, uri: /regioncount, method: GET, req_id: 3348aaf7-44af-4b61-b7fe-82449afb0298, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jan 14 16:13:05.152 INFO[8810] Got stop action so:false kr:false request completed, latency_us: 234, response_code: 204, uri: /stop/cid/0, method: POST, req_id: bc7861a9-4257-420e-884c-ab17cd0f9e19, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:13:05.153 INFO request completed, latency_us: 202, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7d138b03-f0ad-4d93-a8ba-b8f5f48b5e4b, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 14 16:13:09.156 INFO request completed, latency_us: 231, response_code: 200, uri: /state/cid/0, method: GET, req_id: ac4dfcfc-a4ee-479c-abb6-86a23b39d2ea, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 14 16:13:09.177 INFO request completed, latency_us: 189, response_code: 204, uri: /start/cid/0, method: POST, req_id: 55b6f995-d314-4d85-b6df-5aec76ca389f, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:13:09.178 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/0, method: GET, req_id: d0dc5838-f677-4540-9e8d-ac41eaa5f429, remote_addr: 127.0.0.1:44239, 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 14 16:13:13.180 INFO request completed, latency_us: 348, response_code: 200, uri: /state/cid/0, method: GET, req_id: 30e45344-3825-4118-8786-0cde82939843, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Jan 14 16:13:43.467 INFO request completed, latency_us: 203, response_code[8820] Got stop action so:false kr:false : 204, uri: /stop/cid/1, method: POST, req_id: e0175c21-813a-49c5-8502-bb81a926dfdb, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:13:43.468 INFO request completed, latency_us: 128, response_code: 200, uri: /state/cid/1, method: GET, req_id: a36af41b-98b4-4957-b7dc-bd6a6dd066b6, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jan 14 16:13:47.470 INFO request completed, latency_us: 231, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1268ab73-34fd-4549-9357-3a7f5043e841, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jan 14 16:13:47.494 INFO request completed, latency_us: 244, response_code: 204, uri: /start/cid/1, method: POST, req_id: 6aca6769-ce07-44ca-a493-8228a6ca4ddf, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:13:47.494 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/1, method: GET, req_id: 56c7a494-eec9-4a2f-b0b3-152426c2718b, remote_addr: 127.0.0.1:44239, 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 14 16:13:51.496 INFO request completed, latency_us: 366, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1c00c38a-7b06-4967-9d14-c63030d18235, remote_addr: 127.0.0.1:44239, 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 14 16:14:21.780 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 5f1eb787-29b6-4355-bdcd-9467323ada52, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:14:21.780 INFO request completed, latency_us: 129, response_code: 200, uri: /state/cid/2, method: GET, req_id: a566028f-aa6d-4940-9493-893d7d8d258b, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jan 14 16:14:25.783 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/2, method: GET, req_id: c8563cd5-20ba-443b-849a-e41788a83bbf, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 14 16:14:25.807 INFO request completed, latency_us: 232, response_code: 204, uri: /start/cid/2, method: POST, req_id: 01dafdbf-0c1c-4c2d-ab9e-daecce00b143, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:14:25.808 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6bf2edfa-77a7-4ad6-90ba-f790fa89f437, remote_addr: 127.0.0.1:44239, 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 14 16:14:29.809 INFO request completed, latency_us: 357, response_code: 200, uri: /state/cid/2, method: GET, req_id: db8c7ed2-5aaf-4d52-88a2-4ab6f0592179, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Jan 14 16:15:00.082 INFO request completed, latency_us:[8840] Got stop action so:false kr:false 209, response_code: 204, uri: /stop/cid/3, method: POST, req_id: f6d5fcfb-4201-45a5-9f4f-028bc081e43f, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:15:00.082 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/3, method: GET, req_id: a1ed31ae-2586-4c8b-996c-778d17b79c97, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jan 14 16:15:04.084 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/3, method: GET, req_id: 47f6385d-a36d-4c96-ae30-209a73e9a40f, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jan 14 16:15:04.107 INFO request completed, latency_us: 201, response_code: 204, uri: /start/cid/3, method: POST, req_id: d8a058d3-e559-4930-8944-19dfc05c3dc5, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:15:04.107 INFO request completed, latency_us: 93, response_code: 200, uri: /state/cid/3, method: GET, req_id: 35af4b29-fd7f-48f7-9fc3-a683a366dfab, remote_addr: 127.0.0.1:44239, 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 14 16:15:08.109 INFO request completed, latency_us: 349, response_code: 200, uri: /state/cid/3, method: GET, req_id: 99c69923-b1ae-4c01-b5ce-960d1e65f03f, remote_addr: 127.0.0.1:44239, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.426 INFO accepted connection, remote_addr: 127.0.0.1:42096, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.427 INFO request completed, latency_us: 163, response_code: 200, uri: /regioninfo, method: GET, req_id: 404141cf-23d3-4eec-8274-68ab78881ecf, remote_addr: 127.0.0.1:42096, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.428 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: 6ff3d465-950e-4e9f-8914-47affdc3a4eb, remote_addr: 127.0.0.1:42096, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.429 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: f41b44ed-8f98-4a8c-a309-1f9df2c4192b, remote_addr: 127.0.0.1:42096, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.429 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 120b3ef9-1d22-40e1-9e6f-4e8f3ee11d1c, remote_addr: 127.0.0.1:42096, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.430 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 76fd13ed-7c19-45d0-b2cf-2e10f185820b, remote_addr: 127.0.0.1:42096, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.465 INFO accepted connection, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.465 INFO request completed, latency_us: 108, response_code: 200, uri: /regioncount, method: GET, req_id: c2a493f2-d76f-42d0-847f-b854c2ed67b5, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jan 14 16:15:38.866 INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/0[8810] Got stop action so:false kr:false , method: POST, req_id: 2095b41d-b1d8-43e0-8af2-e15355804c3f, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Jan 14 16:15:38.867 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/0, method: GET, req_id: 151a00eb-cf8a-490c-82eb-c12b76925a49, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 14 16:15:42.869 INFO request completed, latency_us: 234, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1ab313a1-4739-435f-864f-3fb217464fcb, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 14 16:16:07.649 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/0, method: POST, req_id: aa7883f0-e330-4b39-8706-aeb8f1f87778, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Jan 14 16:16:11.673 INFO request completed, latency_us: 223, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 6a571ba1-2cb2-426c-9278-0a720c2cd8eb, remote_addr: [8820] Got stop action so:false kr:false 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Jan 14 16:16:11.674 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0f3a4872-f8c2-4c92-bd6c-f57643a1e342, remote_addr: 127.0.0.1:50732, 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 14 16:16:15.676 INFO request completed, latency_us: 390, response_code: 200, uri: /state/cid/1, method: GET, req_id: a7964390-89b4-4f19-85b6-d89ea80a0695, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jan 14 16:16:40.440 INFO request completed, latency_us: 238, response_code: 204, uri: /start/cid/1, method: POST, req_id: bf6a2039-0df5-4978-8496-fee833d5fc89, remote_addr: 127.0.0.1:50732, 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 [8830] Got stop action so:false kr:false Jan 14 16:16:44.467 INFO request completed, latency_us: 340, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 3059a9bf-03fc-416d-9a84-6eebf7718852, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Jan 14 16:16:44.468 INFO request completed, latency_us: 132, response_code: 200, uri: /state/cid/2, method: GET, req_id: 79bcff16-87fe-423c-9d2b-cacff22ba76a, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jan 14 16:16:48.470 INFO request completed, latency_us: 192, response_code: 200, uri: /state/cid/2, method: GET, req_id: 487e5d50-84fa-4858-aeb9-d9647fe5b8a9, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 14 16:17:13.247 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/2, method: POST, req_id: c743f776-37b8-4385-9db7-567e0caebfce, remote_addr: 127.0.0.1:50732, 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 [8840] Got stop action so:false kr:false Jan 14 16:17:17.275 INFO request completed, latency_us: 322, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 636ed777-fc7d-4229-859b-61fbc6332d21, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Jan 14 16:17:17.276 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/3, method: GET, req_id: 98287196-9180-483e-8921-f82e2e05e77c, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jan 14 16:17:21.279 INFO request completed, latency_us: 244, response_code: 200, uri: /state/cid/3, method: GET, req_id: 90fb96ad-bffc-4ebc-9d40-40687664b12c, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jan 14 16:17:46.049 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/3, method: POST, req_id: 3b9c2b65-2e86-4b92-967b-c1719e457b32, remote_addr: 127.0.0.1:50732, 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 [8810] Got stop action so:false kr:false Jan 14 16:17:50.081 INFO request completed, latency_us: 339, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 99c9bcd4-93b6-437d-9327-a1ac3b62b9fc, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Jan 14 16:17:50.082 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5323ebe6-f883-4907-8e1b-937b26dbc26e, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 14 16:17:54.085 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/0, method: GET, req_id: c74e1acf-5f51-4f30-8938-307c46bfd78a, remote_addr: 127.0.0.1:50732, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 14 16:18:18.842 INFO request completed, latency_us: 238, response_code: 204, uri: /start/cid/0, method: POST, req_id: 6fe872ad-4b8e-4f08-aaec-7297e23f9352, remote_addr: 127.0.0.1:50732, 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 14 16:18:22.908 INFO accepted connection, remote_addr: 127.0.0.1:63589, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Jan 14 16:18:22.909 INFO request completed, latency_us: 211[8810] Disable keep_running , response_code: 204, uri:[8810] Got stop action so:false kr:false /shutdown, method: POST, req_id: 1faa5540-0778-4e51-aeef-c473cbbe60d0, remote_addr: 127.0.0.1:63589, local_addr: 127.0.0.1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Disable keep_running [8820] Disable keep_running [8840] Got stop action so:false kr:false [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