/var/tmp/bins/dsc create --cleanup --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.25356382
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.042872623
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.037513297
Created 3 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
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 })
start ds: 8810
start access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
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
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1186)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1187)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1188)
[8810][0] initial start wait reports Running
All downstairs are running
Sep 27 23:04:46.948 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Sep 27 23:04:51.997 INFO accepted connection, remote_addr: 127.0.0.1:60225, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 3
[8810] Disable keep_running
[8830] Disable keep_running
[8820] Disable keep_running
Sep 27 23:04:52.000 INFO request completed, latency_us: 731, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 127e1100-1920-4ac3-9065-64849bb94474, remote_addr: 127.0.0.1:60225, local_addr: 127.0.0.1:9998
Sep 27 23:04:52.082 INFO accepted connection, remote_addr: 127.0.0.1:65157, local_addr: 127.0.0.1:9998
Sep 27 23:04:52.084 INFO request completed, latency_us: 705, response_code: 200, uri: /regioninfo, method: GET, req_id: b739dabf-a57b-4274-b6ce-0929310b0bde, remote_addr: 127.0.0.1:65157, local_addr: 127.0.0.1:9998
Sep 27 23:04:52.085 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 32ee8dec-d4fa-44da-bc45-a437d8dd1201, remote_addr: 127.0.0.1:65157, local_addr: 127.0.0.1:9998
Sep 27 23:04:52.086 INFO request completed, latency_us: 187, response_code: 200, uri: /port/cid/0, method: GET, req_id: c55c4876-7851-4227-8941-bf1c1c26987b, remote_addr: 127.0.0.1:65157, local_addr: 127.0.0.1:9998
Sep 27 23:04:52.086 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2a9aa5c7-c190-463a-88d1-a55d4d5fbd81, remote_addr: 127.0.0.1:65157, local_addr: 127.0.0.1:9998
Sep 27 23:04:52.087 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: c043ee95-ff0e-462f-a84d-f30f36a0ccd1, remote_addr: 127.0.0.1:65157, local_addr: 127.0.0.1:9998
Sep 27 23:05:01.212 INFO accepted connection, remote_addr: 127.0.0.1:53510, local_addr: 127.0.0.1:9998
Sep 27 23:05:01.213 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: 66eb4eea-b51d-409f-82ba-58b91a671b49, remote_addr: 127.0.0.1:53510, local_addr: 127.0.0.1:9998
Sep 27 23:05:01.214 INFO request completed, latency_us: 104, response_code: 200, uri: /regioncount, method: GET, req_id: fd83eabe-c69d-4af2-93f9-9614c532dc0b, remote_addr: 127.0.0.1:53510, local_addr: 127.0.0.1:9998
Sep 27 23:05:01.215 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/0, method: GET, req_id: cd60b9d9-1a93-4672-b92b-ea8d17f7ea01, remote_addr: 127.0.0.1:53510, local_addr: 127.0.0.1:9998
Sep 27 23:05:01.215 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 69713485-5e46-4db0-8131-cc9b83df5eb2, remote_addr: 127.0.0.1:53510, local_addr: 127.0.0.1:9998
Sep 27 23:05:01.216 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/2, method: GET, req_id: d6e077ec-a8b4-4688-9a65-18aa55133c1f, remote_addr: 127.0.0.1:53510, local_addr: 127.0.0.1:9998
Sep 27 23:05:10.446 INFO accepted connection, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998
Sep 27 23:05:10.447 INFO request completed, latency_us: 191, response_code: 200, uri: /regioninfo, method: GET, req_id: d022f03b-53d2-4168-81af-6aa2bd26f76e, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998
Sep 27 23:05:10.448 INFO request completed, latency_us: 122, response_code: 200, uri: /regioncount, method: GET, req_id: e5233d17-ad59-4102-be96-816bbbac0918, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998
Sep 27 23:05:10.448 INFO request completed, latency_us: 136, response_code: 200, uri: /port/cid/0, method: GET, req_id: 10f969f1-adbf-437b-9570-86c46973ca9d, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998
Sep 27 23:05:10.449 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: 114c436d-5727-4735-a519-a6adcc08a14a, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998
Sep 27 23:05:10.449 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: fbe912e4-06ba-45c9-bcf2-598781c95ca1, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998
Sep 27 23:05:28.709 INFO accepted connection, remote_addr: 127.0.0.1:52115, local_addr: 127.0.0.1:9998
Sep 27 23:05:28.710 INFO request completed, latency_us: 178, response_code: 200, uri: /regioninfo, method: GET, req_id: 40f0c018-bb7e-43fe-9f59-6ddeb7d83711, remote_addr: 127.0.0.1:52115, local_addr: 127.0.0.1:9998
Sep 27 23:05:28.711 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: 076d310f-d188-46f0-a8be-306fcc1c6ee9, remote_addr: 127.0.0.1:52115, local_addr: 127.0.0.1:9998
Sep 27 23:05:28.712 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 86f730b0-7321-4457-93d0-71836980639b, remote_addr: 127.0.0.1:52115, local_addr: 127.0.0.1:9998
Sep 27 23:05:28.712 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7b344b73-f359-4e58-8f33-a6d474d3a367, remote_addr: 127.0.0.1:52115, local_addr: 127.0.0.1:9998
Sep 27 23:05:28.713 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: bea1ebfc-c242-4bf3-a75b-22c85d418cc9, remote_addr: 127.0.0.1:52115, local_addr: 127.0.0.1:9998
Sep 27 23:05:47.428 INFO accepted connection, remote_addr: 127.0.0.1:57128, local_addr: 127.0.0.1:9998
Sep 27 23:05:47.429 INFO request completed, latency_us: 158, response_code: 200, uri: /regioninfo, method: GET, req_id: 86e946de-57d3-4b6c-a798-ebf5f7c00a77, remote_addr: 127.0.0.1:57128, local_addr: 127.0.0.1:9998
Sep 27 23:05:47.430 INFO request completed, latency_us: 125, response_code: 200, uri: /regioncount, method: GET, req_id: 19603434-33db-4df5-bb80-afca25789039, remote_addr: 127.0.0.1:57128, local_addr: 127.0.0.1:9998
Sep 27 23:05:47.430 INFO request completed, latency_us: 120, response_code: 200, uri: /port/cid/0, method: GET, req_id: feea9155-51d0-4c7b-9932-da8a535da11f, remote_addr: 127.0.0.1:57128, local_addr: 127.0.0.1:9998
Sep 27 23:05:47.431 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 25604110-bd9f-4874-a25a-3d3b144880cd, remote_addr: 127.0.0.1:57128, local_addr: 127.0.0.1:9998
Sep 27 23:05:47.431 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: cf783a5f-0433-4b78-8618-ae853f7ebf9b, remote_addr: 127.0.0.1:57128, local_addr: 127.0.0.1:9998
Sep 27 23:06:50.380 INFO accepted connection, remote_addr: 127.0.0.1:42750, local_addr: 127.0.0.1:9998
Sep 27 23:06:50.380 INFO request completed, latency_us: 175, response_code: 200, uri: /regioninfo, method: GET, req_id: 6b071463-396d-4801-9f7d-b685afce9dd6, remote_addr: 127.0.0.1:42750, local_addr: 127.0.0.1:9998
Sep 27 23:06:50.381 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: a9115954-c964-4554-98e2-e0ea85827f55, remote_addr: 127.0.0.1:42750, local_addr: 127.0.0.1:9998
Sep 27 23:06:50.382 INFO request completed, latency_us: 151, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5436b539-dbd5-438e-8622-94fe8eb5ab0b, remote_addr: 127.0.0.1:42750, local_addr: 127.0.0.1:9998
Sep 27 23:06:50.382 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5ce7439a-e423-4e0e-972a-f6c4a424787a, remote_addr: 127.0.0.1:42750, local_addr: 127.0.0.1:9998
Sep 27 23:06:50.383 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: b9023cf6-9b0d-4e34-a278-b267aafd7399, remote_addr: 127.0.0.1:42750, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.515 INFO accepted connection, remote_addr: 127.0.0.1:48199, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.515 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: e5c6d9ec-3f59-4f43-b62a-256dbecf749b, remote_addr: 127.0.0.1:48199, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.516 INFO request completed, latency_us: 95, response_code: 200, uri: /regioncount, method: GET, req_id: 08e67e1f-5bb8-4a3e-bf13-407751cf56a9, remote_addr: 127.0.0.1:48199, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.517 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1489dc7d-5555-4d67-938b-a1c3f5eaae29, remote_addr: 127.0.0.1:48199, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.517 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3c3bf64c-8ae1-4588-8dc1-41cf4679d9a5, remote_addr: 127.0.0.1:48199, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.518 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/2, method: GET, req_id: 353a1cb1-67f3-4485-8ebc-6f01ce4aedb6, remote_addr: 127.0.0.1:48199, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.624 INFO accepted connection, remote_addr: 127.0.0.1:47481, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 3
Sep 27 23:06:54.625 INFO request completed, latency_us: 155, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 27082843-473f-4719-b350-3520d6e0eb7b, remote_addr:[8810] Disable keep_running
 127.0.[8830] Disable keep_running
0[8820] Disable keep_running
.1:47481, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.677 INFO accepted connection, remote_addr: 127.0.0.1:46241, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Sep 27 23:06:54.678 INFO request completed, latency_us: 169, response_code:[8830] Got stop action so:false kr:false
 204, uri: /stop/cid/2, method: POST, req_id: dccf71e1-fa2f-4493-aea4-70f6cc62b26e, remote_addr: 127.0.0.1:46241, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Sep 27 23:06:54.735 INFO accepted connection, remote_addr: 127.0.0.1:53602, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Sep 27 23:06:54.736 INFO request completed, latency_us: 175, response_code: 204, uri: /start/cid/2, method: POST, req_id: 09329b18-6acd-4310-8f68-fa3e02d86e36, remote_addr: 127.0.0.1:53602, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.816 INFO accepted connection, remote_addr: 127.0.0.1:57505, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.816 INFO request completed, latency_us: 179, response_code: 200, uri: /regioninfo, method: GET, req_id: 304ad5a4-21e8-4b59-8600-e0697a6f9902, remote_addr: 127.0.0.1:57505, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.817 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: daa56be2-8aee-4e9d-a7fa-d708f5204b71, remote_addr: 127.0.0.1:57505, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.818 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/0, method: GET, req_id: a1a27d93-e0e3-42bb-bfbf-4060633c96bb, remote_addr: 127.0.0.1:57505, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.818 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3a809c35-4007-4a49-acc7-c5ba3ab3c89e, remote_addr: 127.0.0.1:57505, local_addr: 127.0.0.1:9998
Sep 27 23:06:54.819 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4d6ccdad-51d4-4fc7-86ac-dad38c9efae2, remote_addr: 127.0.0.1:57505, 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(1232)
[8830][2] reports Running
Sep 27 23:07:09.051 INFO accepted connection, remote_addr: 127.0.0.1:40417, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Sep 27 23:07:09.051 INFO request completed, latency_us: 245[8810] Disable keep_running
, response_code:[8810] Got stop action so:false kr:false
 204, uri: /shutdown, method: POST, req_id: 2157554b-dabb-4155-824e-2928a5ff7f38, remote_addr: 127.0.0.1:40417, local_addr: 127.0.0.1:9998
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
/var/tmp/bins/dsc create --cleanup --region-count 4 --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.104821905
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.10664369
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.10563736
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.09802438
Created 4 regions
/var/tmp/bins/dsc start --region-count 4 --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 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"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8830
[8820][1] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] 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
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1246)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1247)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1248)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1249)
[8810][0] initial start wait reports Running
All downstairs are running
Sep 27 23:07:14.510 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Sep 27 23:07:19.555 INFO accepted connection, remote_addr: 127.0.0.1:62600, local_addr: 127.0.0.1:9998
Sep 27 23:07:19.556 INFO request completed, latency_us: 321, response_code: 200, uri: /regioninfo, method: GET, req_id: 45d1e4a2-42a7-4cbe-8f46-de304aa58923, remote_addr: 127.0.0.1:62600, local_addr: 127.0.0.1:9998
Sep 27 23:07:19.557 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: 794e15d3-ce8d-4e24-8790-da3e54cdbc85, remote_addr: 127.0.0.1:62600, local_addr: 127.0.0.1:9998
Sep 27 23:07:19.558 INFO request completed, latency_us: 137, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6d7b440b-35b5-4123-86ae-a23a56172a3b, remote_addr: 127.0.0.1:62600, local_addr: 127.0.0.1:9998
Sep 27 23:07:19.558 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: e40d96ac-2dad-42f0-99dd-a6346f99d3bc, remote_addr: 127.0.0.1:62600, local_addr: 127.0.0.1:9998
Sep 27 23:07:19.559 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9ba4ed80-2329-47bd-afa9-94d6968ad33a, remote_addr: 127.0.0.1:62600, local_addr: 127.0.0.1:9998
Sep 27 23:07:19.656 INFO accepted connection, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 27 23:07:19.656 INFO request completed, latency_us: 203, response_code: 204, uri: /stop/cid/0, method: POST, req_id: c5f7218b-8114-40a9-936a-37ecdb020a6b, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
[8810] Got stop action so:false kr:false
Sep 27 23:07:19.657 INFO request completed, latency_us: 118, response_code: 200, uri: /state/cid/0, method: GET, req_id: b5e9aebc-8b09-4c84-a1c6-e8c16bcdf06a, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 27 23:07:23.660 INFO request completed, latency_us: 354, response_code: 200, uri: /state/cid/0, method: GET, req_id: 015e57af-aed8-4194-90d3-a0ba1b02b200, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 27 23:07:23.685 INFO request completed, latency_us: 174, response_code: 204, uri: /start/cid/0, method: POST, req_id: b079dccc-76cc-4f5d-b8cf-62a58bfc0ff5, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:07:23.685 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/0, method: GET, req_id: a571e83a-d7ea-4bcd-b6e9-85ed11c226ed, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:07:27.688 INFO request completed, latency_us: 268, response_code: 200, uri: /state/cid/0, method: GET, req_id: 607c1553-c079-4941-9328-980495708ae6, remote_addr: 127.0.0.1:34143, 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(1252)
[8810][0] reports Running
Sep 27 23:07:31.690 INFO request completed, latency_us: 330, response_code: 200, uri: /state/cid/0, method: GET, req_id: a8d26f77-81b7-4ed7-8d91-640397231763, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 27 23:07:37.718[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: 1b954d79-a3c5-44ff-b315-cc6be3a3bdd2, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:07:37.719 INFO request completed, latency_us: 151, response_code: 200, uri: /state/cid/0, method: GET, req_id: 233b5826-7c7e-4b81-9e7f-d6cab0e59354, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 27 23:07:41.722 INFO request completed, latency_us: 224, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3a06f793-04db-4dfc-a076-0331918c629e, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 27 23:07:41.749 INFO request completed, latency_us: 161, response_code: 204, uri: /start/cid/0, method: POST, req_id: c623c2d7-e1c6-4dca-b6f3-ecd311b248e6, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:07:41.749 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9d4e00df-1d74-4919-802f-f4cb52cc8ac0, remote_addr: 127.0.0.1:34143, 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(1253)
[8810][0] reports Running
Sep 27 23:07:45.752 INFO request completed, latency_us: 344, response_code: 200, uri: /state/cid/0, method: GET, req_id: cdeaf054-db6f-42d4-b8d3-da95664b4511, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Sep 27 23:08:15.051 INFO request completed, latency_us: [8820] Got stop action so:false kr:false
237, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 111a375b-a21d-4782-a197-756bc0f2dbae, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:08:15.054 INFO request completed, latency_us: 134, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5db31c56-d05f-42b1-915c-bf7e0afc19ec, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Sep 27 23:08:19.057 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/1, method: GET, req_id: 996fc14b-2ec2-4dc8-bced-708ce2a27bf2, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Sep 27 23:08:19.083 INFO request completed, latency_us: 204, response_code: 204, uri: /start/cid/1, method: POST, req_id: dd2a42d7-a9f9-4fb9-8136-e8d4bba13f2f, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:08:19.084 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/1, method: GET, req_id: f1ac85a9-7ee7-4db9-90fe-3af063d7d358, remote_addr: 127.0.0.1:34143, 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(1254)
[8820][1] reports Running
Sep 27 23:08:23.087 INFO request completed, latency_us: 364, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7efc5ace-e7d9-4b6c-aba0-8d85cbf74cee, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Sep 27 23:08:52.376 [8830] Got stop action so:false kr:false
INFO request completed, latency_us: 214, response_code: 204, uri: /stop/cid/2, method: POST, req_id: d4aa857a-1689-4acf-9478-1b411341be6c, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:08:52.377 INFO request completed, latency_us: 157, response_code: 200, uri: /state/cid/2, method: GET, req_id: a1e2c44f-de8b-4cf8-9911-f423edeb88df, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Sep 27 23:08:56.378 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7b40cc82-b01e-4874-a2d8-5d429c9cc532, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Sep 27 23:08:56.407 INFO request completed, latency_us: 155, response_code: 204, uri: /start/cid/2, method: POST, req_id: dc461c04-b935-40f6-83ae-0e94ee86ad81, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:08:56.408 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/2, method: GET, req_id: eb3eeb19-d587-4ccf-8888-57ea1ea592cb, remote_addr: 127.0.0.1:34143, 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(1255)
[8830][2] reports Running
Sep 27 23:09:00.410 INFO request completed, latency_us: 339, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5bc2e8fb-065b-4f29-bdc1-2362df0a8039, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Sep 27 23:09:29.696 INFO request completed, latency_us: 218, response_code: 204[8840] Got stop action so:false kr:false
, uri: /stop/cid/3, method: POST, req_id: 2cc87761-c738-495d-950c-44d593667d5e, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:09:29.697 INFO request completed, latency_us: 125, response_code: 200, uri: /state/cid/3, method: GET, req_id: d57d18dc-eebc-4022-a46d-4c65463dd93e, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Sep 27 23:09:33.700 INFO request completed, latency_us: 433, response_code: 200, uri: /state/cid/3, method: GET, req_id: 0b78e38d-0d54-49fa-81e9-95f33ff64467, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Sep 27 23:09:33.730 INFO request completed, latency_us: 175, response_code: 204, uri: /start/cid/3, method: POST, req_id: c09fb3c2-170a-45a6-a751-fbfa2aa96900, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:09:33.731 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/3, method: GET, req_id: f5d70853-a741-46a1-a20e-0b672bef43c6, remote_addr: 127.0.0.1:34143, 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(1256)
[8840][3] reports Running
Sep 27 23:09:37.733 INFO request completed, latency_us: 341, response_code: 200, uri: /state/cid/3, method: GET, req_id: 1080b51a-c563-4bc0-a94f-fbb808bb94e3, remote_addr: 127.0.0.1:34143, local_addr: 127.0.0.1:9998
Sep 27 23:10:03.062 INFO accepted connection, remote_addr: 127.0.0.1:58773, local_addr: 127.0.0.1:9998
Sep 27 23:10:03.063 INFO request completed, latency_us: 196, response_code: 200, uri: /regioninfo, method: GET, req_id: e973fcbf-2b66-4fb8-995d-901c560228d9, remote_addr: 127.0.0.1:58773, local_addr: 127.0.0.1:9998
Sep 27 23:10:03.064 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: 0d563ac0-f6dd-4096-ba3a-9fd1b7eae9bb, remote_addr: 127.0.0.1:58773, local_addr: 127.0.0.1:9998
Sep 27 23:10:03.064 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0291d860-32b7-453a-af58-8f68ee9ace74, remote_addr: 127.0.0.1:58773, local_addr: 127.0.0.1:9998
Sep 27 23:10:03.065 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5928d250-89f7-48f7-a9e2-fb739f0157f6, remote_addr: 127.0.0.1:58773, local_addr: 127.0.0.1:9998
Sep 27 23:10:03.065 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 000b0ed7-4a50-4832-9138-c1b98c51cf36, remote_addr: 127.0.0.1:58773, local_addr: 127.0.0.1:9998
Sep 27 23:10:03.172 INFO accepted connection, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 27 23:10:03.173 INFO request completed, latency_us: 164, response_code: 204, uri: /stop/cid/0, method: POST, req_id: d3cbb7ca-1045-4c93-9643-b5606b4642ee, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
[8810] Got stop action so:false kr:false
Sep 27 23:10:03.173 INFO request completed, latency_us: 140, response_code: 200, uri: /state/cid/0, method: GET, req_id: a724ca7b-86de-454a-b7d1-9f831913601f, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 27 23:10:07.176 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/0, method: GET, req_id: eb6b07a7-9615-4cb7-b7b9-5e2e192eb139, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 27 23:10:31.422 INFO request completed, latency_us: 212, response_code: 204, uri: /start/cid/0, method: POST, req_id: 4c1a9579-94fa-47b6-8bd6-27fc8d82eb82, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Sep 27 23:10:35.462 INFO [8820] Got stop action so:false kr:false
request completed, latency_us: 216, response_code: 204, uri: /stop/cid/1, method: POST, req_id: b756a20b-4cb4-48fb-a35f-bfcfbc9776e2, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Sep 27 23:10:35.463 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/1, method: GET, req_id: c522139f-4154-4438-abf2-6388f6398871, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Sep 27 23:10:39.466 INFO request completed, latency_us: 332, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4c3ebc69-0bba-46f3-bed8-07dd725fe744, remote_addr: 127.0.0.1:57354, 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(1258)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Start(1)
start 1
Sep 27 23:11:03.708 INFO request completed, latency_us: 342, response_code: 204, uri: /start/cid/1, method: POST, req_id: e7ee7556-0e73-4b35-906b-a6848770995c, remote_addr: 127.0.0.1:57354, 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(1259)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Sep 27 23:11:07.748 [8830] Got stop action so:false kr:false
INFO request completed, latency_us: 306, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 21c6b884-6820-4613-b7e8-699bba4a791b, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Sep 27 23:11:07.749 INFO request completed, latency_us: 133, response_code: 200, uri: /state/cid/2, method: GET, req_id: cb09ce89-61ba-465a-a82d-d32a98da5e4f, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Sep 27 23:11:11.751 INFO request completed, latency_us: 293, response_code: 200, uri: /state/cid/2, method: GET, req_id: d1747a81-cc2f-4ba4-8b1a-08779116de1b, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Sep 27 23:11:35.992 INFO request completed, latency_us: 214, response_code: 204, uri: /start/cid/2, method: POST, req_id: f66ae0f4-e7fc-492d-ae8f-0d895ff1d35c, remote_addr: 127.0.0.1:57354, 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(1260)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
[8840] Got stop action so:false kr:false
Sep 27 23:11:40.036 INFO request completed, latency_us: 316, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 89466246-e9df-4064-a246-ade8c736d2d4, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Sep 27 23:11:40.037 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/3, method: GET, req_id: 0ee6983d-02e9-4584-8717-dd1301506b2d, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Sep 27 23:11:44.039 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/3, method: GET, req_id: d5fa408c-ba62-4f46-a0ae-d4ac8e5eadf0, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Sep 27 23:12:08.279 INFO request completed, latency_us: 236, response_code: 204, uri: /start/cid/3, method: POST, req_id: b6237853-d050-47d5-824f-89f5ffdfcaa1, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 27 23:12:12.325 INFO request completed, latency_us: 235, response_code: 204, uri[8810] Got stop action so:false kr:false
: /stop/cid/0, method: POST, req_id: 806591a1-9e14-4160-9901-f673db2f6037, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Sep 27 23:12:12.326 INFO request completed, latency_us: 110, response_code: 200, uri: /state/cid/0, method: GET, req_id: f0a9375d-dd96-4af9-b8a7-6f40e967af8d, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 27 23:12:16.329 INFO request completed, latency_us: 300, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2a2af399-3b82-4d49-a6ee-12b4c0311c0f, remote_addr: 127.0.0.1:57354, 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(1261)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 27 23:12:40.570 INFO request completed, latency_us: 363, response_code: 204, uri: /start/cid/0, method: POST, req_id: e5f90c7a-8598-4afa-ab71-118033d6f9ba, remote_addr: 127.0.0.1:57354, local_addr: 127.0.0.1:9998
Sep 27 23:12:44.639 INFO accepted connection, remote_addr: 127.0.0.1:50005, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Sep 27 23:12:44.639 INFO request completed[8820] Disable keep_running
, latency_us: 174[8830] Disable keep_running
, response_code: 204, uri: /shutdown[8830] Got stop action so:false kr:false
, method: POST, req_id: [8820] Got stop action so:false kr:false
afed4eff-f350-430b-b582-35ae45322362, remote_addr: 127.0.0.1:50005, local_addr: 127.0.0.1:9998
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit