/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.2613358
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.01902841
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.018245673
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.019003255
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.019905116
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.018581856
Created 6 regions
/var/tmp/bins/dsc start --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build --region-count 6
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 })
start ds: 8810
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start access at:127.0.0.1:9998
Starting downstairs at port 8810
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
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"
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/8840 port 8840 PID:Some(1206)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1210)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1207)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1209)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1208)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1205)
[8860][5] initial start wait reports Running
[8820][1] initial start wait reports Running
All downstairs are running
Control access at:127.0.0.1:9998
Dec 03 07:22:01.030 INFO listening, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.072 INFO accepted connection, remote_addr: 127.0.0.1:44867, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.073 INFO request completed, latency_us: 515, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1a8394d8-6360-42eb-93c4-06b512a2ff8f, remote_addr: 127.0.0.1:44867, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.132 INFO accepted connection, remote_addr: 127.0.0.1:64013, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.132 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0ae1bd79-863f-40d6-ad92-a236dbcb5736, remote_addr: 127.0.0.1:64013, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.188 INFO accepted connection, remote_addr: 127.0.0.1:56324, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.189 INFO request completed, latency_us: 148, response_code: 200, uri: /state/cid/2, method: GET, req_id: ec61e527-8dc4-41b9-97fe-a20076b1ce4a, remote_addr: 127.0.0.1:56324, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.245 INFO accepted connection, remote_addr: 127.0.0.1:44061, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.245 INFO request completed, latency_us: 176, response_code: 200, uri: /state/cid/3, method: GET, req_id: a621cd25-2fab-49ea-9be7-6ec875392967, remote_addr: 127.0.0.1:44061, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.302 INFO accepted connection, remote_addr: 127.0.0.1:59415, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.302 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/4, method: GET, req_id: cd749931-7202-4a84-b090-c5d990a99ced, remote_addr: 127.0.0.1:59415, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.359 INFO accepted connection, remote_addr: 127.0.0.1:65229, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.360 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/5, method: GET, req_id: 6be654e3-ce80-45f8-bcac-7fd0ec360856, remote_addr: 127.0.0.1:65229, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.416 INFO accepted connection, remote_addr: 127.0.0.1:64217, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Dec 03 07:22:06.417 INFO request completed, latency_us:[8810] Disable keep_running
 185, response_code: 204, uri: [8820] Disable keep_running
/disablerestart/all[8830] Disable keep_running
, [8840] Disable keep_running
method[8860] Disable keep_running
:[8850] Disable keep_running
 POST, req_id: d8916993-a636-45bf-82eb-c8b21ced7f58, remote_addr: 127.0.0.1:64217, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.553 INFO accepted connection, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.554 INFO request completed, latency_us: 257, response_code: 200, uri: /regioninfo, method: GET, req_id: 840d6374-7ed2-4fdb-a235-4f4e0f498345, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.556 INFO request completed, latency_us: 97, response_code: 200, uri: /regioncount, method: GET, req_id: ea005e06-1400-457d-b3c7-a89f0e3caecd, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.558 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9dc5b011-99bc-41ec-87d2-e7b409863d08, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.558 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: 215649f6-ff3c-4123-8593-d24bf9a411ae, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.559 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1dcaf5ad-b92c-4609-9067-695f086f1732, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.566 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5e3c745e-5c82-49ee-a67d-708e06832ca9, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.566 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1c6d7ee9-111b-4aa8-9121-b659119ed630, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:06.567 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6adfc676-3b6a-4896-9467-29b8b34d0cf4, remote_addr: 127.0.0.1:51674, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.694 INFO accepted connection, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.695 INFO request completed, latency_us: 157, response_code: 200, uri: /regioninfo, method: GET, req_id: 207f80a8-37c6-4d71-9ba2-b3c4338668d5, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.696 INFO request completed, latency_us: 112, response_code: 200, uri: /regioncount, method: GET, req_id: b8cd5f63-8c8d-4885-9068-7bb6706a8598, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.697 INFO request completed, latency_us: 119, response_code: 200, uri: /port/cid/0, method: GET, req_id: daed2d17-8fb2-43ae-b5ba-1ab958c00ad0, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.697 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/1, method: GET, req_id: 406f69bf-e8a0-4a8b-adfd-8ff8ddbad410, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.698 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: fd28285e-c363-4920-bee5-6c2d35fb1c85, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.700 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/3, method: GET, req_id: f08cacae-d237-4ccc-9790-7232ff0032d2, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.701 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/4, method: GET, req_id: 58c868e9-e2b0-493b-b361-bc68e74f7096, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:15.701 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8d6abeed-cbbb-4ea3-b861-b58c105579fa, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.301 INFO accepted connection, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.302 INFO request completed, latency_us: 153, response_code: 200, uri: /regioninfo, method: GET, req_id: 9e588062-ed37-46c5-9982-03228769f821, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.303 INFO request completed, latency_us: 112, response_code: 200, uri: /regioncount, method: GET, req_id: 842421d4-3611-4767-8609-77952c703e3e, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.304 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: 018248ee-aa76-4d43-a7a3-5020c747db70, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.305 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: e8e247f4-4569-48c6-be18-dee977a7efca, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.305 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 11eac64d-cf67-430b-941f-7bc2dac09c90, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.307 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: 6abed482-f0c1-43b1-8b4e-93902a247749, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.308 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 46b1939b-d31f-4c21-983f-f91a82969e49, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:22:25.309 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: cb5b044a-cd35-4d23-9d21-48a37cf3add2, remote_addr: 127.0.0.1:51972, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.035 INFO accepted connection, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.036 INFO request completed, latency_us: 159, response_code: 200, uri: /regioninfo, method: GET, req_id: 78fe665a-421d-473f-b2a7-5d79eba0b8b1, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.037 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 9aee4e6e-9a39-472f-b257-f58d6c89ff1e, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.038 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 31aab1d9-2e33-40af-b888-c6f946db5c6b, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.038 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5a56365d-2ca5-4cbb-89fb-d722b46ce7f8, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.039 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1e75c1f3-bd9f-4209-94b1-61ae12b4397c, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.041 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 1eb23a9f-9997-4e23-9dba-04237f0111ec, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.042 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: a20ead62-c5b5-44d3-a010-4e12a1abda6a, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:23:04.042 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3a374aa6-5e42-46e9-b704-fff088c615b7, remote_addr: 127.0.0.1:51036, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.359 INFO accepted connection, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.360 INFO request completed, latency_us: 172, response_code: 200, uri: /regioninfo, method: GET, req_id: 2f69ae73-d0d6-4aa2-80b9-2fa285405817, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.361 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: d479dc8e-b4c7-435d-9250-f2411f2d3bda, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.361 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0b6bf68d-56f1-41f9-be50-b1f1c3069faf, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.362 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 27330d87-2dfb-49fe-9788-efed94c4c612, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.363 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 6d50a8c6-8607-442f-8543-dca1ce2e36f4, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.365 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/3, method: GET, req_id: e82759aa-1c26-4546-952f-48f6257dd557, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.365 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 46dc8958-b4a0-483d-9cf4-926276f878f7, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:26.366 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8d3c2d57-1d14-431d-a103-f83dd3978baa, remote_addr: 127.0.0.1:41159, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.005 INFO accepted connection, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.006 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: 6db1dc59-4b32-4491-854b-900862d76d25, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.007 INFO request completed, latency_us: 124, response_code: 200, uri: /regioncount, method: GET, req_id: ce5fbabb-2696-48a2-8826-5acc617b4913, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.008 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6c54f318-74ae-4dbd-8af9-dfb7aed04930, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.008 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 767f01c7-a593-4324-9e25-f531ac844244, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.009 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 98eda71a-ccdf-4bb3-bc16-b278982ba187, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.011 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/3, method: GET, req_id: dbd138dc-3ceb-4644-a804-a647a872854d, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.012 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 29faf8b8-e366-47ee-b23f-7d6805e0ca6d, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:49.012 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: 07324813-f736-4406-9cf1-71d06b626e06, remote_addr: 127.0.0.1:43076, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.224 INFO accepted connection, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.225 INFO request completed, latency_us: 161, response_code: 200, uri: /regioninfo, method: GET, req_id: ffb8974b-7670-4785-8fcc-f17fa49ea613, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.226 INFO request completed, latency_us: 110, response_code: 200, uri: /regioncount, method: GET, req_id: 98922fff-37d6-4c65-bfb0-848d0546a863, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.227 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/0, method: GET, req_id: f343a1d0-2382-4066-b8d5-5c7750090a99, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.227 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 08af4f3e-98cf-4c00-aaf8-cb413f7626fb, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.228 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: f7a7e64d-7c83-421d-a298-3e05041e1998, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.230 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 61505c1c-1ddf-4f13-8f46-eecda4ccdf1e, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.231 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 254bcdb5-fe05-44aa-a384-f2b59e78f931, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:53.231 INFO request completed, latency_us: 112, response_code: 200, uri: /port/cid/5, method: GET, req_id: bccd7c3c-1398-4df6-8d56-68c998c7c574, remote_addr: 127.0.0.1:53474, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.422 INFO accepted connection, remote_addr: 127.0.0.1:46515, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Dec 03 07:27:57.423 INFO request completed, latency_us: 181, [8810] Disable keep_running
response_code:[8830] Disable keep_running
 [8840] Disable keep_running
204, [8860] Disable keep_running
uri: [8820] Disable keep_running
/disablerestart/all, method: POST, req_id[8850] Disable keep_running
: 79de0c84-790f-4693-8e09-28e1707a960b, remote_addr: 127.0.0.1:46515, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.480 INFO accepted connection, remote_addr: 127.0.0.1:56245, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
Dec 03 07:27:57.480 INFO request completed, latency_us:got dsc Stop(2)
 stop 2
187, response_code: 204, uri: /stop/cid/2, method: POST, req_id: e00fe174-d4d5-4c81-adea-915262d0bd67, remote_addr: 127.0.0.1:56245, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Dec 03 07:27:57.538 INFO accepted connection, remote_addr: 127.0.0.1:36497, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.539 INFO request completed, latency_us: 174, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0d573643-a166-441b-bcda-04611fae25e8, remote_addr: 127.0.0.1:36497, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.604 INFO accepted connection, remote_addr: 127.0.0.1:55722, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Dec 03 07:27:57.604 INFO request completed, latency_us: 167, response_code: 204, uri: /start/cid/2, method: POST, req_id: 782ecf86-427f-4aae-aa9b-92a026abdd85, remote_addr: 127.0.0.1:55722, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.694 INFO accepted connection, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.695 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: a5d4830b-c1b0-4d96-aaa1-55e6c242c830, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.696 INFO request completed, latency_us: 98, response_code: 200, uri: /regioncount, method: GET, req_id: 6ae08a1b-c45e-4fa2-be12-0aa6f66eb0a8, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.696 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 777718a9-68ce-45d0-9b96-80606841a9b1, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.697 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/1, method: GET, req_id: 9c9e4f83-bd21-4d71-beb7-a0f2770a3f73, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.698 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/2, method: GET, req_id: a8903ef8-5abd-4687-bb12-6e4e6a0ee8bc, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.700 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: 96816d1c-ca2d-425c-9bfb-e8a069391422, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.700 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 650c554a-16db-4790-b9ee-471abf5c384c, remote_addr: 127.0.0.1:53207, local_addr: 127.0.0.1:9998
Dec 03 07:27:57.701 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 9f1dc564-1ebd-467f-b540-e2bd444c2338, remote_addr: 127.0.0.1:53207, 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(1261)
[8830][2] reports Running
Dec 03 07:28:11.970 INFO accepted connection, remote_addr: 127.0.0.1:37288, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Dec 03 07:28:11.971 INFO request completed, [8810] Disable keep_running
latency_us[8820] Disable keep_running
:[8840] Disable keep_running
 188, response_code:[8860] Disable keep_running
 [8840] Got stop action so:false kr:false
204, uri: /shutdown, method:[8850] Disable keep_running
 [8850] Got stop action so:false kr:false
POST, req_id: a92b3fa7-1092-4bcc-8879-7f1cb09c1ef7, remote_addr: 127.0.0.1:37288, local_addr: 127.0.0.1:9998
[8860] Got stop action so:false kr:false
[8820] Got stop action so:false kr:false
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8810] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8840][3] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8810][0] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --extent-count 400 --block-size 4096 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Removing existing dsc directory "/tmp/test_up-build/dsc"
Removing existing region "/var/tmp/test_up-build"
Creating region directory at: /var/tmp/test_up-build
Creating dsc directory at: /tmp/test_up-build/dsc
Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.047617167
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.045706738
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.044886224
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.046432063
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.046722136
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.05252709
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.06561481
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: 400 })
start ds: 8810
start access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start ds: 8870
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8830
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] initial start wait reports Starting
[8820][1] initial start wait reports Starting
Starting downstairs at port 8840
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"
[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
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1278)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1280)
[8870][6] initial start wait reports Starting
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1281)
[8860][5] initial start wait reports Running
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1279)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1282)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1283)
[8840][3] initial start wait reports Running
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1284)
[8870][6] initial start wait reports Running
All downstairs are running
Control access at:127.0.0.1:9998
Dec 03 07:28:17.363 INFO listening, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.409 INFO accepted connection, remote_addr: 127.0.0.1:59931, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.410 INFO request completed, latency_us: 320, response_code: 200, uri: /state/cid/0, method: GET, req_id: 98acc54e-4431-47ec-b081-38db1939e85d, remote_addr: 127.0.0.1:59931, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.467 INFO accepted connection, remote_addr: 127.0.0.1:34054, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.468 INFO request completed, latency_us: 179, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0f1e8aa2-f17c-4d08-b68f-0a0a21a16b4f, remote_addr: 127.0.0.1:34054, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.525 INFO accepted connection, remote_addr: 127.0.0.1:38713, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.526 INFO request completed, latency_us: 171, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2a0bb43e-1f96-412f-8864-2ef5e964dd88, remote_addr: 127.0.0.1:38713, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.586 INFO accepted connection, remote_addr: 127.0.0.1:43122, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.586 INFO request completed, latency_us: 174, response_code: 200, uri: /state/cid/3, method: GET, req_id: b5f40356-8e0e-4e97-85b7-6a1a8d9ef100, remote_addr: 127.0.0.1:43122, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.644 INFO accepted connection, remote_addr: 127.0.0.1:42683, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.645 INFO request completed, latency_us: 165, response_code: 200, uri: /state/cid/4, method: GET, req_id: f1e0f1e1-062f-414f-a20a-519fcf5df8ac, remote_addr: 127.0.0.1:42683, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.703 INFO accepted connection, remote_addr: 127.0.0.1:42246, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.704 INFO request completed, latency_us: 175, response_code: 200, uri: /state/cid/5, method: GET, req_id: ef036239-73b3-4bcd-9f98-d136f978d33e, remote_addr: 127.0.0.1:42246, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.760 INFO accepted connection, remote_addr: 127.0.0.1:34211, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.761 INFO request completed, latency_us: 169, response_code: 200, uri: /state/cid/6, method: GET, req_id: 393fc6b4-2493-4586-8e18-bf908f4f5a03, remote_addr: 127.0.0.1:34211, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.816 INFO accepted connection, remote_addr: 127.0.0.1:55863, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.817 INFO request completed, latency_us: 176, response_code: 200, uri: /port/cid/6, method: GET, req_id: eacace1e-6264-4b81-ae58-9560a1ee7c93, remote_addr: 127.0.0.1:55863, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.880 INFO accepted connection, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.881 INFO request completed, latency_us: 207, response_code: 200, uri: /regioninfo, method: GET, req_id: a9686207-9241-49ff-866b-a4e698a8adbc, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.882 INFO request completed, latency_us: 121, response_code: 200, uri: /regioncount, method: GET, req_id: 7bf58425-bd3e-49a8-a57e-32b45578e82a, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.883 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3df16b24-5600-4a4e-a079-cf739736d5df, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.883 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 99d2ffbd-6e3f-423b-937d-2272a246dee8, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.884 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/2, method: GET, req_id: bceaeaae-92b5-44af-8d40-8069c60aa3ea, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.886 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: 261c2613-4075-4fdf-9d6e-12faeffe2e34, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.887 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0c45fcea-ea7d-4cec-9f79-273f4702dc93, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.887 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5fb5aab3-1d46-416e-82b5-882392990912, remote_addr: 127.0.0.1:48892, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.948 INFO accepted connection, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:28:22.949 INFO request completed, latency_us: 157, response_code: 200, uri: /regioncount, method: GET, req_id: c45973a5-6c72-4c61-9769-1206e0fbbf0c, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Dec 03 07:28:23.707 INFO[8810] Got stop action so:false kr:false
 request completed, latency_us: 224, response_code: 204, uri: /stop/cid/0, method: POST, req_id: f9dad7dc-1e41-4d28-8d34-34c7496e6205, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:28:23.713 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/0, method: GET, req_id: e469da7e-a9d7-4943-bbbd-8916f3245fea, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Dec 03 07:28:27.715 INFO request completed, latency_us: 242, response_code: 200, uri: /state/cid/0, method: GET, req_id: df55172f-1cf7-4fe3-a34a-8853f37724bd, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Dec 03 07:28:28.447 INFO request completed, latency_us: 257, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0e145280-6cbc-42db-bd1e-88af97537bf0, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:28:28.448 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/0, method: GET, req_id: 681a4a6e-04d6-4248-b53d-d79a0d1a1a3f, remote_addr: 127.0.0.1:65358, 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(1295)
[8810][0] reports Running
Dec 03 07:28:32.450 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1c10fa0a-6de5-4f6b-aec9-e26e9da42b6a, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
[8810] Got stop action so:false kr:false
Dec 03 07:28:39.206 INFO request completed, latency_us: 409, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 097ef233-3fd4-4484-afc1-6091cfb823a8, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:28:39.207 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/0, method: GET, req_id: a262ca15-268b-4997-b3f4-b0b3bcd03d74, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Dec 03 07:28:43.209 INFO request completed, latency_us: 249, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3bac83b7-8489-4500-aa74-77ddd10d4c88, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Dec 03 07:28:43.960 INFO request completed, latency_us: 210, response_code: 204, uri: /start/cid/0, method: POST, req_id: 5253b566-82f1-4113-99e7-fe3434f91200, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:28:43.961 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9d8e918b-00c8-47e7-a96e-a0c6cb92706b, remote_addr: 127.0.0.1:65358, 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(1296)
[8810][0] reports Running
Dec 03 07:28:47.963 INFO request completed, latency_us: 239, response_code: 200, uri: /state/cid/0, method: GET, req_id: ee7b911e-d243-496a-8cc9-d5510c7f5ff9, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
[8810] Got stop action so:false kr:false
Dec 03 07:28:53.717 INFO request completed, latency_us: 258, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 82470b52-f680-4862-8936-a3cf8125b897, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:28:53.717 INFO request completed, latency_us: 149, response_code: 200, uri: /state/cid/0, method: GET, req_id: 650902db-b8a5-4e45-a05c-e23606b9fc52, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Dec 03 07:28:57.720 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8cb1c713-8984-4134-8c5e-be0a3496aecd, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Dec 03 07:28:58.480 INFO request completed, latency_us: 213, response_code: 204, uri: /start/cid/0, method: POST, req_id: a8282f3f-5c3f-48e8-a822-f567b091de10, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:28:58.481 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3914e730-6285-46e1-8c11-c4c20bd712b1, remote_addr: 127.0.0.1:65358, 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(1297)
[8810][0] reports Running
Dec 03 07:29:02.483 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/0, method: GET, req_id: de705bac-8591-46bb-9966-b9adb33dd35d, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Dec 03 07:29:07.249[8810] Got stop action so:false kr:false
 INFO request completed, latency_us: 222, response_code: 204, uri: /stop/cid/0, method: POST, req_id: adce7b5c-f9f3-46d3-b669-9bf33d4c20af, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:29:07.249 INFO request completed, latency_us: 114, response_code: 200, uri: /state/cid/0, method: GET, req_id: eb8c9888-4ee1-43a0-be5a-4c1e61f85c64, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Dec 03 07:29:11.252 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7c42cc84-7d75-4cda-a866-a36b1d9a831c, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Dec 03 07:29:12.013 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: 72250df7-26ed-4edd-b636-03f9de3df1d9, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:29:12.013 INFO request completed, latency_us: 114, response_code: 200, uri: /state/cid/0, method: GET, req_id: fe14d387-c3df-430f-a6e1-b0359ca5faa9, remote_addr: 127.0.0.1:65358, 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(1298)
[8810][0] reports Running
Dec 03 07:29:16.015 INFO request completed, latency_us: 223, response_code: 200, uri: /state/cid/0, method: GET, req_id: df93ce3c-68c7-4a5d-b9cc-871475fb6786, remote_addr: 127.0.0.1:65358, local_addr: 127.0.0.1:9998
Dec 03 07:29:48.374 INFO accepted connection, remote_addr: 127.0.0.1:55482, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Dec 03 07:29:48.375 INFO request completed, latency_us: 254, response_code: 204, [8820] Got stop action so:false kr:false
uri: /stop/cid/1, method: POST, req_id: 7a5ef56b-bd17-4af3-b9c1-d23c59cff7e0, remote_addr: 127.0.0.1:55482, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Dec 03 07:29:48.405 INFO request completed, latency_us: 178, response_code: 200, uri: /state/cid/1, method: GET, req_id: c8340050-8371-4e33-b0d7-cdc8cd14e9ed, remote_addr: 127.0.0.1:55482, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Dec 03 07:29:49.182 INFO request completed, latency_us: 230, response_code: 204, uri: /start/cid/1, method: POST, req_id: 907b743d-226b-495d-8f3b-1e44c84a687f, remote_addr: 127.0.0.1:55482, local_addr: 127.0.0.1:9998
Dec 03 07:29:49.183 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/1, method: GET, req_id: 08f7ae1e-3204-4cb8-86e2-9933543572ac, remote_addr: 127.0.0.1:55482, 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(1299)
[8820][1] reports Running
Dec 03 07:29:53.185 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/1, method: GET, req_id: 59de0f80-dd7e-4d91-b641-99b7c3cefa52, remote_addr: 127.0.0.1:55482, local_addr: 127.0.0.1:9998
Dec 03 07:30:26.027 INFO accepted connection, remote_addr: 127.0.0.1:44874, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Dec 03 07:30:26.028 INFO request completed, latency_us: 189, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 85397785-5d5e-470b-a4e0-c841abd15c80, remote_addr: 127.0.0.1:44874, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
Dec 03 07:30:26.029 INFO request completed, latency_us: 132, response_code: 200, uri: /state/cid/2, method: GET, req_id: 876b25bf-77db-4876-bac9-1a673709f8e1, remote_addr: 127.0.0.1:44874, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Dec 03 07:30:30.046 INFO request completed, latency_us: 373, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4fca8b5c-7574-4e05-bbb6-eb8e084ae90f, remote_addr: 127.0.0.1:44874, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Dec 03 07:30:30.796 INFO request completed, latency_us: 217, response_code: 204, uri: /start/cid/2, method: POST, req_id: 4743bc27-9569-43df-ba0f-3aaf53e5ee94, remote_addr: 127.0.0.1:44874, local_addr: 127.0.0.1:9998
Dec 03 07:30:30.797 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/2, method: GET, req_id: b414b213-00cf-4f35-9d28-8841bc32aa7f, remote_addr: 127.0.0.1:44874, local_addr: 127.0.0.1:9998
Dec 03 07:30:34.799 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/2, method: GET, req_id: 99a22d57-0034-4996-ae09-ec7bc027a427, remote_addr: 127.0.0.1:44874, 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(1300)
[8830][2] reports Running
Dec 03 07:30:38.802 INFO request completed, latency_us: 244, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9fb86c6a-53ac-47cc-a277-99daec2ba1f8, remote_addr: 127.0.0.1:44874, local_addr: 127.0.0.1:9998
Dec 03 07:31:12.302 INFO accepted connection, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
[8840] Got stop action so:false kr:false
Dec 03 07:31:12.303 INFO request completed, latency_us: 446, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 963082d0-85a8-4eb2-afdf-57db5625c971, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
Dec 03 07:31:12.303 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/3, method: GET, req_id: 16d43f3f-8397-4f52-90bd-d0e9f4ca1833, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Dec 03 07:31:16.306 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/3, method: GET, req_id: a63e21a6-38fc-4c28-9db2-6aa5467776a8, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Dec 03 07:31:17.073 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/3, method: POST, req_id: b3bcc33a-7eed-485c-9717-13af4cf59df0, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
Dec 03 07:31:17.074 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/3, method: GET, req_id: 9b6cd54b-167f-42b7-9b2c-339f454df051, remote_addr: 127.0.0.1:62287, 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(1301)
[8840][3] reports Running
Dec 03 07:31:21.076 INFO request completed, latency_us: 315, response_code: 200, uri: /state/cid/3, method: GET, req_id: 942ca36d-75aa-4bd8-8ba6-5730d4eb8197, remote_addr: 127.0.0.1:62287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.550 INFO accepted connection, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.551 INFO request completed, latency_us: 192, response_code: 200, uri: /regioninfo, method: GET, req_id: 75c02e15-77d6-47fa-a28c-8ab2ee08b459, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.552 INFO request completed, latency_us: 108, response_code: 200, uri: /regioncount, method: GET, req_id: 40ebdf7f-78cd-4dba-810c-f6493a69e58b, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.553 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/0, method: GET, req_id: df127001-3fc8-4630-866b-7b9c2b10e920, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.554 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3c22d4c4-7bad-42d6-a75e-69fc176cdbbd, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.554 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/2, method: GET, req_id: 29e829a3-67d1-46e1-8984-59ff124129bd, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.557 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/3, method: GET, req_id: 91f93fa7-8cce-4af9-a578-abdd40c6b9ea, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.557 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/4, method: GET, req_id: ad1538ff-f77b-4603-8c4a-31c22fba9f08, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.558 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3bf56593-15d7-4723-870a-b0de6a4ba4a2, remote_addr: 127.0.0.1:54287, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.640 INFO accepted connection, remote_addr: 127.0.0.1:58112, local_addr: 127.0.0.1:9998
Dec 03 07:31:54.640 INFO request completed, latency_us: 144, response_code: 200, uri: /regioncount, method: GET, req_id: a0041b95-24eb-4c0e-af4c-61e5bcbef94f, remote_addr: 127.0.0.1:58112, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Dec 03 07:32:10.231[8810] Got stop action so:false kr:false
 INFO request completed, latency_us: 236, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 8d9c82c0-2ed5-4f5d-93f2-2ff13e89aa10, remote_addr: 127.0.0.1:58112, local_addr: 127.0.0.1:9998
Dec 03 07:32:10.232 INFO request completed, latency_us: 116, response_code: 200, uri: /state/cid/0, method: GET, req_id: 37536cde-79dc-4e65-a051-e6847cf6f777, remote_addr: 127.0.0.1:58112, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Dec 03 07:32:14.235 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/0, method: GET, req_id: c97b95de-b016-447d-84ca-8d681e525bd8, remote_addr: 127.0.0.1:58112, local_addr: 127.0.0.1:9998
Dec 03 07:33:15.756 INFO accepted connection, remote_addr: 127.0.0.1:40240, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Dec 03 07:33:15.756 INFO request completed, latency_us: 198, response_code: 204, uri: /start/cid/0, method: POST, req_id: 2942fc2e-025c-4298-902c-c228e06b93d8, remote_addr: 127.0.0.1:40240, 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(1303)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Dec 03 07:33:20.526 INFO request completed, [8820] Got stop action so:false kr:false
latency_us: 229, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 822eddf0-1279-4373-bb07-55b381a50109, remote_addr: 127.0.0.1:40240, local_addr: 127.0.0.1:9998
Dec 03 07:33:20.527 INFO request completed, latency_us: 124, response_code: 200, uri: /state/cid/1, method: GET, req_id: a6d9b3af-ab31-4214-9b6e-e48725afa101, remote_addr: 127.0.0.1:40240, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Dec 03 07:33:24.530 INFO request completed, latency_us: 246, response_code: 200, uri: /state/cid/1, method: GET, req_id: cba14f6f-05cb-42fd-9f10-55a48b38739f, remote_addr: 127.0.0.1:40240, local_addr: 127.0.0.1:9998
Dec 03 07:34:26.110 INFO accepted connection, remote_addr: 127.0.0.1:52842, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Dec 03 07:34:26.111 INFO request completed, latency_us: 196, response_code: 204, uri: /start/cid/1, method: POST, req_id: 8f3355e8-7882-4cbe-9391-19e28e4f66e0, remote_addr: 127.0.0.1:52842, 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(1304)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Dec 03 07:34:30.886 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/2, method: POST, req_id: [8830] Got stop action so:false kr:false
7827ff10-236b-4047-9a93-f59892ec9a05, remote_addr: 127.0.0.1:52842, local_addr: 127.0.0.1:9998
Dec 03 07:34:30.887 INFO request completed, latency_us: 129, response_code: 200, uri: /state/cid/2, method: GET, req_id: b10c85e8-7796-4a6b-8a77-a95c0b78ab44, remote_addr: 127.0.0.1:52842, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Dec 03 07:34:34.890 INFO request completed, latency_us: 233, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7839ab21-228d-4818-bb83-ce832ffdddd0, remote_addr: 127.0.0.1:52842, local_addr: 127.0.0.1:9998
Dec 03 07:35:36.492 INFO accepted connection, remote_addr: 127.0.0.1:57982, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Dec 03 07:35:36.492 INFO request completed, latency_us: 201, response_code: 204, uri: /start/cid/2, method: POST, req_id: d07d4e4b-afac-4976-9bae-e017df564a7c, remote_addr: 127.0.0.1:57982, 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(1305)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Dec 03 07:35:41.291 INFO request completed, latency_us: 230, response_code: [8840] Got stop action so:false kr:false
204, uri: /stop/cid/3, method: POST, req_id: 1042c4b1-f66b-4e35-9c20-7e27085d2589, remote_addr: 127.0.0.1:57982, local_addr: 127.0.0.1:9998
Dec 03 07:35:41.292 INFO request completed, latency_us: 143, response_code: 200, uri: /state/cid/3, method: GET, req_id: f99f0f06-e16e-451b-8497-c85e3246967f, remote_addr: 127.0.0.1:57982, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Dec 03 07:35:45.293 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/3, method: GET, req_id: 34a556e7-5bab-41b4-8fe3-041154321ba1, remote_addr: 127.0.0.1:57982, local_addr: 127.0.0.1:9998
Dec 03 07:36:46.937 INFO accepted connection, remote_addr: 127.0.0.1:35773, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Dec 03 07:36:46.937 INFO request completed, latency_us: 200, response_code: 204, uri: /start/cid/3, method: POST, req_id: 34be4fea-5f47-42d2-af45-ea82463cf4d9, remote_addr: 127.0.0.1:35773, 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(1306)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Dec 03 07:36:51.989 INFO[8850] Got stop action so:false kr:false
 request completed, latency_us: 214, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 1aff966f-6f24-4afb-a3b5-351628de5aa7, remote_addr: 127.0.0.1:35773, local_addr: 127.0.0.1:9998
Dec 03 07:36:51.990 INFO request completed, latency_us: 134, response_code: 200, uri: /state/cid/4, method: GET, req_id: 2fb8bab2-447d-43cf-a243-4b26970c5fbd, remote_addr: 127.0.0.1:35773, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Dec 03 07:36:55.992 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/4, method: GET, req_id: a8ff1456-f3b4-4d22-ba08-c448bcc31e08, remote_addr: 127.0.0.1:35773, local_addr: 127.0.0.1:9998
Dec 03 07:37:57.558 INFO accepted connection, remote_addr: 127.0.0.1:39233, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Dec 03 07:37:57.559 INFO request completed, latency_us: 200, response_code: 204, uri: /start/cid/4, method: POST, req_id: 0b453700-2b8f-4f7e-8798-9e610205a98c, remote_addr: 127.0.0.1:39233, local_addr: 127.0.0.1:9998
Dec 03 07:38:01.648 INFO accepted connection, remote_addr: 127.0.0.1:60703, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Dec 03 07:38:01.648 Shut it down
INFO[8820] Disable keep_running
 request completed, latency_us[8830] Disable keep_running
:[8820] Got stop action so:false kr:false
 [8840] Disable keep_running
174, response_code: 204, uri: /shutdown, method: POST, req_id: [8830] Got stop action so:false kr:false
a76fdbc3-c3b4-4982-a72b-2bfb8f02b140[8810] Disable keep_running
, remote_addr:[8810] Got stop action so:false kr:false
 [8860] Disable keep_running
127[8860] Got stop action so:false kr:false
.[8840] Got stop action so:false kr:false
0[8870] Disable keep_running
.[8870] Got stop action so:false kr:false
0.1:60703, local_addr: 127.0.0.1:9998
[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