/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.24062936
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018369954
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.01772536
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.019596918
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.01693044
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.017990611
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
start ds: 8860
Starting downstairs at port 8810
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"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8830
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8840
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 8860
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1189)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1190)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1191)
[8840][3] initial start wait reports Running
Jan 28 21:54:22.563 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1193)
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1194)
[8830][2] initial start wait reports Running
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1192)
[8850][4] initial start wait reports Running
All downstairs are running
Jan 28 21:54:27.600 INFO accepted connection, remote_addr: 127.0.0.1:51508, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.602 INFO request completed, latency_us: 482, response_code: 200, uri: /state/cid/0, method: GET, req_id: 85ca6092-b646-448b-9dd1-60ba54dd0c60, remote_addr: 127.0.0.1:51508, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.656 INFO accepted connection, remote_addr: 127.0.0.1:45361, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.657 INFO request completed, latency_us: 127, response_code: 200, uri: /state/cid/1, method: GET, req_id: 74cf77ba-f164-4bb2-95d4-ded57c57e808, remote_addr: 127.0.0.1:45361, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.709 INFO accepted connection, remote_addr: 127.0.0.1:44173, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.710 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/2, method: GET, req_id: ad1a5947-16e4-48e9-b68a-52d4c6eddc4b, remote_addr: 127.0.0.1:44173, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.763 INFO accepted connection, remote_addr: 127.0.0.1:55951, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.764 INFO request completed, latency_us: 129, response_code: 200, uri: /state/cid/3, method: GET, req_id: dc35b14c-1ee3-4424-8618-3be7d28bb1f8, remote_addr: 127.0.0.1:55951, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.818 INFO accepted connection, remote_addr: 127.0.0.1:54752, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.818 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/4, method: GET, req_id: 3a30f4e2-56f7-4c23-8201-cffe5a80ca5d, remote_addr: 127.0.0.1:54752, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.872 INFO accepted connection, remote_addr: 127.0.0.1:65345, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.873 INFO request completed, latency_us: 153, response_code: 200, uri: /state/cid/5, method: GET, req_id: 60a40262-80b1-4b9d-a552-e0f491e58514, remote_addr: 127.0.0.1:65345, local_addr: 127.0.0.1:9998
Jan 28 21:54:27.927 INFO accepted connection, remote_addr: 127.0.0.1:35434, 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 28 21:54:27.928 INFO request completed, latency_us: 157, response_code: 204, uri: /disablerestart/all, method:[8810] Disable keep_running
 [8830] Disable keep_running
POST, req_id: [8840] Disable keep_running
c8cf08c4-c203-447b-9f00-939095724b7d, [8820] Disable keep_running
remote_addr: 127.0.0[8860] Disable keep_running
.[8850] Disable keep_running
1:35434, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.041 INFO accepted connection, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.043 INFO request completed, latency_us: 386, response_code: 200, uri: /regioninfo, method: GET, req_id: 26667b20-3d19-411f-b63c-61a698b08dfe, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.045 INFO request completed, latency_us: 113, response_code: 200, uri: /regioncount, method: GET, req_id: 1450a959-4afc-49b3-bedc-d861ffd08dcc, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.046 INFO request completed, latency_us: 133, response_code: 200, uri: /port/cid/0, method: GET, req_id: 05324f18-90f8-4931-be77-1cce9d474a72, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.047 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/1, method: GET, req_id: 19298daf-d886-480e-ae55-72aa9f5a4733, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.047 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: ef6ee16e-14ae-4122-aef9-7b1900439c99, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.053 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/3, method: GET, req_id: 21120672-42cc-42c1-804a-b2636d87924b, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.053 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9188f9f9-e4cd-4c92-bd35-083f9f9a9030, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:28.054 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: 2580f063-f529-4a65-94ad-3a77634f20cd, remote_addr: 127.0.0.1:44575, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.171 INFO accepted connection, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.172 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: 896c0136-f212-46f6-94af-8f5d7904fe9c, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.173 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 6f218b08-1eeb-4c7e-b07c-b684fb3b1c8f, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.173 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 237c1d3d-0407-4015-9387-c560473fa2dd, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.174 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 06945a9d-f124-4156-959a-c533951dab9b, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.174 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 97eb43b6-296a-4469-8b73-a6bad6209322, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.176 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/3, method: GET, req_id: 95d59184-9926-4b41-94b4-d46609888822, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.177 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/4, method: GET, req_id: d30729b4-1693-42ea-bf5b-a9385e8ac065, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:37.177 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/5, method: GET, req_id: 7640c48d-b791-4390-a024-8806ac66736d, remote_addr: 127.0.0.1:45684, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.747 INFO accepted connection, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.748 INFO request completed, latency_us: 149, response_code: 200, uri: /regioninfo, method: GET, req_id: e091deda-91e3-4458-8128-66e34a6994b2, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.749 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: 973c4a04-4ca9-414c-be6c-6a70924e3a5c, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.750 INFO request completed, latency_us: 119, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0f668e2b-1c4c-49c3-adae-15f7bb211e5e, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.750 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/1, method: GET, req_id: 031400c2-033f-44e1-acb1-d2ef3f7fec3b, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.751 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/2, method: GET, req_id: d9f784f0-a236-4b54-9506-33378c73af6e, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.753 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/3, method: GET, req_id: d399c0f5-cd09-4199-b098-f39a981b4f5e, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.753 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 3f085d31-4efc-42ff-a745-72458a775762, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:54:46.754 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3c638241-e3b1-4a32-9a64-691d14e1d4c1, remote_addr: 127.0.0.1:38327, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.137 INFO accepted connection, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.138 INFO request completed, latency_us: 156, response_code: 200, uri: /regioninfo, method: GET, req_id: 17923c32-c87c-488b-847f-e107eeeb8a0c, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.139 INFO request completed, latency_us: 122, response_code: 200, uri: /regioncount, method: GET, req_id: 092d3eed-6bd0-4d83-b741-b1a2b4514502, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.139 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2ce01c99-8b64-4bc3-a255-77028ef093f2, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.140 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/1, method: GET, req_id: fcc8d3fd-c23a-44de-92eb-a37a5bd0a163, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.140 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: ecdbb485-3517-40a2-a3f1-49dfd8586805, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.142 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/3, method: GET, req_id: d2c06e58-d7d6-4d11-a842-065d08ace0da, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.143 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2f3d1191-b30d-4aa1-8812-2b6d6c8a4623, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:55:25.143 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: ba4020d9-48bf-4b70-9765-e4dd4fe1bb88, remote_addr: 127.0.0.1:41858, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.212 INFO accepted connection, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.213 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: ddb01cd7-17b9-4031-b786-33f6db348c47, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.214 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: c9a82a92-8568-47bf-8e18-5c760eea6f06, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.214 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: b9377002-e861-40e7-9cbc-3f624a17bf05, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.215 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/1, method: GET, req_id: d0d03a7b-4fd7-4e0d-bd40-9b26c822c70e, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.215 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2ceba346-0cc3-4a67-8de4-ba6ec805eadf, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.217 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/3, method: GET, req_id: 374a0c67-4d3b-447c-9dc7-9364aa67ecac, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.218 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9c5a8e34-fe09-4242-853b-05eeb6e2412f, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 21:59:41.218 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/5, method: GET, req_id: 24165aba-9714-45c5-8500-bc2a8b4a2636, remote_addr: 127.0.0.1:42496, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.558 INFO accepted connection, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.559 INFO request completed, latency_us: 173, response_code: 200, uri: /regioninfo, method: GET, req_id: 97a2494b-754f-4aef-907e-a5f92c0ae6aa, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.560 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 34290128-7c33-4d40-aa72-5bb37519e94b, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.561 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: 145a600b-be0e-4d44-9d8d-9e30f4128b97, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.561 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3fd5bf6c-376b-4b35-ba81-1fa838d186d9, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.562 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: c3bd5c91-70fd-4ce9-9819-d82b06fee602, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.564 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: c462a553-4fdd-4671-9079-d234a00ce4d7, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.564 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2f1aec50-6785-4969-af61-c07d7b1377a7, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:53.565 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4b4ed78f-7368-477b-8fb6-b987391eb2ca, remote_addr: 127.0.0.1:51606, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.777 INFO accepted connection, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.778 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: 081b2074-2ca3-4833-91a5-5e7bb9e7b08b, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.779 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 370ab2a4-8ab9-402e-8eed-78da985bb1cb, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.780 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8353ad79-089a-438c-9528-670f56cefbae, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.780 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0d5d1b0f-012b-4a06-b0f0-b992f00a5400, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.781 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: c34f0d24-b08b-404e-8ac2-470b02fc1a91, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.783 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/3, method: GET, req_id: 06fae834-b14f-4303-a335-f953575d246f, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.783 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: 670da1f2-d06e-4d39-8cc9-1b365cad6b2d, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:00:57.784 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8788a82c-052e-4702-839d-d555d8942bcd, remote_addr: 127.0.0.1:45775, local_addr: 127.0.0.1:9998
Jan 28 22:01:01.975 INFO accepted connection, remote_addr: 127.0.0.1:53653, 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 28 22:01:01.976 INFO request completed, latency_us[8810] Disable keep_running
:[8820] Disable keep_running
 175, response_code: [8830] Disable keep_running
204[8860] Disable keep_running
, uri: /disablerestart/all, method: POST, req_id: [8850] Disable keep_running
323349b5-39a2-4252-a226-d51ba6cb6f2a, remote_addr: 127.0.0[8840] Disable keep_running
.1:53653, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.031 INFO accepted connection, remote_addr: 127.0.0.1:40172, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 28 22:01:02.032 INFO request completed[8830] Got stop action so:false kr:false
, latency_us: 137, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 4d41cdc9-28a1-453b-b43c-ae41432dfd74, remote_addr: 127.0.0.1:40172, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 28 22:01:02.087 INFO accepted connection, remote_addr: 127.0.0.1:36314, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.088 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/2, method: GET, req_id: 509e386a-9af0-4f05-9904-a19da433a080, remote_addr: 127.0.0.1:36314, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.146 INFO accepted connection, remote_addr: 127.0.0.1:48969, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 28 22:01:02.147 INFO request completed, latency_us: 143, response_code: 204, uri: /start/cid/2, method: POST, req_id: 34680c2e-975a-428e-80f5-cabb80ed4f63, remote_addr: 127.0.0.1:48969, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.228 INFO accepted connection, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.229 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: 6c36ed71-5af7-420f-a709-67591cc4f7cd, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.230 INFO request completed, latency_us: 127, response_code: 200, uri: /regioncount, method: GET, req_id: 43756a85-f8c2-4e29-99f4-9843035adad9, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.230 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 08a4d1dc-390d-4092-9fe0-c6811859bd66, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.231 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3f28bfe5-f66f-48be-9d77-d24512b30330, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.231 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: da04591e-18ee-40c6-9c26-a60a7f0cea92, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.233 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/3, method: GET, req_id: 6bfe74a3-4cbb-4959-9e80-f07acd92662f, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.234 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: eb25b56d-a245-4115-8cc1-6fa7d8615b8a, remote_addr: 127.0.0.1:50604, local_addr: 127.0.0.1:9998
Jan 28 22:01:02.234 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/5, method: GET, req_id: 82352634-b4a9-4df7-a320-954b20ae08d4, remote_addr: 127.0.0.1:50604, 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(1245)
[8830][2] reports Running
Jan 28 22:01:16.491 INFO accepted connection, remote_addr: 127.0.0.1:42575, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Jan 28 22:01:16.492 INFO request completed, latency_us: 231, response_code: 204, uri: [8810] Disable keep_running
Shut it down
/shutdown[8810] Got stop action so:false kr:false
, method: POST, req_id: 212f55b8-158f-4576-986f-b3e2ba34e477, remote_addr: 127.0.0.1:42575, 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
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8850][4] reports Exit
[8860][5] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] 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.026919354
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.023547947
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.02278851
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.022784172
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.022515403
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.022972753
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.022713812
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
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
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8840][3] initial start wait reports Starting
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Starting downstairs at port 8860
[8850][4] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8860][5] initial start wait reports Starting
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8870][6] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1262)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1263)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1264)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1265)
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1266)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1267)
Jan 28 22:01:21.713 INFO listening, local_addr: 127.0.0.1:9998
[8830][2] initial start wait reports Running
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1268)
[8810][0] initial start wait reports Running
All downstairs are running
Jan 28 22:01:26.746 INFO accepted connection, remote_addr: 127.0.0.1:56338, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.747 INFO request completed, latency_us: 306, response_code: 200, uri: /state/cid/0, method: GET, req_id: 813953f6-d708-45e9-a517-4c398920895f, remote_addr: 127.0.0.1:56338, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.803 INFO accepted connection, remote_addr: 127.0.0.1:45893, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.803 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/1, method: GET, req_id: 2fd47503-4d1b-4a0e-acd6-c702cc79db7a, remote_addr: 127.0.0.1:45893, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.857 INFO accepted connection, remote_addr: 127.0.0.1:59419, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.858 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/2, method: GET, req_id: 92efef51-03f3-4eb3-86b2-4ca1d474e1af, remote_addr: 127.0.0.1:59419, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.911 INFO accepted connection, remote_addr: 127.0.0.1:57960, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.912 INFO request completed, latency_us: 115, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5f59a2d7-7746-4191-b809-df8308652b4b, remote_addr: 127.0.0.1:57960, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.966 INFO accepted connection, remote_addr: 127.0.0.1:63799, local_addr: 127.0.0.1:9998
Jan 28 22:01:26.966 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/4, method: GET, req_id: bd598e2a-e2aa-4a33-ae60-80fe693cd44a, remote_addr: 127.0.0.1:63799, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.020 INFO accepted connection, remote_addr: 127.0.0.1:35275, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.020 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/5, method: GET, req_id: b9d9ce81-01d5-49cd-81ad-ce3b051630f0, remote_addr: 127.0.0.1:35275, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.073 INFO accepted connection, remote_addr: 127.0.0.1:60394, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.074 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/6, method: GET, req_id: 955a2b81-fadb-4a0d-843b-d1cec3a57314, remote_addr: 127.0.0.1:60394, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.128 INFO accepted connection, remote_addr: 127.0.0.1:36062, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.129 INFO request completed, latency_us: 183, response_code: 200, uri: /port/cid/6, method: GET, req_id: 9150e363-12e8-4b0c-aa29-0817e9d2b8c8, remote_addr: 127.0.0.1:36062, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.192 INFO accepted connection, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.193 INFO request completed, latency_us: 224, response_code: 200, uri: /regioninfo, method: GET, req_id: b1f72645-fc6f-445d-b6b6-b6732149dd65, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.194 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: ce0842d2-d57f-468b-b7df-b35c01962ce7, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.194 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/0, method: GET, req_id: 185fac0b-7905-42f4-91ef-de204f660a94, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.195 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5dac898c-1726-42f0-9ab4-2769424f6fb1, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.196 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/2, method: GET, req_id: 52dccc81-811b-48ef-a83c-7bd81d0ecdb1, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.197 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: aab776e3-b933-4582-bfca-b0f89d7eabd0, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.198 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: cbbbf235-620e-4a09-bb9a-fc10bb009dca, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.198 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/5, method: GET, req_id: ae5e7dbc-120c-4b5a-a245-e815193f54bc, remote_addr: 127.0.0.1:58303, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.237 INFO accepted connection, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.238 INFO request completed, latency_us: 132, response_code: 200, uri: /regioncount, method: GET, req_id: 38d302d5-ae3e-48f2-9234-57d6b362d2ed, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Jan 28 22:01:27.417 INFO request completed, latency_us: 235, response_code: 204, uri: /stop/cid/0, method: POST, req_id: f860eaa7-90f7-49fd-aac9-3468efdf219a, remote_addr:[8810] Got stop action so:false kr:false
 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:01:27.418 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3f828efd-e35f-467e-b1bf-fd6ce4d2256d, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Jan 28 22:01:31.420 INFO request completed, latency_us: 243, response_code: 200, uri: /state/cid/0, method: GET, req_id: 853be905-dc4d-426a-990d-d3a1b2a062f4, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Jan 28 22:01:31.590 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/0, method: POST, req_id: e09335d8-571e-4346-bc6b-4a64c2e402e3, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:01:31.590 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/0, method: GET, req_id: eb6cb34d-d8e9-4b76-9505-dbd2d3b638cd, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:01:35.593 INFO request completed, latency_us: 360, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2c7d2941-f323-48ae-8ebe-998bf6ffcdfe, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:01:39.594 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6ddb3c7d-0da2-4691-a95c-ce2fc0073d8a, remote_addr: 127.0.0.1:46249, 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(1279)
[8810][0] reports Running
Jan 28 22:01:43.597 INFO request completed, latency_us: 359, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8c703743-4c8f-4cba-97a7-abdb4d002282, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Jan 28 22:01:49.773 INFO[8810] Got stop action so:false kr:false
 request completed, latency_us: 211, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 7f46d87e-c8d7-4b57-a772-7073a5625b72, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:01:49.776 INFO request completed, latency_us: 187, response_code: 200, uri: /state/cid/0, method: GET, req_id: a0d0d350-1657-4260-83ef-9d9c1bc21f28, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Jan 28 22:01:53.778 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/0, method: GET, req_id: cf08791d-416c-4b5b-8259-ccd3735901c0, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Jan 28 22:01:53.950 INFO request completed, latency_us: 269, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0cb75199-e93a-4e1f-b31f-bcdc5090496c, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:01:53.950 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/0, method: GET, req_id: 646f8906-3638-4e4c-859b-4325d883860d, remote_addr: 127.0.0.1:46249, 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(1280)
[8810][0] reports Running
Jan 28 22:01:57.953 INFO request completed, latency_us: 403, response_code: 200, uri: /state/cid/0, method: GET, req_id: adecb4b4-2925-4449-9f07-320a09a93407, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Jan 28 22:02:27.994 INFO request completed, latency_us: 214, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 568ffd64-bb2f-40c7-b3fd-26a9283da554, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
[8820] Got stop action so:false kr:false
Jan 28 22:02:27.998 INFO request completed, latency_us: 177, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0424b0bf-bfd2-4805-9347-443135690da4, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Jan 28 22:02:32.000 INFO request completed, latency_us: 231, response_code: 200, uri: /state/cid/1, method: GET, req_id: 20193fbe-c538-496f-aaf7-778d0e6d5b8a, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Jan 28 22:02:32.176 INFO request completed, latency_us: 284, response_code: 204, uri: /start/cid/1, method: POST, req_id: fdd4ec03-d2c0-4d60-98aa-8f2ab75d5206, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:02:32.176 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/1, method: GET, req_id: f6a9180f-5071-4509-8c05-f03590bd721d, remote_addr: 127.0.0.1:46249, 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(1281)
[8820][1] reports Running
Jan 28 22:02:36.178 INFO request completed, latency_us: 324, response_code: 200, uri: /state/cid/1, method: GET, req_id: 02fc8428-1328-4fc5-802e-5c21458e08be, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 28 22:03:06.384 [8830] Got stop action so:false kr:false
INFO request completed, latency_us: 210, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 72972f4e-06ab-4ba5-b08f-bad622da37a6, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:03:06.384 INFO request completed, latency_us: 191, response_code: 200, uri: /state/cid/2, method: GET, req_id: 21dc6948-afab-42a1-ae99-555a57c2a0db, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 28 22:03:10.387 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/2, method: GET, req_id: b74476da-e9d3-4995-b439-d529e4f3b9ec, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 28 22:03:10.570 INFO request completed, latency_us: 216, response_code: 204, uri: /start/cid/2, method: POST, req_id: 2d26d610-4526-46fd-a188-c9fa4069d89b, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:03:10.570 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/2, method: GET, req_id: fec2e05a-2398-4657-9de8-ee9975312ebe, remote_addr: 127.0.0.1:46249, 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(1282)
[8830][2] reports Running
Jan 28 22:03:14.574 INFO request completed, latency_us: 343, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1e59aa51-ad98-48ad-a25a-2c3fce8eabd2, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Jan 28 22:03:44.943 INFO[8840] Got stop action so:false kr:false
 request completed, latency_us: 224, response_code: 204, uri: /stop/cid/3, method: POST, req_id: f2209383-306d-43e2-b04a-5c0e038a8a8b, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:03:44.944 INFO request completed, latency_us: 176, response_code: 200, uri: /state/cid/3, method: GET, req_id: dc452f90-22b9-4b4a-9055-e62a9a9b58f2, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Jan 28 22:03:48.946 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/3, method: GET, req_id: b5935bc2-e2ad-4adf-a4b3-2d49d77a5a5a, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Jan 28 22:03:49.122 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/3, method: POST, req_id: a9df3e05-97da-4901-9565-b6df2344aae5, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:03:49.123 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/3, method: GET, req_id: 08017a4d-3242-4100-b008-72863e29afa1, remote_addr: 127.0.0.1:46249, 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(1283)
[8840][3] reports Running
Jan 28 22:03:53.125 INFO request completed, latency_us: 356, response_code: 200, uri: /state/cid/3, method: GET, req_id: 1722b34f-779c-4b12-80a8-c8de83347aec, remote_addr: 127.0.0.1:46249, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.560 INFO accepted connection, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.561 INFO request completed, latency_us: 186, response_code: 200, uri: /regioninfo, method: GET, req_id: a9d6c654-1090-4462-96ae-8eb5d37d3243, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.562 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: ca96c839-4b76-4a3c-b8f1-f8abb5f78799, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.562 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6359668f-03df-4088-8170-5c43097610e8, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.563 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: bedaf118-26e3-4b67-ae00-1a18ff992260, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.563 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: e4bfa4fe-4809-4bc8-bde2-5bf5888c4db3, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.565 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: fda59e5e-0c16-4e5a-a472-e81cc96ab121, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.566 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/4, method: GET, req_id: 4383f889-aab0-407e-9056-fb86a8ea367a, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:23.566 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1b50e702-b6f9-4a00-b99b-e3cc42128b29, remote_addr: 127.0.0.1:36467, local_addr: 127.0.0.1:9998
Jan 28 22:04:24.356 INFO accepted connection, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Jan 28 22:04:24.357 INFO request completed, latency_us: 157, response_code: 200, uri: /regioncount, method: GET, req_id: 10ef9e80-8811-4033-8d04-b30ab8a6f2fd, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Jan 28 22:04:28.292 INFO request completed, latency_us: 2237, response_code: 204, uri: /stop/cid/0, method: POST[8810] Got stop action so:false kr:false
, req_id: fc8f78c3-3010-4cbf-a18b-345f84a56666, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Jan 28 22:04:28.293 INFO request completed, latency_us: 154, response_code: 200, uri: /state/cid/0, method: GET, req_id: 16089675-0c81-46cd-af48-1ba6fa38594f, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Jan 28 22:04:32.295 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0e373fcc-f1ed-4500-bec5-f3451e76ceeb, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Jan 28 22:05:05.958 INFO request completed, latency_us: 221, response_code: 204, uri: /start/cid/0, method: POST, req_id: 5db14c4e-b4f0-4dc1-a8fc-8a50a5e5b711, remote_addr: 127.0.0.1:34542, 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(1285)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Jan 28 22:05:10.131 INFO [8820] Got stop action so:false kr:false
request completed, latency_us: 320, response_code: 204, uri: /stop/cid/1, method: POST, req_id: e3aae87c-d91d-4e8d-9f55-dd6c0e20be03, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Jan 28 22:05:10.132 INFO request completed, latency_us: 124, response_code: 200, uri: /state/cid/1, method: GET, req_id: 16c196c0-ca35-4980-9f75-8e225a65dd31, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Jan 28 22:05:14.134 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6a49f7ec-5949-4332-9484-2afe8a076831, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Jan 28 22:05:47.806 INFO request completed, latency_us: 299, response_code: 204, uri: /start/cid/1, method: POST, req_id: 87e25d55-dd9b-4549-b0c2-da0cabe07cf5, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
Jan 28 22:05:51.987 INFO request completed, latency_us: 211, response_code: 204, uri: /stop/cid/2, method: POST, req_id: a620498f-a3e0-41ba-921e-875dfea80acc, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Jan 28 22:05:51.988 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5ab8297c-d635-4427-9050-7107c180899a, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8820] got start action
[8820] I am going to restart
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8820][1] reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1286)
[8820][1] reports Running
Jan 28 22:05:55.990 INFO request completed, latency_us: 322, response_code: 200, uri: /state/cid/2, method: GET, req_id: 415a70d2-bef8-4814-bd20-9b7be2bd54cf, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 28 22:06:29.675 INFO request completed, latency_us: 244, response_code: 204, uri: /start/cid/2, method: POST, req_id: 306e0993-e426-45f3-9844-b6f9b399df49, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Jan 28 22:06:33.872 INFO request completed, latency_us: 240, response_code: 204, uri: /stop/cid/3, method: POST, req_id: ef89f630-6824-453b-903d-9631760bc29c, remote_addr: 127.0.0.1[8840] Got stop action so:false kr:false
:34542, local_addr: 127.0.0.1:9998
Jan 28 22:06:33.873 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/3, method: GET, req_id: f49e7c14-15a8-4e76-b2a3-19192c1b3a02, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Jan 28 22:06:37.875 INFO request completed, latency_us: 227, response_code: 200, uri: /state/cid/3, method: GET, req_id: 861e7238-1b97-44bc-afce-d14f7aacd285, remote_addr: 127.0.0.1:34542, 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(1287)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Start(3)
start 3
Jan 28 22:07:11.545 INFO request completed, latency_us: 374, response_code: 204, uri: /start/cid/3, method: POST, req_id: c4cd6f9e-2a7d-41ae-8e4b-8ccc7154c74e, remote_addr: 127.0.0.1:34542, 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(1288)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
[8850] Got stop action so:false kr:false
Jan 28 22:07:15.792 INFO request completed, latency_us: 354, response_code: 204, uri: /stop/cid/4, method: POST, req_id: b1b84118-0d70-4070-b92b-bcd17740c4f0, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Jan 28 22:07:15.793 INFO request completed, latency_us: 134, response_code: 200, uri: /state/cid/4, method: GET, req_id: 9048d388-4836-4502-8f09-e66327b463b3, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Jan 28 22:07:19.795 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/4, method: GET, req_id: dfdf3d0f-ac5d-46f4-9b81-7a46fe8dccdf, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Jan 28 22:07:53.453 INFO request completed, latency_us: 233, response_code: 204, uri: /start/cid/4, method: POST, req_id: feae2a7b-1ddb-4aa7-a0ee-ae080bddf9c7, remote_addr: 127.0.0.1:34542, local_addr: 127.0.0.1:9998
Jan 28 22:07:57.526 INFO accepted connection, remote_addr: 127.0.0.1:55648, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
[8810] Disable keep_running
[8810] Got stop action so:false kr:false
Jan 28 22:07:57.527 INFO request completed, latency_us: Shut it down
165, response_code: 204, uri: /shutdown, method: POST, req_id: eeb6e4ec-cb35-4b84-8f19-195cb3da3da1, remote_addr: 127.0.0.1:55648, 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
[8860] Disable keep_running
[8830] Got stop action so:false kr:false
[8860] Got stop action so:false kr:false
[8840] Got stop action so:false kr:false
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
[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
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit