/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.24796633
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018788205
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017080167
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.017391011
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.0176503
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.017570935
Created 6 regions
/var/tmp/bins/dsc start --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build --region-count 6
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 })
start ds: 8810
start access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
Starting downstairs at port 8810
Starting downstairs at port 8820
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8810][0] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8840][3] initial start wait reports Starting
[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(1197)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1198)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1199)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1202)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1201)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1200)
[8840][3] initial start wait reports Running
All downstairs are running
Mar 17 22:16:08.651 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Mar 17 22:16:13.670 INFO accepted connection, remote_addr: 127.0.0.1:54709, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.672 INFO request completed, latency_us: 524, response_code: 200, uri: /state/cid/0, method: GET, req_id: 51464ef5-6422-4a65-b5ca-20c1e5d239c7, remote_addr: 127.0.0.1:54709, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.725 INFO accepted connection, remote_addr: 127.0.0.1:62995, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.726 INFO request completed, latency_us: 127, response_code: 200, uri: /state/cid/1, method: GET, req_id: c40c81be-8545-486a-9ac7-663680f5a38e, remote_addr: 127.0.0.1:62995, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.777 INFO accepted connection, remote_addr: 127.0.0.1:49671, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.778 INFO request completed, latency_us: 140, response_code: 200, uri: /state/cid/2, method: GET, req_id: c9a4f676-b423-42e2-974f-63b427b743e8, remote_addr: 127.0.0.1:49671, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.829 INFO accepted connection, remote_addr: 127.0.0.1:47805, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.830 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/3, method: GET, req_id: f243b0a8-d8be-4144-a78c-5cacba07e61d, remote_addr: 127.0.0.1:47805, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.882 INFO accepted connection, remote_addr: 127.0.0.1:38548, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.882 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/4, method: GET, req_id: 5628135f-a418-4ccb-a540-4fb41000246c, remote_addr: 127.0.0.1:38548, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.934 INFO accepted connection, remote_addr: 127.0.0.1:34870, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.935 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/5, method: GET, req_id: 1d3effbf-0236-44e0-ab57-5b131bb5bf10, remote_addr: 127.0.0.1:34870, local_addr: 127.0.0.1:9998
Mar 17 22:16:13.988 INFO accepted connection, remote_addr: 127.0.0.1:64640, 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 17 22:16:13.989 INFO request completed, latency_us: 142, response_code: 204, uri: /disablerestart/all, method: POST, req_id: f84ea46f-191c-42d6-98d8-a2d03f721cea, remote_addr: 127.0[8810] Disable keep_running
.0.1:[8820] Disable keep_running
64640[8840] Disable keep_running
, [8850] Disable keep_running
local_addr: 127.0.0.1:9998
[8860] Disable keep_running
[8830] Disable keep_running
Mar 17 22:16:14.102 INFO accepted connection, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.103 INFO request completed, latency_us: 308, response_code: 200, uri: /regioninfo, method: GET, req_id: b7171568-827d-40ae-b27c-943d29329b4b, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.105 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: 5174c5da-8856-4b8e-995b-66df1d403a72, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.107 INFO request completed, latency_us: 143, response_code: 200, uri: /port/cid/0, method: GET, req_id: 779a8df4-380f-45df-bee3-e1cceca6fdf1, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.107 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 59c6b611-7853-48b8-8b48-cbc5357ab666, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.108 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/2, method: GET, req_id: 13e8df38-3c84-4d87-9f74-71af1cef9061, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.113 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/3, method: GET, req_id: a883ac25-722d-419d-b293-6ca2079406a9, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.113 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1099e601-983c-4e3f-a3c9-88d1a3daf091, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:14.114 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: dd56cf50-6f63-457e-8576-0bbe4dafdca0, remote_addr: 127.0.0.1:44034, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.233 INFO accepted connection, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.234 INFO request completed, latency_us: 152, response_code: 200, uri: /regioninfo, method: GET, req_id: 4940142b-8f83-4b9b-a5b0-36daf120cdad, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.235 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: fa343820-261a-4320-a3b8-d22a42683e4a, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.236 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: c2b3f5b4-f2d0-4302-8a81-7441c5c10dba, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.236 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 49685a0d-ab33-4d20-a9c0-3cddcb4db6f8, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.237 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: be4149fd-71bc-4f30-82cb-7527d6659e24, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.239 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4cb99cc3-1f1b-4462-84d3-58e912b60576, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.239 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 6b2608a5-be3c-49f7-92e0-9b4e256a6967, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:23.240 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8d31456a-ecfc-4629-ac4a-737c7cc826eb, remote_addr: 127.0.0.1:65069, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.823 INFO accepted connection, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.824 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: 243c50cb-e4a6-438d-95b3-2542da959755, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.825 INFO request completed, latency_us: 102, response_code: 200, uri: /regioncount, method: GET, req_id: 9fe6942b-9463-4785-ad0b-58c800353bb8, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.825 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6258b197-3528-4815-98c6-d8dd55b7e10d, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.826 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 085f096a-5d44-4df5-9a51-47b3a3df51eb, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.827 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/2, method: GET, req_id: ea55bf99-caa6-4299-8a7d-28285b9c431e, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.829 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8799d037-3356-486f-9fd8-5da1845ba319, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.829 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2c161f53-53cf-42e0-8c35-704d5394c7d3, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:16:32.830 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: c2694163-2bbc-492f-a9b8-c352e7e609ce, remote_addr: 127.0.0.1:52320, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.436 INFO accepted connection, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.437 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: a9dab531-0e3b-49bf-8aeb-3f3602fda413, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.438 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: c8662a6d-4db9-4aaf-8d72-4e6f1f32e2f8, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.439 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/0, method: GET, req_id: 29e21e9e-2d30-4940-9dc8-d6bca8a02c36, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.439 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 02e8785a-b35b-4448-a600-1b08b940a9a9, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.440 INFO request completed, latency_us: 149, response_code: 200, uri: /port/cid/2, method: GET, req_id: 0ae10811-c357-4f2d-8662-3c390cfbf05f, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.442 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: 27bdfb18-c55d-46fb-ae43-901f1371739d, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.442 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/4, method: GET, req_id: 32fd6048-715f-40fe-9f7c-60d7ff552c58, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:17:11.443 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: 347da2a7-4232-4f50-aaf4-22dd13073f7a, remote_addr: 127.0.0.1:49439, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.373 INFO accepted connection, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.374 INFO request completed, latency_us: 162, response_code: 200, uri: /regioninfo, method: GET, req_id: 27150bce-3990-45a6-8e82-98e77d8aa079, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.375 INFO request completed, latency_us: 106, response_code: 200, uri: /regioncount, method: GET, req_id: 2de3a584-4173-4111-9e77-2b9848b080e1, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.376 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 7a9242a7-5496-4d92-b864-5f27d4d07ea6, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.376 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/1, method: GET, req_id: bf10eb8a-d279-4119-9491-41a483d9a17e, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.377 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: b29aee9d-f769-449b-9707-9d39b1b773fc, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.379 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4c616378-ce9b-4a31-a385-02852615921e, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.379 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1befcc0a-c19e-4362-9319-1489ad58675b, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:21:29.380 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/5, method: GET, req_id: 09bc3305-e13d-4be9-a4bf-ffee61dad7be, remote_addr: 127.0.0.1:58669, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.214 INFO accepted connection, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.215 INFO request completed, latency_us: 155, response_code: 200, uri: /regioninfo, method: GET, req_id: 9c525435-1def-4235-a885-39e678b2e292, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.216 INFO request completed, latency_us: 119, response_code: 200, uri: /regioncount, method: GET, req_id: f8e1e0d3-d982-42f8-bf30-2786a388f80a, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.216 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/0, method: GET, req_id: ebc1f280-33a8-452b-9a30-ddf00ccf41a2, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.217 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: efaac92e-183b-4830-b39d-f4d07ddef91d, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.217 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: c70c9298-27c9-49de-8aa0-79dab23f8d2d, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.219 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: 3f6394dd-52bd-41c1-abf7-e344de2d32f6, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.220 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1b25cd43-1617-405b-a526-c81ac8f1e1c2, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:42.220 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 0ccb29a2-8d1a-4909-9686-32f9108e6dc4, remote_addr: 127.0.0.1:36004, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.424 INFO accepted connection, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.425 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: 216006a3-36b8-4a8b-ae5c-d813de05c7b5, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.426 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: 268fa56f-4bda-48aa-93e5-ad01a072443e, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.426 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/0, method: GET, req_id: acf2fb89-cda5-4835-aaaf-f223a85d191b, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.427 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: d635a6d2-e467-4b00-98c7-c7e857351dbb, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.428 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 09c4997f-8e01-4b1b-9b80-f4541c75514c, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.429 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/3, method: GET, req_id: 62b6720a-fd84-48f3-b44d-80a17c6c754d, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.430 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/4, method: GET, req_id: 3c8695be-12d8-438d-9fb3-a05521fe4b83, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:46.430 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: cdef8d4e-0f5a-44f4-a3e3-1072a3671f06, remote_addr: 127.0.0.1:64782, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.633 INFO accepted connection, remote_addr: 127.0.0.1:47341, 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 17 22:22:50.634 INFO request completed, latency_us: 176, response_code: 204, uri: /disablerestart/all, method: POST, [8810] Disable keep_running
req_id: 5e4b1944-2e8a-46ed-8d04-45e9b74d0c1b, [8830] Disable keep_running
remote_addr[8820] Disable keep_running
:[8860] Disable keep_running
 127.0.0.1:47341, local_addr: 127.0.0.1[8840] Disable keep_running
:9998
[8850] Disable keep_running
Mar 17 22:22:50.687 INFO accepted connection, remote_addr: 127.0.0.1:44271, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 17 22:22:50.687 INFO request completed, latency_us: 130, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 919142f5-7fa5-430b-bcc5-d4ed764c02e8, remote_addr: 127.0.0.1:44271, local_addr[8830] Got stop action so:false kr:false
: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 17 22:22:50.741 INFO accepted connection, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.742 INFO request completed, latency_us: 159, response_code: 200, uri: /state/cid/2, method: GET, req_id: c43fcd58-13b1-4b7d-8721-09385befa3aa, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.800 INFO accepted connection, remote_addr: 127.0.0.1:42928, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 17 22:22:50.801 INFO request completed, latency_us: 169, response_code: 204, uri: /start/cid/2, method: POST, req_id: 9842b7cd-7b0a-4a4f-b41d-7d9187d8a30e, remote_addr: 127.0.0.1:42928, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.881 INFO accepted connection, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.881 INFO request completed, latency_us: 150, response_code: 200, uri: /regioninfo, method: GET, req_id: ec11ae1c-1740-4fff-ac42-17d9aadbf61c, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.882 INFO request completed, latency_us: 98, response_code: 200, uri: /regioncount, method: GET, req_id: a69f459e-343a-4e9a-81c1-89c4f93b62a1, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.883 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2c656545-6bf9-4a75-83a9-4cd136d4cd58, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.884 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 532e9f4d-710f-413b-a3ce-3562d3cad691, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.884 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5b285d4e-91f7-4440-953b-4711e9bffb0b, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.886 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8216cfb3-d8fe-4492-8726-8df77f6cb839, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.887 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: b5350bd5-9e38-4a8b-8ee6-6a20b950a11f, remote_addr: 127.0.0.1:36836, local_addr: 127.0.0.1:9998
Mar 17 22:22:50.887 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: c405fd4c-d46e-4553-8ae5-09093dd9f4fa, remote_addr: 127.0.0.1:36836, 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 17 22:23:05.141 INFO accepted connection, remote_addr: 127.0.0.1:64427, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Mar 17 22:23:05.142 INFO request completed, latency_us: 205, [8820] Disable keep_running
response_code[8810] Disable keep_running
: 204, uri: /shutdown, method[8810] Got stop action so:false kr:false
: POST, req_id[8830] Disable keep_running
: 648d3b7c-1f36-4ae6-8c26-6c81219348fb[8830] Got stop action so:false kr:false
, remote_addr: 127.0.0.[8820] Got stop action so:false kr:false
1:64427, local_addr: 127.0.0.1:9998
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820][1] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
/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.026825998
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.024301255
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.024031622
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.023964597
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.024021983
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.023933172
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.024155246
Created 7 regions
/var/tmp/bins/dsc start --region-count 7 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 100 })
start ds: 8810
start access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start ds: 8870
Starting downstairs at port 8810
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8810][0] initial start wait reports Starting
[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 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8830][2] initial start wait reports Starting
Starting downstairs at port 8850
[8840][3] initial start wait reports Starting
[8850][4] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Starting downstairs at port 8860
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8860][5] initial start wait reports Starting
[8870][6] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1270)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1271)
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1272)
[8860][5] 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/8820 port 8820 PID:Some(1274)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1275)
[8850][4] initial start wait reports Running
Mar 17 22:23:10.368 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1276)
[8810][0] initial start wait reports Running
All downstairs are running
Mar 17 22:23:15.400 INFO accepted connection, remote_addr: 127.0.0.1:63534, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.401 INFO request completed, latency_us: 335, response_code: 200, uri: /state/cid/0, method: GET, req_id: ba7c4ec3-52ce-4a34-9131-94b05cf01d63, remote_addr: 127.0.0.1:63534, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.455 INFO accepted connection, remote_addr: 127.0.0.1:47179, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.456 INFO request completed, latency_us: 149, response_code: 200, uri: /state/cid/1, method: GET, req_id: 68feb8e6-aa49-49af-bf0d-7b08f6a28335, remote_addr: 127.0.0.1:47179, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.510 INFO accepted connection, remote_addr: 127.0.0.1:41161, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.510 INFO request completed, latency_us: 130, response_code: 200, uri: /state/cid/2, method: GET, req_id: 944a1e2a-be88-4703-852e-bfaa1d4e345e, remote_addr: 127.0.0.1:41161, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.564 INFO accepted connection, remote_addr: 127.0.0.1:58082, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.564 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/3, method: GET, req_id: b7d0e7c0-98e8-45c4-8523-c24738ccc3a3, remote_addr: 127.0.0.1:58082, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.618 INFO accepted connection, remote_addr: 127.0.0.1:65482, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.618 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/4, method: GET, req_id: 2d4475e3-7aed-41fe-9459-2aaae2f3d571, remote_addr: 127.0.0.1:65482, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.672 INFO accepted connection, remote_addr: 127.0.0.1:38153, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.672 INFO request completed, latency_us: 157, response_code: 200, uri: /state/cid/5, method: GET, req_id: 84e0b299-d637-422d-a83e-da6ec7069419, remote_addr: 127.0.0.1:38153, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.726 INFO accepted connection, remote_addr: 127.0.0.1:54884, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.726 INFO request completed, latency_us: 115, response_code: 200, uri: /state/cid/6, method: GET, req_id: 13b5897a-b2d6-4919-9833-6dd7a774d053, remote_addr: 127.0.0.1:54884, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.780 INFO accepted connection, remote_addr: 127.0.0.1:49645, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.780 INFO request completed, latency_us: 168, response_code: 200, uri: /port/cid/6, method: GET, req_id: 936b6c3f-0536-481c-8094-242cf86a7e5f, remote_addr: 127.0.0.1:49645, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.839 INFO accepted connection, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.840 INFO request completed, latency_us: 191, response_code: 200, uri: /regioninfo, method: GET, req_id: c4338be1-3f07-4ae7-a213-5124ee05d478, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.841 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: e050be31-87e3-4a83-bfc0-f1033dad0927, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.842 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 397403f2-e60f-4e6c-b54c-ee475b277bcc, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.842 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: 36ff9eb8-5e6a-4bd1-8075-99161d9d329e, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.843 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/2, method: GET, req_id: fbcb8a03-c834-4e39-97b1-adeb7c7820a3, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.845 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/3, method: GET, req_id: bc86ce47-30e2-4dfb-8771-ed60d9cb55e9, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.845 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0f42bc42-6dba-4905-9a53-63119dabff45, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.846 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1591f20c-875b-4527-862c-594aee627812, remote_addr: 127.0.0.1:51511, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.886 INFO accepted connection, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Mar 17 22:23:15.886 INFO request completed, latency_us: 111, response_code: 200, uri: /regioncount, method: GET, req_id: f33ca9fc-b42c-475b-b30d-225cf25de2bc, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Mar 17 22:23:16.074 INFO request completed, latency_us: 232, response_code: 204[8810] Got stop action so:false kr:false
, uri: /stop/cid/0, method: POST, req_id: ee05ea2e-227e-43d2-a467-7bec88cd5198, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Mar 17 22:23:16.075 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1cb926be-2d1b-4d97-858c-28304b33581f, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Mar 17 22:23:20.077 INFO request completed, latency_us: 239, response_code: 200, uri: /state/cid/0, method: GET, req_id: df0688fe-3268-4a23-966d-795e63e8799e, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Mar 17 22:23:20.252 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/0, method: POST, req_id: 4dc5b213-0144-4dc5-88a2-ad4f2c0fd54c, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Mar 17 22:23:20.252 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/0, method: GET, req_id: 08778023-c922-4eeb-b269-0476f9e90cd6, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Mar 17 22:23:24.255 INFO request completed, latency_us: 283, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7347a1b5-d32c-4e29-9b4e-648558985b12, remote_addr: 127.0.0.1:52412, 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 17 22:23:28.258 INFO request completed, latency_us: 422, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3681fe9d-eb4f-4393-a613-97349847ffc8, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Mar 17 22:23:34.442 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/0, method: [8810] Got stop action so:false kr:false
POST, req_id: f6964ad4-8c8b-484a-8570-329816f03b26, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Mar 17 22:23:34.443 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/0, method: GET, req_id: b37d6348-3fa4-4c7a-bfdc-f51ba52d7c9f, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Mar 17 22:23:38.446 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/0, method: GET, req_id: 220f4133-32e5-4454-aee0-289a8ca628ad, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Mar 17 22:23:38.625 INFO request completed, latency_us: 211, response_code: 204, uri: /start/cid/0, method: POST, req_id: aada35e3-ae52-4670-9b1d-2ead2e92f006, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Mar 17 22:23:38.625 INFO request completed, latency_us: 118, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3a250cff-cd00-45e6-b242-a23c37cc9bba, remote_addr: 127.0.0.1:52412, 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(1288)
[8810][0] reports Running
Mar 17 22:23:42.628 INFO request completed, latency_us: 452, response_code: 200, uri: /state/cid/0, method: GET, req_id: 318d6c62-774d-4f53-bd69-77e4d4b85243, remote_addr: 127.0.0.1:52412, local_addr: 127.0.0.1:9998
Mar 17 22:24:12.678 INFO accepted connection, remote_addr: 127.0.0.1:32866, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Mar 17 22:24:12.681 INFO request completed, latency_us: 184, response_code: 204, uri: /stop/cid/1, method: POST, req_id: a1508948-0203-4a66-a97f-955b265bd4ea, remote_addr: [8820] Got stop action so:false kr:false
127.0.0.1:32866, local_addr: 127.0.0.1:9998
Mar 17 22:24:12.682 INFO request completed, latency_us: 170, response_code: 200, uri: /state/cid/1, method: GET, req_id: b60b286e-9681-451f-8baa-e5f8e1d72da6, remote_addr: 127.0.0.1:32866, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Mar 17 22:24:16.684 INFO request completed, latency_us: 253, response_code: 200, uri: /state/cid/1, method: GET, req_id: a03c1703-9252-4e12-ae42-140b765e0c5f, remote_addr: 127.0.0.1:32866, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Mar 17 22:24:16.866 INFO request completed, latency_us: 191, response_code: 204, uri: /start/cid/1, method: POST, req_id: 127adf52-de34-4220-a5f8-8a1705814084, remote_addr: 127.0.0.1:32866, local_addr: 127.0.0.1:9998
Mar 17 22:24:16.867 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/1, method: GET, req_id: deb97bfc-a055-4ae7-bb7b-a5dc80fe1afc, remote_addr: 127.0.0.1:32866, 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(1289)
[8820][1] reports Running
Mar 17 22:24:20.869 INFO request completed, latency_us: 358, response_code: 200, uri: /state/cid/1, method: GET, req_id: 13b97861-6660-4df4-ab95-9a87f8e989ea, remote_addr: 127.0.0.1:32866, local_addr: 127.0.0.1:9998
Mar 17 22:24:51.085 INFO accepted connection, remote_addr: 127.0.0.1:46793, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Mar 17 22:24:51.089 INFO request completed, latency_us: 207, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 38f55d7a-2b66-45f6-89ce-50d5952be08c, remote_addr: 127.0.0.1:46793, local_addr: 127.0.0.1:[8830] Got stop action so:false kr:false
9998
Mar 17 22:24:51.090 INFO request completed, latency_us: 154, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2467ca8c-2525-4fdd-a936-db6bc9cec320, remote_addr: 127.0.0.1:46793, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 17 22:24:55.092 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4aa424a0-f2d2-49c5-8595-db89f51ad68d, remote_addr: 127.0.0.1:46793, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 17 22:24:55.271 INFO request completed, latency_us: 184, response_code: 204, uri: /start/cid/2, method: POST, req_id: 5a1ec9f7-4e95-4389-8f88-9f64144ef95e, remote_addr: 127.0.0.1:46793, local_addr: 127.0.0.1:9998
Mar 17 22:24:55.271 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/2, method: GET, req_id: 49e630ad-ea77-4422-b186-e7d054137c3c, remote_addr: 127.0.0.1:46793, 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 17 22:24:59.275 INFO request completed, latency_us: 523, response_code: 200, uri: /state/cid/2, method: GET, req_id: e48331aa-b66d-487d-82de-fb20c595656c, remote_addr: 127.0.0.1:46793, local_addr: 127.0.0.1:9998
Mar 17 22:25:29.651 INFO accepted connection, 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(3)
stop 3
Mar 17 22:25:29.655 INFO request completed, latency_us: 198, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 621b7f15-f852-4043-b1b3-e333463d0bf7, [8840] Got stop action so:false kr:false
remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
Mar 17 22:25:29.656 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/3, method: GET, req_id: ff971022-4eff-4f35-9d8a-59747e0c1503, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Mar 17 22:25:33.658 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/3, method: GET, req_id: abe76504-f3f0-4f0f-be5d-27f786bef0ef, 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 Start(3)
start 3
Mar 17 22:25:33.837 INFO request completed, latency_us: 163, response_code: 204, uri: /start/cid/3, method: POST, req_id: 56e16a20-aa15-464b-9094-8648ac89523f, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
Mar 17 22:25:33.838 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/3, method: GET, req_id: 040192e6-0eda-41d0-bd80-da7c367a1c31, remote_addr: 127.0.0.1:51618, 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 17 22:25:37.841 INFO request completed, latency_us: 431, response_code: 200, uri: /state/cid/3, method: GET, req_id: d24a4319-29ef-4142-a7bc-be8f9b15ab2b, remote_addr: 127.0.0.1:51618, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.274 INFO accepted connection, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.275 INFO request completed, latency_us: 182, response_code: 200, uri: /regioninfo, method: GET, req_id: d06c726c-b914-44bb-a481-8c9d5398612c, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.276 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: af682c3f-baa3-4a2b-a800-9de43812a44a, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.276 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5b06f961-e949-40b6-b27a-fe3016edf8cb, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.277 INFO request completed, latency_us: 204, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6c3634c5-fe9f-419b-934c-0f1fcd03cab4, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.278 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/2, method: GET, req_id: a49718dd-d4bc-4bfc-826d-b89678415621, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.279 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/3, method: GET, req_id: b6f1c6bd-6613-4d2e-928b-2bf37c1a8d84, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.280 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/4, method: GET, req_id: c9929bb8-53c4-4dba-ac88-fa2680448f33, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:08.280 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: 22145c9f-68e8-4d55-990a-1b396baef34e, remote_addr: 127.0.0.1:38213, local_addr: 127.0.0.1:9998
Mar 17 22:26:09.076 INFO accepted connection, remote_addr: 127.0.0.1:47480, local_addr: 127.0.0.1:9998
Mar 17 22:26:09.076 INFO request completed, latency_us: 161, response_code: 200, uri: /regioncount, method: GET, req_id: 14e295b5-0973-4397-b2e6-ff5f2d82d997, remote_addr: 127.0.0.1:47480, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Mar 17 22:26:12.988 INFO request completed, latency_us: 225, response_code: 204, uri: /stop/cid/0, method: POST, req_id: f71945af-63a4-403b-9007-d56fd31e29a6, remote_addr: 127.0.0.1:47480, local_addr: 127[8810] Got stop action so:false kr:false
.0.0.1:9998
Mar 17 22:26:12.989 INFO request completed, latency_us: 147, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4b3e8c92-3860-4c3a-97d4-c02368eb5a29, remote_addr: 127.0.0.1:47480, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Mar 17 22:26:16.992 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0998700d-b1ef-41b0-aefb-d6e3fb04eeca, remote_addr: 127.0.0.1:47480, local_addr: 127.0.0.1:9998
Mar 17 22:26:50.528 INFO accepted connection, remote_addr: 127.0.0.1:52544, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Mar 17 22:26:50.528 INFO request completed, latency_us: 212, response_code: 204, uri: /start/cid/0, method: POST, req_id: 1e34ca2a-610c-4f77-bd45-c7ac460cf402, remote_addr: 127.0.0.1:52544, 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(1293)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Mar 17 22:26:54.715 INFO request completed, latency_us: 359, response_code: 204[8820] Got stop action so:false kr:false
, uri: /stop/cid/1, method: POST, req_id: 54a89ac5-16e6-4fbd-8db4-bf287ed966ec, remote_addr: 127.0.0.1:52544, local_addr: 127.0.0.1:9998
Mar 17 22:26:54.716 INFO request completed, latency_us: 168, response_code: 200, uri: /state/cid/1, method: GET, req_id: 90817234-8428-4694-8c97-d4fd9f9e2308, remote_addr: 127.0.0.1:52544, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Mar 17 22:26:58.719 INFO request completed, latency_us: 263, response_code: 200, uri: /state/cid/1, method: GET, req_id: e3f352e3-c7c8-4545-9104-bcd14467e8d9, remote_addr: 127.0.0.1:52544, local_addr: 127.0.0.1:9998
Mar 17 22:27:32.290 INFO accepted connection, remote_addr: 127.0.0.1:33741, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Mar 17 22:27:32.291 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/1, method: POST, req_id: 27473d99-a636-401e-9ac5-ce0023090def, remote_addr: 127.0.0.1:33741, 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 17 22:27:36.487 [8830] Got stop action so:false kr:false
INFO request completed, latency_us: 441, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 77bff46f-f5da-4242-9e6e-33a43ab03273, remote_addr: 127.0.0.1:33741, local_addr: 127.0.0.1:9998
Mar 17 22:27:36.488 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/2, method: GET, req_id: efa04d3e-cb23-41d2-be50-9bf3e54f8672, remote_addr: 127.0.0.1:33741, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Mar 17 22:27:40.491 INFO request completed, latency_us: 340, response_code: 200, uri: /state/cid/2, method: GET, req_id: b5a8fcf1-94d8-499a-87ff-85d5e315a065, remote_addr: 127.0.0.1:33741, local_addr: 127.0.0.1:9998
Mar 17 22:28:14.057 INFO accepted connection, remote_addr: 127.0.0.1:64729, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Mar 17 22:28:14.057 INFO request completed, latency_us: 187, response_code: 204, uri: /start/cid/2, method: POST, req_id: ddcf4811-bb3d-4a01-8453-d02be48f1ebe, remote_addr: 127.0.0.1:64729, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Mar 17 22:28:18.252 INFO request completed[8840] Got stop action so:false kr:false
, latency_us: 274, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 5775ae51-8214-466b-82b5-203cf54989e2, remote_addr: 127.0.0.1:64729, local_addr: 127.0.0.1:9998
Mar 17 22:28:18.253 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7d51a294-b888-4eae-9c81-3950aea9356e, remote_addr: 127.0.0.1:64729, 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 17 22:28:22.256 INFO request completed, latency_us: 420, response_code: 200, uri: /state/cid/3, method: GET, req_id: 43f0fb6e-e999-4a81-a44c-bdedddbd6639, remote_addr: 127.0.0.1:64729, local_addr: 127.0.0.1:9998
Mar 17 22:28:55.806 INFO accepted connection, remote_addr: 127.0.0.1:49227, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Mar 17 22:28:55.807 INFO request completed, latency_us: 206, response_code: 204, uri: /start/cid/3, method: POST, req_id: 6afc6280-8a88-482d-ba6d-6dee193a1481, remote_addr: 127.0.0.1:49227, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Mar 17 22:29:00.056[8850] Got stop action so:false kr:false
 INFO request completed, latency_us: 234, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 22c400d6-1ec1-4b9c-8a73-3dd1fa5ffcc8, remote_addr: 127.0.0.1:49227, local_addr: 127.0.0.1:9998
Mar 17 22:29:00.057 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/4, method: GET, req_id: 157a43bd-119b-43b9-9182-7009a1914b55, remote_addr: 127.0.0.1:49227, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840] got start action
[8840] I am going to restart
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8840][3] reports Starting
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1296)
[8840][3] reports Running
Mar 17 22:29:04.060 INFO request completed, latency_us: 406, response_code: 200, uri: /state/cid/4, method: GET, req_id: 98da2ac3-7a32-4d92-8edf-88baea308dfc, remote_addr: 127.0.0.1:49227, local_addr: 127.0.0.1:9998
Mar 17 22:29:37.619 INFO accepted connection, remote_addr: 127.0.0.1:53675, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Mar 17 22:29:37.620 INFO request completed, latency_us: 213, response_code: 204, uri: /start/cid/4, method: POST, req_id: bdabc6ea-4cd4-469f-8296-184f6c4a51f0, remote_addr: 127.0.0.1:53675, 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 17 22:29:41.695 INFO accepted connection, remote_addr: 127.0.0.1:56410, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Mar 17 22:29:41.696 Shut it down
INFO[8810] Disable keep_running
 [8810] Got stop action so:false kr:false
request completed, latency_us: 247, response_code: 204, uri: /shutdown, method: POST, req_id: 63be643d-b15c-40e3-af35-04b1dae10124, remote_addr: 127.0.0.1:56410, local_addr: 127.0.0.1:9998
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8860] Disable keep_running
[8870] Disable keep_running
[8860] Got stop action so:false kr:false
[8870] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] 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