/var/tmp/bins/dsc create --cleanup --region-count 3 --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.2315546
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.017112589
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.01721584
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 --region-count 3
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 })
start ds: 8810
start ds: 8820
start ds: 8830
start access at:127.0.0.1:9998
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-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8810][0] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1186)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1187)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1188)
[8830][2] initial start wait reports Running
All downstairs are running
Nov 28 04:50:15.284 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Nov 28 04:50:20.322 INFO accepted connection, remote_addr: 127.0.0.1:37276, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.324 INFO request completed, latency_us: 382, response_code: 200, uri: /state/cid/0, method: GET, req_id: 53e4c244-99c7-411a-a4ab-a5c526a87050, remote_addr: 127.0.0.1:37276, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.376 INFO accepted connection, remote_addr: 127.0.0.1:55193, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.377 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/1, method: GET, req_id: cdf8f024-4131-4e18-9512-2cf9b36c6319, remote_addr: 127.0.0.1:55193, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.428 INFO accepted connection, remote_addr: 127.0.0.1:59032, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.429 INFO request completed, latency_us: 128, response_code: 200, uri: /state/cid/2, method: GET, req_id: d8f0b3f4-b3bf-4aa7-ad55-3d7451254077, remote_addr: 127.0.0.1:59032, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.481 INFO accepted connection, remote_addr: 127.0.0.1:38236, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 3
Nov 28 04:50:20.482 INFO request completed, latency_us: 123, response_code: 204, uri: /disablerestart/all, method: POST, req_id[8810] Disable keep_running
: aa208364-bc52-4fea-ae4b-8f939456d7b2, remote_addr: 127.[8820] Disable keep_running
0[8830] Disable keep_running
.0.1:38236, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.592 INFO accepted connection, remote_addr: 127.0.0.1:65450, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.593 INFO request completed, latency_us: 258, response_code: 200, uri: /regioninfo, method: GET, req_id: 21bb8880-1fbb-4159-af59-e5ac4507092c, remote_addr: 127.0.0.1:65450, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.595 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: fd24f1dd-a451-4601-86e4-95656687c787, remote_addr: 127.0.0.1:65450, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.596 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/0, method: GET, req_id: ce9fc8f3-397f-4aa8-8fbf-803fd6dc4bd7, remote_addr: 127.0.0.1:65450, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.596 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: e9fd860f-6b40-4dbe-a1e2-e2459259afc2, remote_addr: 127.0.0.1:65450, local_addr: 127.0.0.1:9998
Nov 28 04:50:20.597 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: b328d067-ae6c-4662-82b3-3f8483a11bc8, remote_addr: 127.0.0.1:65450, local_addr: 127.0.0.1:9998
Nov 28 04:50:29.722 INFO accepted connection, remote_addr: 127.0.0.1:64724, local_addr: 127.0.0.1:9998
Nov 28 04:50:29.722 INFO request completed, latency_us: 157, response_code: 200, uri: /regioninfo, method: GET, req_id: 400363ed-080b-450f-ac89-2c573c04e4ef, remote_addr: 127.0.0.1:64724, local_addr: 127.0.0.1:9998
Nov 28 04:50:29.723 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: d24d617f-4a1a-4e4d-bdbd-3842610cad21, remote_addr: 127.0.0.1:64724, local_addr: 127.0.0.1:9998
Nov 28 04:50:29.724 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3159deb0-442e-4836-9951-404a6b5d4fb0, remote_addr: 127.0.0.1:64724, local_addr: 127.0.0.1:9998
Nov 28 04:50:29.724 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7b07eb20-2b0e-4afe-8757-3e68b3df6137, remote_addr: 127.0.0.1:64724, local_addr: 127.0.0.1:9998
Nov 28 04:50:29.725 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/2, method: GET, req_id: 23b07654-e181-4094-ae10-f6f8784a8687, remote_addr: 127.0.0.1:64724, local_addr: 127.0.0.1:9998
Nov 28 04:50:38.904 INFO accepted connection, remote_addr: 127.0.0.1:42196, local_addr: 127.0.0.1:9998
Nov 28 04:50:38.905 INFO request completed, latency_us: 154, response_code: 200, uri: /regioninfo, method: GET, req_id: 3e57511a-3845-4476-bedb-460038e95edf, remote_addr: 127.0.0.1:42196, local_addr: 127.0.0.1:9998
Nov 28 04:50:38.906 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 9972d377-baa7-4496-b34e-98f1e9a9437a, remote_addr: 127.0.0.1:42196, local_addr: 127.0.0.1:9998
Nov 28 04:50:38.906 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8ba6e03d-55d2-46e3-abb8-10b9eafa7706, remote_addr: 127.0.0.1:42196, local_addr: 127.0.0.1:9998
Nov 28 04:50:38.907 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: 70bfd784-8fa3-4795-bdc2-30cb52b6fc8f, remote_addr: 127.0.0.1:42196, local_addr: 127.0.0.1:9998
Nov 28 04:50:38.908 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/2, method: GET, req_id: bfe682fd-1400-411c-bda5-7166b7ca509d, remote_addr: 127.0.0.1:42196, local_addr: 127.0.0.1:9998
Nov 28 04:50:56.557 INFO accepted connection, remote_addr: 127.0.0.1:64077, local_addr: 127.0.0.1:9998
Nov 28 04:50:56.558 INFO request completed, latency_us: 154, response_code: 200, uri: /regioninfo, method: GET, req_id: 00603769-a425-4f09-9da7-d2c40d190949, remote_addr: 127.0.0.1:64077, local_addr: 127.0.0.1:9998
Nov 28 04:50:56.559 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 7550ed98-7156-4844-b239-33bf2e223cbe, remote_addr: 127.0.0.1:64077, local_addr: 127.0.0.1:9998
Nov 28 04:50:56.559 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5818b1ac-d350-4a71-a523-a0133515d3fc, remote_addr: 127.0.0.1:64077, local_addr: 127.0.0.1:9998
Nov 28 04:50:56.560 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3cbdb837-1506-4e7c-b15b-1d296e11e06a, remote_addr: 127.0.0.1:64077, local_addr: 127.0.0.1:9998
Nov 28 04:50:56.560 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: f46f2ad1-57c6-413d-9ab6-89e1cf10f3c7, remote_addr: 127.0.0.1:64077, local_addr: 127.0.0.1:9998
Nov 28 04:51:11.235 INFO accepted connection, remote_addr: 127.0.0.1:55507, local_addr: 127.0.0.1:9998
Nov 28 04:51:11.235 INFO request completed, latency_us: 166, response_code: 200, uri: /regioninfo, method: GET, req_id: 3a76e10b-fab8-49b0-9b01-68c6f4adcdb8, remote_addr: 127.0.0.1:55507, local_addr: 127.0.0.1:9998
Nov 28 04:51:11.236 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 892e1d80-a611-44dd-9cf0-e3f31575a43b, remote_addr: 127.0.0.1:55507, local_addr: 127.0.0.1:9998
Nov 28 04:51:11.237 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: 42796c08-9a39-400d-944b-6daa912e5e46, remote_addr: 127.0.0.1:55507, local_addr: 127.0.0.1:9998
Nov 28 04:51:11.237 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/1, method: GET, req_id: 24011869-a2ba-439f-bf53-1d0aec2e612b, remote_addr: 127.0.0.1:55507, local_addr: 127.0.0.1:9998
Nov 28 04:51:11.238 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/2, method: GET, req_id: 322af08b-bb89-4b6a-bf7a-3805b9a4106c, remote_addr: 127.0.0.1:55507, local_addr: 127.0.0.1:9998
Nov 28 04:52:13.594 INFO accepted connection, remote_addr: 127.0.0.1:59055, local_addr: 127.0.0.1:9998
Nov 28 04:52:13.595 INFO request completed, latency_us: 155, response_code: 200, uri: /regioninfo, method: GET, req_id: 30e3f5a2-8a71-421f-a212-80edd16cabeb, remote_addr: 127.0.0.1:59055, local_addr: 127.0.0.1:9998
Nov 28 04:52:13.596 INFO request completed, latency_us: 104, response_code: 200, uri: /regioncount, method: GET, req_id: 88065506-fc30-4438-9ad9-44760848bc2f, remote_addr: 127.0.0.1:59055, local_addr: 127.0.0.1:9998
Nov 28 04:52:13.597 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/0, method: GET, req_id: 326cde6c-ff07-445e-b2fd-ef26705b06de, remote_addr: 127.0.0.1:59055, local_addr: 127.0.0.1:9998
Nov 28 04:52:13.597 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7f972ea4-85dd-47ea-87dc-53c13f528106, remote_addr: 127.0.0.1:59055, local_addr: 127.0.0.1:9998
Nov 28 04:52:13.598 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: b66c020f-6241-452f-991b-ef91c2baad3e, remote_addr: 127.0.0.1:59055, local_addr: 127.0.0.1:9998
Nov 28 04:52:17.724 INFO accepted connection, remote_addr: 127.0.0.1:40532, local_addr: 127.0.0.1:9998
Nov 28 04:52:17.725 INFO request completed, latency_us: 154, response_code: 200, uri: /regioninfo, method: GET, req_id: a3f4c7b9-b7f2-4a13-87b0-97f126c9eb99, remote_addr: 127.0.0.1:40532, local_addr: 127.0.0.1:9998
Nov 28 04:52:17.726 INFO request completed, latency_us: 106, response_code: 200, uri: /regioncount, method: GET, req_id: e95ffefe-6e77-4b6e-97c7-bcde90581dbf, remote_addr: 127.0.0.1:40532, local_addr: 127.0.0.1:9998
Nov 28 04:52:17.726 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1b6c7ddd-7d00-45d9-96c0-48d0cdd584f2, remote_addr: 127.0.0.1:40532, local_addr: 127.0.0.1:9998
Nov 28 04:52:17.727 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: c14082a2-55c7-4a4a-b0dd-2b624f12d79b, remote_addr: 127.0.0.1:40532, local_addr: 127.0.0.1:9998
Nov 28 04:52:17.727 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5322f560-a28b-495c-ad7d-d41f89074c9a, remote_addr: 127.0.0.1:40532, local_addr: 127.0.0.1:9998
Nov 28 04:52:21.836 INFO accepted connection, remote_addr: 127.0.0.1:52730, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 3
Nov 28 04:52:21.837 INFO request completed, latency_us: 173, response_code: 204, uri: /disablerestart/all, method:[8810] Disable keep_running
 [8830] Disable keep_running
POST, req_id: 8047987c-4969-40ff-abff-2aab5446a269, remote_addr: 127[8820] Disable keep_running
.0.0.1:52730, local_addr: 127.0.0.1:9998
Nov 28 04:52:21.890 INFO accepted connection, remote_addr: 127.0.0.1:40772, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
Nov 28 04:52:21.890 INFO request completed, latency_us: 156, response_code: 204, uri: /stop/cid/2, method: POST, req_id: b49dd96e-8a0b-498e-8fc0-4b5b266c6735, remote_addr: 127.0.0.1:40772, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 28 04:52:21.943 INFO accepted connection, remote_addr: 127.0.0.1:36698, local_addr: 127.0.0.1:9998
Nov 28 04:52:21.944 INFO request completed, latency_us: 136, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4b2dad77-2af4-40e5-8f1a-2c23a19bebf7, remote_addr: 127.0.0.1:36698, local_addr: 127.0.0.1:9998
Nov 28 04:52:22.000 INFO accepted connection, remote_addr: 127.0.0.1:39783, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 28 04:52:22.000 INFO request completed, latency_us: 137, response_code: 204, uri: /start/cid/2, method: POST, req_id: 0af740dd-57b9-4825-aef1-393167699d03, remote_addr: 127.0.0.1:39783, local_addr: 127.0.0.1:9998
Nov 28 04:52:22.082 INFO accepted connection, remote_addr: 127.0.0.1:40342, local_addr: 127.0.0.1:9998
Nov 28 04:52:22.082 INFO request completed, latency_us: 136, response_code: 200, uri: /regioninfo, method: GET, req_id: 112ad7bf-a518-477f-8b08-49f773634e41, remote_addr: 127.0.0.1:40342, local_addr: 127.0.0.1:9998
Nov 28 04:52:22.083 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 48154d2d-8545-4c41-895e-b750922cf4cb, remote_addr: 127.0.0.1:40342, local_addr: 127.0.0.1:9998
Nov 28 04:52:22.084 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/0, method: GET, req_id: 75b8eb9c-afe2-41b0-9569-9ba4d32220ff, remote_addr: 127.0.0.1:40342, local_addr: 127.0.0.1:9998
Nov 28 04:52:22.085 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/1, method: GET, req_id: 72b9005c-155f-483c-be70-a49a952a5de9, remote_addr: 127.0.0.1:40342, local_addr: 127.0.0.1:9998
Nov 28 04:52:22.085 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3c35189e-5d5e-4577-9f0d-c7f408dd25ed, remote_addr: 127.0.0.1:40342, 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(1236)
[8830][2] reports Running
Nov 28 04:52:36.291 INFO accepted connection, remote_addr: 127.0.0.1:47124, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Nov 28 04:52:36.292 INFO request completed, latency_us: 191, response_code: 204, uri: /shutdown, method: POST, req_id: 1eeebc82-e009-4ad7-9a91-00873605f532, remote_addr: 127.0.0.1:47124, local_addr[8810] Disable keep_running
:[8810] Got stop action so:false kr:false
 [8820] Disable keep_running
127[8820] Got stop action so:false kr:false
.[8830] Disable keep_running
0[8830] Got stop action so:false kr:false
.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8810][0] 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.026266163
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.023280274
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.023019902
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.022477364
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 access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
start ds: 8840
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 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8820][1] initial start wait reports Starting
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8840
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8840][3] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1250)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1251)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1252)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1253)
[8820][1] initial start wait reports Running
All downstairs are running
Nov 28 04:52:41.429 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Nov 28 04:52:46.468 INFO accepted connection, remote_addr: 127.0.0.1:43374, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.470 INFO request completed, latency_us: 310, response_code: 200, uri: /state/cid/0, method: GET, req_id: 600c9f2f-57f4-4e1e-81f8-8d33a1927349, remote_addr: 127.0.0.1:43374, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.524 INFO accepted connection, remote_addr: 127.0.0.1:55510, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.524 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/1, method: GET, req_id: 51064365-775c-4762-a637-15a70dd471c8, remote_addr: 127.0.0.1:55510, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.578 INFO accepted connection, remote_addr: 127.0.0.1:35077, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.578 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7c5e43ba-381e-46bf-a098-d8c686756613, remote_addr: 127.0.0.1:35077, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.630 INFO accepted connection, remote_addr: 127.0.0.1:57441, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.631 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7b0e55b3-f832-4c09-90ae-2670e37857a9, remote_addr: 127.0.0.1:57441, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.683 INFO accepted connection, remote_addr: 127.0.0.1:38786, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.683 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/3, method: GET, req_id: 9f1073c6-dd44-4613-834e-3b998a7f9809, remote_addr: 127.0.0.1:38786, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.744 INFO accepted connection, remote_addr: 127.0.0.1:56395, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.744 INFO request completed, latency_us: 165, response_code: 200, uri: /regioninfo, method: GET, req_id: aa43d7cc-6a17-4085-942f-b51504084d08, remote_addr: 127.0.0.1:56395, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.745 INFO request completed, latency_us: 98, response_code: 200, uri: /regioncount, method: GET, req_id: 24494a15-54c3-487e-9a50-33a6afe8c24a, remote_addr: 127.0.0.1:56395, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.746 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 40ac510b-8ddb-48da-b313-de9a703ef823, remote_addr: 127.0.0.1:56395, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.746 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 69769a9b-781e-4385-a4f7-533bbdd56aee, remote_addr: 127.0.0.1:56395, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.747 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: dfc3a232-7733-4553-af55-23a3c0484584, remote_addr: 127.0.0.1:56395, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.817 INFO accepted connection, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.818 INFO request completed, latency_us: 101, response_code: 200, uri: /regioncount, method: GET, req_id: ee6629d0-2bf7-4e5b-89f3-f1e7f9502d2e, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 28 04:52:46.842 INFO request completed, latency_us: 300, response_code: 204, uri: /stop/cid/0, method: POST, req_id: d8b11961-3a07-410a-a1e1-24790804c9b4, remote_addr: [8810] Got stop action so:false kr:false
127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:52:46.843 INFO request completed, latency_us: 173, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8cd3526e-f059-4d5e-837e-f883f2d46c0a, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 28 04:52:50.845 INFO request completed, latency_us: 242, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4957d3be-a562-4065-9656-8d4d4c0f48e2, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 28 04:52:50.867 INFO request completed, latency_us: 153, response_code: 204, uri: /start/cid/0, method: POST, req_id: ff3b82db-50e8-4857-9a14-bf72e053111e, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:52:50.867 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/0, method: GET, req_id: 48deb53d-ea39-437c-8210-9e4e3b5001fe, remote_addr: 127.0.0.1:36442, 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(1261)
[8810][0] reports Running
Nov 28 04:52:54.869 INFO request completed, latency_us: 319, response_code: 200, uri: /state/cid/0, method: GET, req_id: 837b7fb0-2c89-44d5-86e5-f9b0b90adc1e, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Nov 28 04:53:25.156 INFO request completed, latency_us: 222[8820] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 4f497f7b-7a55-4c80-b433-7918bef063e5, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:53:25.157 INFO request completed, latency_us: 156, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3e540f20-cc1c-48a3-ba21-af40fe3c0ccd, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 28 04:53:29.159 INFO request completed, latency_us: 202, response_code: 200, uri: /state/cid/1, method: GET, req_id: ac2c883e-f03b-4e0b-a14d-6205034a2686, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 28 04:53:29.180 INFO request completed, latency_us: 143, response_code: 204, uri: /start/cid/1, method: POST, req_id: e69eaf7c-b880-4525-9e2f-09fd910b5c80, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:53:29.181 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/1, method: GET, req_id: a8347a55-2f75-4efd-a379-17cc5f9cb898, remote_addr: 127.0.0.1:36442, 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(1262)
[8820][1] reports Running
Nov 28 04:53:33.183 INFO request completed, latency_us: 324, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8c6792a8-2ad1-487a-94f6-466fc856c2f0, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 28 04:54:03.471 [8830] Got stop action so:false kr:false
INFO request completed, latency_us: 213, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 805c3fb9-80ec-40e3-b7c9-c0a68d4d1676, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:54:03.471 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1b100de7-c173-4e02-a511-2d1d50b60afa, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 28 04:54:07.473 INFO request completed, latency_us: 182, response_code: 200, uri: /state/cid/2, method: GET, req_id: 168f2128-7555-440b-b466-4abd2e15b925, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 28 04:54:07.498 INFO request completed, latency_us: 136, response_code: 204, uri: /start/cid/2, method: POST, req_id: af027ebe-00b9-4977-82e3-95029bba8cf8, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:54:07.498 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/2, method: GET, req_id: c0619021-000f-416f-8767-e766b8827988, remote_addr: 127.0.0.1:36442, 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(1263)
[8830][2] reports Running
Nov 28 04:54:11.500 INFO request completed, latency_us: 281, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7d11ad29-ee71-4db7-8dab-c8bbe9c88ff9, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Nov 28 04:54:41.786 INFO request completed, latency_us: 223, response_code: 204, [8840] Got stop action so:false kr:false
uri: /stop/cid/3, method: POST, req_id: 7eec8ccb-89e2-480b-a842-94dce054b88e, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:54:41.787 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/3, method: GET, req_id: 51cebba5-4421-4ebd-bb98-dd7655974c6a, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Nov 28 04:54:45.789 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/3, method: GET, req_id: 01f6ddd2-9342-432a-9a4c-96be0fd9d613, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Nov 28 04:54:45.812 INFO request completed, latency_us: 206, response_code: 204, uri: /start/cid/3, method: POST, req_id: 4199675b-7b74-4630-a9b8-7401a0a79b07, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:54:45.812 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/3, method: GET, req_id: 12c4e938-da30-47ae-8716-79e3a62d7537, remote_addr: 127.0.0.1:36442, 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(1264)
[8840][3] reports Running
Nov 28 04:54:49.814 INFO request completed, latency_us: 444, response_code: 200, uri: /state/cid/3, method: GET, req_id: af99d246-fa16-4626-9ce8-0fe3b810b3f6, remote_addr: 127.0.0.1:36442, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.152 INFO accepted connection, remote_addr: 127.0.0.1:48735, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.153 INFO request completed, latency_us: 175, response_code: 200, uri: /regioninfo, method: GET, req_id: 07941b7f-a88a-452c-ae59-592d32540327, remote_addr: 127.0.0.1:48735, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.154 INFO request completed, latency_us: 101, response_code: 200, uri: /regioncount, method: GET, req_id: a193da38-2d7c-4356-88fa-6149169aec86, remote_addr: 127.0.0.1:48735, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.154 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: dd6097bc-ad18-4b69-ba49-0d8df8a7016b, remote_addr: 127.0.0.1:48735, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.155 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/1, method: GET, req_id: 4bf75dd6-9cd1-4d0c-a908-f7bdd65bfe35, remote_addr: 127.0.0.1:48735, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.155 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1d0e1d27-c5f6-46e0-9a06-1432d5de6eb5, remote_addr: 127.0.0.1:48735, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.225 INFO accepted connection, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.225 INFO request completed, latency_us: 113, response_code: 200, uri: /regioncount, method: GET, req_id: 4fbee750-fdca-497c-9481-d1f5b5751b55, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 28 04:55:20.614 INFO request completed, latency_us: 277[8810] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/0, method: POST, req_id: c464b19e-5a0d-46d0-9a94-cb7919a4a7e2, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Nov 28 04:55:20.615 INFO request completed, latency_us: 120, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7cbd081a-addb-42e5-ab10-06c2cea5b10d, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 28 04:55:24.616 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/0, method: GET, req_id: c72b2ce2-9099-4b2b-abb8-3d8ac214b93a, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 28 04:55:49.409 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8dacc107-7a47-47c2-aead-fe06f8a7cd99, remote_addr: 127.0.0.1:53391, 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(1266)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
[8820] Got stop action so:false kr:false
Nov 28 04:55:53.433 INFO request completed, latency_us: 385, response_code: 204, uri: /stop/cid/1, method: POST, req_id: e3ea1ae1-62e8-4f21-9233-8c343edbf560, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Nov 28 04:55:53.434 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/1, method: GET, req_id: e7c0dec2-d08c-4ed8-b69a-09d20e56d0a3, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 28 04:55:57.435 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/1, method: GET, req_id: b3d8c616-0b32-4710-a44f-c9e8f60850a4, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 28 04:56:22.209 INFO request completed, latency_us: 214, response_code: 204, uri: /start/cid/1, method: POST, req_id: a88f4886-d818-4788-9834-3800c3072d53, remote_addr: 127.0.0.1:53391, 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(1267)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 28 04:56:26.234 INFO request completed[8830] Got stop action so:false kr:false
, latency_us: 322, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 0a91f8a8-97e0-45f2-9b4d-4ee69f5162b2, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Nov 28 04:56:26.235 INFO request completed, latency_us: 115, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6ec39769-fa8d-4a63-ae17-14edf21461ce, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 28 04:56:30.237 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/2, method: GET, req_id: a24fb451-b332-4be1-8c37-bf03354d85fc, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 28 04:56:55.022 INFO request completed, latency_us: 234, response_code: 204, uri: /start/cid/2, method: POST, req_id: 6bb16a84-e9dd-44c6-82ad-5d35e3e03036, remote_addr: 127.0.0.1:53391, 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(1268)
[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
Nov 28 04:56:59.049 INFO request completed, latency_us: 326, response_code: 204, uri: /stop/cid/3, method: POST, req_id: fd5d1e59-8142-4ec6-843e-229be9f173b2, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Nov 28 04:56:59.050 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/3, method: GET, req_id: 636cd168-92e0-431a-b546-6b59d0bd164c, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Nov 28 04:57:03.052 INFO request completed, latency_us: 182, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7e571874-21d6-4f5c-a714-3a76c92e255d, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Nov 28 04:57:27.841 INFO request completed, latency_us: 224, response_code: 204, uri: /start/cid/3, method: POST, req_id: 449b86e0-1313-47d5-a276-2ff7d70d931d, remote_addr: 127.0.0.1:53391, 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(1269)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 28 04:57:31.874 INFO request completed, latency_us:[8810] Got stop action so:false kr:false
 330, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 3aa5ffd3-3f7a-462e-99aa-db88686a2eaa, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Nov 28 04:57:31.875 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6dc868e2-87e7-4592-9992-709b1d2c213e, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 28 04:57:35.877 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0bd8bf52-7cd9-46d8-ace2-c6b44edc33d7, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 28 04:58:00.657 INFO request completed, latency_us: 213, response_code: 204, uri: /start/cid/0, method: POST, req_id: 4dcad3ff-f104-46bf-affb-8f4e72845577, remote_addr: 127.0.0.1:53391, local_addr: 127.0.0.1:9998
Nov 28 04:58:04.724 INFO accepted connection, remote_addr: 127.0.0.1:51439, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
[8820] Disable keep_running
Nov 28 04:58:04.725[8820] Got stop action so:false kr:false
 [8840] Disable keep_running
INFO[8840] Got stop action so:false kr:false
 [8830] Disable keep_running
request completed, latency_us[8830] Got stop action so:false kr:false
: 168, response_code: 204, uri: /shutdown, method: POST, req_id: e70fcf10-30d6-4fe7-9ac1-9f6c7f786637, remote_addr: 127.0.0.1:51439, 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
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit