/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.23074847 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.01985904 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.020585345 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 8820 Starting downstairs at port 8810 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 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/8820 port 8820 PID:Some(1191) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1192) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1193) [8810][0] initial start wait reports Running All downstairs are running Nov 19 17:07:58.111 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Nov 19 17:08:03.152 INFO accepted connection, remote_addr: 127.0.0.1:59979, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.154 INFO request completed, latency_us: 454, response_code: 200, uri: /state/cid/0, method: GET, req_id: 48bbb817-edeb-46ec-b881-95108acf2835, remote_addr: 127.0.0.1:59979, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.212 INFO accepted connection, remote_addr: 127.0.0.1:59834, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.213 INFO request completed, latency_us: 180, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0c95de41-eca8-4dbf-9e33-f14a435e9024, remote_addr: 127.0.0.1:59834, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.272 INFO accepted connection, remote_addr: 127.0.0.1:62284, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.273 INFO request completed, latency_us: 172, response_code: 200, uri: /state/cid/2, method: GET, req_id: 41c214de-f9a2-4459-9faa-b0e8ae26397f, remote_addr: 127.0.0.1:62284, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.329 INFO accepted connection, remote_addr: 127.0.0.1:63619, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Nov 19 17:08:03.330 INFO request completed, latency_us: 181, response_code: 204, uri[8810] Disable keep_running :[8830] Disable keep_running /disablerestart/all, method: POST, req_id: 8db92ff3-9e31-454b-a652-790b289d8226, [8820] Disable keep_running remote_addr: 127.0.0.1:63619, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.433 INFO accepted connection, remote_addr: 127.0.0.1:37174, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.434 INFO request completed, latency_us: 286, response_code: 200, uri: /regioninfo, method: GET, req_id: 42431d8e-50e3-46db-b742-9203efca6782, remote_addr: 127.0.0.1:37174, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.435 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 9a7e82c8-db99-4f58-a1f1-9da8ddaf2852, remote_addr: 127.0.0.1:37174, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.436 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/0, method: GET, req_id: 313500e4-769c-4951-970e-2781fa822133, remote_addr: 127.0.0.1:37174, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.437 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: b2696ada-3c1a-47a8-a216-6fc08d763c08, remote_addr: 127.0.0.1:37174, local_addr: 127.0.0.1:9998 Nov 19 17:08:03.437 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: c01839c8-3b92-4112-9bdb-9408e4dfd413, remote_addr: 127.0.0.1:37174, local_addr: 127.0.0.1:9998 Nov 19 17:08:12.575 INFO accepted connection, remote_addr: 127.0.0.1:39424, local_addr: 127.0.0.1:9998 Nov 19 17:08:12.575 INFO request completed, latency_us: 160, response_code: 200, uri: /regioninfo, method: GET, req_id: f4c33720-791e-4cfc-8271-2b1619f2553f, remote_addr: 127.0.0.1:39424, local_addr: 127.0.0.1:9998 Nov 19 17:08:12.576 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: 7b56cd26-05db-41b0-9d4d-714d39c7f7ab, remote_addr: 127.0.0.1:39424, local_addr: 127.0.0.1:9998 Nov 19 17:08:12.577 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 27cb3f93-e6cc-4924-9bd1-3c18aed49eec, remote_addr: 127.0.0.1:39424, local_addr: 127.0.0.1:9998 Nov 19 17:08:12.578 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/1, method: GET, req_id: cef4efaf-8d61-4e2b-b0ac-c4adfbae4d38, remote_addr: 127.0.0.1:39424, local_addr: 127.0.0.1:9998 Nov 19 17:08:12.578 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3e9868fe-becc-487d-830c-3a92fbe54fa4, remote_addr: 127.0.0.1:39424, local_addr: 127.0.0.1:9998 Nov 19 17:08:21.928 INFO accepted connection, remote_addr: 127.0.0.1:38659, local_addr: 127.0.0.1:9998 Nov 19 17:08:21.929 INFO request completed, latency_us: 172, response_code: 200, uri: /regioninfo, method: GET, req_id: deff92ce-6be8-48cb-acd3-e0171344a9a1, remote_addr: 127.0.0.1:38659, local_addr: 127.0.0.1:9998 Nov 19 17:08:21.930 INFO request completed, latency_us: 95, response_code: 200, uri: /regioncount, method: GET, req_id: 7cf95ebe-342e-44df-b972-cbb3128e4526, remote_addr: 127.0.0.1:38659, local_addr: 127.0.0.1:9998 Nov 19 17:08:21.930 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/0, method: GET, req_id: 399d20c9-7302-44cc-90c7-8a2a39dfc71a, remote_addr: 127.0.0.1:38659, local_addr: 127.0.0.1:9998 Nov 19 17:08:21.931 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/1, method: GET, req_id: 998e12a0-55ca-491d-b18d-eaa83fbfe280, remote_addr: 127.0.0.1:38659, local_addr: 127.0.0.1:9998 Nov 19 17:08:21.931 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/2, method: GET, req_id: a14380b3-eec3-4220-bc43-4dba661daa00, remote_addr: 127.0.0.1:38659, local_addr: 127.0.0.1:9998 Nov 19 17:09:18.235 INFO accepted connection, remote_addr: 127.0.0.1:58833, local_addr: 127.0.0.1:9998 Nov 19 17:09:18.236 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: b5fbfa1f-69e5-4c1b-8920-6e4c6f7f677c, remote_addr: 127.0.0.1:58833, local_addr: 127.0.0.1:9998 Nov 19 17:09:18.237 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: b886d3a7-4f2a-46f8-986a-e1b27c7b7439, remote_addr: 127.0.0.1:58833, local_addr: 127.0.0.1:9998 Nov 19 17:09:18.237 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9f0f604d-5b11-4df6-9993-f50fa93daefa, remote_addr: 127.0.0.1:58833, local_addr: 127.0.0.1:9998 Nov 19 17:09:18.238 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: d57f36d3-05ed-4ebf-a93c-fd9137239cf3, remote_addr: 127.0.0.1:58833, local_addr: 127.0.0.1:9998 Nov 19 17:09:18.239 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/2, method: GET, req_id: 6a204294-13bb-446b-9d23-9a0e6d867eb2, remote_addr: 127.0.0.1:58833, local_addr: 127.0.0.1:9998 Nov 19 17:10:03.375 INFO accepted connection, remote_addr: 127.0.0.1:45985, local_addr: 127.0.0.1:9998 Nov 19 17:10:03.376 INFO request completed, latency_us: 192, response_code: 200, uri: /regioninfo, method: GET, req_id: a9c2d3f2-fbae-481d-8b7b-6e2d0e15bd1d, remote_addr: 127.0.0.1:45985, local_addr: 127.0.0.1:9998 Nov 19 17:10:03.377 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 69f4e221-b1ef-4ebd-bb8c-5dd968f1e6d4, remote_addr: 127.0.0.1:45985, local_addr: 127.0.0.1:9998 Nov 19 17:10:03.378 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 69f5ebc8-6d35-4df1-a95a-1e4656ec5fa7, remote_addr: 127.0.0.1:45985, local_addr: 127.0.0.1:9998 Nov 19 17:10:03.379 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6605187c-af00-405d-ac9d-7ed9b465b1a0, remote_addr: 127.0.0.1:45985, local_addr: 127.0.0.1:9998 Nov 19 17:10:03.379 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5a844427-67c9-4f4b-b854-9feb06b1e09a, remote_addr: 127.0.0.1:45985, local_addr: 127.0.0.1:9998 Nov 19 17:11:15.940 INFO accepted connection, remote_addr: 127.0.0.1:45645, local_addr: 127.0.0.1:9998 Nov 19 17:11:15.941 INFO request completed, latency_us: 184, response_code: 200, uri: /regioninfo, method: GET, req_id: 3fd51c83-9eda-4d1d-9e05-5481bd9317c8, remote_addr: 127.0.0.1:45645, local_addr: 127.0.0.1:9998 Nov 19 17:11:15.942 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 881893fe-4c5b-4664-85ba-814199a83345, remote_addr: 127.0.0.1:45645, local_addr: 127.0.0.1:9998 Nov 19 17:11:15.942 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: ba924db9-f764-41b1-8158-0fccb54e2033, remote_addr: 127.0.0.1:45645, local_addr: 127.0.0.1:9998 Nov 19 17:11:15.943 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 165065af-77fd-4c59-b263-40dc8c877a29, remote_addr: 127.0.0.1:45645, local_addr: 127.0.0.1:9998 Nov 19 17:11:15.944 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/2, method: GET, req_id: e53faeba-8965-4cb3-b975-f8bd12cefab0, remote_addr: 127.0.0.1:45645, local_addr: 127.0.0.1:9998 Nov 19 17:11:20.141 INFO accepted connection, remote_addr: 127.0.0.1:59347, local_addr: 127.0.0.1:9998 Nov 19 17:11:20.142 INFO request completed, latency_us: 183, response_code: 200, uri: /regioninfo, method: GET, req_id: c6098d65-d942-4077-9ff2-46857ecdd99f, remote_addr: 127.0.0.1:59347, local_addr: 127.0.0.1:9998 Nov 19 17:11:20.143 INFO request completed, latency_us: 118, response_code: 200, uri: /regioncount, method: GET, req_id: 9090299d-b77f-4be7-967c-0f22bc0dfdec, remote_addr: 127.0.0.1:59347, local_addr: 127.0.0.1:9998 Nov 19 17:11:20.143 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: fc66bdc5-1bb5-4181-8e2b-40af5eae3b35, remote_addr: 127.0.0.1:59347, local_addr: 127.0.0.1:9998 Nov 19 17:11:20.144 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: c298a9b3-f059-48bb-a90a-8694b2d42d31, remote_addr: 127.0.0.1:59347, local_addr: 127.0.0.1:9998 Nov 19 17:11:20.144 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/2, method: GET, req_id: 15be5240-6440-4932-b97f-c64976555ddf, remote_addr: 127.0.0.1:59347, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.321 INFO accepted connection, remote_addr: 127.0.0.1:51503, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Nov 19 17:11:24.322 INFO request completed, latency_us: 173, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 985e05ea-8ca3-41c8-92b8-ff9c399ce3c6, [8820] Disable keep_running remote_addr[8810] Disable keep_running : 127.0.0.1:51503, local_addr: 127.0[8830] Disable keep_running .0.1:9998 Nov 19 17:11:24.378 INFO accepted connection, remote_addr: 127.0.0.1:38246, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Nov 19 17:11:24.379 INFO request completed[8830] Got stop action so:false kr:false , latency_us: 219, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 383636cb-78ec-41c4-b3a4-ed2673e22192, remote_addr: 127.0.0.1:38246, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Nov 19 17:11:24.438 INFO accepted connection, remote_addr: 127.0.0.1:43844, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.438 INFO request completed, latency_us: 184, response_code: 200, uri: /state/cid/2, method: GET, req_id: b25d6649-2375-4218-95cc-38368bf04dcf, remote_addr: 127.0.0.1:43844, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.502 INFO accepted connection, remote_addr: 127.0.0.1:50594, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Nov 19 17:11:24.503 INFO request completed, latency_us: 251, response_code: 204, uri: /start/cid/2, method: POST, req_id: 25396d30-a3b7-4434-95e7-a0253ba2b936, remote_addr: 127.0.0.1:50594, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.593 INFO accepted connection, remote_addr: 127.0.0.1:32993, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.594 INFO request completed, latency_us: 165, response_code: 200, uri: /regioninfo, method: GET, req_id: ba74aa83-e019-4788-9805-aab2ee1471aa, remote_addr: 127.0.0.1:32993, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.595 INFO request completed, latency_us: 122, response_code: 200, uri: /regioncount, method: GET, req_id: 3daf0f12-19ae-4fec-afed-aa3e19d6d609, remote_addr: 127.0.0.1:32993, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.596 INFO request completed, latency_us: 141, response_code: 200, uri: /port/cid/0, method: GET, req_id: b4dfd4f2-92ed-4a8c-b32f-3bbebe999572, remote_addr: 127.0.0.1:32993, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.596 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/1, method: GET, req_id: bcd66e29-deb8-4a6d-9717-522e3451fcad, remote_addr: 127.0.0.1:32993, local_addr: 127.0.0.1:9998 Nov 19 17:11:24.597 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9bc12ac4-b0ad-487b-bed4-6e46b475e88a, remote_addr: 127.0.0.1:32993, 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(1241) [8830][2] reports Running Nov 19 17:11:38.846 INFO accepted connection, remote_addr: 127.0.0.1:36935, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Nov 19 17:11:38.847 INFO request completed, latency_us: 233, response_code: 204, uri: /shutdown, method: POST, req_id: 5068d5ad-163b-4372-932d-f3446e6a7306, remote_addr: 127.0.0.1:36935, local_addr: 127.0.0.[8810] Disable keep_running 1[8810] Got stop action so:false kr:false :9998[8820] Disable keep_running [8820] Got stop action so:false kr:false [8830] Disable keep_running [8830] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8810] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8810][0] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit /var/tmp/bins/dsc create --encrypted --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.027752709 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.025816465 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.025386024 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.026485492 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 access at:127.0.0.1:9998 start ds: 8830 start ds: 8840 Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Starting downstairs at port 8830 [8810][0] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8820][1] initial start wait reports Starting [8830][2] initial start wait reports Starting Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1255) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1256) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1257) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1258) [8830][2] initial start wait reports Running All downstairs are running Nov 19 17:11:44.001 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Nov 19 17:11:49.043 INFO accepted connection, remote_addr: 127.0.0.1:33687, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.045 INFO request completed, latency_us: 354, response_code: 200, uri: /state/cid/0, method: GET, req_id: 748360ec-21d5-4cff-ba14-aecc7a5f6562, remote_addr: 127.0.0.1:33687, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.104 INFO accepted connection, remote_addr: 127.0.0.1:64184, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.104 INFO request completed, latency_us: 175, response_code: 200, uri: /state/cid/1, method: GET, req_id: 85f1be19-38d8-4017-bca6-0895a4fb97e5, remote_addr: 127.0.0.1:64184, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.162 INFO accepted connection, remote_addr: 127.0.0.1:37649, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.162 INFO request completed, latency_us: 185, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7e89bbb9-2e3b-48c2-ae1d-e7315db90872, remote_addr: 127.0.0.1:37649, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.222 INFO accepted connection, remote_addr: 127.0.0.1:45483, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.223 INFO request completed, latency_us: 174, response_code: 200, uri: /state/cid/3, method: GET, req_id: 9531cea4-b98f-48b4-8719-e5ad75e4bd01, remote_addr: 127.0.0.1:45483, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.284 INFO accepted connection, remote_addr: 127.0.0.1:63603, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.285 INFO request completed, latency_us: 200, response_code: 200, uri: /port/cid/3, method: GET, req_id: ebd0a624-aa69-45ac-b957-7e11b90a8474, remote_addr: 127.0.0.1:63603, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.352 INFO accepted connection, remote_addr: 127.0.0.1:33196, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.353 INFO request completed, latency_us: 253, response_code: 200, uri: /regioninfo, method: GET, req_id: 5446f593-28f9-4fe9-b64b-62624cbb1535, remote_addr: 127.0.0.1:33196, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.354 INFO request completed, latency_us: 139, response_code: 200, uri: /regioncount, method: GET, req_id: 4814dfaf-94a5-487d-a76f-6a364b4130f1, remote_addr: 127.0.0.1:33196, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.355 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: b21bb3a8-05fe-4e5e-8c92-d8b417e63498, remote_addr: 127.0.0.1:33196, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.355 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: d84358c8-0aa6-49e3-835d-bbe5ccbb4571, remote_addr: 127.0.0.1:33196, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.356 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1dd3c884-0931-4d64-818b-a9ad6c39cab3, remote_addr: 127.0.0.1:33196, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.430 INFO accepted connection, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.430 INFO request completed, latency_us: 182, response_code: 200, uri: /regioncount, method: GET, req_id: b64eb225-f8ff-4e3e-977c-7c270824949f, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Nov 19 17:11:49.521 INFO request completed, latency_us: 238, response_code: 204[8810] Got stop action so:false kr:false , uri: /stop/cid/0, method: POST, req_id: d49bb613-73ef-48c9-9cb6-ac82d3d5e1cf, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:11:49.522 INFO request completed, latency_us: 154, response_code: 200, uri: /state/cid/0, method: GET, req_id: baf7f5f2-5ff8-4e0f-925a-e1645f02d8f2, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Nov 19 17:11:53.525 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/0, method: GET, req_id: 18dc7578-dba3-41a7-aa85-eb041140c033, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Nov 19 17:11:53.606 INFO request completed, latency_us: 234, response_code: 204, uri: /start/cid/0, method: POST, req_id: c8eedf9a-a9cb-4cf4-9ef8-62b73ace9fb7, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:11:53.607 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/0, method: GET, req_id: 17b4d760-568a-47c6-9083-3fd6c3746080, remote_addr: 127.0.0.1:55343, 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(1266) [8810][0] reports Running Nov 19 17:11:57.609 INFO request completed, latency_us: 393, response_code: 200, uri: /state/cid/0, method: GET, req_id: dd4d9169-d4a1-4e20-bea5-986f973d824c, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Nov 19 17:12:28.061 INFO request completed, [8820] Got stop action so:false kr:false latency_us: 246, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 2cf04f5e-7d72-4cd3-bac3-32f6e1e1b046, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:12:28.062 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8220ff47-c25a-4186-a253-4c98881a6528, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Nov 19 17:12:32.065 INFO request completed, latency_us: 243, response_code: 200, uri: /state/cid/1, method: GET, req_id: f49ddc1f-e831-438e-865f-7fcf954103a7, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Nov 19 17:12:32.147 INFO request completed, latency_us: 232, response_code: 204, uri: /start/cid/1, method: POST, req_id: 9fdb2952-95b1-437c-a2aa-d9681bcde8b4, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:12:32.147 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/1, method: GET, req_id: 020fe6ac-ad4e-425c-9f1e-120941542b11, remote_addr: 127.0.0.1:55343, 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(1267) [8820][1] reports Running Nov 19 17:12:36.150 INFO request completed, latency_us: 336, response_code: 200, uri: /state/cid/1, method: GET, req_id: f9be4a0c-aed8-4251-adc5-a9938800a370, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Nov 19 17:13:06.678 INFO request completed, [8830] Got stop action so:false kr:false latency_us: 235, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 72ab2509-4ccd-4c7d-aac8-d0559212fb98, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:13:06.679 INFO request completed, latency_us: 159, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6364507f-013d-4be4-9ace-c9e5b9b3ca0a, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Nov 19 17:13:10.681 INFO request completed, latency_us: 236, response_code: 200, uri: /state/cid/2, method: GET, req_id: 538474db-1386-4877-bc0a-66d23b6cb5ec, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Nov 19 17:13:10.766 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/2, method: POST, req_id: 29fd098f-ed59-4ab3-ab27-4fefd7b0c790, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:13:10.767 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/2, method: GET, req_id: 16cd9672-8f4e-4229-907a-008d9d05b947, remote_addr: 127.0.0.1:55343, 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(1268) [8830][2] reports Running Nov 19 17:13:14.769 INFO request completed, latency_us: 359, response_code: 200, uri: /state/cid/2, method: GET, req_id: 67c1e31c-6e70-4c1b-b636-9b8245974d00, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Nov 19 17:13:45.383 [8840] Got stop action so:false kr:false INFO request completed, latency_us: 232, response_code: 204, uri: /stop/cid/3, method: POST, req_id: de10ecb5-7f34-4134-9cac-9d113e0172e3, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:13:45.384 INFO request completed, latency_us: 147, response_code: 200, uri: /state/cid/3, method: GET, req_id: 740ec0fc-095f-484c-b996-d08361f3a5bc, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Nov 19 17:13:49.385 INFO request completed, latency_us: 286, response_code: 200, uri: /state/cid/3, method: GET, req_id: 988bb9ad-7128-4546-bc8a-81237bef8b99, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Nov 19 17:13:49.473 INFO request completed, latency_us: 252, response_code: 204, uri: /start/cid/3, method: POST, req_id: f677ee6c-4624-4632-a8e7-da51682b51c2, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:13:49.473 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/3, method: GET, req_id: f8140fb4-deb8-4589-b5e8-3da0a2993cc9, remote_addr: 127.0.0.1:55343, 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(1269) [8840][3] reports Running Nov 19 17:13:53.476 INFO request completed, latency_us: 373, response_code: 200, uri: /state/cid/3, method: GET, req_id: f9775f41-406d-476f-ba83-8302368b5be9, remote_addr: 127.0.0.1:55343, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.168 INFO accepted connection, remote_addr: 127.0.0.1:36644, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.169 INFO request completed, latency_us: 180, response_code: 200, uri: /regioninfo, method: GET, req_id: fdcba2d1-ba8e-456a-b77e-2526b73b86ee, remote_addr: 127.0.0.1:36644, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.170 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: 7b6dfcef-b3c4-4e9a-b7e4-0c5567707545, remote_addr: 127.0.0.1:36644, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.171 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/0, method: GET, req_id: 179c0342-079d-41b7-ab92-7b7d5de07ab8, remote_addr: 127.0.0.1:36644, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.171 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 8c6c1525-cd40-43eb-8f22-b50873c906ed, remote_addr: 127.0.0.1:36644, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.172 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 59e5e585-8720-4bc8-91ea-bdf9dbd5e383, remote_addr: 127.0.0.1:36644, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.244 INFO accepted connection, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Nov 19 17:14:24.245 INFO request completed, latency_us: 186, response_code: 200, uri: /regioncount, method: GET, req_id: 29f28114-4e2a-47a4-ba90-be0150d31729, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Nov 19 17:14:26.207 INFO request completed, latency_us: 235, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 46c5aebf-4101-4552-8e22-a3e51d418d8c, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 [8810] Got stop action so:false kr:false Nov 19 17:14:26.208 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/0, method: GET, req_id: d94de2ea-a050-4902-af47-7db91968ce90, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Nov 19 17:14:30.211 INFO request completed, latency_us: 245, response_code: 200, uri: /state/cid/0, method: GET, req_id: 485e9540-c9dd-40a5-ac75-748e4c4312b8, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Nov 19 17:14:59.021 INFO request completed, latency_us: 246, response_code: 204, uri: /start/cid/0, method: POST, req_id: 07ecee43-bb79-4894-8473-9af52909375c, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Nov 19 17:15:03.111 INFO request completed, latency_us: [8820] Got stop action so:false kr:false 223, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 994fca67-92ba-4110-a5f2-30b9b5e1db35, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Nov 19 17:15:03.111 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7ede4e61-ed26-42ea-be03-f0eddb558a22, remote_addr: 127.0.0.1:60874, 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(1271) [8810][0] reports Running Nov 19 17:15:07.115 INFO request completed, latency_us: 384, response_code: 200, uri: /state/cid/1, method: GET, req_id: a0677c3a-5b28-4edf-b571-de7eee2fa136, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Nov 19 17:15:35.929 INFO request completed, latency_us: 259, response_code: 204, uri: /start/cid/1, method: POST, req_id: 59210e6c-fcc1-45df-9d22-93f0c431d6ad, remote_addr: 127.0.0.1:60874, 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(1272) [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 Nov 19 17:15:40.022 INFO request completed, latency_us: 361, response_code: 204, uri: /stop/cid/2, method: POST, req_id: c44f09f1-7a6e-49a0-a37f-60c4aae7e75f, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Nov 19 17:15:40.022 INFO request completed, latency_us: 150, response_code: 200, uri: /state/cid/2, method: GET, req_id: 95390642-d3c8-4bcd-9ac3-c9640d1d4d42, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Nov 19 17:15:44.025 INFO request completed, latency_us: 232, response_code: 200, uri: /state/cid/2, method: GET, req_id: 19b9d715-da8c-4af5-afab-30be689e2561, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Nov 19 17:16:12.828 INFO request completed, latency_us: 252, response_code: 204, uri: /start/cid/2, method: POST, req_id: 674fd459-804c-4d24-9444-85f1538dce8a, remote_addr: 127.0.0.1:60874, 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(1273) [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 Nov 19 17:16:16.926 INFO request completed, latency_us: 335, response_code: 204, uri: /stop/cid/3, method: POST, req_id: af909a34-7b82-4a4f-8621-de3939edaf1a, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Nov 19 17:16:16.927 INFO request completed, latency_us: 193, response_code: 200, uri: /state/cid/3, method: GET, req_id: fe113475-38bc-4aeb-a0c5-f55c099e50d4, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Nov 19 17:16:20.929 INFO request completed, latency_us: 230, response_code: 200, uri: /state/cid/3, method: GET, req_id: 95de4810-9fd1-4862-a976-8bec11814b51, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Nov 19 17:16:49.690 INFO request completed, latency_us: 250, response_code: 204, uri: /start/cid/3, method: POST, req_id: e044116c-f261-4551-b17e-d324eafd2134, remote_addr: 127.0.0.1:60874, 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(1274) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(0) stop 0 Nov 19 17:16:53.808 INFO request completed, latency_us: 371, response_code:[8810] Got stop action so:false kr:false 204, uri: /stop/cid/0, method: POST, req_id: 7168fa87-b361-4adf-9807-8e28a98edb69, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Nov 19 17:16:53.809 INFO request completed, latency_us: 147, response_code: 200, uri: /state/cid/0, method: GET, req_id: 90e69cd7-0120-4d8d-8939-c327b0a711da, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Nov 19 17:16:57.811 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/0, method: GET, req_id: ce6e337d-e1ba-48c6-b11d-40a2898d3301, remote_addr: 127.0.0.1:60874, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Nov 19 17:17:26.603 INFO request completed, latency_us: 245, response_code: 204, uri: /start/cid/0, method: POST, req_id: 47ffff22-8c21-40bf-9148-8d8095a84e2c, remote_addr: 127.0.0.1:60874, 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(1275) [8810][0] reports Running Nov 19 17:17:30.677 INFO accepted connection, remote_addr: 127.0.0.1:60944, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Nov 19 17:17:30.678 INFO request completed, latency_us: 216, response_code: 204[8810] Disable keep_running , Shut it down uri: /shutdown, method: POST, [8830] Disable keep_running req_id: 2d07533f-f11d-4a30-824c-8e4e361f6f33[8830] Got stop action so:false kr:false , [8820] Disable keep_running remote_addr: 127.0.0.1:60944, local_addr: 127.0.[8820] Got stop action so:false kr:false 0.1:9998 [8840] Disable keep_running [8840] Got stop action so:false kr:false [8810] Got stop action so:false kr:false [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8840] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8840][3] reports Exit