/var/tmp/bins/dsc create --encrypted --cleanup --region-count 6 --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.28579962
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018569805
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.019742033
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.021221086
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.020203464
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.018946232
Created 6 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 6
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
start ds: 8840
start ds: 8850
start ds: 8860
Starting downstairs at port 8830
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Starting downstairs at port 8820
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Starting downstairs at port 8860
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8810][0] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8840][3] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1205)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1208)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1210)
[8840][3] initial start wait reports Running
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1207)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1209)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1206)
[8820][1] initial start wait reports Running
[8810][0] initial start wait reports Running
All downstairs are running
Oct 22 21:44:15.822 INFO Control access at:127.0.0.1:9998
listening, local_addr: 127.0.0.1:9998
Oct 22 21:44:20.861 INFO accepted connection, remote_addr: 127.0.0.1:40195, local_addr: 127.0.0.1:9998
Oct 22 21:44:20.863 INFO request completed, latency_us: 426, response_code: 200, uri: /state/cid/0, method: GET, req_id: 49b5bf1a-121d-468d-a23c-cb90ceaad985, remote_addr: 127.0.0.1:40195, local_addr: 127.0.0.1:9998
Oct 22 21:44:20.918 INFO accepted connection, remote_addr: 127.0.0.1:42255, local_addr: 127.0.0.1:9998
Oct 22 21:44:20.919 INFO request completed, latency_us: 169, response_code: 200, uri: /state/cid/1, method: GET, req_id: 04c50c17-6364-4b81-8371-6428eae0cb77, remote_addr: 127.0.0.1:42255, local_addr: 127.0.0.1:9998
Oct 22 21:44:20.974 INFO accepted connection, remote_addr: 127.0.0.1:55983, local_addr: 127.0.0.1:9998
Oct 22 21:44:20.975 INFO request completed, latency_us: 163, response_code: 200, uri: /state/cid/2, method: GET, req_id: c23bade4-25f9-4e82-a69a-7743227d0714, remote_addr: 127.0.0.1:55983, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.030 INFO accepted connection, remote_addr: 127.0.0.1:47554, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.031 INFO request completed, latency_us: 179, response_code: 200, uri: /state/cid/3, method: GET, req_id: a431b23d-8015-4407-8140-58a0a0ee888b, remote_addr: 127.0.0.1:47554, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.087 INFO accepted connection, remote_addr: 127.0.0.1:55317, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.087 INFO request completed, latency_us: 160, response_code: 200, uri: /state/cid/4, method: GET, req_id: 3afa1249-cee0-4d86-8344-335e7a2d877a, remote_addr: 127.0.0.1:55317, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.143 INFO accepted connection, remote_addr: 127.0.0.1:47874, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.144 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/5, method: GET, req_id: d3cbd475-ad01-4074-99a6-e5b42a0af0fb, remote_addr: 127.0.0.1:47874, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.198 INFO accepted connection, remote_addr: 127.0.0.1:37916, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Oct 22 21:44:21.199 INFO request completed, latency_us: 206, response_code: 204, uri: /disablerestart/all, method: POST, req_id: ec24d91d-29be-430f-be82-822023eb1629, remote_addr: 127.[8810] Disable keep_running
0.0.1:37916, local_addr: 127.0.[8830] Disable keep_running
0[8820] Disable keep_running
.1:9998
[8860] Disable keep_running
[8850] Disable keep_running
[8840] Disable keep_running
Oct 22 21:44:21.324 INFO accepted connection, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.325 INFO request completed, latency_us: 316, response_code: 200, uri: /regioninfo, method: GET, req_id: e5d23e9f-17a2-4864-8185-4c22205fcc44, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.328 INFO request completed, latency_us: 114, response_code: 200, uri: /regioncount, method: GET, req_id: 7843a02a-c0f4-4988-b2f9-4d2bb65d436b, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.329 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/0, method: GET, req_id: a3912313-b9ec-4fd6-882e-fb13a5f6ddbb, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.330 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2e501575-f4bc-4db4-a465-c57095fbe76a, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.330 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4d84361d-ee4f-4b53-9e73-dd5222f1db7f, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.335 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/3, method: GET, req_id: a38f372f-62a2-4ff0-86d3-20b5fa774d00, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.336 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1315802f-f136-42db-9f2e-d4840b3bb59b, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:21.336 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/5, method: GET, req_id: 63dda5a5-136c-4eb4-acf9-605327da8d57, remote_addr: 127.0.0.1:48967, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.460 INFO accepted connection, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.461 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: 85d04297-f97d-4b6c-9575-22982ab9c30a, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.462 INFO request completed, latency_us: 109, response_code: 200, uri: /regioncount, method: GET, req_id: de18eadd-0ca0-4bbd-83ce-620421764fff, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.463 INFO request completed, latency_us: 140, response_code: 200, uri: /port/cid/0, method: GET, req_id: 20cfecf2-740e-431f-a7c9-cfccec7b7d40, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.464 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3e64fb88-888f-47cd-b251-f9ff9fdc3d12, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.464 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/2, method: GET, req_id: 0e432184-757b-4c39-8d75-d947eea3f580, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.466 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 562ac698-4449-42d7-be19-c7f85a5c40d0, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.467 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/4, method: GET, req_id: 19630ae3-efe5-409b-bbbf-2fff0a6fde17, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:30.467 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 39bb4e54-bdab-4887-aca8-6cc493dad788, remote_addr: 127.0.0.1:61819, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.050 INFO accepted connection, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.051 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: 8d11c1fe-9448-439a-b768-674a3bb0056b, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.052 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: c98a4bf8-74c6-48de-aa96-ffbfb04d41e0, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.052 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: affa717d-ea91-41ba-9c8d-111301e046e3, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.053 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2c12cbdb-bca7-42fc-8d83-0cb476bad85a, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.054 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9c42d85b-7838-4a1c-97a2-8193da74323e, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.056 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5d36f4ee-453d-44ce-87f6-3e45812230aa, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.056 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 223f9f2c-01a9-4561-9b43-7de78a1fba4a, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:44:40.057 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: d0282163-8526-48f3-bbe1-8df627040495, remote_addr: 127.0.0.1:64143, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.939 INFO accepted connection, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.939 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: 52e3c6d7-24fe-4941-b0e8-2843f691c574, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.940 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: 7b2a40b1-5e34-4595-a278-a2ce3812c785, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.941 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8d09fccb-a755-4212-876b-89aafcce0d8e, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.941 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 951b9d2a-340b-4921-84c9-44993ce9e441, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.942 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 12b6e4d9-c77a-4d2a-95c5-393ad7dbbb9a, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.944 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: a52748d4-a3a5-447c-882e-a57ddfb3a432, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.945 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/4, method: GET, req_id: b70c88e6-3612-4c2b-97cc-dd22aa1110da, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:45:18.945 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: d7f11d7a-72fd-4521-820b-426e933af6e6, remote_addr: 127.0.0.1:39164, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.396 INFO accepted connection, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.397 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: 4f925b7e-be6f-425c-b831-6f1812e6abbf, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.398 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: 5794410c-f24d-4544-b9e5-2d93313c6bf9, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.399 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2d054dcc-91fa-42ac-b87b-65a657857a82, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.400 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0671e2b4-bfa0-4c0d-9d12-47a60002d4b5, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.400 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: d2dfbc90-5b23-4fe2-b99c-95e3cbd82841, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.402 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: 90363c59-690c-4995-b4da-8abef79b5a01, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.403 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: bccf4d59-9cd4-42c5-9828-b208d700c3a5, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:49:39.403 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/5, method: GET, req_id: 57357963-e094-4f75-b5a8-8908ed74d245, remote_addr: 127.0.0.1:48070, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.171 INFO accepted connection, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.171 INFO request completed, latency_us: 172, response_code: 200, uri: /regioninfo, method: GET, req_id: a0478009-6855-4e60-a5db-86bbf9137952, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.172 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: c443e9e0-ee16-47a0-9703-59050de74643, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.173 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0609d7cd-9dd8-49bc-b18c-f41b47fc3e4e, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.174 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/1, method: GET, req_id: d2cdce7d-637a-4b31-868f-f1d710610f0c, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.174 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: c61a35b4-ae3e-48d6-8ff5-8dd09f37f075, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.177 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 683084d6-86ef-419b-99eb-e08ad3837664, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.177 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: 6df818f9-54e4-444b-86eb-8de736a20955, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:07.178 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: bf81dbf7-400a-4c4f-9327-5355bf1d5d53, remote_addr: 127.0.0.1:42083, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.385 INFO accepted connection, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.385 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: 849e5e98-bc7f-405d-9afd-c952e8717105, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.386 INFO request completed, latency_us: 81, response_code: 200, uri: /regioncount, method: GET, req_id: cbadfed9-4432-405c-84c4-340c1951ec4f, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.387 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8cefb366-a9d2-4021-9781-02d8b4bc4285, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.388 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 9aca8020-8898-4a3e-8dc4-d79963ccd969, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.388 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: cbf0a4e9-2741-4313-9ac6-ebf8ecfd9ab2, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.390 INFO request completed, latency_us: 126, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4c02a2c3-b69c-4c45-b88c-61b891fcc9ef, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.391 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 803c7dd1-2d29-4594-8277-c684bec72244, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:11.391 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/5, method: GET, req_id: dbf37d46-0340-429e-beaf-712b2b983041, remote_addr: 127.0.0.1:56954, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.581 INFO accepted connection, remote_addr: 127.0.0.1:36206, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Oct 22 21:50:15.582 INFO request completed, latency_us: [8810] Disable keep_running
178[8830] Disable keep_running
, response_code: 204, [8860] Disable keep_running
[8850] Disable keep_running
uri: /disablerestart/all, method: POST, req_id: [8820] Disable keep_running
0eb5ee9d-3adb-4f4f-8d27-a915dadf1ba0[8840] Disable keep_running
, remote_addr: 127.0.0.1:36206, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.639 INFO accepted connection, remote_addr: 127.0.0.1:55401, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Oct 22 21:50:15.640 INFO request completed, latency_us: 198, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 88f8c8d5-6871-4f38-a7e4-0e9da6a1bc37, remote_addr: 127.0.0.1:[8830] Got stop action so:false kr:false
55401, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Oct 22 21:50:15.697 INFO accepted connection, remote_addr: 127.0.0.1:52926, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.698 INFO request completed, latency_us: 173, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6eb891d0-ea21-414a-a42c-e9a7b979dad6, remote_addr: 127.0.0.1:52926, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.760 INFO accepted connection, remote_addr: 127.0.0.1:50037, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Oct 22 21:50:15.761 INFO request completed, latency_us: 176, response_code: 204, uri: /start/cid/2, method: POST, req_id: 7b2cd17b-8f19-451e-b5ce-94be3cb10522, remote_addr: 127.0.0.1:50037, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.851 INFO accepted connection, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.851 INFO request completed, latency_us: 161, response_code: 200, uri: /regioninfo, method: GET, req_id: 0a19c3d1-6af7-4448-9aa8-6947a6c4cd1c, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.853 INFO request completed, latency_us: 120, response_code: 200, uri: /regioncount, method: GET, req_id: 7d9cccf3-89f7-4858-81b7-fca743bfffc8, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.853 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: a520ac90-96ca-4737-9ce2-877ba9430b00, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.854 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6c5398aa-ecd6-4c43-af14-48efeabad611, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.854 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: fb244727-8375-4144-bc20-f73f4ac07281, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.856 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: ed5cd53a-2d6c-4876-a853-74dc5902bec4, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.857 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/4, method: GET, req_id: 95041c34-a0c6-4777-91c0-120b55775047, remote_addr: 127.0.0.1:45709, local_addr: 127.0.0.1:9998
Oct 22 21:50:15.858 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/5, method: GET, req_id: 313c08df-da76-4648-899d-afcadcbf2502, remote_addr: 127.0.0.1:45709, 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(1261)
[8830][2] reports Running
Oct 22 21:50:30.150 INFO accepted connection, remote_addr: 127.0.0.1:50627, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Oct 22 21:50:30.151 INFO request completed, latency_us: 163, response_code: 204, [8820] Disable keep_running
uri[8820] Got stop action so:false kr:false
: /shutdown, [8840] Disable keep_running
method[8840] Got stop action so:false kr:false
: [8850] Disable keep_running
POST[8850] Got stop action so:false kr:false
, req_id: f7a2ab47-f5f1-40ec-ba5a-0aa59d0dda95, remote_addr: 127.0.0.1:[8860] Disable keep_running
50627[8860] Got stop action so:false kr:false
, local_addr: 127.0.0.1:9998
[8810] Disable keep_running
[8810] 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))
[8830][2] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820][1] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --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.37870106
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.38058886
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.37719807
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.37994513
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.38158223
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.3899172
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.44113138
Created 7 regions
/var/tmp/bins/dsc start --region-count 7 --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
start ds: 8850
start ds: 8860
start ds: 8870
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
Starting downstairs at port 8850
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] initial start wait reports Starting
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8840][3] initial start wait reports Starting
[8860][5] initial start wait reports Starting
[8870][6] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1278)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1279)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1284)
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1280)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1282)
Control access at:127.0.0.1:9998
Oct 22 21:50:37.922 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1283)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1281)
[8850][4] initial start wait reports Running
[8820][1] initial start wait reports Running
[8830][2] initial start wait reports Running
[8870][6] initial start wait reports Running
[8860][5] initial start wait reports Running
[8810][0] initial start wait reports Running
[8840][3] initial start wait reports Running
All downstairs are running
Oct 22 21:50:42.967 INFO accepted connection, remote_addr: 127.0.0.1:38465, local_addr: 127.0.0.1:9998
Oct 22 21:50:42.968 INFO request completed, latency_us: 322, response_code: 200, uri: /state/cid/0, method: GET, req_id: 64e3c033-cec6-4bc7-9568-2c98dcf2263d, remote_addr: 127.0.0.1:38465, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.026 INFO accepted connection, remote_addr: 127.0.0.1:39766, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.026 INFO request completed, latency_us: 165, response_code: 200, uri: /state/cid/1, method: GET, req_id: 67d52b49-dbe6-4770-9427-875693efd409, remote_addr: 127.0.0.1:39766, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.084 INFO accepted connection, remote_addr: 127.0.0.1:58844, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.084 INFO request completed, latency_us: 183, response_code: 200, uri: /state/cid/2, method: GET, req_id: 8ee3a322-8798-42cf-ba06-a10bb547eb49, remote_addr: 127.0.0.1:58844, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.140 INFO accepted connection, remote_addr: 127.0.0.1:55362, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.141 INFO request completed, latency_us: 172, response_code: 200, uri: /state/cid/3, method: GET, req_id: f8a4a912-6ec5-40a0-8279-e9d5261bf2f1, remote_addr: 127.0.0.1:55362, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.197 INFO accepted connection, remote_addr: 127.0.0.1:63502, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.198 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/4, method: GET, req_id: 430ea200-b880-4b78-aaaf-2c50b3403c22, remote_addr: 127.0.0.1:63502, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.254 INFO accepted connection, remote_addr: 127.0.0.1:55762, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.255 INFO request completed, latency_us: 184, response_code: 200, uri: /state/cid/5, method: GET, req_id: 34554b6f-8757-4c00-884b-76f2713a4264, remote_addr: 127.0.0.1:55762, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.311 INFO accepted connection, remote_addr: 127.0.0.1:38131, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.312 INFO request completed, latency_us: 162, response_code: 200, uri: /state/cid/6, method: GET, req_id: 61b3511b-6fbb-4d7c-b448-97aa9ab677b1, remote_addr: 127.0.0.1:38131, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.369 INFO accepted connection, remote_addr: 127.0.0.1:45699, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.369 INFO request completed, latency_us: 201, response_code: 200, uri: /port/cid/6, method: GET, req_id: ad24f750-5e2b-41ee-9eb0-168f09271fd7, remote_addr: 127.0.0.1:45699, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.432 INFO accepted connection, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.433 INFO request completed, latency_us: 196, response_code: 200, uri: /regioninfo, method: GET, req_id: 070a7cfe-f4cb-4920-8858-411fe2700846, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.434 INFO request completed, latency_us: 119, response_code: 200, uri: /regioncount, method: GET, req_id: 35edfba0-5d3b-4d27-a031-9778b58ea560, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.435 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3175f095-8d2d-46b2-bb75-b924586c374b, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.435 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 591ad350-e99e-4da8-add9-ecc7272b3f42, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.436 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: c90866b6-f556-46eb-8bdd-561ea3aabf79, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.438 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: d316a975-b408-402f-93ac-5fe9fc8a9399, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.439 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1beddb76-5f7a-4615-abf6-5138e699d791, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.439 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: a621f48c-3220-4c08-b20c-c6457cca7921, remote_addr: 127.0.0.1:43676, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.483 INFO accepted connection, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:50:43.484 INFO request completed, latency_us: 134, response_code: 200, uri: /regioncount, method: GET, req_id: 2f2af41f-1815-4559-b2a8-086f88710ff3, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Oct 22 21:50:44.226 INFO request completed, latency_us: 341[8810] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 0ca2fd43-736b-4899-8fd4-9ffb0db92ea0, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:50:44.227 INFO request completed, latency_us: 128, response_code: 200, uri: /state/cid/0, method: GET, req_id: dd0b2d88-8738-408f-bf6d-9dbfb71baf65, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 22 21:50:48.228 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/0, method: GET, req_id: 436923d7-3aa2-4ada-a86b-852025a8f37a, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 22 21:50:48.954 INFO request completed, latency_us: 230, response_code: 204, uri: /start/cid/0, method: POST, req_id: 9569aaec-3c72-4d0a-bee4-72f33573adf8, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:50:48.954 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/0, method: GET, req_id: a6e0bb1a-987f-4288-a368-5930bdc49678, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:50:52.956 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/0, method: GET, req_id: ca852188-f4c5-40eb-9b1a-540d4a0247f8, remote_addr: 127.0.0.1:55948, 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(1295)
[8810][0] reports Running
Oct 22 21:50:56.959 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0dd6ae0d-c113-4963-92c8-9dab9f7c436f, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Oct 22 21:51:03.707 INFO request completed, [8810] Got stop action so:false kr:false
latency_us: 249, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 77a13e95-023f-4356-9a14-3bfebe61f16d, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:51:03.708 INFO request completed, latency_us: 171, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4f114e2b-5102-4208-a16f-d8b50416b64a, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 22 21:51:07.718 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8f65f24d-9e57-4b47-ab17-1c7c9d485c1f, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
Oct 22 21:51:08.448start 0
 INFO request completed, latency_us: 210, response_code: 204, uri: /start/cid/0, method: POST, req_id: 86a14ef2-0298-427e-b45c-efb475fbe690, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:51:08.449 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/0, method: GET, req_id: 87695905-5cd5-42ea-a7e2-a636d7bb073e, remote_addr: 127.0.0.1:55948, 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(1296)
[8810][0] reports Running
Oct 22 21:51:12.451 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7da49275-da8d-40d5-b6ee-366d62d1b1e9, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Oct 22 21:51:18.200 INFO request completed, latency_us: 302, response_code: [8810] Got stop action so:false kr:false
204, uri: /stop/cid/0, method: POST, req_id: 809dc3ad-7e49-43e0-ba86-7845529ffb56, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:51:18.201 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/0, method: GET, req_id: 556ab4f2-e32e-446a-b412-f86408f42cfd, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 22 21:51:22.203 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4e1d8144-2a75-444f-86fc-a36bfc0c4132, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 22 21:51:22.940 INFO request completed, latency_us: 216, response_code: 204, uri: /start/cid/0, method: POST, req_id: 1c5379e6-77cb-4a59-bf64-cb1e9c9b0a59, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:51:22.941 INFO request completed, latency_us: 127, response_code: 200, uri: /state/cid/0, method: GET, req_id: f8f5b0a8-664a-480f-a241-81f2b0ba36f0, remote_addr: 127.0.0.1:55948, 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(1297)
[8810][0] reports Running
Oct 22 21:51:26.943 INFO request completed, latency_us: 205, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3dccfb3a-213f-47d7-9c5f-388ff6f41cf2, remote_addr: 127.0.0.1:55948, local_addr: 127.0.0.1:9998
Oct 22 21:51:59.561 INFO accepted connection, remote_addr: 127.0.0.1:46358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Oct 22 21:51:59.561 INFO request completed, latency_us: 180, response_code: 204, uri: /stop/cid/1, method: POST, req_id[8820] Got stop action so:false kr:false
: ff18414a-636f-4f59-b8b0-db8548231dd7, remote_addr: 127.0.0.1:46358, local_addr: 127.0.0.1:9998
Oct 22 21:51:59.562 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/1, method: GET, req_id: a4098973-64e0-47a9-915d-0b1d21d4fb43, remote_addr: 127.0.0.1:46358, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Oct 22 21:52:03.564 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/1, method: GET, req_id: 085274fd-7964-4711-bb90-03e5a072ed85, remote_addr: 127.0.0.1:46358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Oct 22 21:52:04.300 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/1, method: POST, req_id: 7e66c5d2-09c1-4baa-a346-77d3878996ea, remote_addr: 127.0.0.1:46358, local_addr: 127.0.0.1:9998
Oct 22 21:52:04.301 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/1, method: GET, req_id: 114fbdec-c9b8-4f8a-a593-51020b583542, remote_addr: 127.0.0.1:46358, 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(1298)
[8820][1] reports Running
Oct 22 21:52:08.303 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4e4f9514-711d-4d46-869b-df44f6dbeb7e, remote_addr: 127.0.0.1:46358, local_addr: 127.0.0.1:9998
Oct 22 21:52:41.479 INFO accepted connection, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Oct 22 21:52:41.480 INFO request completed, latency_us: 179, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 1e2a25fd-62a4-4514-84f6-c1c2503d9e75, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
Oct 22 21:52:41.481 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9209535a-d1fb-41dc-a416-e7f2421fa52d, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Oct 22 21:52:45.483 INFO request completed, latency_us: 230, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0634d52a-3652-4632-94ae-d4a75d7b0069, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Oct 22 21:52:46.231 INFO request completed, latency_us: 212, response_code: 204, uri: /start/cid/2, method: POST, req_id: 8bc62ce9-74d9-421f-91a8-1051c76cffe0, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Oct 22 21:52:46.232 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/2, method: GET, req_id: bdbaa26d-99ed-4bf5-a1fc-3b1276f66af4, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Oct 22 21:52:50.234 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/2, method: GET, req_id: a4c26164-fcfb-4831-8cf8-aa777adc63da, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Oct 22 21:52:54.236 INFO request completed, latency_us: 225, response_code: 200, uri: /state/cid/2, method: GET, req_id: ee368795-a826-4e85-8f15-600fac424d47, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Oct 22 21:52:58.238 INFO request completed, latency_us: 268, response_code: 200, uri: /state/cid/2, method: GET, req_id: 90ac862c-1cd2-45c3-882a-ecea17bee57c, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Oct 22 21:53:02.240 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4841faa1-2f51-4e9a-b3bd-f5c75fba34f6, remote_addr: 127.0.0.1:46115, 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(1299)
[8830][2] reports Running
Oct 22 21:53:06.243 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/2, method: GET, req_id: e6f7a644-c9ad-415d-ad65-aa8305337bf4, remote_addr: 127.0.0.1:46115, local_addr: 127.0.0.1:9998
Oct 22 21:53:40.070 INFO accepted connection, remote_addr: 127.0.0.1:51163, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Oct 22 21:53:40.070 INFO request completed, latency_us: 185, [8840] Got stop action so:false kr:false
response_code: 204, uri: /stop/cid/3, method: POST, req_id: f4cc3143-5a15-4322-b48e-f2b997983068, remote_addr: 127.0.0.1:51163, local_addr: 127.0.0.1:9998
Oct 22 21:53:40.071 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/3, method: GET, req_id: 62734784-5144-4ef6-9e1f-21be717d154b, remote_addr: 127.0.0.1:51163, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Oct 22 21:53:44.072 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/3, method: GET, req_id: d34eef3e-bafa-4dd5-b308-61fab8378973, remote_addr: 127.0.0.1:51163, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Oct 22 21:53:44.830 INFO request completed, latency_us: 212, response_code: 204, uri: /start/cid/3, method: POST, req_id: 6c0a48fe-3a16-4192-a99d-c7c6dd93bee0, remote_addr: 127.0.0.1:51163, local_addr: 127.0.0.1:9998
Oct 22 21:53:44.831 INFO request completed, latency_us: 128, response_code: 200, uri: /state/cid/3, method: GET, req_id: 40b4231f-a6d9-4ad6-bd52-91983c0fef63, remote_addr: 127.0.0.1:51163, 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(1300)
[8840][3] reports Running
Oct 22 21:53:48.833 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/3, method: GET, req_id: 9a4d3030-a752-4aba-9316-6c9f217a968a, remote_addr: 127.0.0.1:51163, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.660 INFO accepted connection, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.660 INFO request completed, latency_us: 156, response_code: 200, uri: /regioninfo, method: GET, req_id: f0e2ba18-102a-4ff1-a52e-206a500197ce, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.662 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 22463fc5-3373-4db1-953c-bb2f5a2f8877, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.662 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8418f02d-53e4-4df3-88cc-6bfa6febc6b2, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.663 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: df96a5e6-5149-4863-b039-9266f0bf7d3b, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.663 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: e7a93e05-9bd6-46a1-ad1a-0448a3db8c5c, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.665 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/3, method: GET, req_id: bf48a9c6-6f13-472e-b6f0-80a20f5858d7, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.666 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/4, method: GET, req_id: cfc4c2dc-911b-4899-b707-9e946e8572de, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:22.667 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: a1eee2af-1678-4222-a22b-4086842e6050, remote_addr: 127.0.0.1:60801, local_addr: 127.0.0.1:9998
Oct 22 21:54:23.168 INFO accepted connection, remote_addr: 127.0.0.1:37005, local_addr: 127.0.0.1:9998
Oct 22 21:54:23.168 INFO request completed, latency_us: 150, response_code: 200, uri: /regioncount, method: GET, req_id: 91ddca60-c108-4411-b66a-2d30b3a5a84f, remote_addr: 127.0.0.1:37005, 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
Oct 22 21:54:38.624 INFO request completed, latency_us: 211, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 941e82aa-0d87-42cd-a716-f19b2444818c, remote_addr: 127.0.0.1:37005, local_addr: 127.0.0.1:9998
Oct 22 21:54:38.625 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/0, method: GET, req_id: a40c90e4-f68b-4d77-bc28-03bd5d96cb61, remote_addr: 127.0.0.1:37005, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 22 21:54:42.627 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/0, method: GET, req_id: b16feba8-d79a-4336-b747-3d846eb532b5, remote_addr: 127.0.0.1:37005, local_addr: 127.0.0.1:9998
Oct 22 21:55:43.995 INFO accepted connection, remote_addr: 127.0.0.1:51828, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 22 21:55:43.996 INFO request completed, latency_us: 189, response_code: 204, uri: /start/cid/0, method: POST, req_id: 24ba4696-1fc7-4055-8500-a7082f0f0088, remote_addr: 127.0.0.1:51828, 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(1302)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Oct 22 21:55:48.752 INFO request completed, latency_us: 218, [8820] Got stop action so:false kr:false
response_code: 204, uri: /stop/cid/1, method: POST, req_id: 55c90e2c-aa2a-412d-a0d2-76b14061615e, remote_addr: 127.0.0.1:51828, local_addr: 127.0.0.1:9998
Oct 22 21:55:48.753 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/1, method: GET, req_id: b475c367-bd52-4402-8173-52a997fce86f, remote_addr: 127.0.0.1:51828, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Oct 22 21:55:52.755 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8dc8ce04-f457-401a-ab72-81ccd35223a4, remote_addr: 127.0.0.1:51828, local_addr: 127.0.0.1:9998
Oct 22 21:56:54.058 INFO accepted connection, remote_addr: 127.0.0.1:41398, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Oct 22 21:56:54.059 INFO request completed, latency_us: 209, response_code: 204, uri: /start/cid/1, method: POST, req_id: f4021304-b11b-4bc5-b3ec-f3c44977b3a9, remote_addr: 127.0.0.1:41398, 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(1303)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Oct 22 21:56:58.820 INFO request completed, latency_us:[8830] Got stop action so:false kr:false
 219, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 0a3d5a5c-94c9-435b-9916-23e6ea4b07af, remote_addr: 127.0.0.1:41398, local_addr: 127.0.0.1:9998
Oct 22 21:56:58.821 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4a5c6fe0-c061-45e0-a83b-d6c8a58fa7d0, remote_addr: 127.0.0.1:41398, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Oct 22 21:57:02.823 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/2, method: GET, req_id: c32b778c-15f8-41a4-90af-25d33942edfc, remote_addr: 127.0.0.1:41398, local_addr: 127.0.0.1:9998
Oct 22 21:58:04.089 INFO accepted connection, remote_addr: 127.0.0.1:36246, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Oct 22 21:58:04.089 INFO request completed, latency_us: 203, response_code: 204, uri: /start/cid/2, method: POST, req_id: 76e0fab7-6966-4b4d-9de4-4259bfa7b900, remote_addr: 127.0.0.1:36246, 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(1304)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Oct 22 21:58:08.911 INFO request completed, latency_us: 225, response_code: 204[8840] Got stop action so:false kr:false
, uri: /stop/cid/3, method: POST, req_id: de1edfb1-0d7c-4445-af9d-0e6653ef0b25, remote_addr: 127.0.0.1:36246, local_addr: 127.0.0.1:9998
Oct 22 21:58:08.912 INFO request completed, latency_us: 193, response_code: 200, uri: /state/cid/3, method: GET, req_id: a7f77171-2dd1-45fc-86e3-cb5eb19c7250, remote_addr: 127.0.0.1:36246, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Oct 22 21:58:12.915 INFO request completed, latency_us: 240, response_code: 200, uri: /state/cid/3, method: GET, req_id: 153d095f-67e7-4ff8-9911-ea6880a3b72e, remote_addr: 127.0.0.1:36246, local_addr: 127.0.0.1:9998
Oct 22 21:59:14.246 INFO accepted connection, remote_addr: 127.0.0.1:64455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Oct 22 21:59:14.247 INFO request completed, latency_us: 207, response_code: 204, uri: /start/cid/3, method: POST, req_id: 2c6af61b-7d63-4bd2-899e-7fd7b7f8627c, remote_addr: 127.0.0.1:64455, 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(1305)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Oct 22 21:59:19.344 INFO request completed, latency_us: 210, response_code: 204, uri[8850] Got stop action so:false kr:false
: /stop/cid/4, method: POST, req_id: 9d712a3a-3f60-4c10-924e-f700e4ee5dac, remote_addr: 127.0.0.1:64455, local_addr: 127.0.0.1:9998
Oct 22 21:59:19.345 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/4, method: GET, req_id: 40facaa6-cb72-4784-af89-5060890470f8, remote_addr: 127.0.0.1:64455, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Oct 22 21:59:23.347 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/4, method: GET, req_id: a69d4adc-d9c6-45d5-ac9b-6359763ef30d, remote_addr: 127.0.0.1:64455, local_addr: 127.0.0.1:9998
Oct 22 22:00:24.671 INFO accepted connection, remote_addr: 127.0.0.1:61213, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Oct 22 22:00:24.671 INFO request completed, latency_us: 208, response_code: 204, uri: /start/cid/4, method: POST, req_id: 3b361b09-9167-4944-bf76-4d57c9365100, remote_addr: 127.0.0.1:61213, local_addr: 127.0.0.1:9998
[8850] got start action
[8850] I am going to restart
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] reports Starting
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1306)
[8850][4] reports Running
Oct 22 22:00:28.764 INFO accepted connection, remote_addr: 127.0.0.1:55730, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Oct 22 22:00:28.764 INFO request completed, latency_us: 173, response_code: 204, uri: [8810] Disable keep_running
/shutdown, [8820] Disable keep_running
method[8820] Got stop action so:false kr:false
: POST, [8840] Disable keep_running
req_id[8810] Got stop action so:false kr:false
:[8850] Disable keep_running
 2844a7e8-9186-458b-94a0-502607eb7ef0[8850] Got stop action so:false kr:false
, remote_addr:[8830] Disable keep_running
 [8830] Got stop action so:false kr:false
127.0.0.1:55730, local_addr: 127.0.0.1:9998
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
[8840] Got stop action so:false kr:false
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] 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
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit