/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.17229976
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018176407
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.019078718
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.018114213
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.017301917
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.018439973
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 8820
Starting downstairs at port 8830
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
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 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"
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8810][0] initial start wait reports Starting
[8840][3] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1197)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1198)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1199)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1202)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1200)
[8810][0] initial start wait reports Running
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1201)
[8850][4] initial start wait reports Running
All downstairs are running
Feb 25 17:18:39.055 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Feb 25 17:18:44.091 INFO accepted connection, remote_addr: 127.0.0.1:50027, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.095 INFO request completed, latency_us: 1049, response_code: 200, uri: /state/cid/0, method: GET, req_id: ce3b9d13-ce83-471a-9949-74baacfd9cad, remote_addr: 127.0.0.1:50027, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.152 INFO accepted connection, remote_addr: 127.0.0.1:42128, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.153 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/1, method: GET, req_id: d84fdfd0-41f3-461c-9f6c-069d5f2630a4, remote_addr: 127.0.0.1:42128, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.206 INFO accepted connection, remote_addr: 127.0.0.1:39898, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.207 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6213c38f-21c3-4129-946a-ac8aae210667, remote_addr: 127.0.0.1:39898, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.260 INFO accepted connection, remote_addr: 127.0.0.1:42713, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.260 INFO request completed, latency_us: 130, response_code: 200, uri: /state/cid/3, method: GET, req_id: a1f01112-d123-4f11-83ce-ff1d411cc000, remote_addr: 127.0.0.1:42713, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.315 INFO accepted connection, remote_addr: 127.0.0.1:57550, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.315 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/4, method: GET, req_id: 3d91b4f7-93f5-40d1-8beb-3c20d9938d0e, remote_addr: 127.0.0.1:57550, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.368 INFO accepted connection, remote_addr: 127.0.0.1:54497, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.369 INFO request completed, latency_us: 148, response_code: 200, uri: /state/cid/5, method: GET, req_id: a760fee5-db71-4d3e-bae1-6833ca7b566e, remote_addr: 127.0.0.1:54497, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.424 INFO accepted connection, remote_addr: 127.0.0.1:45558, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Feb 25 17:18:44.424 INFO request completed, latency_us: 200, [8810] Disable keep_running
response_code: 204, uri: /disablerestart/all, method: POST, req_id: 8197897d-2ab3-477b-96a1-70591183e9c2, remote_addr: 127.0.0.1:45558, local_addr: 127.0.0[8820] Disable keep_running
.[8830] Disable keep_running
1[8840] Disable keep_running
:[8860] Disable keep_running
9998
[8850] Disable keep_running
Feb 25 17:18:44.507 INFO accepted connection, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.508 INFO request completed, latency_us: 488, response_code: 200, uri: /regioninfo, method: GET, req_id: b888a253-471f-466e-901b-585a3c5bf279, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.509 INFO request completed, latency_us: 107, response_code: 200, uri: /regioncount, method: GET, req_id: c09c5da0-f183-46fe-8f6c-fcddc5926856, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.510 INFO request completed, latency_us: 126, response_code: 200, uri: /port/cid/0, method: GET, req_id: e0469cba-e422-4ae9-a158-5e8e6134a27e, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.511 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: 57af2683-9aef-4907-b107-9fd5e928ed7f, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.511 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 970a2347-114a-4af2-aef3-b929f3593982, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.514 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/3, method: GET, req_id: 77da8005-ecd5-4d82-8ebb-63190ad585c0, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.515 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 80360aae-dc93-48d5-ae1b-8c8118b58b14, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:44.515 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 34f13c1b-7aed-470a-8904-6703dee85531, remote_addr: 127.0.0.1:58517, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.635 INFO accepted connection, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.636 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: 27bf9c9e-d1c2-4fc7-95f3-7ea3d39554eb, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.637 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: 08ec4844-d159-4455-a491-2e93dda79ff5, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.638 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/0, method: GET, req_id: 834ddf0b-12f3-4ea0-88f4-c77ab61582b4, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.638 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3ded8468-aede-4107-92d7-711374d7fd1c, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.639 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 08b2543a-dfc3-45ec-bdfa-7ee1e6bcb61d, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.640 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/3, method: GET, req_id: 1d692b7f-dce9-4e7e-9a2d-b3ab22d57c1e, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.641 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/4, method: GET, req_id: b95f7930-2a07-454a-961d-70d56047b775, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:18:53.641 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/5, method: GET, req_id: 46cfcd7b-f57c-45a4-a77e-52d6f8311d49, remote_addr: 127.0.0.1:35510, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.224 INFO accepted connection, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.225 INFO request completed, latency_us: 154, response_code: 200, uri: /regioninfo, method: GET, req_id: aa07b696-3e7a-4ce0-8b87-f39f929cad64, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.226 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: 0b4eb08e-9832-428e-bc36-00c4472ef20b, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.226 INFO request completed, latency_us: 131, response_code: 200, uri: /port/cid/0, method: GET, req_id: a9ce3152-6771-4906-9439-c261acfd306d, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.227 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: 314b77d6-3b18-4883-9a2c-b19983f72143, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.227 INFO request completed, latency_us: 126, response_code: 200, uri: /port/cid/2, method: GET, req_id: b4ce31e8-da3e-4511-811d-2d6d5e40d283, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.229 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 872e414d-8eab-4b16-bdbc-b9ac086fd957, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.230 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 193a9124-4545-4c56-8def-131f6d496710, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:03.230 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/5, method: GET, req_id: 62ed97a4-c903-4a23-91be-be03995e1d28, remote_addr: 127.0.0.1:47615, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.956 INFO accepted connection, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.957 INFO request completed, latency_us: 148, response_code: 200, uri: /regioninfo, method: GET, req_id: 510a5483-9a9c-4bf3-a24f-8b2345afdb58, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.958 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: bcbc38b6-3e17-4ac3-b4f9-75ee04306b54, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.958 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 77bcf648-bbb6-44fd-9678-4c9e942ec2c0, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.959 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/1, method: GET, req_id: c24c28dc-55ae-4789-a9d5-16866c32355a, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.959 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/2, method: GET, req_id: f1369afb-eca6-46be-acf5-400ad32fd127, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.961 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: 57b7b035-86fc-4465-99cf-076064e216c7, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.962 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/4, method: GET, req_id: e1b8724b-e9e8-42f9-98d4-e21b2385be7e, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:19:41.962 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 452ca60a-af7d-4118-a9f3-36bccc14468d, remote_addr: 127.0.0.1:41125, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.414 INFO accepted connection, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.415 INFO request completed, latency_us: 146, response_code: 200, uri: /regioninfo, method: GET, req_id: 2afb3b2b-68b9-4214-b08e-44af34b70815, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.416 INFO request completed, latency_us: 114, response_code: 200, uri: /regioncount, method: GET, req_id: 2ccb8bd3-8ec5-4575-b95b-06b545249ee9, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.417 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/0, method: GET, req_id: d78dab4c-ddf4-4f71-9cd5-0508bbce5065, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.417 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/1, method: GET, req_id: be7873b6-ff59-4b9a-9b03-072fba9935dd, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.418 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1b7fe3fd-6a15-4fa9-8a4a-b922dd441159, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.419 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/3, method: GET, req_id: b66a8c68-be5c-4053-ab8d-bcaaa911361d, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.420 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/4, method: GET, req_id: 46997a18-a9cf-411b-a7fb-15eee040917d, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:24:01.420 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/5, method: GET, req_id: 22606a10-b11d-4b35-a695-a1f5e9f6a167, remote_addr: 127.0.0.1:43968, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.687 INFO accepted connection, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.688 INFO request completed, latency_us: 164, response_code: 200, uri: /regioninfo, method: GET, req_id: 13950b50-22ed-47e2-bec7-1e8e9dd7497c, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.689 INFO request completed, latency_us: 83, response_code: 200, uri: /regioncount, method: GET, req_id: de4bf586-2144-4093-8301-3e24c4163598, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.689 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2f8be656-1c5a-4210-9dfe-32f479668064, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.690 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 15865c22-18ec-480b-8233-081e6d756de4, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.690 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 28011046-6616-4ecd-a98d-12ca9b14b2ef, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.692 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: 71a01c71-079f-4313-8d0c-72def9d19496, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.693 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 5ea05326-9bd7-4995-978f-236bb3b5a707, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:13.694 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: eb9070c0-5e79-43bb-b445-ede2ec520be3, remote_addr: 127.0.0.1:53483, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.908 INFO accepted connection, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.908 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: 27eea605-61f1-45c3-88bd-04769ac8a9de, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.909 INFO request completed, latency_us: 124, response_code: 200, uri: /regioncount, method: GET, req_id: c745a743-f242-4997-8b98-1962a958289a, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.910 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/0, method: GET, req_id: ec28ca24-e1cc-47a0-9dcc-113e0366cb81, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.910 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: f47553d3-c355-4afc-ac3f-4be3b5fd85d6, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.911 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 8849cd88-dc03-4676-9870-949fa99a1167, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.913 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5f223e6f-a9b8-4093-b786-79a717b9a9b2, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.913 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: 8e16c47c-62f8-4331-bf3f-a118a9665ca8, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:17.914 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: febdf758-720e-49ef-bae4-235e57450b50, remote_addr: 127.0.0.1:38106, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.102 INFO accepted connection, remote_addr: 127.0.0.1:59922, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Feb 25 17:25:22.103 INFO request completed, latency_us: 192, response_code: 204, [8820] Disable keep_running
uri[8810] Disable keep_running
: /disablerestart/all, method: POST, req_id:[8860] Disable keep_running
 23e4a548-853b-44d4-aa2b-372dbebc196a[8850] Disable keep_running
, remote_addr: 127.0.0.1:59922, local_addr: 127.0.0[8830] Disable keep_running
.1:9998
[8840] Disable keep_running
Feb 25 17:25:22.158 INFO accepted connection, remote_addr: 127.0.0.1:51905, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Feb 25 17:25:22.158 INFO request completed, latency_us: 164, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 712866bf-c34c-403b-873c-cd5ef11da8d2, remote_addr: 127.0.0.1:51905[8830] Got stop action so:false kr:false
, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Feb 25 17:25:22.214 INFO accepted connection, remote_addr: 127.0.0.1:34523, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.215 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/2, method: GET, req_id: 88daef4f-1a58-4511-92e9-5926f3e8b647, remote_addr: 127.0.0.1:34523, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.275 INFO accepted connection, remote_addr: 127.0.0.1:52480, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Feb 25 17:25:22.275 INFO request completed, latency_us: 159, response_code: 204, uri: /start/cid/2, method: POST, req_id: 6870c9d2-339c-4050-b682-4baa3b87a2da, remote_addr: 127.0.0.1:52480, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.357 INFO accepted connection, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.358 INFO request completed, latency_us: 190, response_code: 200, uri: /regioninfo, method: GET, req_id: a1dcba0d-23cd-4323-8804-8402fcf2de9a, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.359 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: 9e8b0383-367f-44be-8487-d0027223da4f, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.359 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9152a30e-3199-4d39-aec5-cc8f54c49446, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.360 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 4bc81b51-4f4b-48bf-b479-f86abc6ea423, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.360 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/2, method: GET, req_id: 8772c356-f01e-46b2-ac98-b2177d508f51, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.362 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/3, method: GET, req_id: dc1dd512-2c49-46e6-ab6d-c5e1f3d5d2ff, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.363 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9dd46c0a-9d90-4bc0-b99b-d18eb9f37a27, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
Feb 25 17:25:22.363 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1f7ddbd5-ff6f-45e1-a7da-9cd71a5defa3, remote_addr: 127.0.0.1:51610, local_addr: 127.0.0.1:9998
[8830] got start action
[8830] I am going to restart
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] reports Starting
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1253)
[8830][2] reports Running
Feb 25 17:25:36.615 INFO accepted connection, remote_addr: 127.0.0.1:56453, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Feb 25 17:25:36.615 INFO [8810] Disable keep_running
request completed, latency_us[8810] Got stop action so:false kr:false
: 197, response_code: Shut it down
204, uri: /shutdown, method: POST, req_id: 4cf6db4d-d36c-4383-8444-6b2ef80f691a, remote_addr: 127.0.0.1:56453, 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
[8820] Disable keep_running
[8820] 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
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840][3] reports Exit
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --extent-count 300 --block-size 4096 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Removing existing dsc directory "/tmp/test_up-build/dsc"
Removing existing region "/var/tmp/test_up-build"
Creating region directory at: /var/tmp/test_up-build
Creating dsc directory at: /tmp/test_up-build/dsc
Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.027800633
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.0251906
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.02411361
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.023976697
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.024636071
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024134235
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.023760565
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 ds: 8860
start access at:127.0.0.1:9998
start ds: 8870
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"
[8810][0] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Starting downstairs at port 8850
[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"
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Starting downstairs at port 8870
[8860][5] initial start wait reports Starting
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/8850 port 8850 PID:Some(1270)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1271)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1272)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1273)
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1274)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1275)
[8830][2] initial start wait reports Running
[8860][5] initial start wait reports Running
Feb 25 17:25:41.844 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1276)
[8810][0] initial start wait reports Running
All downstairs are running
Control access at:127.0.0.1:9998
Feb 25 17:25:46.877 INFO accepted connection, remote_addr: 127.0.0.1:51041, local_addr: 127.0.0.1:9998
Feb 25 17:25:46.878 INFO request completed, latency_us: 296, response_code: 200, uri: /state/cid/0, method: GET, req_id: 19bf1a24-252c-4052-9bec-345aaefe4352, remote_addr: 127.0.0.1:51041, local_addr: 127.0.0.1:9998
Feb 25 17:25:46.934 INFO accepted connection, remote_addr: 127.0.0.1:38638, local_addr: 127.0.0.1:9998
Feb 25 17:25:46.935 INFO request completed, latency_us: 154, response_code: 200, uri: /state/cid/1, method: GET, req_id: ed4df147-84c5-4394-9ac9-de94c74a1d18, remote_addr: 127.0.0.1:38638, local_addr: 127.0.0.1:9998
Feb 25 17:25:46.991 INFO accepted connection, remote_addr: 127.0.0.1:39380, local_addr: 127.0.0.1:9998
Feb 25 17:25:46.992 INFO request completed, latency_us: 160, response_code: 200, uri: /state/cid/2, method: GET, req_id: b3fb8cd8-b9ef-42c5-abdc-c1a9c38b2907, remote_addr: 127.0.0.1:39380, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.048 INFO accepted connection, remote_addr: 127.0.0.1:35606, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.049 INFO request completed, latency_us: 170, response_code: 200, uri: /state/cid/3, method: GET, req_id: c7c6477e-2f9b-4fc0-aeb6-0dbb3e148161, remote_addr: 127.0.0.1:35606, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.104 INFO accepted connection, remote_addr: 127.0.0.1:43589, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.105 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/4, method: GET, req_id: 4e91bb60-c7b4-4e46-97a9-c7387089041b, remote_addr: 127.0.0.1:43589, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.161 INFO accepted connection, remote_addr: 127.0.0.1:39319, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.161 INFO request completed, latency_us: 164, response_code: 200, uri: /state/cid/5, method: GET, req_id: d2bdb8ad-8073-4b3e-aab8-6b4de4d014ec, remote_addr: 127.0.0.1:39319, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.217 INFO accepted connection, remote_addr: 127.0.0.1:59336, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.218 INFO request completed, latency_us: 160, response_code: 200, uri: /state/cid/6, method: GET, req_id: 5675b25c-4e60-4615-94d9-8a2fb823017b, remote_addr: 127.0.0.1:59336, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.272 INFO accepted connection, remote_addr: 127.0.0.1:46234, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.273 INFO request completed, latency_us: 175, response_code: 200, uri: /port/cid/6, method: GET, req_id: 482bdb50-53e8-4d25-80ac-4a8f8fc4932c, remote_addr: 127.0.0.1:46234, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.334 INFO accepted connection, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.335 INFO request completed, latency_us: 203, response_code: 200, uri: /regioninfo, method: GET, req_id: 5158b24c-de1b-47e3-a14d-879d089ba33e, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.336 INFO request completed, latency_us: 111, response_code: 200, uri: /regioncount, method: GET, req_id: 0352ba69-9bfe-415c-a8fb-33ed08f69601, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.337 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: 12b534f8-6f29-4ab5-8c8c-17f2e23be2bc, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.337 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 70d1ae75-d6b5-4b2e-9d41-0a5bd894f77f, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.338 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/2, method: GET, req_id: 524910a5-0675-4c4b-a53c-1dd1a36f7399, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.339 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/3, method: GET, req_id: 22ea5846-ac83-41e7-9cb8-d54c00d1fcb0, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.340 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 14d520b6-e9ce-4d5e-b9a5-4895b5e6fb79, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.340 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/5, method: GET, req_id: 683b76c5-3a81-4be3-88f6-23db93d36e8d, remote_addr: 127.0.0.1:35903, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.381 INFO accepted connection, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.381 INFO request completed, latency_us: 120, response_code: 200, uri: /regioncount, method: GET, req_id: b8c29290-3a7c-4188-b36b-6772808c8440, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Feb 25 17:25:47.561 INFO request completed, latency_us[8810] Got stop action so:false kr:false
: 232, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 79b33578-c78d-4d1e-8598-680d350f8407, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:25:47.562 INFO request completed, latency_us: 191, response_code: 200, uri: /state/cid/0, method: GET, req_id: c1db5224-800e-4880-9724-1fdc8dffd2d5, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Feb 25 17:25:51.565 INFO request completed, latency_us: 250, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2dee1376-de15-4046-b87e-991d2544ca00, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 25 17:25:51.740 INFO request completed, latency_us: 222, response_code: 204, uri: /start/cid/0, method: POST, req_id: 1b44b2d7-1763-4150-b356-ac9647ef23da, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:25:51.740 INFO request completed, latency_us: 114, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3f6a1444-0b5a-45f3-b903-6ea944ea193f, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8810] got start action
[8810] I am going to restart
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8810][0] reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1287)
[8810][0] reports Running
Feb 25 17:25:55.742 INFO request completed, latency_us: 341, response_code: 200, uri: /state/cid/0, method: GET, req_id: 782e8865-81b9-4565-945d-d1872b481e4b, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 25 17:26:26.596 INFO request completed, latency_us: 230[8820] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 8307d25c-2686-4dfe-883f-32b032c06a2e, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:26:26.598 INFO request completed, latency_us: 132, response_code: 200, uri: /state/cid/1, method: GET, req_id: 24e4b58c-2ddf-4cec-b3df-e8232fe1abac, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Feb 25 17:26:30.600 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/1, method: GET, req_id: a0d8924a-876d-48e9-888f-e18ed4dfe378, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 25 17:26:30.776 INFO request completed, latency_us: 318, response_code: 204, uri: /start/cid/1, method: POST, req_id: 85b2b026-15af-4a9f-9c2c-69308931ba58, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:26:30.777 INFO request completed, latency_us: 116, response_code: 200, uri: /state/cid/1, method: GET, req_id: c348544c-13e2-4171-9104-cd3e26751531, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:26:34.780 INFO request completed, latency_us: 272, response_code: 200, uri: /state/cid/1, method: GET, req_id: d3944bc1-4512-4392-ae79-ba8ede66c309, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8820] got start action
[8820] I am going to restart
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8820][1] reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1288)
[8820][1] reports Running
Feb 25 17:26:38.783 INFO request completed, latency_us: 352, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4db84d1e-876c-4c16-8a49-fa886b5ad8b9, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 25 17:26:44.967 INFO request completed[8820] Got stop action so:false kr:false
, latency_us: 248, response_code: 204, uri: /stop/cid/1, method: POST, req_id: a1376032-1561-415f-b4af-9b28de1f1be4, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:26:44.970 INFO request completed, latency_us: 125, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8e80293e-271e-4304-aff4-8c1884ae135e, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Feb 25 17:26:48.973 INFO request completed, latency_us: 266, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5a31710a-46c0-47f6-9664-a4c1bb2320f1, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 25 17:26:49.152 INFO request completed, latency_us: 224, response_code: 204, uri: /start/cid/1, method: POST, req_id: 9d12b6e0-6fa7-4c05-8311-8c57c400acd9, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:26:49.153 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/1, method: GET, req_id: 889c439c-d53b-4ce4-8b8d-20bdd7a75a9c, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:26:53.155 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/1, method: GET, req_id: 36dfe3f6-e422-4a7c-93a7-1d2d23772142, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8820] got start action
[8820] I am going to restart
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8820][1] reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1289)
[8820][1] reports Running
Feb 25 17:26:57.158 INFO request completed, latency_us: 346, response_code: 200, uri: /state/cid/1, method: GET, req_id: 81f43403-b1fe-4dc4-9eef-47370042b18d, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 25 17:27:02.342[8820] Got stop action so:false kr:false
 INFO request completed, latency_us: 257, response_code: 204, uri: /stop/cid/1, method: POST, req_id: a382a502-e03e-4a19-a365-dab1251fd39e, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:27:02.343 INFO request completed, latency_us: 147, response_code: 200, uri: /state/cid/1, method: GET, req_id: 57741481-3428-4ce4-98f6-357a1596ffdf, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Feb 25 17:27:06.345 INFO request completed, latency_us: 333, response_code: 200, uri: /state/cid/1, method: GET, req_id: 95205724-fb90-40ba-8616-be5b44987c83, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 25 17:27:06.524 INFO request completed, latency_us: 214, response_code: 204, uri: /start/cid/1, method: POST, req_id: a27f55b5-a6bf-4d18-8515-4ace6ee01b58, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:27:06.525 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/1, method: GET, req_id: 48407b20-a1a2-4d3c-8cda-cf0435671175, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:27:10.527 INFO request completed, latency_us: 349, response_code: 200, uri: /state/cid/1, method: GET, req_id: 28514626-7bb0-4c4c-bc88-e88c0e2d0f2a, remote_addr: 127.0.0.1:43612, 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(1290)
[8820][1] reports Running
Feb 25 17:27:14.529 INFO request completed, latency_us: 324, response_code: 200, uri: /state/cid/1, method: GET, req_id: 892090fc-79ef-4064-b1a9-064cf80d208f, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 25 17:27:18.710 INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 3dc0598e-deee-4d58-8282-e99299ff702e, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8820] Got stop action so:false kr:false
Feb 25 17:27:18.710 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6de191a2-1c7b-4828-956c-5caaef62121d, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Feb 25 17:27:22.712 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/1, method: GET, req_id: 27d59e46-0f94-4063-9947-18c44402a973, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 25 17:27:22.900 INFO request completed, latency_us: 230, response_code: 204, uri: /start/cid/1, method: POST, req_id: ea17410a-d39d-4b03-af57-232f8a13c766, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:27:22.900 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/1, method: GET, req_id: be9a2812-b62c-4bf2-9af0-1dc144633911, remote_addr: 127.0.0.1:43612, 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(1291)
[8820][1] reports Running
Feb 25 17:27:26.902 INFO request completed, latency_us: 346, response_code: 200, uri: /state/cid/1, method: GET, req_id: 69cf6023-b6df-45a3-9610-69b5c7130064, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Feb 25 17:27:55.467 INFO request completed, latency_us: 216[8830] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/2, method: POST, req_id: eaf338a1-a12b-4c5f-85a9-76d9733ad7d2, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:27:55.468 INFO request completed, latency_us: 148, response_code: 200, uri: /state/cid/2, method: GET, req_id: 493fa38f-ecbb-4013-ace6-4edc2a1f6c5e, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Feb 25 17:27:59.470 INFO request completed, latency_us: 340, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7aa01f25-b103-495d-9078-9ed57e672fc3, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Feb 25 17:27:59.646 INFO request completed, latency_us: 192, response_code: 204, uri: /start/cid/2, method: POST, req_id: 80b113c7-b350-4388-8684-655b593262d2, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:27:59.647 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/2, method: GET, req_id: c9bd5ad4-3be9-4bfc-9ffb-6b9727e7679c, remote_addr: 127.0.0.1:43612, 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(1292)
[8830][2] reports Running
Feb 25 17:28:03.648 INFO request completed, latency_us: 331, response_code: 200, uri: /state/cid/2, method: GET, req_id: d063e388-449e-492a-810f-604b07ec6152, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Feb 25 17:28:32.329 INFO request completed, latency_us: 233, response_code[8840] Got stop action so:false kr:false
: 204, uri: /stop/cid/3, method: POST, req_id: 2391480f-72c9-46ea-be57-45aee6b1ce2e, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:28:32.330 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/3, method: GET, req_id: e981f5c0-1a2c-49dc-b7dc-4488b4387562, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Feb 25 17:28:36.333 INFO request completed, latency_us: 352, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8c35dbc2-fbc0-47b0-be16-4317e7093b10, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Feb 25 17:28:36.513 INFO request completed, latency_us: 213, response_code: 204, uri: /start/cid/3, method: POST, req_id: bfd496fd-1e88-4e73-828d-2618adf9f217, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:28:36.513 INFO request completed, latency_us: 127, response_code: 200, uri: /state/cid/3, method: GET, req_id: 6b71dcc4-4f5a-474b-a59f-657f66f6f9ca, remote_addr: 127.0.0.1:43612, 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(1293)
[8840][3] reports Running
Feb 25 17:28:40.516 INFO request completed, latency_us: 343, response_code: 200, uri: /state/cid/3, method: GET, req_id: 31bc383d-fe09-4875-bd2b-a1edff9dcbac, remote_addr: 127.0.0.1:43612, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.267 INFO accepted connection, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.268 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: 76911c37-25c4-4dd4-92ca-1d5296600cc0, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.269 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: bc1f5c3c-f262-49be-87fd-51c3c7e45a0c, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.269 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 7533d31f-3216-46a6-9882-29b278ebf63e, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.270 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: b28c612e-d1ea-4c2a-a05e-5a927af2c024, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.270 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/2, method: GET, req_id: 143e1000-046b-4795-bd5b-4120242f7458, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.272 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: fe804322-cfdb-4733-9d9f-3dcd12ca74f7, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.273 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/4, method: GET, req_id: c7b3bf94-323a-4113-9247-9d4e9329ef54, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:09.273 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8f98cc04-8e85-4f68-b9b4-3ac8e8955256, remote_addr: 127.0.0.1:33279, local_addr: 127.0.0.1:9998
Feb 25 17:29:10.073 INFO accepted connection, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Feb 25 17:29:10.074 INFO request completed, latency_us: 167, response_code: 200, uri: /regioncount, method: GET, req_id: d83b0602-6564-45d8-a614-b37c4dd3f8be, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Feb 25 17:29:13.998 INFO request completed, latency_us: 223, response_code: 204, uri: /stop/cid/0, [8810] Got stop action so:false kr:false
method: POST, req_id: 6d8a1a0d-6801-419d-b8a8-bf2448d83797, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Feb 25 17:29:13.999 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/0, method: GET, req_id: 58595e01-ab49-4415-90fe-cd102c87375f, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Feb 25 17:29:18.002 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/0, method: GET, req_id: 186d8990-0bf3-4986-a188-b6f2d6f68359, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 25 17:29:51.577 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0d6cc952-bb30-4137-9e68-3dc64a67c064, remote_addr: 127.0.0.1:39693, 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
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 25 17:29:55.762 [8820] Got stop action so:false kr:false
INFO request completed, latency_us: 337, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 710b85f6-1222-46d9-8a9f-0db3a12e9905, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Feb 25 17:29:55.763 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1300dc07-c493-45e3-a89c-22559fe72db0, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Feb 25 17:29:59.766 INFO request completed, latency_us: 291, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6bc4b83b-29b9-4fc2-8174-712d12ce9972, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 25 17:30:33.324 INFO request completed, latency_us: 243, response_code: 204, uri: /start/cid/1, method: POST, req_id: 5d286836-3c98-46a7-883b-6168e3a9c63e, remote_addr: 127.0.0.1:39693, 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(1296)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
Feb 25 17:30:37.504 INFO request completed, latency_us: 337, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 82f495bf-9d75-4e29-bc52-7c314a07ac2d, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Feb 25 17:30:37.505 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/2, method: GET, req_id: ae72795f-b73f-4e3e-8e5c-ec60fe1e0b64, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Feb 25 17:30:41.508 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/2, method: GET, req_id: f472f1a3-0286-4d71-8a46-9dddcd139e51, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Feb 25 17:31:15.080 INFO request completed, latency_us: 253, response_code: 204, uri: /start/cid/2, method: POST, req_id: 57997145-21ff-476b-beb0-88c2aaeb4c7e, remote_addr: 127.0.0.1:39693, 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(1297)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Feb 25 17:31:19.298 INFO request completed, latency_us: 327, response_code: 204, uri: [8840] Got stop action so:false kr:false
/stop/cid/3, method: POST, req_id: 3b245e23-e1ca-4edb-b70f-f5b4c872b4ee, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Feb 25 17:31:19.299 INFO request completed, latency_us: 164, response_code: 200, uri: /state/cid/3, method: GET, req_id: df9594f6-1cc3-421f-8f91-eb0929727abe, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Feb 25 17:31:23.301 INFO request completed, latency_us: 195, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8dd3c6aa-18f6-41d7-9429-ef1bf38ff6a1, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Feb 25 17:31:56.899 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/3, method: POST, req_id: c90a0c54-2b49-4096-87b9-903671b8f586, remote_addr: 127.0.0.1:39693, 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(1298)
[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
Feb 25 17:32:01.159 INFO request completed, latency_us: 323, response_code: 204, uri: /stop/cid/4, method: POST, req_id: bb6c092d-ef0c-4175-b353-f5377a9113f7, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Feb 25 17:32:01.160 INFO request completed, latency_us: 118, response_code: 200, uri: /state/cid/4, method: GET, req_id: 7424c893-deab-45fb-b63c-b97aa9be2f61, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Feb 25 17:32:05.161 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/4, method: GET, req_id: 76d2fad6-2a0e-4108-8a4f-c781a8cdf590, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Feb 25 17:32:38.702 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/4, method: POST, req_id: 6a61351a-315f-4726-ba96-8436b99daa27, remote_addr: 127.0.0.1:39693, local_addr: 127.0.0.1:9998
[8850] got start action
[8850] I am going to restart
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] reports Starting
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1299)
[8850][4] reports Running
Feb 25 17:32:42.775 INFO accepted connection, remote_addr: 127.0.0.1:61221, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Feb 25 17:32:42.776 INFO request completed, latency_us: 263, response_code: 204, uri: /shutdown, method: POST, req_id: [8810] Disable keep_running
a0211c5a-4d34-4905-b478-ec3039c26a35[8810] Got stop action so:false kr:false
, remote_addr: 127.0.0[8820] Disable keep_running
.[8820] Got stop action so:false kr:false
1[8850] Disable keep_running
:[8850] Got stop action so:false kr:false
61221[8840] Disable keep_running
, [8840] Got stop action so:false kr:false
local_addr[8870] Disable keep_running
:[8870] Got stop action so:false kr:false
 127.[8860] Disable keep_running
0[8860] Got stop action so:false kr:false
.[8830] Disable keep_running
0[8830] Got stop action so:false kr:false
.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] 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
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit