/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.26475084
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.0200052
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.019681985
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.020928739
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.017833998
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.02145296
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 ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start access at:127.0.0.1:9998
Starting downstairs at port 8820
Starting downstairs at port 8810
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8820][1] initial start wait reports Starting
[8810][0] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8840][3] initial start wait reports Starting
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1197)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1198)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1199)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1200)
[8830][2] initial start wait reports Running
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1201)
[8820][1] initial start wait reports Running
Mar 18 04:59:01.241 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1202)
[8840][3] initial start wait reports Running
All downstairs are running
Mar 18 04:59:06.275 INFO accepted connection, remote_addr: 127.0.0.1:60556, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.277 INFO request completed, latency_us: 581, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6e4b1aa1-7e57-4ee0-85af-1bfbc366bba5, remote_addr: 127.0.0.1:60556, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.330 INFO accepted connection, remote_addr: 127.0.0.1:55445, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.331 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6752626e-2098-48d9-b560-754eed432bb4, remote_addr: 127.0.0.1:55445, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.383 INFO accepted connection, remote_addr: 127.0.0.1:42183, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.384 INFO request completed, latency_us: 179, response_code: 200, uri: /state/cid/2, method: GET, req_id: dba53a3f-7c5d-4ebc-b20e-db13df1f273b, remote_addr: 127.0.0.1:42183, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.444 INFO accepted connection, remote_addr: 127.0.0.1:39137, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.444 INFO request completed, latency_us: 171, response_code: 200, uri: /state/cid/3, method: GET, req_id: 9515bc43-48eb-4221-a601-635bdcbfeeda, remote_addr: 127.0.0.1:39137, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.502 INFO accepted connection, remote_addr: 127.0.0.1:52427, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.503 INFO request completed, latency_us: 163, response_code: 200, uri: /state/cid/4, method: GET, req_id: 8ae51ce6-c496-45b5-a20b-499454da6d46, remote_addr: 127.0.0.1:52427, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.560 INFO accepted connection, remote_addr: 127.0.0.1:54559, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.560 INFO request completed, latency_us: 193, response_code: 200, uri: /state/cid/5, method: GET, req_id: 6d688929-483a-4506-9ae1-5a2a4bf9b3c3, remote_addr: 127.0.0.1:54559, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.616 INFO accepted connection, remote_addr: 127.0.0.1:51571, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Mar 18 04:59:06.616 INFO request completed, latency_us: 203, response_code: 204, uri: /disablerestart/all, [8810] Disable keep_running
method[8820] Disable keep_running
[8830] Disable keep_running
: POST, req_id: 913d936e-32cf-4467-ae32-c06fe9ce744a, remote_addr:[8840] Disable keep_running
 127.0.[8850] Disable keep_running
0.1:51571[8860] Disable keep_running
, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.701 INFO accepted connection, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.702 INFO request completed, latency_us: 234, response_code: 200, uri: /regioninfo, method: GET, req_id: b02dca91-d89f-44a8-bfc2-e59c948a277a, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.704 INFO request completed, latency_us: 144, response_code: 200, uri: /regioncount, method: GET, req_id: 284a658f-c121-4b79-8c72-2e626e23eefe, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.705 INFO request completed, latency_us: 144, response_code: 200, uri: /port/cid/0, method: GET, req_id: 282e05f2-e72f-49cb-8830-413bb975c446, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.705 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/1, method: GET, req_id: ff83183e-34b9-4683-b38b-11a6fedbb3a1, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.706 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2cb196ed-ea95-4ab8-84f8-8870e296f432, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.709 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8afcb0cf-a059-4cc8-a97d-61301526a31c, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.709 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: ca2f55bc-05a8-4ee3-9c36-62fac5fb1a82, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:06.710 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1c2a7367-b58f-4009-bc9a-60c35ca2d973, remote_addr: 127.0.0.1:33102, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.825 INFO accepted connection, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.826 INFO request completed, latency_us: 144, response_code: 200, uri: /regioninfo, method: GET, req_id: 820b543b-fc68-48fe-9b6c-7201d5227443, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.827 INFO request completed, latency_us: 102, response_code: 200, uri: /regioncount, method: GET, req_id: 265721b0-1051-4b82-9b96-0095509208dd, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.828 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3c602bf9-583c-4f66-8cb1-812f6c13fc5c, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.828 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3f94454f-7151-4595-963d-a48d81954aba, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.829 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 06f3e918-f40b-4d76-a88e-a3a2e48e7a14, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.831 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4874cbfb-6a84-4713-b605-e920e5bc8ca6, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.831 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: e5f0fa62-4d33-436c-a45d-7493a80e8a8f, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:15.832 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4ed4de7e-9c8e-41db-bc5e-8d0789009988, remote_addr: 127.0.0.1:37148, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.427 INFO accepted connection, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.428 INFO request completed, latency_us: 160, response_code: 200, uri: /regioninfo, method: GET, req_id: 90fc86c3-a240-4a4d-948b-4840501d443b, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.428 INFO request completed, latency_us: 95, response_code: 200, uri: /regioncount, method: GET, req_id: 942b2ef0-d892-4758-98dc-ef92651c2933, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.429 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/0, method: GET, req_id: b436246b-b027-43e9-9a5e-a08bcf6974e8, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.430 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: edb92271-521e-42b0-8c84-804ce89bd5fa, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.430 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/2, method: GET, req_id: 64e2a44e-eb89-4ce2-9d3f-c440847a93f5, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.432 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/3, method: GET, req_id: 2049d0b9-89a8-4751-8f3f-d1c4e1efc76b, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.433 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 82250a2c-7f18-4140-8dd7-4b05c4c6a187, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 04:59:25.433 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: e4f84fa5-295e-4115-932a-9448ee07095d, remote_addr: 127.0.0.1:64761, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.265 INFO accepted connection, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.266 INFO request completed, latency_us: 163, response_code: 200, uri: /regioninfo, method: GET, req_id: 1bc9f75e-fc26-45a2-bb3e-7eb3753aef2e, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.267 INFO request completed, latency_us: 107, response_code: 200, uri: /regioncount, method: GET, req_id: fadc29dc-2b1b-40f6-bc5f-e483ca477ab3, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.268 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4b97cb3a-bc66-4563-bc4b-bea0762fea8b, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.268 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: c91290c0-b50d-42cb-82af-995c6af13fef, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.269 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 59b157a2-5bf8-4934-98da-de6aeb52abe3, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.271 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7e963015-cfd7-4777-8bc6-d00a196dc4f0, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.272 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/4, method: GET, req_id: bb81741f-e9d6-4994-902a-1e3139399ea8, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:00:04.272 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: cedee583-2bb3-43a8-b99f-160baf14d6b8, remote_addr: 127.0.0.1:63591, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.763 INFO accepted connection, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.764 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: 2b5c14d3-9255-43ac-900f-ad7208b9f37a, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.765 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 78158638-2515-4af7-a61e-8287607b49a2, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.766 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0594864d-2c59-48ad-b3d6-adbeecc9eb10, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.766 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/1, method: GET, req_id: ba71427d-e339-4cd3-8f58-586cb461bcd4, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.767 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4e7486ba-b107-4a09-84be-a0a12e33c789, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.769 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: be565c14-167c-41f8-a48e-819d8ee0c23c, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.769 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: d29cca5a-86b0-4cb2-bdc2-25b245718be2, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:04:22.770 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/5, method: GET, req_id: a0691b2a-226a-44e4-acc8-0eb12227a075, remote_addr: 127.0.0.1:59604, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.283 INFO accepted connection, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.284 INFO request completed, latency_us: 159, response_code: 200, uri: /regioninfo, method: GET, req_id: 5dfb3753-b863-45c3-b6ab-d6969778e748, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.285 INFO request completed, latency_us: 110, response_code: 200, uri: /regioncount, method: GET, req_id: 038b7a50-3fce-43fe-a9d4-a688e384daa3, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.285 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: b6910c32-cffa-47bf-b54b-cbe4ab526217, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.286 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6f6ca6d2-4ddf-40a9-b8ed-ac0243a9fc3e, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.287 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 50227aba-4a9b-4e8d-8297-097df9056864, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.289 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4636b041-2074-4bb9-bea2-465b17d8ab39, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.289 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/4, method: GET, req_id: e006260b-9066-444c-ad6b-db85f6f717f8, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:40.290 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/5, method: GET, req_id: dbd88b48-c962-4a66-a082-af4e4be81a12, remote_addr: 127.0.0.1:54630, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.494 INFO accepted connection, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.495 INFO request completed, latency_us: 162, response_code: 200, uri: /regioninfo, method: GET, req_id: f0bb85dc-4e5b-4562-a3c2-32fa61b85b4e, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.495 INFO request completed, latency_us: 85, response_code: 200, uri: /regioncount, method: GET, req_id: 3d8c6ba7-354f-4b4d-bf89-aeb283c41faf, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.496 INFO request completed, latency_us: 130, response_code: 200, uri: /port/cid/0, method: GET, req_id: 20699134-290e-4491-9406-d4428ae35ad7, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.497 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 610c7dc0-f32d-4f7c-a78b-90cdf801cb18, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.497 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4bd47cca-f8da-4629-9cee-860f0368b0c5, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.499 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7e074c04-f4e8-4f7b-bdc9-6d01b85c1452, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.500 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/4, method: GET, req_id: 783b303b-def8-47fe-9932-6cb9a53c8750, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:44.500 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 0195d3bb-4439-48e3-a195-72175da33386, remote_addr: 127.0.0.1:40572, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.686 INFO accepted connection, remote_addr: 127.0.0.1:36315, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Mar 18 05:05:48.687 INFO request completed, latency_us: 175, response_code: 204, uri[8810] Disable keep_running
: /disablerestart/all, method: POST, req_id: [8820] Disable keep_running
2e63593e-c0a2-4c0f-a8b3-ed9dd21da7c3[8830] Disable keep_running
, [8840] Disable keep_running
remote_addr[8850] Disable keep_running
: 127[8860] Disable keep_running
.0.0.1:36315, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.740 INFO accepted connection, remote_addr: 127.0.0.1:49043, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 05:05:48.741 INFO request completed, latency_us: 146, response_code:[8830] Got stop action so:false kr:false
 204, uri: /stop/cid/2, method: POST, req_id: 9e21bac6-9f5f-42d4-aab3-639ed36abc8a, remote_addr: 127.0.0.1:49043, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 05:05:48.795 INFO accepted connection, remote_addr: 127.0.0.1:61630, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.796 INFO request completed, latency_us: 147, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1befa242-5b33-49a9-94f9-e6a5e49a58ea, remote_addr: 127.0.0.1:61630, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.853 INFO accepted connection, remote_addr: 127.0.0.1:45445, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 05:05:48.854 INFO request completed, latency_us: 170, response_code: 204, uri: /start/cid/2, method: POST, req_id: f4f540f1-9f72-4709-9524-d3a6a355cf36, remote_addr: 127.0.0.1:45445, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.935 INFO accepted connection, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.936 INFO request completed, latency_us: 162, response_code: 200, uri: /regioninfo, method: GET, req_id: aa62c0f0-3b87-4d1d-87be-bd1ef50fcdc9, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.937 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: 8be57a76-3113-4643-a2d7-5b04bea20ea3, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.938 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 49ac04e2-c69e-4eba-95d7-64369706370b, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.938 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/1, method: GET, req_id: 1de24495-6bea-48c1-8f61-de45047ed67b, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.939 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: be5ca7bd-f544-40bb-b2a1-850ab8dcba2f, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.941 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/3, method: GET, req_id: 1fd4630d-981b-4db6-9efb-60fa297ad4c4, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.941 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 79003dd8-41e2-4b1b-b900-9a6ad3f77fac, remote_addr: 127.0.0.1:33116, local_addr: 127.0.0.1:9998
Mar 18 05:05:48.942 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 924aeaf9-e2af-4224-87ff-a7bfff96df87, remote_addr: 127.0.0.1:33116, 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(1253)
[8830][2] reports Running
Mar 18 05:06:03.188 INFO accepted connection, remote_addr: 127.0.0.1:48628, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Mar 18 05:06:03.189 INFO request completed, latency_us: 205, response_code: 204, uri: /shutdown, method: POST, req_id: 1c3c51e0-bb16-4ed9-a805-9f26bbf75664, remote_addr: 127.0.0.1:48628, local_addr: 127.0.0.1:9998
[8810] Disable keep_running
[8810] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8850] Disable keep_running
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8850] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --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.027939169
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.024687376
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.024165312
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.023932347
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.024414005
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.023942728
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.023792304
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: 100 })
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-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8830
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8840][3] initial start wait reports Starting
Starting downstairs at port 8850
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8860][5] initial start wait reports Starting
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8870][6] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1270)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1271)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1272)
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1273)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1274)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1275)
[8840][3] initial start wait reports Running
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1276)
[8810][0] initial start wait reports Running
All downstairs are running
Mar 18 05:06:08.427 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Mar 18 05:06:13.448 INFO accepted connection, remote_addr: 127.0.0.1:39521, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.449 INFO request completed, latency_us: 317, response_code: 200, uri: /state/cid/0, method: GET, req_id: 938697e2-8860-4f94-b312-f7769621ffea, remote_addr: 127.0.0.1:39521, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.503 INFO accepted connection, remote_addr: 127.0.0.1:32785, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.504 INFO request completed, latency_us: 162, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4d9a87dc-7217-492c-bfd4-f5e260bf72f0, remote_addr: 127.0.0.1:32785, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.558 INFO accepted connection, remote_addr: 127.0.0.1:65513, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.558 INFO request completed, latency_us: 143, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6417d65e-b41f-4a7b-a512-0971839981ef, remote_addr: 127.0.0.1:65513, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.611 INFO accepted connection, remote_addr: 127.0.0.1:61848, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.612 INFO request completed, latency_us: 114, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8fec5ed8-fe97-440c-900d-20b127282a3e, remote_addr: 127.0.0.1:61848, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.664 INFO accepted connection, remote_addr: 127.0.0.1:50568, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.665 INFO request completed, latency_us: 128, response_code: 200, uri: /state/cid/4, method: GET, req_id: 35bb8d59-4685-485e-914e-77bffa75f069, remote_addr: 127.0.0.1:50568, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.717 INFO accepted connection, remote_addr: 127.0.0.1:50496, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.718 INFO request completed, latency_us: 134, response_code: 200, uri: /state/cid/5, method: GET, req_id: 15b59169-accb-4cc5-b886-b57a54179925, remote_addr: 127.0.0.1:50496, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.770 INFO accepted connection, remote_addr: 127.0.0.1:39757, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.771 INFO request completed, latency_us: 126, response_code: 200, uri: /state/cid/6, method: GET, req_id: c937dc76-79a4-40cf-9429-ac585f51ff82, remote_addr: 127.0.0.1:39757, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.824 INFO accepted connection, remote_addr: 127.0.0.1:35542, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.825 INFO request completed, latency_us: 146, response_code: 200, uri: /port/cid/6, method: GET, req_id: bc92099d-2ae8-4ba1-aedc-4608681f2ab5, remote_addr: 127.0.0.1:35542, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.885 INFO accepted connection, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.885 INFO request completed, latency_us: 191, response_code: 200, uri: /regioninfo, method: GET, req_id: 5f452f73-1688-413b-9a0f-285231756279, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.887 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: 284112a5-2e73-4d03-a0bd-f8c79dd86127, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.887 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 66da1d5b-fd04-4a9f-89d0-6a2bd04d8d4e, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.888 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 94a9bbe9-edb5-4f89-8c1b-338327679a15, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.888 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/2, method: GET, req_id: 33accfe7-f5cc-4b9d-9ff6-aa65d43cbe25, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.890 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: e2c19fd1-1568-4c4b-b7d7-65400d361bc0, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.891 INFO request completed, latency_us: 148, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2baae930-c1f0-4e59-9f30-6b46c60cbe6f, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.891 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3d659046-ee35-4990-bddf-b4b9984e592d, remote_addr: 127.0.0.1:58567, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.930 INFO accepted connection, remote_addr: 127.0.0.1:54470, local_addr: 127.0.0.1:9998
Mar 18 05:06:13.931 INFO request completed, latency_us: 106, response_code: 200, uri: /regioncount, method: GET, req_id: 16635292-2a22-4b30-ad72-5729241a6ef2, remote_addr: 127.0.0.1:54470, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Mar 18 05:06:14.112 INFO request completed, latency_us: 237, response_code: 204, uri: /stop/cid/0, method: POST, req_id: b81f0fba-1341-4273-80b2-1d85bd03948b, remote_addr: 127.0.0.[8810] Got stop action so:false kr:false
1:54470, local_addr: 127.0.0.1:9998
Mar 18 05:06:14.112 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4c45aa1a-cef6-4353-acf3-c88d1cef28ce, remote_addr: 127.0.0.1:54470, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Mar 18 05:06:18.115 INFO request completed, latency_us: 276, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7338beab-dfad-4cd5-8997-5937f32c525f, remote_addr: 127.0.0.1:54470, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Mar 18 05:06:18.294 INFO request completed, latency_us: 220, response_code: 204, uri: /start/cid/0, method: POST, req_id: 23176e2b-6322-4ac2-ab72-576aaf404909, remote_addr: 127.0.0.1:54470, local_addr: 127.0.0.1:9998
Mar 18 05:06:18.295 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9b709b43-e4af-44f9-b96d-973be2743ea3, remote_addr: 127.0.0.1:54470, 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(1287)
[8810][0] reports Running
Mar 18 05:06:22.297 INFO request completed, latency_us: 323, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5fb5c6a5-6628-499f-867f-15f85b88daee, remote_addr: 127.0.0.1:54470, local_addr: 127.0.0.1:9998
Mar 18 05:06:53.159 INFO accepted connection, remote_addr: 127.0.0.1:34365, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Mar 18 05:06:53.159 INFO request completed, latency_us: 177, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 52753dfc-7dbd-4f32-959f-cb99b6e73761, remote_addr: 127.0.0.1:34365, local_addr[8820] Got stop action so:false kr:false
: 127.0.0.1:9998
Mar 18 05:06:53.160 INFO request completed, latency_us: 159, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3705b9df-fed6-4fbc-a8f9-7ba49ac3d591, remote_addr: 127.0.0.1:34365, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Mar 18 05:06:57.162 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/1, method: GET, req_id: 85138e74-7dbf-44c4-a3e6-a0e6612bfd55, remote_addr: 127.0.0.1:34365, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Mar 18 05:06:57.339 INFO request completed, latency_us: 260, response_code: 204, uri: /start/cid/1, method: POST, req_id: a4cf9ab2-c1d6-4fa3-ad9a-1689162e30ae, remote_addr: 127.0.0.1:34365, local_addr: 127.0.0.1:9998
Mar 18 05:06:57.340 INFO request completed, latency_us: 120, response_code: 200, uri: /state/cid/1, method: GET, req_id: bdd07b46-8fb1-4ae6-859d-57b81eb11a39, remote_addr: 127.0.0.1:34365, 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(1288)
[8820][1] reports Running
Mar 18 05:07:01.342 INFO request completed, latency_us: 342, response_code: 200, uri: /state/cid/1, method: GET, req_id: 24d809e9-9a69-4341-80a8-62df3fb8c535, remote_addr: 127.0.0.1:34365, local_addr: 127.0.0.1:9998
Mar 18 05:07:32.395 INFO accepted connection, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 05:07:32.396 INFO request completed, latency_us: 252, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 8f802b3b-96eb-4022-8f3f-46e9f280bf2a, remote_addr[8830] Got stop action so:false kr:false
: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:07:32.397 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/2, method: GET, req_id: a3b2970d-bcb1-441e-ae21-c50df5a5cc06, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 05:07:36.402 INFO request completed, latency_us: 193, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5b5635f2-1664-4a19-aece-e5e1ae2f751b, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 05:07:36.578 INFO request completed, latency_us: 199, response_code: 204, uri: /start/cid/2, method: POST, req_id: 982623de-94c4-4c9d-9d68-8130fdbc6f6a, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:07:36.579 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/2, method: GET, req_id: 34d39c92-6f46-40b7-8960-f6dd156e97e1, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:07:40.580 INFO request completed, latency_us: 227, response_code: 200, uri: /state/cid/2, method: GET, req_id: 84af06fa-d6c5-4d67-a38b-2c3836c12740, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:07:44.582 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/2, method: GET, req_id: d2b0fd9c-554e-458a-9073-9245f7645028, remote_addr: 127.0.0.1:35455, 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(1289)
[8830][2] reports Running
Mar 18 05:07:48.585 INFO request completed, latency_us: 329, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9e000b4c-0017-4adb-ab02-fb9a24505eee, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 05:07:54.768 INFO request completed[8830] Got stop action so:false kr:false
, latency_us: 216, response_code: 204, uri: /stop/cid/2, method: POST, req_id: bb0efd58-7317-43da-8978-132a3e633d8b, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:07:54.769 INFO request completed, latency_us: 133, response_code: 200, uri: /state/cid/2, method: GET, req_id: 38408884-b835-4373-b822-ceef11d72d96, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 05:07:58.771 INFO request completed, latency_us: 316, response_code: 200, uri: /state/cid/2, method: GET, req_id: cbff0ab6-8a02-4863-9b62-6ca91122b739, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 05:07:58.962 INFO request completed, latency_us: 324, response_code: 204, uri: /start/cid/2, method: POST, req_id: ba4195ce-f5ce-4048-a627-e49e5975e82d, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:07:58.962 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/2, method: GET, req_id: 235143e2-4875-4a8e-8540-96b7e06a132b, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:08:02.965 INFO request completed, latency_us: 268, response_code: 200, uri: /state/cid/2, method: GET, req_id: dd5ac4e9-cfc1-4e70-9f27-96659ce5208e, remote_addr: 127.0.0.1:35455, 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(1290)
[8830][2] reports Running
Mar 18 05:08:06.968 INFO request completed, latency_us: 336, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5529f3e4-950e-487e-97c1-34b935fc0e0f, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 05:08:12.151 INFO request completed, [8830] Got stop action so:false kr:false
latency_us: 238, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 4237da6a-7cff-42f5-9ba3-034a836c4c2f, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:08:12.152 INFO request completed, latency_us: 151, response_code: 200, uri: /state/cid/2, method: GET, req_id: 8ef19230-93bf-4d47-953e-26f187bedadc, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 05:08:16.154 INFO request completed, latency_us: 195, response_code: 200, uri: /state/cid/2, method: GET, req_id: a13fcd8a-37f5-4f2a-905f-7ad938ce0e55, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 05:08:16.330 INFO request completed, latency_us: 188, response_code: 204, uri: /start/cid/2, method: POST, req_id: cc76f635-05c3-47e0-9a1e-3582219950c1, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:08:16.330 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/2, method: GET, req_id: cee549f7-fb4f-43de-a999-802fbaf38ad7, remote_addr: 127.0.0.1:35455, 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(1291)
[8830][2] reports Running
Mar 18 05:08:20.333 INFO request completed, latency_us: 333, response_code: 200, uri: /state/cid/2, method: GET, req_id: 37e68a4a-7671-42d3-86c1-92cdfd3bd2b1, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Mar 18 05:08:49.916 INFO request completed, latency_us: 212, response_code: 204, uri: /stop/cid/3, method: POST, req_id: aef54a30-b100-4899-97c1-513e8353a2c4[8840] Got stop action so:false kr:false
, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:08:49.917 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2b6bad02-5dc6-470b-a4f0-9a986c05b5ef, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Mar 18 05:08:53.919 INFO request completed, latency_us: 237, response_code: 200, uri: /state/cid/3, method: GET, req_id: 54fe1cf0-effd-4d0c-9964-af548b7f3f11, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Mar 18 05:08:54.111 INFO request completed, latency_us: 235, response_code: 204, uri: /start/cid/3, method: POST, req_id: 2d89ec7b-a3a4-4774-8c0e-550564171df6, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:08:54.111 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/3, method: GET, req_id: 03dca577-827b-4aa9-8107-52f4bdf1615d, remote_addr: 127.0.0.1:35455, 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(1292)
[8840][3] reports Running
Mar 18 05:08:58.113 INFO request completed, latency_us: 366, response_code: 200, uri: /state/cid/3, method: GET, req_id: 871e755a-43c4-4966-a3b7-ac77b4e39611, remote_addr: 127.0.0.1:35455, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.717 INFO accepted connection, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.718 INFO request completed, latency_us: 205, response_code: 200, uri: /regioninfo, method: GET, req_id: 08e08ae0-df71-4945-a0ee-130f10fc5f7d, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.719 INFO request completed, latency_us: 122, response_code: 200, uri: /regioncount, method: GET, req_id: a55e0733-5117-4156-8628-a108eabcdf6d, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.720 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: c88f4b4d-848d-4d37-ba6a-740a044db61d, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.720 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 1cf6ddfa-3a4d-400c-a846-3332cb337d02, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.721 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 34b8a3e5-00fb-4b79-9ce8-83dda28efeda, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.723 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/3, method: GET, req_id: 63f4d887-fe25-401b-8a21-832e1cc34a48, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.723 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2ad21b9e-f584-4445-a2c9-39ec90ab04b9, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:27.724 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5212ce0e-f8d4-4543-b205-dcd08bde9a76, remote_addr: 127.0.0.1:45922, local_addr: 127.0.0.1:9998
Mar 18 05:09:28.522 INFO accepted connection, remote_addr: 127.0.0.1:53650, local_addr: 127.0.0.1:9998
Mar 18 05:09:28.522 INFO request completed, latency_us: 210, response_code: 200, uri: /regioncount, method: GET, req_id: 3d78c29b-fe4c-4e62-ac08-1afdabb6edae, remote_addr: 127.0.0.1:53650, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Mar 18 05:09:32.390 INFO request completed, latency_us: 213, response_code: 204[8810] Got stop action so:false kr:false
, uri: /stop/cid/0, method: POST, req_id: 8c82f807-2f47-499b-bcd7-194862b1eb30, remote_addr: 127.0.0.1:53650, local_addr: 127.0.0.1:9998
Mar 18 05:09:32.391 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/0, method: GET, req_id: 588f8443-6089-4dc0-955f-d5de5bfcbf94, remote_addr: 127.0.0.1:53650, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Mar 18 05:09:36.393 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/0, method: GET, req_id: dca0c51d-973b-4b99-b5ec-e4d917be2e9e, remote_addr: 127.0.0.1:53650, local_addr: 127.0.0.1:9998
Mar 18 05:10:10.035 INFO accepted connection, remote_addr: 127.0.0.1:44261, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Mar 18 05:10:10.035 INFO request completed, latency_us: 180, response_code: 204, uri: /start/cid/0, method: POST, req_id: 915788ff-6065-4008-923b-16d1821fcd29, remote_addr: 127.0.0.1:44261, 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(1294)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Mar 18 05:10:14.217 INFO request completed, [8820] Got stop action so:false kr:false
latency_us: 317, response_code: 204, uri: /stop/cid/1, method: POST, req_id: e45aea5c-e451-4dce-9952-c58aeb9992a0, remote_addr: 127.0.0.1:44261, local_addr: 127.0.0.1:9998
Mar 18 05:10:14.218 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/1, method: GET, req_id: b5782027-5453-4e32-92a0-9695bf7ea931, remote_addr: 127.0.0.1:44261, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Mar 18 05:10:18.220 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/1, method: GET, req_id: d5146959-f096-47d8-92ea-cb7ca360ab8c, remote_addr: 127.0.0.1:44261, local_addr: 127.0.0.1:9998
Mar 18 05:10:51.870 INFO accepted connection, remote_addr: 127.0.0.1:44174, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Mar 18 05:10:51.871 INFO request completed, latency_us: 200, response_code: 204, uri: /start/cid/1, method: POST, req_id: 0fedde27-b54b-48d9-b526-e3b78a348528, remote_addr: 127.0.0.1:44174, 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(1295)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 05:10:56.053 INFO request completed, latency_us: 336, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 8a96d512-5cc5-4bfe-a320-ec77f7c099d5, remote_addr: 127.0.0.1:44174, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
Mar 18 05:10:56.054 INFO request completed, latency_us: 110, response_code: 200, uri: /state/cid/2, method: GET, req_id: e01e488e-e29d-4c6d-b345-8abc3850c14d, remote_addr: 127.0.0.1:44174, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 05:11:00.056 INFO request completed, latency_us: 328, response_code: 200, uri: /state/cid/2, method: GET, req_id: 40da2d1b-1f4c-4801-8433-84a803a7217d, remote_addr: 127.0.0.1:44174, local_addr: 127.0.0.1:9998
Mar 18 05:11:33.740 INFO accepted connection, remote_addr: 127.0.0.1:44173, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 05:11:33.741 INFO request completed, latency_us: 214, response_code: 204, uri: /start/cid/2, method: POST, req_id: ef7cf816-9d5a-4f4b-b5a7-6ed6e3187762, remote_addr: 127.0.0.1:44173, 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(1296)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Mar 18 05:11:37.977 INFO request completed, latency_us: 339, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 4b709d2c-fadb-44dc-ac62-30c9e5d9c03d, remote_addr: 127.[8840] Got stop action so:false kr:false
0.0.1:44173, local_addr: 127.0.0.1:9998
Mar 18 05:11:37.978 INFO request completed, latency_us: 126, response_code: 200, uri: /state/cid/3, method: GET, req_id: cd05751f-2e35-429e-bf09-689d8f1c269a, remote_addr: 127.0.0.1:44173, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Mar 18 05:11:41.980 INFO request completed, latency_us: 262, response_code: 200, uri: /state/cid/3, method: GET, req_id: ce529491-094a-4809-ada4-53779e4af99c, remote_addr: 127.0.0.1:44173, local_addr: 127.0.0.1:9998
Mar 18 05:12:15.649 INFO accepted connection, remote_addr: 127.0.0.1:57534, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Mar 18 05:12:15.649 INFO request completed, latency_us: 201, response_code: 204, uri: /start/cid/3, method: POST, req_id: 231736af-7241-4041-bb29-8d24bbf8bdb7, remote_addr: 127.0.0.1:57534, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Mar 18 05:12:19.884 INFO request completed, [8850] Got stop action so:false kr:false
latency_us: 227, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 29ab9690-2394-4f72-8042-b076ce4a0250, remote_addr: 127.0.0.1:57534, local_addr: 127.0.0.1:9998
Mar 18 05:12:19.885 INFO request completed, latency_us: 125, response_code: 200, uri: /state/cid/4, method: GET, req_id: b4bafe7a-bcb4-4520-a098-b5b1766e8a39, remote_addr: 127.0.0.1:57534, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[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(1297)
[8840][3] reports Running
Mar 18 05:12:23.888 INFO request completed, latency_us: 351, response_code: 200, uri: /state/cid/4, method: GET, req_id: 7ef6702f-8c34-47ef-a781-2fa5397d6a99, remote_addr: 127.0.0.1:57534, local_addr: 127.0.0.1:9998
Mar 18 05:12:57.542 INFO accepted connection, remote_addr: 127.0.0.1:42884, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Mar 18 05:12:57.543 INFO request completed, latency_us: 205, response_code: 204, uri: /start/cid/4, method: POST, req_id: 3c9bf8a6-e5e3-4d43-998f-c1adb94a7060, remote_addr: 127.0.0.1:42884, 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(1298)
[8850][4] reports Running
Mar 18 05:13:01.620 INFO accepted connection, remote_addr: 127.0.0.1:50165, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Mar 18 05:13:01.620 INFO request completed, latency_us: 204, response_codeShut it down
: 204[8810] Disable keep_running
, [8810] Got stop action so:false kr:false
uri: /shutdown, method: POST, req_id: 09cca0f6-b350-4cfc-ad1e-17faaa096b40, remote_addr: 127.0.0.1:50165, local_addr: 127.0.0.1:9998
[8830] Disable keep_running
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8830] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8870] Disable keep_running
[8870] 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))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820][1] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit