/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.23437406
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.01847308
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017965188
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.020851685
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.019474732
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.018330496
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 access at:127.0.0.1:9998
start ds: 8840
start ds: 8850
Starting downstairs at port 8810
start ds: 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8840
[8810][0] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8840][3] initial start wait reports Starting
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] 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
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1191)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1192)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1193)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1195)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1194)
[8820][1] initial start wait reports Running
[8840][3] initial start wait reports Running
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1196)
Jan 23 17:37:40.641 INFO listening, local_addr: 127.0.0.1:9998
[8810][0] initial start wait reports Running
All downstairs are running
Jan 23 17:37:45.676 INFO accepted connection, remote_addr: 127.0.0.1:63853, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.678 INFO request completed, latency_us: 601, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6b0f671c-4fe1-449b-8ede-cb675f47a91c, remote_addr: 127.0.0.1:63853, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.737 INFO accepted connection, remote_addr: 127.0.0.1:48389, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.737 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5eaaf229-48e4-423e-aa92-23bc426ebb85, remote_addr: 127.0.0.1:48389, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.794 INFO accepted connection, remote_addr: 127.0.0.1:51421, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.795 INFO request completed, latency_us: 171, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4df71a58-b919-4cb2-a401-635273a27d0e, remote_addr: 127.0.0.1:51421, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.853 INFO accepted connection, remote_addr: 127.0.0.1:49099, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.853 INFO request completed, latency_us: 165, response_code: 200, uri: /state/cid/3, method: GET, req_id: c59a049a-0f38-4123-a2c3-b8f63277a0a0, remote_addr: 127.0.0.1:49099, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.910 INFO accepted connection, remote_addr: 127.0.0.1:53472, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.910 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/4, method: GET, req_id: f8f41791-e214-4d33-8509-faf781d3bb84, remote_addr: 127.0.0.1:53472, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.966 INFO accepted connection, remote_addr: 127.0.0.1:41153, local_addr: 127.0.0.1:9998
Jan 23 17:37:45.967 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/5, method: GET, req_id: f3b330ef-24c4-4fe7-98ca-17f63ca8e87e, remote_addr: 127.0.0.1:41153, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.023 INFO accepted connection, remote_addr: 127.0.0.1:35259, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Jan 23 17:37:46.024 INFO request completed, latency_us: 174, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 0f2f36da-98f5-4603-ad68-c7d4bed64372, remote_addr: [8810] Disable keep_running
127[8830] Disable keep_running
.0.[8820] Disable keep_running
0[8840] Disable keep_running
.[8860] Disable keep_running
1:35259, local_addr: [8850] Disable keep_running
127.0.0.1:9998
Jan 23 17:37:46.141 INFO accepted connection, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.142 INFO request completed, latency_us: 235, response_code: 200, uri: /regioninfo, method: GET, req_id: 86c74ce8-b73c-4e8b-bb80-2cbc5ca745ac, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.145 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: 9f4e395a-0330-4a76-a1c7-4e8f84787ab9, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.146 INFO request completed, latency_us: 137, response_code: 200, uri: /port/cid/0, method: GET, req_id: 753bc401-64a3-406b-a38a-e39798df2433, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.146 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: af0bfe2a-b941-466e-b91f-1e810d8527d3, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.147 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1da4bf68-059b-4c9f-bb04-d8be34e5c1ba, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.152 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/3, method: GET, req_id: 42876c9d-80f1-4d32-ae30-74a37f7ef0d2, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.152 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: 5eb86bcb-2370-4a0b-8074-69b41d020d68, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:46.153 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4da91e13-ed58-4992-a32d-a648317f9555, remote_addr: 127.0.0.1:43549, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.274 INFO accepted connection, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.274 INFO request completed, latency_us: 146, response_code: 200, uri: /regioninfo, method: GET, req_id: b10c8a44-a326-4c00-a34e-493e1820ee62, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.275 INFO request completed, latency_us: 109, response_code: 200, uri: /regioncount, method: GET, req_id: 33709dd6-5be6-45ae-b32c-0d2ab16079c7, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.276 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/0, method: GET, req_id: 34e3b747-2abe-4f60-873f-8bc71c4e3715, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.276 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: 76bb5c94-a5a7-4b7f-925c-074607ce289c, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.277 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: a3a26aba-f43a-40c9-b8c3-42871bf6361b, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.279 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/3, method: GET, req_id: b828614e-b426-425a-8a3a-3c318e562985, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.279 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/4, method: GET, req_id: 4c68243a-2422-4663-b314-c78d16c93cbb, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:37:55.280 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/5, method: GET, req_id: 434d8cf1-ab7f-4779-b7b7-a48c8e7b72c3, remote_addr: 127.0.0.1:42044, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.852 INFO accepted connection, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.853 INFO request completed, latency_us: 165, response_code: 200, uri: /regioninfo, method: GET, req_id: 46c63686-5336-42e1-a82d-0d0fd120c29e, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.854 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: 4d214622-a325-4c55-a4fa-0eeb7a862485, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.855 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1a5f6d4e-fdc0-4238-a858-9f567d0504b2, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.855 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 53a4a3b7-f69a-4581-8a25-bddc0ab5d74e, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.856 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7a4cf4c9-037e-4865-8d05-99839652e7a2, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.858 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5ee1808d-ae30-4fdd-a493-34e1116aa465, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.858 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 7eafb8be-bae2-4208-bd31-c90a30c3f158, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:04.859 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6bc59856-d2c6-4ca7-a057-cce4889c5997, remote_addr: 127.0.0.1:46532, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.528 INFO accepted connection, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.529 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: d703e11a-a53f-4244-ad1a-f896f515273f, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.530 INFO request completed, latency_us: 112, response_code: 200, uri: /regioncount, method: GET, req_id: 4223257c-264a-406f-b8cc-ad969b54e6f0, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.531 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: ac2e88c7-791a-4ab1-afde-9e5e3067cdd9, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.531 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 66b4c57e-9f6f-4809-8fef-680b44e0e4b8, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.532 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 14c87949-5024-4161-981e-9a175377e40e, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.534 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/3, method: GET, req_id: 0df936fe-9dc3-4355-ae6c-767311a861d6, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.534 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: 53518136-ec5c-4974-bd83-c9c8f6791e4e, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:38:43.535 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 961860d9-ae76-4d88-bf8d-7f5981771eb3, remote_addr: 127.0.0.1:60942, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.688 INFO accepted connection, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.688 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: d4e49820-50ac-4672-99ea-0aefa8fed47f, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.689 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: 401d35ed-a245-4f00-8ca3-20b02eb8bf44, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.690 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: bdbb487c-cd6f-4e4d-a25c-795f8de52b54, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.690 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/1, method: GET, req_id: 1e108253-7f2f-4b83-8b40-5e23648782d3, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.691 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: e6b0e761-7d3b-4506-b5b2-d1f484f255d4, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.693 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: 04a7c4df-224d-4b71-9aaa-db431d1a08d2, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.693 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0271d9c5-e626-4d59-abb0-af2e4ca3b89d, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:42:59.694 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 50d798f3-a761-4176-81ae-0b833b1709d1, remote_addr: 127.0.0.1:49234, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.159 INFO accepted connection, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.160 INFO request completed, latency_us: 170, response_code: 200, uri: /regioninfo, method: GET, req_id: e692dacd-71b9-4d73-a964-be475bfbdb32, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.161 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 991d0586-a539-47af-a4a4-eaf1dff5f0c0, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.162 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: a19a24cf-1253-4dac-a7c8-77aa226012d1, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.162 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 06da2b5c-e4f8-445e-bf2d-461c17275220, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.163 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 69cea005-3bd3-483f-80d4-881dde0d116f, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.165 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: 618783e0-66dc-4477-9d36-4a4caf23e1ca, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.165 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: c086c36d-2c31-4b47-ba68-d10aa218f02d, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:12.166 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/5, method: GET, req_id: d05e95cf-531b-4f47-ae99-3f1bd74d977a, remote_addr: 127.0.0.1:57096, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.374 INFO accepted connection, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.375 INFO request completed, latency_us: 161, response_code: 200, uri: /regioninfo, method: GET, req_id: 823ea696-60fa-43a9-a491-fc3f1d9ceb5c, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.376 INFO request completed, latency_us: 124, response_code: 200, uri: /regioncount, method: GET, req_id: 2493bd1c-4cee-4e95-9ce5-1a76b7cc4f69, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.376 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/0, method: GET, req_id: 297f21e2-95cf-40c4-8839-673aaf89366d, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.377 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: c6750b15-16ca-411d-b432-41a6d3f28540, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.377 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: b658c45e-2ec0-4065-832d-ba84c9a1728f, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.379 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/3, method: GET, req_id: 030180be-cdab-4a98-9154-ef13e59dafeb, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.380 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/4, method: GET, req_id: 3d150917-8fea-4eea-bfe0-36a37983208d, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:16.380 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: 570c65b1-f33f-4053-b0a7-6b3d2d58ba7e, remote_addr: 127.0.0.1:36627, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.584 INFO accepted connection, remote_addr: 127.0.0.1:60549, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Jan 23 17:44:20.585 INFO request completed, latency_us: 188, response_code: 204, uri: /disablerestart/all, method: POST, req_id: e249086b-2249-4264-833d-7fe0938a5697, remote_addr: [8820] Disable keep_running
127.[8830] Disable keep_running
0[8840] Disable keep_running
.[8850] Disable keep_running
0.1:60549, local_addr: 127.0.0.1:9998
[8860] Disable keep_running
[8810] Disable keep_running
Jan 23 17:44:20.642 INFO accepted connection, remote_addr: 127.0.0.1:50098, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 23 17:44:20.643 INFO request completed, latency_us: 177, response_code: 204, uri: /stop/cid/2, method: POST, req_id: b435a36c-3287-4d0a-84a8-f2cf1cbdf6f8, remote_addr: 127.0.0.1:50098, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 23 17:44:20.701 INFO accepted connection, remote_addr: 127.0.0.1:63149, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.702 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/2, method: GET, req_id: 357d02bb-1f88-4aa9-bb6f-51470f952830, remote_addr: 127.0.0.1:63149, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.763 INFO accepted connection, remote_addr: 127.0.0.1:52699, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 23 17:44:20.764 INFO request completed, latency_us: 192, response_code: 204, uri: /start/cid/2, method: POST, req_id: 38296a09-d16e-48a2-bae9-0eb86f113bb2, remote_addr: 127.0.0.1:52699, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.849 INFO accepted connection, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.850 INFO request completed, latency_us: 162, response_code: 200, uri: /regioninfo, method: GET, req_id: e2b464d8-3391-4b6a-9c1f-ef00910b0157, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.851 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: 2c26d91e-b559-44bc-8486-fbef7a75114b, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.852 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/0, method: GET, req_id: bc9bf190-f32c-4960-bd76-0e882287550e, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.852 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0b500438-aea7-44f7-a1c2-a63de0a439f0, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.853 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/2, method: GET, req_id: c54ff604-11ba-4c57-97ff-bc172aa5322f, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.855 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 50520e04-9c3a-4ba6-8793-bd178b062c27, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.855 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1ccb3c64-afa1-4bc8-be3d-39f63e1944d6, remote_addr: 127.0.0.1:52003, local_addr: 127.0.0.1:9998
Jan 23 17:44:20.856 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3f68c39e-4860-40c0-b4ac-8f017d4fa517, remote_addr: 127.0.0.1:52003, 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(1247)
[8830][2] reports Running
Jan 23 17:44:35.108 INFO accepted connection, remote_addr: 127.0.0.1:44609, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Jan 23 17:44:35.109 INFOShut it down
 request completed, latency_us: [8810] Disable keep_running
227, [8810] Got stop action so:false kr:false
response_code: 204, uri: /shutdown, method: POST, req_id: e59ed405-6846-4485-a31a-cfcf16e9d375, remote_addr: 127.0.0.1:44609, local_addr: 127.0.0.1:9998
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] 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))
[8840][3] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8810][0] reports Exit
[8850][4] 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.026405014
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.024697768
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.024239227
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.023846116
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.024359845
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024327513
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.024305897
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 ds: 8830
start ds: 8840
start ds: 8850
start access at:127.0.0.1:9998
start ds: 8860
Starting downstairs at port 8810
Starting downstairs at port 8820
start ds: 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8820][1] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8830
Starting downstairs at port 8840
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"
[8840][3] initial start wait reports Starting
Starting downstairs at port 8870
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8850][4] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8870][6] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1264)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1265)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1266)
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1267)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1268)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1269)
[8850][4] initial start wait reports Running
Jan 23 17:44:40.341 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1270)
[8810][0] initial start wait reports Running
All downstairs are running
Control access at:127.0.0.1:9998
Jan 23 17:44:45.370 INFO accepted connection, remote_addr: 127.0.0.1:46068, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.371 INFO request completed, latency_us: 337, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4e1e16af-7c1c-4996-bed9-05a05c0ab1ec, remote_addr: 127.0.0.1:46068, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.427 INFO accepted connection, remote_addr: 127.0.0.1:34594, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.428 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/1, method: GET, req_id: dd9f0ecc-ef40-4a45-8ac4-6ea3fd9d978b, remote_addr: 127.0.0.1:34594, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.484 INFO accepted connection, remote_addr: 127.0.0.1:42215, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.485 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/2, method: GET, req_id: 445aebd5-77ad-4f7e-a98c-eff70e853ee0, remote_addr: 127.0.0.1:42215, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.540 INFO accepted connection, remote_addr: 127.0.0.1:45646, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.541 INFO request completed, latency_us: 169, response_code: 200, uri: /state/cid/3, method: GET, req_id: fe98f1e1-72f6-4107-841c-8ae9377495f5, remote_addr: 127.0.0.1:45646, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.596 INFO accepted connection, remote_addr: 127.0.0.1:65511, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.596 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/4, method: GET, req_id: 18200290-4a0d-49a0-89fe-ab4578bb2876, remote_addr: 127.0.0.1:65511, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.654 INFO accepted connection, remote_addr: 127.0.0.1:48673, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.654 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/5, method: GET, req_id: 822f6063-8606-4ac3-ad76-358a16a90d5b, remote_addr: 127.0.0.1:48673, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.710 INFO accepted connection, remote_addr: 127.0.0.1:38293, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.711 INFO request completed, latency_us: 143, response_code: 200, uri: /state/cid/6, method: GET, req_id: 7252af1c-e495-4a50-a1f1-459167a7ec05, remote_addr: 127.0.0.1:38293, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.766 INFO accepted connection, remote_addr: 127.0.0.1:57420, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.767 INFO request completed, latency_us: 176, response_code: 200, uri: /port/cid/6, method: GET, req_id: cfcd1ce1-2cea-4cd4-b8b2-b1252741c143, remote_addr: 127.0.0.1:57420, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.829 INFO accepted connection, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.830 INFO request completed, latency_us: 201, response_code: 200, uri: /regioninfo, method: GET, req_id: 498828a7-c1a3-42f0-9079-cc71e1b02f07, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.831 INFO request completed, latency_us: 116, response_code: 200, uri: /regioncount, method: GET, req_id: 0fffb1b8-bbdb-4dd6-b8f7-ab9dee128b37, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.831 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 92f02ff8-2722-4756-b2ba-5d84963e1b6d, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.832 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/1, method: GET, req_id: 61c17eb2-3fa5-4cc1-8323-87cc39e6723c, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.832 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/2, method: GET, req_id: d1b152ec-6fad-4f78-98e8-55927a0215fe, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.834 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: 44ce02c7-2e9c-4ba8-878f-af658e65e688, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.835 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: a0d64708-8b99-476b-92bc-779ad5fb701d, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.835 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/5, method: GET, req_id: e0c30703-99af-4fb8-b8aa-5d165b59eff3, remote_addr: 127.0.0.1:51479, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.876 INFO accepted connection, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:44:45.876 INFO request completed, latency_us: 129, response_code: 200, uri: /regioncount, method: GET, req_id: a7ddbb2b-2d6c-4b5f-853b-dfeee99a22a7, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Jan 23 17:44:46.051 INFO request completed, latency_us[8810] Got stop action so:false kr:false
: 234, response_code: 204, uri: /stop/cid/0, method: POST, req_id: eda7f9f2-74e8-4339-8cb0-be7a343babad, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:44:46.052 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4d884297-2869-4ec9-a099-037ad13de44f, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Jan 23 17:44:50.054 INFO request completed, latency_us: 264, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8723b3fe-ba1c-400b-814c-ab43af2c144d, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Jan 23 17:44:50.225 INFO request completed, latency_us: 240, response_code: 204, uri: /start/cid/0, method: POST, req_id: 6b3f6cea-84c5-4cbb-8f65-41017ec0c20e, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:44:50.226 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/0, method: GET, req_id: 47d2f896-d9a7-4f5b-9b4f-7dd2056067c5, remote_addr: 127.0.0.1:40548, 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(1281)
[8810][0] reports Running
Jan 23 17:44:54.228 INFO request completed, latency_us: 343, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2f713654-43c3-472b-82fa-7d3063026524, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Jan 23 17:45:25.083[8820] Got stop action so:false kr:false
 INFO request completed, latency_us: 215, response_code: 204, uri: /stop/cid/1, method: POST, req_id: de409ac8-cf02-4a44-9fd4-9b78b04f7098, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:45:25.084 INFO request completed, latency_us: 178, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4c53f6b4-1dc1-4551-a207-aecd426026a5, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Jan 23 17:45:29.086 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/1, method: GET, req_id: 377eb5ca-f9d0-4505-9bcd-361d309b91e2, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Jan 23 17:45:29.256 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/1, method: POST, req_id: a71d493f-7ecc-4819-ba37-68a2e3bb05ed, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:45:29.256 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/1, method: GET, req_id: e4adf776-e526-49ad-8df7-52b83f5b81b3, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:45:33.258 INFO request completed, latency_us: 219, response_code: 200, uri: /state/cid/1, method: GET, req_id: 96225218-8089-4757-b09f-57dab16a2f75, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:45:37.261 INFO request completed, latency_us: 240, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8b94e8de-8e6b-4ae3-83f6-991864b65144, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:45:41.263 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/1, method: GET, req_id: de5ff9e4-9e39-4208-8d14-7a7bcb1abe6b, remote_addr: 127.0.0.1:40548, 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(1282)
[8820][1] reports Running
Jan 23 17:45:45.266 INFO request completed, latency_us: 359, response_code: 200, uri: /state/cid/1, method: GET, req_id: e8a6c608-5eab-4918-bf85-a5d72dbaa7f9, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Jan 23 17:45:51.445[8820] Got stop action so:false kr:false
 INFO request completed, latency_us: 217, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 45e540fc-c7c0-4fed-a0aa-b4e25e0221f0, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:45:51.446 INFO request completed, latency_us: 196, response_code: 200, uri: /state/cid/1, method: GET, req_id: 77131583-b2ba-433d-8f07-07fab459eac5, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Jan 23 17:45:55.448 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/1, method: GET, req_id: a49b9109-7b0d-4d8e-acb7-0829e6670175, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Jan 23 17:45:55.621 INFO request completed, latency_us: 265, response_code: 204, uri: /start/cid/1, method: POST, req_id: dedd37fd-c86b-4c97-b5a5-67363c98092c, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:45:55.622 INFO request completed, latency_us: 110, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8a9c84ea-cc0e-43d3-b2fa-f8a298e24307, remote_addr: 127.0.0.1:40548, 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(1283)
[8820][1] reports Running
Jan 23 17:45:59.624 INFO request completed, latency_us: 359, response_code: 200, uri: /state/cid/1, method: GET, req_id: 843cd9ba-0d12-4dd1-a669-735d4bff80dc, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 23 17:46:29.845 INFO request completed, latency_us: 228, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 0d5c2298-03e4-466c-af1f-1443592cb086, remote_addr: 127[8830] Got stop action so:false kr:false
.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:46:29.845 INFO request completed, latency_us: 153, response_code: 200, uri: /state/cid/2, method: GET, req_id: 01d9968e-3234-402a-85db-9caa5f41bc22, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 23 17:46:33.848 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7781fa08-2ab6-4139-9543-c81352659adb, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 23 17:46:34.021 INFO request completed, latency_us: 233, response_code: 204, uri: /start/cid/2, method: POST, req_id: 0c182d0c-a357-46b8-aa7c-f2906d885e75, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:46:34.021 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/2, method: GET, req_id: f3776903-8762-4848-bec5-13a3d129dc37, remote_addr: 127.0.0.1:40548, 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(1284)
[8830][2] reports Running
Jan 23 17:46:38.024 INFO request completed, latency_us: 375, response_code: 200, uri: /state/cid/2, method: GET, req_id: f4ad9b84-d436-4649-bb89-9c34f58f0f14, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Jan 23 17:47:08.399[8840] Got stop action so:false kr:false
 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 165c1537-4cdb-43d7-bb22-3105da1a755d, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:47:08.400 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/3, method: GET, req_id: e6362f38-8fd1-4c50-bdc9-fb802b9d873c, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Jan 23 17:47:12.402 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/3, method: GET, req_id: 316819ca-69c2-4d63-9c22-8ecfe94c0410, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Jan 23 17:47:12.577 INFO request completed, latency_us: 224, response_code: 204, uri: /start/cid/3, method: POST, req_id: 5e3c6f19-26a4-468d-b2ef-82014862cec3, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:47:12.577 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/3, method: GET, req_id: b5dd4010-31d5-476a-9163-00d03a67eb63, remote_addr: 127.0.0.1:40548, 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(1285)
[8840][3] reports Running
Jan 23 17:47:16.579 INFO request completed, latency_us: 335, response_code: 200, uri: /state/cid/3, method: GET, req_id: ff320968-674f-45fe-8634-007b3073f8a6, remote_addr: 127.0.0.1:40548, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.031 INFO accepted connection, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.032 INFO request completed, latency_us: 166, response_code: 200, uri: /regioninfo, method: GET, req_id: 38f16743-9ce3-4823-ba70-c0cf9e5a4ef2, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.033 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: 327810ba-41c9-4b4d-8090-266e3b1c8ee0, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.033 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: fecccc67-c3a0-4331-803c-60d262b2a549, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.034 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: e37a437d-3b1b-4633-9118-28582867457b, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.034 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: acdf3d45-4f5e-454f-a2cf-c7d0f6942140, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.036 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: 627c725b-2ade-4277-b146-ced1cf8c84ba, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.037 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: b24fce5d-2b8d-48d9-a978-e46cbb6dcf4d, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:47.037 INFO request completed, latency_us: 121, response_code: 200, uri: /port/cid/5, method: GET, req_id: 78b3a9cd-3fd9-460e-bbb3-ff7a1eff74a1, remote_addr: 127.0.0.1:53611, local_addr: 127.0.0.1:9998
Jan 23 17:47:48.584 INFO accepted connection, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Jan 23 17:47:48.585 INFO request completed, latency_us: 163, response_code: 200, uri: /regioncount, method: GET, req_id: 53c9c5ce-92b7-44a7-b8b5-ac8af9819a5f, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Jan 23 17:47:52.495 INFO request completed, latency_us: 222, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 50352b94-8447-41cd-b223-0c5c7a08caee, [8810] Got stop action so:false kr:false
remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Jan 23 17:47:52.496 INFO request completed, latency_us: 168, response_code: 200, uri: /state/cid/0, method: GET, req_id: a65b94fb-9e88-4b02-9287-cc95ad73ad78, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Jan 23 17:47:56.499 INFO request completed, latency_us: 230, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4e1daa36-5c29-401b-8c6f-551191ebf174, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Jan 23 17:48:30.152 INFO request completed, latency_us: 233, response_code: 204, uri: /start/cid/0, method: POST, req_id: ace89f4f-7921-4cc6-8a7e-65d236673412, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Jan 23 17:48:34.330 INFO request completed, latency_us: 211, response_code: 204, uri: /stop/cid/1, method: POST, req_id: fd1ffe83-227c-4813-a913-06b30596137c, remote_addr: [8820] Got stop action so:false kr:false
127.0.0.1:42790, local_addr: 127.0.0.1:9998
Jan 23 17:48:34.331 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/1, method: GET, req_id: b27ce64c-77da-40f4-987b-d827c917a487, remote_addr: 127.0.0.1:42790, 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(1287)
[8810][0] reports Running
Jan 23 17:48:38.334 INFO request completed, latency_us: 373, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4bac1804-ff8d-40b5-b1f5-1b6e15b57272, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Jan 23 17:49:12.028 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/1, method: POST, req_id: 96e76293-c109-4257-af47-9e8e42d66d3c, remote_addr: 127.0.0.1:42790, 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
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 23 17:49:16.210 INFO request completed, latency_us[8830] Got stop action so:false kr:false
: 318, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 64b30f8c-a941-4132-9a5e-22d98c6cc715, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Jan 23 17:49:16.211 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/2, method: GET, req_id: 32b1474e-80b8-4272-940c-4c069ca5b98d, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 23 17:49:20.213 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/2, method: GET, req_id: df98c5f4-4997-46e7-bad5-7dc0aab7c83a, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 23 17:49:53.897 INFO request completed, latency_us: 214, response_code: 204, uri: /start/cid/2, method: POST, req_id: 92fcfb8f-06f1-4a81-ac49-6c36b9562580, remote_addr: 127.0.0.1:42790, 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
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Jan 23 17:49:58.084 INFO request completed, [8840] Got stop action so:false kr:false
latency_us: 334, response_code: 204, uri: /stop/cid/3, method: POST, req_id: bef38a7d-ac7f-40d2-9da3-4cf1999edf53, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Jan 23 17:49:58.085 INFO request completed, latency_us: 149, response_code: 200, uri: /state/cid/3, method: GET, req_id: 223df0d1-8790-4650-bfcb-af20d4cc40cf, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Jan 23 17:50:02.087 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/3, method: GET, req_id: 9a24dd01-9750-4f69-8d79-f8e600515ec7, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Jan 23 17:50:35.762 INFO request completed, latency_us: 232, response_code: 204, uri: /start/cid/3, method: POST, req_id: 6c375a16-6e53-4651-9f81-b059cdea639b, remote_addr: 127.0.0.1:42790, 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(1290)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Jan 23 17:50:40.004 INFO request completed[8850] Got stop action so:false kr:false
, latency_us: 320, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 94146086-71ee-4eec-9fd9-0a2bc06ef1d3, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Jan 23 17:50:40.004 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/4, method: GET, req_id: 9d8bf353-7c29-4141-919c-4c4d9d98b999, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Jan 23 17:50:44.007 INFO request completed, latency_us: 194, response_code: 200, uri: /state/cid/4, method: GET, req_id: 916deb4f-7c7e-4adb-af54-1acb882acd7e, remote_addr: 127.0.0.1:42790, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Jan 23 17:51:17.675 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/4, method: POST, req_id: f1e5af57-45fc-43bb-a432-0a408e53fd95, remote_addr: 127.0.0.1:42790, 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(1291)
[8850][4] reports Running
Jan 23 17:51:21.749 INFO accepted connection, remote_addr: 127.0.0.1:51515, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Jan 23 17:51:21.750 INFO request completed, latency_us: 220, response_code[8810] Disable keep_running
: 204, uri: /shutdown, [8810] Got stop action so:false kr:false
method: POST, req_id: 273a62a2-f038-4be5-a9c7-15a9a7666ee0, remote_addr: 127.0.0.1:51515, local_addr: 127.0.0.1:9998
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8830] Disable keep_running
[8840] Disable keep_running
[8850] Disable keep_running
[8830] Got stop action so:false kr:false
[8840] Got stop action so:false kr:false
[8850] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8820][1] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit