/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.24995594
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018314872
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.0185535
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.018116333
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.019354844
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.02074394
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
Starting downstairs at port 8840
start access at:127.0.0.1:9998
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
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-8850.txt"
[8840][3] initial start wait reports Starting
Starting downstairs at port 8810
Starting downstairs at port 8860
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8850][4] initial start wait reports Starting
[8810][0] 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 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8820][1] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1197)
[8860][5] 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/8820 port 8820 PID:Some(1199)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1200)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1201)
[8830][2] initial start wait reports Running
Mar 18 15:12:40.273 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
Control access at:127.0.0.1:9998
Mar 18 15:12:45.309 INFO accepted connection, remote_addr: 127.0.0.1:62117, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.311 INFO request completed, latency_us: 533, response_code: 200, uri: /state/cid/0, method: GET, req_id: f91bc59c-6427-40f0-b8f8-d6a7cfc40e81, remote_addr: 127.0.0.1:62117, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.365 INFO accepted connection, remote_addr: 127.0.0.1:56197, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.365 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6992ddb4-2c3c-4ea0-96e0-ffa9ad5b603f, remote_addr: 127.0.0.1:56197, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.417 INFO accepted connection, remote_addr: 127.0.0.1:50367, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.418 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9a2f9a17-f87c-432f-8af8-8d8de1c01b90, remote_addr: 127.0.0.1:50367, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.470 INFO accepted connection, remote_addr: 127.0.0.1:40265, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.471 INFO request completed, latency_us: 130, response_code: 200, uri: /state/cid/3, method: GET, req_id: 3156e9b9-b17f-4c1c-a19b-b0d835862191, remote_addr: 127.0.0.1:40265, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.523 INFO accepted connection, remote_addr: 127.0.0.1:33448, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.524 INFO request completed, latency_us: 149, response_code: 200, uri: /state/cid/4, method: GET, req_id: 78eddd8d-60e3-44b9-ac79-58fc9b906562, remote_addr: 127.0.0.1:33448, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.578 INFO accepted connection, remote_addr: 127.0.0.1:45659, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.579 INFO request completed, latency_us: 151, response_code: 200, uri: /state/cid/5, method: GET, req_id: 39d2b85e-95d7-439c-ac70-dd5b21b703cc, remote_addr: 127.0.0.1:45659, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.633 INFO accepted connection, remote_addr: 127.0.0.1:59388, 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 15:12:45.634 INFO request completed, latency_us: 184, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 49d4a69f-258e-4d76-b95b-aa837805f431, remote_addr[8820] Disable keep_running
:[8830] Disable keep_running
 [8840] Disable keep_running
127[8860] Disable keep_running
.0.0.1:59388, local_addr: 127.0.0.1:9998
[8810] Disable keep_running
[8850] Disable keep_running
Mar 18 15:12:45.744 INFO accepted connection, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.746 INFO request completed, latency_us: 217, response_code: 200, uri: /regioninfo, method: GET, req_id: 0599eab4-e381-4fec-9b17-ab6d6b347aeb, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.748 INFO request completed, latency_us: 97, response_code: 200, uri: /regioncount, method: GET, req_id: e17bade9-9fd8-4848-a586-9c4bb098240a, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.749 INFO request completed, latency_us: 121, response_code: 200, uri: /port/cid/0, method: GET, req_id: 549cf1fb-61a8-45d3-9e75-a581fcb356f0, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.750 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: 461d4424-cdc2-4215-bfa6-604953193631, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.750 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/2, method: GET, req_id: dc5a1fb5-bbc9-4439-94e5-f0b7a27ccd71, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.755 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/3, method: GET, req_id: d4617d46-1b1d-4d7d-9029-6e2eec0ae3a4, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.755 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/4, method: GET, req_id: 8eb6ad2e-975f-4e1f-8e73-ecf8f4a04ec0, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:45.756 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/5, method: GET, req_id: 14f019b2-54e0-4874-b622-ca4c1d545a6f, remote_addr: 127.0.0.1:56536, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.875 INFO accepted connection, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.875 INFO request completed, latency_us: 162, response_code: 200, uri: /regioninfo, method: GET, req_id: b63d7c0a-1976-4139-b746-b8802bfe209d, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.876 INFO request completed, latency_us: 97, response_code: 200, uri: /regioncount, method: GET, req_id: 6d8ff87f-438c-40a8-a03d-1a516032d18a, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.877 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: be4199f6-49dd-4466-9054-60ab01837652, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.878 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: b68f456e-cdb3-434c-b433-8427c6ceac81, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.878 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 41000075-5aec-4f72-918b-9568b8f47e86, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.880 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5b42c30b-0aa1-42f4-9861-fadefabcf5cb, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.880 INFO request completed, latency_us: 84, response_code: 200, uri: /port/cid/4, method: GET, req_id: 601f0c0e-6891-414c-821f-6f78f2a357f6, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:12:54.881 INFO request completed, latency_us: 83, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1b938324-77df-4e54-8736-c7e66e90f40a, remote_addr: 127.0.0.1:35716, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.472 INFO accepted connection, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.472 INFO request completed, latency_us: 137, response_code: 200, uri: /regioninfo, method: GET, req_id: 8db730a3-ee63-46cd-bd1e-c82413b2e9de, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.473 INFO request completed, latency_us: 104, response_code: 200, uri: /regioncount, method: GET, req_id: e0c48d66-7036-423c-9b75-760ebb2d24e4, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.474 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8a7cfd3d-e2b7-4698-835c-43d007c1f003, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.475 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/1, method: GET, req_id: 748db452-ed92-452a-a903-82efc79eaa68, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.475 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1df65e53-b530-4c3b-b059-ca1153015641, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.477 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/3, method: GET, req_id: 1586ec2d-39f9-4102-adba-a9e46aae9232, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.478 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: dd533849-fb0d-476e-9637-d1383f081d73, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:04.478 INFO request completed, latency_us: 84, response_code: 200, uri: /port/cid/5, method: GET, req_id: 68138a76-6c54-4ef5-9290-112707ef86e9, remote_addr: 127.0.0.1:54935, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.232 INFO accepted connection, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.233 INFO request completed, latency_us: 152, response_code: 200, uri: /regioninfo, method: GET, req_id: 5938b0f4-d216-4ca4-a34e-53e24525e6ea, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.234 INFO request completed, latency_us: 84, response_code: 200, uri: /regioncount, method: GET, req_id: 77656773-92f0-450c-b441-f4aee0034f3d, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.235 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/0, method: GET, req_id: 511484ce-4e33-4710-88ab-2e025f0a238a, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.235 INFO request completed, latency_us: 84, response_code: 200, uri: /port/cid/1, method: GET, req_id: 48240474-511c-417a-a1bd-3b6382084f2f, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.236 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3c181698-e8dc-4195-becb-99653a81d979, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.237 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/3, method: GET, req_id: 3cb093dc-8b67-4f2a-be9e-f74a94d62079, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.238 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/4, method: GET, req_id: 4649fd41-c6e8-4689-8061-71c3221de678, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:13:43.238 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5c8253a1-43c0-4b0d-bf70-8253623aea86, remote_addr: 127.0.0.1:56692, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.806 INFO accepted connection, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.806 INFO request completed, latency_us: 154, response_code: 200, uri: /regioninfo, method: GET, req_id: 2d4bc3da-fc60-494d-9db8-b8542466b30d, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.807 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: d8c20695-883d-4b07-a588-ec1d1a2ff036, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.808 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1439db52-4be6-4f78-8186-ba847c2b8fd6, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.809 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/1, method: GET, req_id: c2b57dbb-2829-4b6e-beb7-ea04f3f85876, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.809 INFO request completed, latency_us: 84, response_code: 200, uri: /port/cid/2, method: GET, req_id: 413579d8-bc58-4d37-b42f-b4b1bb11cd86, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.811 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 740bfdc7-34de-4d43-824c-dd4fe2d23a0d, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.811 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9ab90e66-2665-4a00-805f-25184efbf5e0, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:18:01.812 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1f80f4f8-2e8e-45ab-9a7e-a32483439613, remote_addr: 127.0.0.1:34713, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.238 INFO accepted connection, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.239 INFO request completed, latency_us: 160, response_code: 200, uri: /regioninfo, method: GET, req_id: 5ee75d86-92f7-4cfb-8c58-c7f884a1dc36, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.240 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: ca6b50e9-e754-4764-beb9-fa2a3ebd36e9, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.240 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0f2741c3-0db4-4cf8-a0f2-0d56395c8e36, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.241 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/1, method: GET, req_id: 622b09a8-44b6-48db-8ee3-a4492bc3f458, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.241 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1c40c830-dc9f-4427-87fe-af939a65c64c, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.243 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: c31c7250-aa15-4b91-a798-e68ccb431baa, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.244 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9863dfaa-dbf0-4c56-8dd7-4f8e60c014a4, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:19.244 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/5, method: GET, req_id: 925a1290-8983-4e43-8447-4af3cd3e47b6, remote_addr: 127.0.0.1:47922, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.449 INFO accepted connection, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.450 INFO request completed, latency_us: 141, response_code: 200, uri: /regioninfo, method: GET, req_id: baf7d767-7e32-48b1-b138-1821e707b1ba, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.451 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: fb84b4f3-6084-4acf-a35f-8abd2db43a13, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.451 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9bd0c976-4874-49ef-a571-c62ef9a956ec, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.452 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: 12dd765d-4055-4a75-9e83-f7ee5e6f487a, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.452 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9067cc5a-c3b6-454a-895b-02056a5520cf, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.454 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/3, method: GET, req_id: a39c043d-08a4-4f11-a343-295e8e4e158e, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.455 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/4, method: GET, req_id: 7a2f0b25-f6d0-40bc-be00-72e4e4ab652e, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:23.455 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 9c61679a-6c26-4314-b89c-b9113de4b3ae, remote_addr: 127.0.0.1:56828, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.643 INFO accepted connection, remote_addr: 127.0.0.1:34173, 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 15:19:27.644 INFO request completed, latency_us: 135, response_code: [8810] Disable keep_running
204, uri: /disablerestart/all[8830] Disable keep_running
, method: POST, req_id: 6866a02b-b972-410a-ad0f-8c42453c9e7f, remote_addr: 127.0[8850] Disable keep_running
.[8860] Disable keep_running
0.1:34173, local_addr: 127.0.0.[8820] Disable keep_running
1:9998
[8840] Disable keep_running
Mar 18 15:19:27.697 INFO accepted connection, remote_addr: 127.0.0.1:64513, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 15:19:27.697 INFO request completed, latency_us: 144, response_code: 204, uri: /stop/cid/2, method: POST, req_id: bb7b080d-286f-4617-88b4-87a4ea88799d, remote_addr: 127.0.0[8830] Got stop action so:false kr:false
.1:64513, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 15:19:27.751 INFO accepted connection, remote_addr: 127.0.0.1:57414, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.751 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/2, method: GET, req_id: eff327d8-e36c-4a45-852c-8aea07dead1b, remote_addr: 127.0.0.1:57414, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.809 INFO accepted connection, remote_addr: 127.0.0.1:59300, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 15:19:27.810 INFO request completed, latency_us: 167, response_code: 204, uri: /start/cid/2, method: POST, req_id: 42539f79-ca62-490c-a293-5166740dff85, remote_addr: 127.0.0.1:59300, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.890 INFO accepted connection, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.891 INFO request completed, latency_us: 155, response_code: 200, uri: /regioninfo, method: GET, req_id: 1fa640dc-8677-47cf-a15c-ca191253a1d3, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.892 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: 9e7ac997-becb-4a34-bfe8-55eea12c7ae5, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.892 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 19c708d8-5b75-4b80-95e1-9ce139b2111c, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.893 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/1, method: GET, req_id: 939a3607-bfc1-44c5-8ed5-c733497cbaa2, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.893 INFO request completed, latency_us: 84, response_code: 200, uri: /port/cid/2, method: GET, req_id: f58c4716-cd10-4e13-b70c-2ad79aab8b60, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.895 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/3, method: GET, req_id: aa6b5be7-e4bc-4e59-9bd6-a9b4d6f10281, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.896 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/4, method: GET, req_id: 098de4b2-f506-4831-81f4-18d98327c038, remote_addr: 127.0.0.1:36075, local_addr: 127.0.0.1:9998
Mar 18 15:19:27.896 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/5, method: GET, req_id: adee2910-6e22-489d-8e40-45889e7e51bc, remote_addr: 127.0.0.1:36075, 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 15:19:42.142 INFO accepted connection, remote_addr: 127.0.0.1:53900, 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 15:19:42.143 INFO request completed, latency_us: 180, response_code: 204, uri: /shutdown, method: POST, req_id: 91d131b4-d852-47cc-87cb-d01b22d23384, remote_addr: 127.0.0.1:53900, local_addr: 127.0.[8820] Disable keep_running
0.1:9998[8820] Got stop action so:false kr:false

[8810] Disable keep_running
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8810] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8850][4] reports Exit
[8860][5] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
/var/tmp/bins/dsc create --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.026215104
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.024868444
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.024628015
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.02413766
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.023951108
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024327604
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.024009448
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 ds: 8820
start access at:127.0.0.1:9998
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
Starting downstairs at port 8810
start ds: 8870
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8810][0] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8820][1] initial start wait reports Starting
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8850
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8830][2] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8840][3] initial start wait reports Starting
Starting downstairs at port 8860
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/8850 port 8850 PID:Some(1272)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1273)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1274)
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1275)
Mar 18 15:19:47.368 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1276)
[8810][0] initial start wait reports Running
[8830][2] initial start wait reports Running
All downstairs are running
Control access at:127.0.0.1:9998
Mar 18 15:19:52.397 INFO accepted connection, remote_addr: 127.0.0.1:33900, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.399 INFO request completed, latency_us: 293, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8fc4e48e-9d7b-4f57-b208-73d3cf65602e, remote_addr: 127.0.0.1:33900, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.452 INFO accepted connection, remote_addr: 127.0.0.1:64518, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.452 INFO request completed, latency_us: 165, response_code: 200, uri: /state/cid/1, method: GET, req_id: 133fb973-9505-40aa-96b6-93a66a0e1ebe, remote_addr: 127.0.0.1:64518, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.507 INFO accepted connection, remote_addr: 127.0.0.1:42305, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.507 INFO request completed, latency_us: 153, response_code: 200, uri: /state/cid/2, method: GET, req_id: c7291323-0c1d-4951-940a-28489bace9cd, remote_addr: 127.0.0.1:42305, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.561 INFO accepted connection, remote_addr: 127.0.0.1:45700, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.562 INFO request completed, latency_us: 164, response_code: 200, uri: /state/cid/3, method: GET, req_id: c4e5332a-a661-4da7-b610-81afc47a0d59, remote_addr: 127.0.0.1:45700, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.616 INFO accepted connection, remote_addr: 127.0.0.1:41607, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.617 INFO request completed, latency_us: 157, response_code: 200, uri: /state/cid/4, method: GET, req_id: 8672fd54-1b3e-477a-9aa8-f1d97b163053, remote_addr: 127.0.0.1:41607, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.671 INFO accepted connection, remote_addr: 127.0.0.1:54182, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.672 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/5, method: GET, req_id: a2a25bb8-5096-4dfb-b1f2-546adc1532e9, remote_addr: 127.0.0.1:54182, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.727 INFO accepted connection, remote_addr: 127.0.0.1:37033, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.727 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/6, method: GET, req_id: c611a789-2bea-40df-b82f-59e7e2541452, remote_addr: 127.0.0.1:37033, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.783 INFO accepted connection, remote_addr: 127.0.0.1:35545, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.783 INFO request completed, latency_us: 169, response_code: 200, uri: /port/cid/6, method: GET, req_id: ac0884db-c96e-43c6-9510-3e7efa6e684f, remote_addr: 127.0.0.1:35545, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.843 INFO accepted connection, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.843 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: e6c8690d-eab4-4c97-b977-e8437f392cec, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.844 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: c3507104-c6ff-4afc-9314-a2c0753cd75e, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.845 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: 38b449b2-3fe5-4e9d-bfa1-56b899d7c1e4, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.845 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/1, method: GET, req_id: d7d88ad5-dc5a-4e97-8b0d-5aa25cd5fbc9, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.846 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9a07a99b-9e80-4072-8a06-3be0bba5f877, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.848 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 9195c999-f86a-4cfc-8f54-3c63b5d7d3d1, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.849 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 05090515-b1e7-4f52-8de5-727c07e7d238, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.849 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4af8945d-bf68-4906-abd1-15dbf5c3e243, remote_addr: 127.0.0.1:54812, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.888 INFO accepted connection, remote_addr: 127.0.0.1:41713, local_addr: 127.0.0.1:9998
Mar 18 15:19:52.888 INFO request completed, latency_us: 138, response_code: 200, uri: /regioncount, method: GET, req_id: adab22eb-ff8f-4ac3-aef8-5575f607914d, remote_addr: 127.0.0.1:41713, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Mar 18 15:19:53.066 INFO request completed, latency_us: 214, response_code[8810] Got stop action so:false kr:false
: 204, uri: /stop/cid/0, method: POST, req_id: 0a8dc32a-4fb5-4298-b2e8-392f6bf607a3, remote_addr: 127.0.0.1:41713, local_addr: 127.0.0.1:9998
Mar 18 15:19:53.067 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8f16423f-6fab-4759-9532-3b12511c5951, remote_addr: 127.0.0.1:41713, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Mar 18 15:19:57.068 INFO request completed, latency_us: 186, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1f68c8f1-975c-468e-9dc9-1248b15d9ad4, remote_addr: 127.0.0.1:41713, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Mar 18 15:19:57.243 INFO request completed, latency_us: 207, response_code: 204, uri: /start/cid/0, method: POST, req_id: d6170aee-171a-40a4-aec8-c0f544169873, remote_addr: 127.0.0.1:41713, local_addr: 127.0.0.1:9998
Mar 18 15:19:57.243 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/0, method: GET, req_id: e3607c48-37e5-4dc0-98c9-3ab52f0878fd, remote_addr: 127.0.0.1:41713, 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 15:20:01.245 INFO request completed, latency_us: 305, response_code: 200, uri: /state/cid/0, method: GET, req_id: df079f3e-2f7d-4cba-a8be-5d248ec6b3f0, remote_addr: 127.0.0.1:41713, local_addr: 127.0.0.1:9998
Mar 18 15:20:32.105 INFO accepted connection, remote_addr: 127.0.0.1:56917, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Mar 18 15:20:32.105 INFO request completed, latency_us: 178, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 67339379-ba89-4e04-a3c9-10da6553070b, remote_addr: 127.0.0.1:56917, local_addr: 127.0.0.1:9998
[8820] Got stop action so:false kr:false
Mar 18 15:20:32.106 INFO request completed, latency_us: 190, response_code: 200, uri: /state/cid/1, method: GET, req_id: 9bb332f8-10a5-48b2-bd25-5f093cb6068e, remote_addr: 127.0.0.1:56917, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Mar 18 15:20:36.108 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/1, method: GET, req_id: 89974c4a-9e96-4973-a3b3-a4eaa8214265, remote_addr: 127.0.0.1:56917, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Mar 18 15:20:36.283 INFO request completed, latency_us: 196, response_code: 204, uri: /start/cid/1, method: POST, req_id: cfda6d54-1202-42e5-96da-bc4f0ab3cb87, remote_addr: 127.0.0.1:56917, local_addr: 127.0.0.1:9998
Mar 18 15:20:36.284 INFO request completed, latency_us: 127, response_code: 200, uri: /state/cid/1, method: GET, req_id: 06c4df06-44d4-43e6-929b-6b11745fee2f, remote_addr: 127.0.0.1:56917, 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 15:20:40.286 INFO request completed, latency_us: 305, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8a9c6ef1-5d82-406b-9b3a-a7aaa73731bb, remote_addr: 127.0.0.1:56917, local_addr: 127.0.0.1:9998
Mar 18 15:21:11.323 INFO accepted connection, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 15:21:11.326 INFO request completed, latency_us: 188, response_code[8830] Got stop action so:false kr:false
: 204, uri: /stop/cid/2, method: POST, req_id: a049b1f4-9c7a-4e9d-a24a-d8be7847b2fd, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Mar 18 15:21:11.327 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/2, method: GET, req_id: dbd6b0fa-223d-4e11-a072-1884c8a798b7, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 15:21:15.329 INFO request completed, latency_us: 195, response_code: 200, uri: /state/cid/2, method: GET, req_id: e83c2523-df23-447d-a8e3-0bbb8dc5ad8b, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 15:21:15.501 INFO request completed, latency_us: 196, response_code: 204, uri: /start/cid/2, method: POST, req_id: 3e25403a-286c-4942-9f02-0ebc0ecf711f, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Mar 18 15:21:15.502 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4cebd052-3160-4846-920d-a5c0bfa7fd2b, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Mar 18 15:21:19.504 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0fc955ec-9eed-409b-a6c8-b7915c31433f, remote_addr: 127.0.0.1:37056, 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 15:21:23.507 INFO request completed, latency_us: 351, response_code: 200, uri: /state/cid/2, method: GET, req_id: 891e8582-b8b3-497a-9946-0720d71f2185, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 15:21:29.695 INFO [8830] Got stop action so:false kr:false
request completed, latency_us: 205, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 3b9cff8a-8a54-4ca9-93fd-87041e1497c7, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Mar 18 15:21:29.696 INFO request completed, latency_us: 238, response_code: 200, uri: /state/cid/2, method: GET, req_id: 760e37fd-f903-4bdc-93af-3f401b85264a, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 15:21:33.698 INFO request completed, latency_us: 204, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2b163e69-ff61-4cc2-b9de-8f12a6bae678, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 15:21:33.871 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/2, method: POST, req_id: 3ee9ee00-d08f-45eb-9caa-cba420a45952, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Mar 18 15:21:33.872 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/2, method: GET, req_id: abc2ee36-90e6-4322-beac-f268d1011182, remote_addr: 127.0.0.1:37056, 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 15:21:37.874 INFO request completed, latency_us: 359, response_code: 200, uri: /state/cid/2, method: GET, req_id: 39505860-0a09-433c-a796-c8e50b8a0145, remote_addr: 127.0.0.1:37056, local_addr: 127.0.0.1:9998
Mar 18 15:22:08.259 INFO accepted connection, remote_addr: 127.0.0.1:58573, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Mar 18 15:22:08.259 INFO request completed, latency_us: 181, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 8790187e-ef90-412d-b67b-edd83d410f1f, remote_addr: 127.0.0.1:58573, local_addr: 127.0.0.1:9998
[8840] Got stop action so:false kr:false
Mar 18 15:22:08.260 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/3, method: GET, req_id: ab8192a7-a515-4dcf-8fdb-02a04e7be491, remote_addr: 127.0.0.1:58573, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Mar 18 15:22:12.262 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/3, method: GET, req_id: 583b3eca-f0b3-4b0b-a496-be0ef926b874, remote_addr: 127.0.0.1:58573, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Mar 18 15:22:12.441 INFO request completed, latency_us: 197, response_code: 204, uri: /start/cid/3, method: POST, req_id: 1992badb-00f8-4f86-a7fa-ccaa0772e0e9, remote_addr: 127.0.0.1:58573, local_addr: 127.0.0.1:9998
Mar 18 15:22:12.441 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2f3617c9-9ea8-4c3c-becb-918629f4f912, remote_addr: 127.0.0.1:58573, 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(1291)
[8840][3] reports Running
Mar 18 15:22:16.444 INFO request completed, latency_us: 364, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2c2b7667-c87d-41c9-a6e5-9e2148b5585c, remote_addr: 127.0.0.1:58573, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.875 INFO accepted connection, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.876 INFO request completed, latency_us: 193, response_code: 200, uri: /regioninfo, method: GET, req_id: bd21aef0-ddf6-49c7-a72c-e9062f5a19d0, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.877 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 4e607b01-6d30-4cd1-b221-81fcfe2ec4f4, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.877 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/0, method: GET, req_id: f029cd6b-86d6-40ae-8881-21e67e415078, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.878 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/1, method: GET, req_id: d63ac6cb-d874-44df-877c-fd473b977786, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.878 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5c8b6ef8-3538-4802-bc35-5c2d0ef680d3, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.880 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/3, method: GET, req_id: 56322105-08da-4b70-b0ee-4dd0b0f3a772, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.881 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: 04487477-72b8-4b56-8730-ae979ac4f831, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:46.881 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1485ba61-6792-4d98-8832-a6510a7b4afe, remote_addr: 127.0.0.1:59402, local_addr: 127.0.0.1:9998
Mar 18 15:22:47.648 INFO accepted connection, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
Mar 18 15:22:47.649 INFO request completed, latency_us: 141, response_code: 200, uri: /regioncount, method: GET, req_id: 50692d2a-9587-4ee8-bc21-a46cf7512837, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Mar 18 15:22:51.521 INFO request completed, latency_us: [8810] Got stop action so:false kr:false
219, response_code: 204, uri: /stop/cid/0, method: POST, req_id: e0960a0f-5c23-410a-bc45-e4cb0dba6782, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
Mar 18 15:22:51.522 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/0, method: GET, req_id: a4dba5a0-6bb9-44db-b5dd-4f32535c19bd, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Mar 18 15:22:55.525 INFO request completed, latency_us: 181, response_code: 200, uri: /state/cid/0, method: GET, req_id: cf7098f6-0c6f-4916-a272-be3fc25f098d, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
Mar 18 15:23:29.096 INFO accepted connection, remote_addr: 127.0.0.1:45624, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Mar 18 15:23:29.096 INFO request completed, latency_us: 168, response_code: 204, uri: /start/cid/0, method: POST, req_id: 27f0259e-c3aa-4d9f-8e9b-921c71b8a2a8, remote_addr: 127.0.0.1:45624, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Mar 18 15:23:33.280 INFO request completed[8820] Got stop action so:false kr:false
, latency_us: 195, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 1ac814c5-e131-40de-80ed-fad04c77b7f4, remote_addr: 127.0.0.1:45624, local_addr: 127.0.0.1:9998
Mar 18 15:23:33.281 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/1, method: GET, req_id: a44b8116-11d2-495c-8582-0d34f0fe8d38, remote_addr: 127.0.0.1:45624, 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(1293)
[8810][0] reports Running
Mar 18 15:23:37.284 INFO request completed, latency_us: 322, response_code: 200, uri: /state/cid/1, method: GET, req_id: 07e734eb-63cb-460a-92ad-5065d140c81d, remote_addr: 127.0.0.1:45624, local_addr: 127.0.0.1:9998
Mar 18 15:24:10.877 INFO accepted connection, remote_addr: 127.0.0.1:50788, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Mar 18 15:24:10.877 INFO request completed, latency_us: 192, response_code: 204, uri: /start/cid/1, method: POST, req_id: 16a02b67-8fe0-4843-a840-2556f1b35289, remote_addr: 127.0.0.1:50788, 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(1294)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 18 15:24:15.062 INFO request completed, latency_us[8830] Got stop action so:false kr:false
: 299, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 1b2fd7e9-1eee-4ae7-9326-d4df2b89d179, remote_addr: 127.0.0.1:50788, local_addr: 127.0.0.1:9998
Mar 18 15:24:15.063 INFO request completed, latency_us: 125, response_code: 200, uri: /state/cid/2, method: GET, req_id: 143be067-376f-4cb9-8c2c-8484f7b2c81f, remote_addr: 127.0.0.1:50788, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 18 15:24:19.066 INFO request completed, latency_us: 199, response_code: 200, uri: /state/cid/2, method: GET, req_id: 54717675-d9ed-4dd9-9676-672c5e31c81d, remote_addr: 127.0.0.1:50788, local_addr: 127.0.0.1:9998
Mar 18 15:24:52.615 INFO accepted connection, remote_addr: 127.0.0.1:48261, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 18 15:24:52.615 INFO request completed, latency_us: 169, response_code: 204, uri: /start/cid/2, method: POST, req_id: 62b0e56e-dd51-4b25-bcc0-7f85b9ae4019, remote_addr: 127.0.0.1:48261, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Mar 18 15:24:56.815 INFO request completed, latency_us: 197, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 59cbc67d-dd43-4aad-b21b-f793ea3214bb, remote_addr: 127.0.0.1:48261, local_addr: 127.0.0.1:9998[8840] Got stop action so:false kr:false

Mar 18 15:24:56.816 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/3, method: GET, req_id: 0ac2c006-9f61-4409-8aeb-333bcedc1d0d, remote_addr: 127.0.0.1:48261, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] 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(1295)
[8830][2] reports Running
Mar 18 15:25:00.819 INFO request completed, latency_us: 380, response_code: 200, uri: /state/cid/3, method: GET, req_id: 828ed3e2-682f-4013-92a1-afd1a0358ad7, remote_addr: 127.0.0.1:48261, local_addr: 127.0.0.1:9998
Mar 18 15:25:34.400 INFO accepted connection, remote_addr: 127.0.0.1:55299, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Mar 18 15:25:34.400 INFO request completed, latency_us: 205, response_code: 204, uri: /start/cid/3, method: POST, req_id: 2ee1fde5-44e8-4ff5-bbcf-56f05eae214f, remote_addr: 127.0.0.1:55299, 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(1296)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Mar 18 15:25:38.636 [8850] Got stop action so:false kr:false
INFO request completed, latency_us: 349, response_code: 204, uri: /stop/cid/4, method: POST, req_id: c7bf4d9f-3c9e-4d6f-8cb8-c5372d7f088e, remote_addr: 127.0.0.1:55299, local_addr: 127.0.0.1:9998
Mar 18 15:25:38.637 INFO request completed, latency_us: 115, response_code: 200, uri: /state/cid/4, method: GET, req_id: 1bd44e38-18e8-4b7d-ae74-2056f133f8af, remote_addr: 127.0.0.1:55299, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Mar 18 15:25:42.639 INFO request completed, latency_us: 199, response_code: 200, uri: /state/cid/4, method: GET, req_id: 627b8464-12c4-4e77-b6ec-19469efa1ee9, remote_addr: 127.0.0.1:55299, local_addr: 127.0.0.1:9998
Mar 18 15:26:16.221 INFO accepted connection, remote_addr: 127.0.0.1:49141, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Mar 18 15:26:16.221 INFO request completed, latency_us: 194, response_code: 204, uri: /start/cid/4, method: POST, req_id: 6bcd81c5-d30f-47cb-8f73-9233ec5dedbd, remote_addr: 127.0.0.1:49141, 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(1297)
[8850][4] reports Running
Mar 18 15:26:20.291 INFO accepted connection, remote_addr: 127.0.0.1:34320, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Mar 18 15:26:20.292 INFO request completed, latency_us: 219, response_code: 204, uri: /shutdown, method: POST, req_id: 823ab7ac-0786-49db-8336-664b27df53f4, remote_addr: 127.0.0.1:34320, local_addr: [8810] Disable keep_running
127[8810] Got stop action so:false kr:false
.[8820] Disable keep_running
0.0.1:9998
Shut it down
[8830] Disable keep_running
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8820] Got stop action so:false kr:false
[8850] Disable keep_running
[8830] Got stop action so:false kr:false
[8860] Disable keep_running
[8850] Got stop action so:false kr:false
[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))
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840][3] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8870][6] reports Exit