/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.18502623
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.011420686
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.010571881
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.010638832
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010749057
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010565902
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 access at:127.0.0.1:9998
start ds: 8850
start ds: 8860
Starting downstairs at port 8810
Starting downstairs at port 8840
Starting downstairs at port 8820
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-8820.txt"
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
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"
[8810][0] initial start wait reports Starting
[8840][3] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1139)
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1141)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1138)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1142)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1140)
[8830][2] initial start wait reports Running
[8850][4] initial start wait reports Running
[8840][3] initial start wait reports Running
[8820][1] initial start wait reports Running
[8860][5] initial start wait reports Running
May 14 20:46:11.345 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1143)
[8810][0] initial start wait reports Running
All downstairs are running
May 14 20:46:16.356 INFO accepted connection, remote_addr: 127.0.0.1:62110, local_addr: 127.0.0.1:9998
May 14 20:46:16.357 INFO request completed, latency_us: 387, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9ec75d99-af2d-4694-bfed-df9934ad8a1b, remote_addr: 127.0.0.1:62110, local_addr: 127.0.0.1:9998
May 14 20:46:16.371 INFO accepted connection, remote_addr: 127.0.0.1:48795, local_addr: 127.0.0.1:9998
May 14 20:46:16.371 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/1, method: GET, req_id: b984bb86-2430-487b-8dc6-702f030717ed, remote_addr: 127.0.0.1:48795, local_addr: 127.0.0.1:9998
May 14 20:46:16.384 INFO accepted connection, remote_addr: 127.0.0.1:49403, local_addr: 127.0.0.1:9998
May 14 20:46:16.385 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/2, method: GET, req_id: 829f3f78-1f27-4cd6-b82e-59c53f209a45, remote_addr: 127.0.0.1:49403, local_addr: 127.0.0.1:9998
May 14 20:46:16.398 INFO accepted connection, remote_addr: 127.0.0.1:55866, local_addr: 127.0.0.1:9998
May 14 20:46:16.398 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/3, method: GET, req_id: 27a2f7fd-72f3-4de6-8ee2-c68ceeb7117e, remote_addr: 127.0.0.1:55866, local_addr: 127.0.0.1:9998
May 14 20:46:16.411 INFO accepted connection, remote_addr: 127.0.0.1:64670, local_addr: 127.0.0.1:9998
May 14 20:46:16.411 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/4, method: GET, req_id: 21d1c5b3-ae5f-4617-a6fa-20582184070b, remote_addr: 127.0.0.1:64670, local_addr: 127.0.0.1:9998
May 14 20:46:16.424 INFO accepted connection, remote_addr: 127.0.0.1:44149, local_addr: 127.0.0.1:9998
May 14 20:46:16.424 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/5, method: GET, req_id: d2414b55-b7dc-4233-8a09-7c68f6976726, remote_addr: 127.0.0.1:44149, local_addr: 127.0.0.1:9998
May 14 20:46:16.437 INFO accepted connection, remote_addr: 127.0.0.1:51740, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
May 14 20:46:16.437 INFO disable restart on all: 6
request completed, latency_us: 87, response_code: 204, uri: /disablerestart/all, method: POST, req_id: e3f01700-edc2-42bd-b029-8ac9a79f766e, remote_addr: 127.0.0.1:51740, local_addr: 127.0.0.1:9998
[8810] Disable keep_running
[8830] Disable keep_running
[8840] Disable keep_running
[8820] Disable keep_running
[8850] Disable keep_running
[8860] Disable keep_running
May 14 20:46:16.501 INFO accepted connection, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.501 INFO request completed, latency_us: 258, response_code: 200, uri: /regioninfo, method: GET, req_id: 0b8c9968-9acc-473d-abab-d4de15e9c784, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.503 INFO request completed, latency_us: 34, response_code: 200, uri: /regioncount, method: GET, req_id: dec08d1e-76ed-4035-8cbf-aa80f405178c, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.504 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: f79558b0-5d58-4222-a92e-59d74ffdf2ed, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.504 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/1, method: GET, req_id: aaff2f1e-d5f1-425b-95ac-24f1c0bbc5c8, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.504 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/2, method: GET, req_id: f25c0b36-2796-421d-adae-dfa7a9025fde, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.509 INFO request completed, latency_us: 49, response_code: 200, uri: /port/cid/3, method: GET, req_id: a7b7911d-1319-44c7-9f61-173c394e7d9b, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.509 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: dc3d0360-4ad9-4f3e-ba44-3c388f2a904c, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:16.509 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6b046e5e-bc9b-4357-8dcb-983847635eb1, remote_addr: 127.0.0.1:58055, local_addr: 127.0.0.1:9998
May 14 20:46:25.566 INFO accepted connection, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.566 INFO request completed, latency_us: 160, response_code: 200, uri: /regioninfo, method: GET, req_id: 82b7e734-fd58-4957-9f68-d2b36a6871c2, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.567 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: 538e83ca-59bb-40d3-a0a8-e7ea163e82a1, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.567 INFO request completed, latency_us: 66, response_code: 200, uri: /port/cid/0, method: GET, req_id: bfac252a-6bd7-4abf-be83-734185bb4381, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.568 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: 74e2d5f8-dc43-4b75-b038-e3137a5823cc, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.568 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1deef78d-8843-47a3-a6c7-803ecf196694, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.569 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/3, method: GET, req_id: 84baf077-1893-4f51-8080-617eedd87352, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.569 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/4, method: GET, req_id: 8b6acae1-b38d-4bbc-bc36-7ace43fcd8dd, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:25.570 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: 306972c5-87a7-476a-9cfd-5452d8e63b6c, remote_addr: 127.0.0.1:56413, local_addr: 127.0.0.1:9998
May 14 20:46:34.874 INFO accepted connection, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.875 INFO request completed, latency_us: 160, response_code: 200, uri: /regioninfo, method: GET, req_id: a62ba046-82c2-4950-afd6-911567a052a8, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.876 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 3d54605a-bf37-49c7-8802-f1318873347c, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.876 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/0, method: GET, req_id: 20bc4f53-4f1b-4493-8976-c837a07cf674, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.876 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/1, method: GET, req_id: 36a4652a-1403-4b92-89ab-b39706962303, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.877 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7026619d-9646-416b-8f4c-eaab6516f9f1, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.878 INFO request completed, latency_us: 67, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7111ef48-75dc-4f05-bfb8-d79badf99272, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.878 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/4, method: GET, req_id: d6dff81f-27eb-4b70-a38e-81467c298b9b, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:34.879 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/5, method: GET, req_id: 518676a0-58e4-4571-bca6-8c3ae4d30a35, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
May 14 20:46:59.733 INFO accepted connection, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.733 INFO request completed, latency_us: 160, response_code: 200, uri: /regioninfo, method: GET, req_id: d4911635-913d-46ba-b228-66dc6d7febd5, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.734 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: 3cefa6f0-2d99-4840-a3cb-046e5814af98, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.734 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: cebed408-a60e-4f49-b945-79a989438feb, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.735 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: a6ab844c-e3cb-46bc-af1a-3ea828d21e95, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.735 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 94b8e483-6c55-4f31-b78a-234eed18bdc1, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.736 INFO request completed, latency_us: 67, response_code: 200, uri: /port/cid/3, method: GET, req_id: 31ed1080-e4ec-47c7-b5f1-b2319c3da88f, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.737 INFO request completed, latency_us: 64, response_code: 200, uri: /port/cid/4, method: GET, req_id: 60fd29cf-fb09-4447-b629-34c816fec99e, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:46:59.737 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/5, method: GET, req_id: e9d69e31-d7e8-4e37-b15f-6eafc7ef3780, remote_addr: 127.0.0.1:42853, local_addr: 127.0.0.1:9998
May 14 20:49:31.983 INFO accepted connection, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.983 INFO request completed, latency_us: 157, response_code: 200, uri: /regioninfo, method: GET, req_id: b9fae4c6-360f-4fa6-9888-a2bf81746ae9, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.984 INFO request completed, latency_us: 70, response_code: 200, uri: /regioncount, method: GET, req_id: c018389d-0b77-4283-97a8-79fd974eb0d9, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.984 INFO request completed, latency_us: 62, response_code: 200, uri: /port/cid/0, method: GET, req_id: bffe16f9-4d38-4e16-9c8c-fd157e20be8b, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.984 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2b77f07c-fe58-4cf6-921b-8312c15c4c90, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.985 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/2, method: GET, req_id: f02c8032-c1a3-4242-b797-60c38d67bb91, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.986 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/3, method: GET, req_id: 0d5cd108-50c8-45d5-a9f6-676bd37b43c1, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.986 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2e321772-d6f2-4f59-8d81-cda458262029, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:31.986 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: 71a59c62-bb82-4526-96fd-b5ff4c9ab0d5, remote_addr: 127.0.0.1:60906, local_addr: 127.0.0.1:9998
May 14 20:49:48.663 INFO accepted connection, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.663 INFO request completed, latency_us: 159, response_code: 200, uri: /regioninfo, method: GET, req_id: bb65b0cc-02c0-4428-a9f7-d96280f468ac, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.664 INFO request completed, latency_us: 39, response_code: 200, uri: /regioncount, method: GET, req_id: f1ea0b42-0d49-403e-810c-3b387f1bbac4, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.664 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6c8c9135-6236-4567-af38-981b045e0f54, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.664 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: 78d262a1-c015-4442-b23a-02cb6a8f6fca, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.664 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3b5cb135-68f2-42a0-8742-814f7cf09ef9, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.666 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8c6061ff-920d-4783-a4c5-259ea0ef91a2, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.666 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/4, method: GET, req_id: 4f32e32a-c8a8-4920-b7c0-25e3ab8e665c, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:48.666 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: dc1cf78f-7c39-41a9-a9c1-055c2b92fd9c, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998
May 14 20:49:52.774 INFO accepted connection, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.774 INFO request completed, latency_us: 157, response_code: 200, uri: /regioninfo, method: GET, req_id: 00ca182a-92d7-4d4e-9f2f-a46c534e1436, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.775 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: 44cebb76-3652-45d3-bb4f-3c920546a3a3, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.775 INFO request completed, latency_us: 71, response_code: 200, uri: /port/cid/0, method: GET, req_id: fb5e1f39-8b02-4c04-8164-e098177c7e0c, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.775 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/1, method: GET, req_id: 63f79fb2-bc15-40ac-b466-2f26975f2f61, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.776 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: ee4ceb0e-b8da-40b3-bfc0-489000bdd391, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.777 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5e0ac61f-35d3-4ae7-83ad-fccb91e26d26, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.777 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/4, method: GET, req_id: 5e815e99-a892-4fa5-b2ba-38c700a8875d, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:52.777 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/5, method: GET, req_id: 68713dce-8add-4e5e-a6e7-3f391f3e56d7, remote_addr: 127.0.0.1:51891, local_addr: 127.0.0.1:9998
May 14 20:49:56.872 INFO accepted connection, remote_addr: 127.0.0.1:48560, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
May 14 20:49:56.872 INFO request completed, latency_us: 140, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 0c4b3bab-15dc-43fa-b352-cfb5d01a44ae, remote_addr: 127.0.0.1:48560, local_addr: 127.0.0.1:9998
[8820] Disable keep_running
[8810] Disable keep_running
[8840] Disable keep_running
[8850] Disable keep_running
[8860] Disable keep_running
[8830] Disable keep_running
May 14 20:49:56.886 INFO accepted connection, remote_addr: 127.0.0.1:44552, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
May 14 20:49:56.886 INFO request completed, latency_us: 82, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 6982e154-71ec-418d-ab4d-80fd8e9dab7c, remote_addr: 127.0.0.1:44552, local_addr: 127.0.0.1:9998
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 14 20:49:56.900 INFO accepted connection, remote_addr: 127.0.0.1:34828, local_addr: 127.0.0.1:9998
May 14 20:49:56.901 INFO request completed, latency_us: 89, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3f48c44e-1f75-4a50-8eb1-72cd333f8daa, remote_addr: 127.0.0.1:34828, local_addr: 127.0.0.1:9998
May 14 20:49:56.916 INFO accepted connection, remote_addr: 127.0.0.1:34951, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 14 20:49:56.916 INFO request completed, latency_us: 76, response_code: 204, uri: /start/cid/2, method: POST, req_id: a61302a2-4434-4b6b-a5d2-ce682d535e5c, remote_addr: 127.0.0.1:34951, local_addr: 127.0.0.1:9998
May 14 20:49:56.929 INFO accepted connection, remote_addr: 127.0.0.1:59781, local_addr: 127.0.0.1:9998
May 14 20:49:56.930 INFO request completed, latency_us: 79, response_code: 200, uri: /state/cid/2, method: GET, req_id: b6e4eed6-0e1a-41d8-ae67-f16a7be78906, remote_addr: 127.0.0.1:59781, 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(1194)
[8830][2] reports Running
May 14 20:50:01.946 INFO accepted connection, remote_addr: 127.0.0.1:59857, local_addr: 127.0.0.1:9998
May 14 20:50:01.947 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4c087b6d-6d08-4006-87e8-6559e061ae92, remote_addr: 127.0.0.1:59857, local_addr: 127.0.0.1:9998
May 14 20:50:01.981 INFO accepted connection, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.982 INFO request completed, latency_us: 139, response_code: 200, uri: /regioninfo, method: GET, req_id: 5d17fe8a-eefb-46c1-8994-72180719f04c, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.982 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: 6a23d38b-92f2-4298-aa92-68a23e27ea8d, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.983 INFO request completed, latency_us: 64, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9c3fc0c7-a717-46e8-ba19-a6821f6c0562, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.983 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/1, method: GET, req_id: edf99dda-d34f-474a-a35f-2345c5c911d4, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.983 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: bd4cbe42-8e3b-4ddc-8190-334763241e40, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.984 INFO request completed, latency_us: 45, response_code: 200, uri: /port/cid/3, method: GET, req_id: e02a155e-23e8-4ad0-baba-d8daf5d5db37, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.985 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/4, method: GET, req_id: aaff465a-5bcc-4b6f-89d4-ed5b60aef21d, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:01.985 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5ee69b43-bd8c-464d-ae14-050dd9f06dae, remote_addr: 127.0.0.1:38940, local_addr: 127.0.0.1:9998
May 14 20:50:06.119 INFO accepted connection, remote_addr: 127.0.0.1:35780, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
May 14 20:50:06.120 INFO request completed, latency_us: 129[8810] Disable keep_running
, [8810] Got stop action so:false kr:false
response_code: 204, uri: /shutdown, method: POST, req_id:[8820] Disable keep_running
 [8820] Got stop action so:false kr:false
b89f140e-1db4-44c6-82cb-6dbbf4d2ab8b, [8840] Disable keep_running
remote_addr[8840] Got stop action so:false kr:false
:[8860] Disable keep_running
 127.[8860] Got stop action so:false kr:false
0.0[8850] Disable keep_running
.1:[8850] Got stop action so:false kr:false
35780[8830] Disable keep_running
, [8830] Got stop action so:false kr:false
local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820][1] reports Exit
[8840][3] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 6 --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.029490136
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.028014459
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.026165728
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.024995187
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.025829976
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.025618734
Created 6 regions
/var/tmp/bins/dsc start --region-count 6 --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
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
Starting downstairs at port 8840
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Starting downstairs at port 8860
[8840][3] initial start wait reports Starting
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/8830 port 8830 PID:Some(1218)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1217)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1214)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1215)
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1216)
[8830][2] initial start wait reports Running
[8820][1] initial start wait reports Running
[8840][3] initial start wait reports Running
[8860][5] initial start wait reports Running
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1213)
[8810][0] initial start wait reports Running
All downstairs are running
May 14 20:50:11.302 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
May 14 20:50:16.314 INFO accepted connection, remote_addr: 127.0.0.1:51536, local_addr: 127.0.0.1:9998
May 14 20:50:16.315 INFO request completed, latency_us: 308, response_code: 200, uri: /state/cid/0, method: GET, req_id: a5db9019-ab8d-49e3-899b-2a43863e4d59, remote_addr: 127.0.0.1:51536, local_addr: 127.0.0.1:9998
May 14 20:50:16.329 INFO accepted connection, remote_addr: 127.0.0.1:58355, local_addr: 127.0.0.1:9998
May 14 20:50:16.329 INFO request completed, latency_us: 124, response_code: 200, uri: /state/cid/1, method: GET, req_id: 373932ed-7a75-4702-aaa8-bbb66f9c17db, remote_addr: 127.0.0.1:58355, local_addr: 127.0.0.1:9998
May 14 20:50:16.343 INFO accepted connection, remote_addr: 127.0.0.1:46730, local_addr: 127.0.0.1:9998
May 14 20:50:16.343 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/2, method: GET, req_id: c7949769-2526-413c-b365-69a8b4bc410f, remote_addr: 127.0.0.1:46730, local_addr: 127.0.0.1:9998
May 14 20:50:16.356 INFO accepted connection, remote_addr: 127.0.0.1:57365, local_addr: 127.0.0.1:9998
May 14 20:50:16.357 INFO request completed, latency_us: 68, response_code: 200, uri: /state/cid/3, method: GET, req_id: a61823f7-5c66-4d19-a195-815c093c4d1b, remote_addr: 127.0.0.1:57365, local_addr: 127.0.0.1:9998
May 14 20:50:16.370 INFO accepted connection, remote_addr: 127.0.0.1:61904, local_addr: 127.0.0.1:9998
May 14 20:50:16.370 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/4, method: GET, req_id: 8271c628-0558-4d7e-94b3-49d8aaeb5ca1, remote_addr: 127.0.0.1:61904, local_addr: 127.0.0.1:9998
May 14 20:50:16.383 INFO accepted connection, remote_addr: 127.0.0.1:36124, local_addr: 127.0.0.1:9998
May 14 20:50:16.383 INFO request completed, latency_us: 73, response_code: 200, uri: /state/cid/5, method: GET, req_id: fb073b55-953a-470e-9466-48d28e479d7d, remote_addr: 127.0.0.1:36124, local_addr: 127.0.0.1:9998
May 14 20:50:16.402 INFO accepted connection, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.403 INFO request completed, latency_us: 120, response_code: 200, uri: /regioninfo, method: GET, req_id: 2d00be5d-124f-4b69-92b0-b644a29a5882, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.404 INFO request completed, latency_us: 39, response_code: 200, uri: /regioncount, method: GET, req_id: db204262-c856-4e33-bf21-7b8d97fbfe0a, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.404 INFO request completed, latency_us: 46, response_code: 200, uri: /port/cid/0, method: GET, req_id: fe2f541a-5517-40c0-bb1c-5a978961e5dd, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.404 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: d1df3c98-e709-485c-a059-b470bbe5770e, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.404 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: 90ee66cd-ea2d-4ff2-85d9-aaf694cac765, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.406 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/3, method: GET, req_id: d973aa8d-b86b-42f4-a6b9-cff30641cf77, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.406 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0d96fe37-083a-42da-99a8-e131f81894e3, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.406 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1a2635bf-d98c-456e-95db-99afc86d0f5e, remote_addr: 127.0.0.1:36561, local_addr: 127.0.0.1:9998
May 14 20:50:16.812 INFO accepted connection, remote_addr: 127.0.0.1:52998, 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
May 14 20:50:16.813 INFO request completed, latency_us: 232, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 28c9219e-a1cf-40af-bb3f-95a7064933a3, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:50:16.813 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/0, method: GET, req_id: 50d26cf2-afbc-457d-bce9-a988f0ff1343, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 14 20:50:20.816 INFO request completed, latency_us: 205, response_code: 200, uri: /state/cid/0, method: GET, req_id: fb781184-e5e4-42bf-be27-02d860f4e2b4, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 14 20:50:21.210 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/0, method: POST, req_id: d4660a6a-5cdf-4da6-9a58-ed5f57e68a20, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
May 14 20:50:21.211 INFO request completed[8820] Got stop action so:false kr:false
, latency_us: 70, response_code: 204, uri: /stop/cid/1, method: POST, req_id: b2565e0a-62fa-43d2-bb1d-5b9dd547e9b4, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:50:21.211 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/0, method: GET, req_id: ecc20038-48da-4c8a-9b11-194e299e1adf, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8810] got start action
[8810] I am going to restart
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8810][0] reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1227)
[8810][0] reports Running
May 14 20:50:25.214 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/0, method: GET, req_id: d5520f5d-285d-4e7f-b757-528ae945ece8, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:50:25.214 INFO request completed, latency_us: 40, response_code: 200, uri: /state/cid/1, method: GET, req_id: eb780b4a-fe24-4c25-9b09-a434fc0173c9, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
May 14 20:50:37.217 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/1, method: POST, req_id: 3afd94ca-5bac-4d00-bf70-6b4f954ab471, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:50:37.218 INFO request completed, latency_us: 54, response_code: 200, uri: /state/cid/0, method: GET, req_id: 03b75278-5a3b-450c-b5af-9d57be3babff, remote_addr: 127.0.0.1:52998, 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(1228)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
[8820] Got stop action so:false kr:false
May 14 20:50:54.360 INFO request completed, latency_us: 249, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 54088609-3313-4377-b87b-6976367408f6, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:50:54.361 INFO request completed, latency_us: 171, response_code: 200, uri: /state/cid/1, method: GET, req_id: b1e73d4f-208b-462b-8cd2-bf07edbffb9c, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
May 14 20:50:58.362 INFO request completed, latency_us: 230, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3e21ef88-be21-443f-b12e-813798226a9a, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
May 14 20:50:58.768 INFO request completed, latency_us: 264, response_code: 204, uri: /start/cid/1, method: POST, req_id: e750f470-fb5a-40c7-8f38-29c9e292ab0d, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
May 14 20:50:58.768 INFO request completed, latency_us: 69, response_code: 204, uri: /stop/cid/2, method: POST, [8830] Got stop action so:false kr:false
req_id: 95e1a6d9-a2f8-48f3-ad59-7297c978e6ea, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:50:58.769 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/1, method: GET, req_id: e6abf418-5109-4ef4-97d1-21d19fc09cf4, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[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(1229)
[8820][1] reports Running
May 14 20:51:02.770 INFO request completed, latency_us: 188, response_code: 200, uri: /state/cid/1, method: GET, req_id: 538312ee-672c-4684-8bcc-b2458cd76ecb, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:51:02.771 INFO request completed, latency_us: 34, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0bead456-9a31-4453-8cae-fcc7b9caf83e, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 14 20:51:14.776 INFO request completed, latency_us: 220, response_code: 204, uri: /start/cid/2, method: POST, req_id: 0849b560-fee6-47ff-858a-991db51b2835, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:51:14.776 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/1, method: GET, req_id: fb9dd786-930f-4782-af26-a30e99856da7, remote_addr: 127.0.0.1:52998, 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(1230)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
May 14 20:51:32.197 INFO [8830] Got stop action so:false kr:false
request completed, latency_us: 224, response_code: 204, uri: /stop/cid/2, method: POST, req_id: dd9cbec8-575c-4343-b433-c495d761790d, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:51:32.198 INFO request completed, latency_us: 129, response_code: 200, uri: /state/cid/2, method: GET, req_id: 27f2825e-b3fd-424a-9a7a-0a5949f5c09b, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 14 20:51:36.201 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/2, method: GET, req_id: d42bcd09-fea8-4cd0-b5e3-b09e6f3a10a1, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 14 20:51:36.610 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/2, method: POST, req_id: 24bedb27-5bba-4941-ba7f-81ab5c235c08, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 14 20:51:36.610 INFO request completed, latency_us: 38, response_code: 204, uri: /stop/cid/0, method: [8810] Got stop action so:false kr:false
POST, req_id: b9d4278e-8e1a-4d36-a53b-5ddd7bfb782d, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:51:36.611 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/2, method: GET, req_id: 81c0b07d-580b-4719-bd97-08b947fc996c, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[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(1231)
[8830][2] reports Running
May 14 20:51:40.612 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/2, method: GET, req_id: 87064a66-9cfc-4996-b771-44f106e73371, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:51:40.613 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/0, method: GET, req_id: e1ebbd98-353f-4a6f-8b4d-08b8e58ae1d1, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 14 20:51:52.617 INFO request completed, latency_us: 235, response_code: 204, uri: /start/cid/0, method: POST, req_id: 9fb97e7c-b437-4e9f-9315-55cb4a443b6f, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:51:52.618 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/2, method: GET, req_id: e993fa1e-f12e-46e5-9229-3bd8262476e1, remote_addr: 127.0.0.1:52998, 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(1232)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
May 14 20:52:10.284 INFO request completed, [8840] Got stop action so:false kr:false
latency_us: 229, response_code: 204, uri: /stop/cid/3, method: POST, req_id: a24ba079-01c8-41f0-b30e-c43e93360bea, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:52:10.284 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5b9c0de7-d490-466a-98cb-bcf8d2b83a06, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
May 14 20:52:14.287 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/3, method: GET, req_id: 982254ad-2627-4622-b118-98a27cdb1e8d, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
May 14 20:52:14.700 INFO request completed, latency_us: 230, response_code: 204, uri: /start/cid/3, method: POST, req_id: 6d2b723c-9e2f-43a5-8fba-717ae2840cb6, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(4)
stop 4
May 14 20:52:14.700 INFO request completed[8850] Got stop action so:false kr:false
, latency_us: 119, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 157bc602-4676-4755-ad6c-5580ea565ce0, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:52:14.701 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8ccf8ba1-bf7d-4049-93c8-bd1fccc02475, remote_addr: 127.0.0.1:52998, 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(1233)
[8840][3] reports Running
May 14 20:52:18.703 INFO request completed, latency_us: 193, response_code: 200, uri: /state/cid/3, method: GET, req_id: 3bfca8ed-caa6-4243-a420-0dc806f06e69, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:52:18.703 INFO request completed, latency_us: 36, response_code: 200, uri: /state/cid/4, method: GET, req_id: 93988abf-24e3-43d6-ba86-4db17e511911, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
May 14 20:52:30.706 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/4, method: POST, req_id: acaac2f1-9a90-43d6-a938-d9e8f30d7f5d, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:52:30.707 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/3, method: GET, req_id: 11e8daa9-77ee-406d-ad77-ebfdf1983e4b, remote_addr: 127.0.0.1:52998, 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(1234)
[8850][4] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
May 14 20:52:48.616[8850] Got stop action so:false kr:false
 INFO request completed, latency_us: 226, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 650f8e5a-1174-4ce4-8b22-2cf5e5137955, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:52:48.616 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/4, method: GET, req_id: 45bb75ff-f042-4b71-82b9-32727badf504, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
May 14 20:52:52.618 INFO request completed, latency_us: 219, response_code: 200, uri: /state/cid/4, method: GET, req_id: 92354f49-789e-4720-8611-027b946768c7, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
May 14 20:52:53.031 INFO request completed, latency_us: 245, response_code: 204, uri: /start/cid/4, method: POST, req_id: aed8e255-8a73-429a-bf7b-1c7729a0b4fe, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(5)
stop 5
May 14 20:52:53.032 INFO request completed, latency_us: 38, response_code: 204, uri: /stop/cid/5, method: POST, req_id: 82509d1f-646a-4381-8c0a-139bd65ddfa0, [8860] Got stop action so:false kr:false
remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:52:53.032 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/4, method: GET, req_id: f5422c51-256e-4665-a8ab-a6202fa5367c, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
May 14 20:52:57.033 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/4, method: GET, req_id: a1db09f4-13fd-4901-8672-7de690e1806c, remote_addr: 127.0.0.1:52998, 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(1235)
[8850][4] reports Running
May 14 20:53:01.035 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/4, method: GET, req_id: 01d8b671-b82d-47a0-b3e0-8d0d6e87d40d, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:53:01.036 INFO request completed, latency_us: 74, response_code: 200, uri: /state/cid/5, method: GET, req_id: cac44246-b759-41ea-bb07-35f3888aca66, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(5)
start 5
May 14 20:53:13.040 INFO request completed, latency_us: 231, response_code: 204, uri: /start/cid/5, method: POST, req_id: 08455ea5-1aa9-45fe-b4bd-14742126b177, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
May 14 20:53:13.041 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/4, method: GET, req_id: 3de72f20-d9e3-4cbd-a689-a4a064d65954, remote_addr: 127.0.0.1:52998, local_addr: 127.0.0.1:9998
[8860] got start action
[8860] I am going to restart
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8860][5] reports Starting
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1236)
[8860][5] reports Running
May 14 20:53:30.807 INFO accepted connection, remote_addr: 127.0.0.1:34183, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
May 14 20:53:30.808 INFO request completed, [8810] Disable keep_running
latency_us[8820] Disable keep_running
:[8810] Got stop action so:false kr:false
 142, [8820] Got stop action so:false kr:false
response_code[8830] Disable keep_running
: 204, uri: /shutdown, method: POST, req_id: 05fffa42-b3e5-4e18-aa3d-65c9af675f00, remote_addr: 127.0.0.1:34183, local_addr:[8840] Disable keep_running
 [8840] Got stop action so:false kr:false
127.0[8850] Disable keep_running
.[8850] Got stop action so:false kr:false
0.1:9998
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8830] Got stop action so:false kr:false
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] 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
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820][1] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit