/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.20026954
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.01263302
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.011442281
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 8810
Starting downstairs at port 8820
Starting downstairs at port 8830
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"
[8810][0] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8820][1] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1140)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1138)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1139)
[8820][1] initial start wait reports Running
[8830][2] initial start wait reports Running
[8810][0] initial start wait reports Running
All downstairs are running
Nov 05 16:56:12.097 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Nov 05 16:56:17.108 INFO accepted connection, remote_addr: 127.0.0.1:43653, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.109 INFO request completed, latency_us: 423, response_code: 200, uri: /state/cid/0, method: GET, req_id: 027a97df-505c-4bec-8d9c-8020a0491e72, remote_addr: 127.0.0.1:43653, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.122 INFO accepted connection, remote_addr: 127.0.0.1:46392, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.122 INFO request completed, latency_us: 75, response_code: 200, uri: /state/cid/1, method: GET, req_id: 93def763-e914-4aad-a2e0-1ac7f03323b7, remote_addr: 127.0.0.1:46392, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.134 INFO accepted connection, remote_addr: 127.0.0.1:55700, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.134 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/2, method: GET, req_id: c93639d9-0419-4a17-b265-529eda3c1122, remote_addr: 127.0.0.1:55700, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.146 INFO accepted connection, remote_addr: 127.0.0.1:60957, 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
Nov 05 16:56:17.147 INFO request completed, latency_us: 179, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 1176e076-eb15-4d9b-9223-57dc0a597e26, remote_addr: 127.0.0.1:60957, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.194 INFO accepted connection, remote_addr: 127.0.0.1:49948, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.195 INFO request completed, latency_us: 188, response_code: 200, uri: /regioninfo, method: GET, req_id: ed8fcfce-9552-4c2f-943f-20b8399c70d8, remote_addr: 127.0.0.1:49948, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.197 INFO request completed, latency_us: 43, response_code: 200, uri: /regioncount, method: GET, req_id: 46a53bd7-a33b-43b5-b404-41b2b01635ca, remote_addr: 127.0.0.1:49948, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.198 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/0, method: GET, req_id: df3cee74-dff4-4707-8f1a-1aec45834a5f, remote_addr: 127.0.0.1:49948, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.198 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/1, method: GET, req_id: e3f03872-7120-49dc-857c-097964613841, remote_addr: 127.0.0.1:49948, local_addr: 127.0.0.1:9998
Nov 05 16:56:17.198 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: 97c59f7f-65a2-4b6d-9244-0481aeefc97d, remote_addr: 127.0.0.1:49948, local_addr: 127.0.0.1:9998
Nov 05 16:56:26.243 INFO accepted connection, remote_addr: 127.0.0.1:49946, local_addr: 127.0.0.1:9998
Nov 05 16:56:26.244 INFO request completed, latency_us: 163, response_code: 200, uri: /regioninfo, method: GET, req_id: b081b6df-3d20-4e88-aa44-2d974a8b912f, remote_addr: 127.0.0.1:49946, local_addr: 127.0.0.1:9998
Nov 05 16:56:26.244 INFO request completed, latency_us: 60, response_code: 200, uri: /regioncount, method: GET, req_id: 5f8cbad8-0fdd-40f9-8f4b-622395456322, remote_addr: 127.0.0.1:49946, local_addr: 127.0.0.1:9998
Nov 05 16:56:26.245 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/0, method: GET, req_id: 16de058f-c308-4574-bfb6-c4ef443af13f, remote_addr: 127.0.0.1:49946, local_addr: 127.0.0.1:9998
Nov 05 16:56:26.245 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/1, method: GET, req_id: 04a1dd94-4406-4505-8add-131d9717caaf, remote_addr: 127.0.0.1:49946, local_addr: 127.0.0.1:9998
Nov 05 16:56:26.245 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/2, method: GET, req_id: d77b05cc-e8d6-46eb-b044-1d6babfb61e1, remote_addr: 127.0.0.1:49946, local_addr: 127.0.0.1:9998
Nov 05 16:56:35.305 INFO accepted connection, remote_addr: 127.0.0.1:53685, local_addr: 127.0.0.1:9998
Nov 05 16:56:35.305 INFO request completed, latency_us: 154, response_code: 200, uri: /regioninfo, method: GET, req_id: d6855944-b07a-4aeb-bb38-b894549ddc95, remote_addr: 127.0.0.1:53685, local_addr: 127.0.0.1:9998
Nov 05 16:56:35.306 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: 56f508d9-2162-45de-8faa-edd37144ff9d, remote_addr: 127.0.0.1:53685, local_addr: 127.0.0.1:9998
Nov 05 16:56:35.306 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: 154fd248-c7e1-48b5-ae6c-d55567892f06, remote_addr: 127.0.0.1:53685, local_addr: 127.0.0.1:9998
Nov 05 16:56:35.306 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/1, method: GET, req_id: 814c1cd9-7553-4b67-a84c-39ec713c00cb, remote_addr: 127.0.0.1:53685, local_addr: 127.0.0.1:9998
Nov 05 16:56:35.307 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7b407824-9ec5-42c6-bf67-262e5bf3fd1d, remote_addr: 127.0.0.1:53685, local_addr: 127.0.0.1:9998
Nov 05 16:56:47.905 INFO accepted connection, remote_addr: 127.0.0.1:33889, local_addr: 127.0.0.1:9998
Nov 05 16:56:47.906 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: b6ed32a8-3b46-4a8e-9fa9-f7b7b881449f, remote_addr: 127.0.0.1:33889, local_addr: 127.0.0.1:9998
Nov 05 16:56:47.906 INFO request completed, latency_us: 49, response_code: 200, uri: /regioncount, method: GET, req_id: 53805e22-ead5-4ae9-9f4d-b82113e6a29f, remote_addr: 127.0.0.1:33889, local_addr: 127.0.0.1:9998
Nov 05 16:56:47.907 INFO request completed, latency_us: 66, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1e1d66f6-8861-4294-b8e7-5f1de67101e8, remote_addr: 127.0.0.1:33889, local_addr: 127.0.0.1:9998
Nov 05 16:56:47.907 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: 39cc91ff-d089-4c6f-ad04-1123a1d7d472, remote_addr: 127.0.0.1:33889, local_addr: 127.0.0.1:9998
Nov 05 16:56:47.907 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 95e01c66-5363-4c5e-8d87-87141934a3c5, remote_addr: 127.0.0.1:33889, local_addr: 127.0.0.1:9998
Nov 05 16:56:59.175 INFO accepted connection, remote_addr: 127.0.0.1:52440, local_addr: 127.0.0.1:9998
Nov 05 16:56:59.176 INFO request completed, latency_us: 156, response_code: 200, uri: /regioninfo, method: GET, req_id: fe68f20d-0c20-4480-9166-488678cb54a8, remote_addr: 127.0.0.1:52440, local_addr: 127.0.0.1:9998
Nov 05 16:56:59.177 INFO request completed, latency_us: 66, response_code: 200, uri: /regioncount, method: GET, req_id: c0e2ebb9-65e7-454d-b3a8-4d7d4606d706, remote_addr: 127.0.0.1:52440, local_addr: 127.0.0.1:9998
Nov 05 16:56:59.177 INFO request completed, latency_us: 78, response_code: 200, uri: /port/cid/0, method: GET, req_id: bfd064da-4a92-4f01-bc5b-a42b2f99ee6b, remote_addr: 127.0.0.1:52440, local_addr: 127.0.0.1:9998
Nov 05 16:56:59.177 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/1, method: GET, req_id: 50d33248-9d94-458e-8f58-60aefb420a12, remote_addr: 127.0.0.1:52440, local_addr: 127.0.0.1:9998
Nov 05 16:56:59.178 INFO request completed, latency_us: 81, response_code: 200, uri: /port/cid/2, method: GET, req_id: ecf9d2a4-1eba-48c5-a7ab-d1302ce76e46, remote_addr: 127.0.0.1:52440, local_addr: 127.0.0.1:9998
Nov 05 16:57:09.453 INFO accepted connection, remote_addr: 127.0.0.1:33520, local_addr: 127.0.0.1:9998
Nov 05 16:57:09.454 INFO request completed, latency_us: 143, response_code: 200, uri: /regioninfo, method: GET, req_id: cb349ecd-3d12-4930-a37a-7fd013f111cd, remote_addr: 127.0.0.1:33520, local_addr: 127.0.0.1:9998
Nov 05 16:57:09.455 INFO request completed, latency_us: 66, response_code: 200, uri: /regioncount, method: GET, req_id: e2cf95e4-2c76-4181-aca2-a27051f7a56f, remote_addr: 127.0.0.1:33520, local_addr: 127.0.0.1:9998
Nov 05 16:57:09.455 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: f7378ffc-a4d6-4ac6-b68f-f7c92f9ccfdb, remote_addr: 127.0.0.1:33520, local_addr: 127.0.0.1:9998
Nov 05 16:57:09.455 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/1, method: GET, req_id: cce616e9-2c06-4f85-a162-fabc886a8f69, remote_addr: 127.0.0.1:33520, local_addr: 127.0.0.1:9998
Nov 05 16:57:09.455 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/2, method: GET, req_id: f80eaaea-0019-4b2d-a9f6-1996134662e3, remote_addr: 127.0.0.1:33520, local_addr: 127.0.0.1:9998
Nov 05 16:57:13.494 INFO accepted connection, remote_addr: 127.0.0.1:61741, local_addr: 127.0.0.1:9998
Nov 05 16:57:13.494 INFO request completed, latency_us: 147, response_code: 200, uri: /regioninfo, method: GET, req_id: 7485aef6-5ff9-4277-877a-ae86ef1d4d0d, remote_addr: 127.0.0.1:61741, local_addr: 127.0.0.1:9998
Nov 05 16:57:13.495 INFO request completed, latency_us: 40, response_code: 200, uri: /regioncount, method: GET, req_id: ed7c3da3-6617-40d4-be64-0eca571f647b, remote_addr: 127.0.0.1:61741, local_addr: 127.0.0.1:9998
Nov 05 16:57:13.495 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9d9edfbb-2867-445b-a487-2a3fe67d83db, remote_addr: 127.0.0.1:61741, local_addr: 127.0.0.1:9998
Nov 05 16:57:13.495 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: 418c1c09-0f78-4b5e-862e-53981ea3cdec, remote_addr: 127.0.0.1:61741, local_addr: 127.0.0.1:9998
Nov 05 16:57:13.495 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: e5b69694-4188-48f3-8c1d-c50821b1c7e5, remote_addr: 127.0.0.1:61741, local_addr: 127.0.0.1:9998
Nov 05 16:57:17.522 INFO accepted connection, remote_addr: 127.0.0.1:35044, 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 05 16:57:17.522 INFO request completed, latency_us: 135, response_code: 204, uri: /disablerestart/all, method: POST, req_id: fb389858-bc23-4b40-96c0-61d68991ffaa, remote_addr: 127.0.0.1:35044, local_addr: 127.0.[8820] Disable keep_running
0[8810] Disable keep_running
.[8830] Disable keep_running
1:9998
Nov 05 16:57:17.535 INFO accepted connection, remote_addr: 127.0.0.1:40475, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
Nov 05 16:57:17.535 INFO request completed, latency_us: 94stop 2
, response_code: 204, uri: /stop/cid/2, method: POST, req_id: a9b531c7-8318-4156-aab1-6875a285bb4a, remote_addr: 127.0.0.1:40475, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 05 16:57:17.547 INFO accepted connection, remote_addr: 127.0.0.1:36074, local_addr: 127.0.0.1:9998
Nov 05 16:57:17.548 INFO request completed, latency_us: 77, response_code: 200, uri: /state/cid/2, method: GET, req_id: 216338b7-2f26-4827-b7c1-b5d7b3941bad, remote_addr: 127.0.0.1:36074, local_addr: 127.0.0.1:9998
Nov 05 16:57:17.563 INFO accepted connection, remote_addr: 127.0.0.1:51986, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 05 16:57:17.563 INFO request completed, latency_us: 80, response_code: 204, uri: /start/cid/2, method: POST, req_id: 9d28f5a9-2010-48f2-899a-76a752ab158e, remote_addr: 127.0.0.1:51986, local_addr: 127.0.0.1:9998
Nov 05 16:57:17.575 INFO accepted connection, remote_addr: 127.0.0.1:49669, local_addr: 127.0.0.1:9998
Nov 05 16:57:17.575 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/2, method: GET, req_id: a42ebec1-ae9d-4f7f-aab6-b293d2c2b21f, remote_addr: 127.0.0.1:49669, 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(1188)
[8830][2] reports Running
Nov 05 16:57:22.591 INFO accepted connection, remote_addr: 127.0.0.1:63479, local_addr: 127.0.0.1:9998
Nov 05 16:57:22.591 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/2, method: GET, req_id: c78df75f-b49b-4a47-b5bd-857cc7c508c2, remote_addr: 127.0.0.1:63479, local_addr: 127.0.0.1:9998
Nov 05 16:57:22.850 INFO accepted connection, remote_addr: 127.0.0.1:56520, local_addr: 127.0.0.1:9998
Nov 05 16:57:22.850 INFO request completed, latency_us: 139, response_code: 200, uri: /regioninfo, method: GET, req_id: 95370b2e-d8d1-47ab-9ed3-f311615acdae, remote_addr: 127.0.0.1:56520, local_addr: 127.0.0.1:9998
Nov 05 16:57:22.851 INFO request completed, latency_us: 34, response_code: 200, uri: /regioncount, method: GET, req_id: d69ed17d-e62c-488d-b166-0483dc56943e, remote_addr: 127.0.0.1:56520, local_addr: 127.0.0.1:9998
Nov 05 16:57:22.851 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: 7a402dd9-1064-40c2-ba14-58e048a7ae08, remote_addr: 127.0.0.1:56520, local_addr: 127.0.0.1:9998
Nov 05 16:57:22.851 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: 483bcdf5-6f11-42b0-8792-fa9781fab8b3, remote_addr: 127.0.0.1:56520, local_addr: 127.0.0.1:9998
Nov 05 16:57:22.852 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: e0e5e503-640f-403c-a630-3897dc431967, remote_addr: 127.0.0.1:56520, local_addr: 127.0.0.1:9998
Nov 05 16:57:26.945 INFO accepted connection, remote_addr: 127.0.0.1:37882, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Nov 05 16:57:26.945 INFO request completed, Shut it down
latency_us: 143, response_code: 204, uri: /shutdown, method: POST, req_id: 15e7ff15-dd9f-4edc-ba08-ca2f6668e157, remote_addr: 127.0.0.1:37882, local_addr: 127[8810] Disable keep_running
.0.0.1[8830] Disable keep_running
:[8810] Got stop action so:false kr:false
9998
[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
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820][1] reports Exit
/var/tmp/bins/dsc create --cleanup --region-count 3 --extent-count 400 --block-size 4096 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Removing existing dsc directory "/tmp/test_up-build/dsc"
Removing existing region "/var/tmp/test_up-build"
Creating region directory at: /var/tmp/test_up-build
Creating dsc directory at: /tmp/test_up-build/dsc
Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.029518267
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.027944708
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.027856808
Created 3 regions
/var/tmp/bins/dsc start --region-count 3 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 400 })
start ds: 8810
start access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
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(1205)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1206)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1204)
[8820][1] initial start wait reports Running
[8830][2] initial start wait reports Running
[8810][0] initial start wait reports Running
All downstairs are running
Nov 05 16:57:32.052 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Nov 05 16:57:37.063 INFO accepted connection, remote_addr: 127.0.0.1:40799, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.064 INFO request completed, latency_us: 316, response_code: 200, uri: /state/cid/0, method: GET, req_id: a639b36a-4916-458a-a730-ace0c1957cea, remote_addr: 127.0.0.1:40799, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.077 INFO accepted connection, remote_addr: 127.0.0.1:42132, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.078 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/1, method: GET, req_id: 275ecefe-b882-4621-9650-b621da0183c6, remote_addr: 127.0.0.1:42132, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.091 INFO accepted connection, remote_addr: 127.0.0.1:58235, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.091 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/2, method: GET, req_id: 44684c38-a0a9-416a-a614-cf4189b525a4, remote_addr: 127.0.0.1:58235, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.110 INFO accepted connection, remote_addr: 127.0.0.1:44744, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.110 INFO request completed, latency_us: 109, response_code: 200, uri: /regioninfo, method: GET, req_id: 1de98d3e-7b5b-4623-9d5c-23555528e464, remote_addr: 127.0.0.1:44744, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.111 INFO request completed, latency_us: 41, response_code: 200, uri: /regioncount, method: GET, req_id: 4d1a4ade-9dae-4ffe-b716-b8b52a452fae, remote_addr: 127.0.0.1:44744, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.111 INFO request completed, latency_us: 47, response_code: 200, uri: /port/cid/0, method: GET, req_id: 780a302d-7a15-4ad1-8aa2-9fca8913afc0, remote_addr: 127.0.0.1:44744, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.111 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: a7b2d74e-fb25-4fb5-926d-4dd8abc17961, remote_addr: 127.0.0.1:44744, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.112 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4ab4b863-c01b-4690-a72c-15095b2a88eb, remote_addr: 127.0.0.1:44744, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.151 INFO accepted connection, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 05 16:57:37.154 INFO request completed, latency_us: 211, response_code: 204, uri: [8810] Got stop action so:false kr:false
/stop/cid/0, method: POST, req_id: f62910e7-b1c9-443a-ae7d-39c18956f1fe, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:57:37.155 INFO request completed, latency_us: 54, response_code: 200, uri: /state/cid/0, method: GET, req_id: add2507a-1966-4817-810e-2da76c3ddd00, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 05 16:57:41.156 INFO request completed, latency_us: 240, response_code: 200, uri: /state/cid/0, method: GET, req_id: 27041082-a51a-4cc2-9f7d-04a8adc8558b, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 05 16:57:41.188 INFO request completed, latency_us: 236, response_code: 204, uri: /start/cid/0, method: POST, req_id: 98ce86a1-6949-4ebb-872e-f5b9611c8986, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Nov 05 16:57:41.188 INFO request completed, latency_us: 51, response_code: 204, uri: /stop/cid/1, method: POST, req_id[8820] Got stop action so:false kr:false
: 598b17a3-1721-479b-9dca-1e5bddc2ff80, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:57:41.189 INFO request completed, latency_us: 148, response_code: 200, uri: /state/cid/0, method: GET, req_id: 789be4a2-b93f-45d3-8bfc-da20389f00d5, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[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(1212)
[8810][0] reports Running
Nov 05 16:57:45.191 INFO request completed, latency_us: 223, response_code: 200, uri: /state/cid/0, method: GET, req_id: d0ed4b0e-734e-4f97-9904-2ea3baa1fc43, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:57:45.192 INFO request completed, latency_us: 40, response_code: 200, uri: /state/cid/1, method: GET, req_id: aaf4df57-2b0c-477d-bf2a-36cb8bb90b8e, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 05 16:57:57.198 INFO request completed, latency_us: 209, response_code: 204, uri: /start/cid/1, method: POST, req_id: 7014f2a0-664a-44f0-9e81-ac44497d57e3, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:57:57.198 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4477fb70-1846-4d24-a05a-fbd64fb4cac0, remote_addr: 127.0.0.1:39371, 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(1213)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Nov 05 16:58:21.395 INFO request completed, [8820] Got stop action so:false kr:false
latency_us: 244, response_code: 204, uri: /stop/cid/1, method: POST, req_id: e5704a2c-f65f-4f84-9f1a-0b33344a7c73, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:58:21.396 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/1, method: GET, req_id: 29a10405-75dc-4583-8275-7afdc366bcd0, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 05 16:58:25.398 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/1, method: GET, req_id: acd7cdb0-6db2-4ab6-a458-5d2b0f99b16a, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 05 16:58:25.438 INFO request completed, latency_us: 206, response_code: 204, uri: /start/cid/1, method: POST, req_id: 40750059-41a3-4312-8f33-9b3181a3245c, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 05 16:58:25.438 INFO request completed, latency_us: 39, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 3816708d-e238-4e93-b5b1-773e0dc990ac, remote_addr: 127.0.0.1:39371, local_addr: [8830] Got stop action so:false kr:false
127.0.0.1:9998
Nov 05 16:58:25.439 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/1, method: GET, req_id: f3783af7-1239-498f-b555-38700a1003fe, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 05 16:58:29.441 INFO request completed, latency_us: 205, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5627babc-83a4-4c2e-bbdd-c0952e8f555b, remote_addr: 127.0.0.1:39371, 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(1214)
[8820][1] reports Running
Nov 05 16:58:33.442 INFO request completed, latency_us: 170, response_code: 200, uri: /state/cid/1, method: GET, req_id: c1339bc6-802f-41b4-9cb8-f25b79797869, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:58:33.443 INFO request completed, latency_us: 37, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2a1c2067-c2a3-46b7-8ec2-77dc72b60af4, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 05 16:58:45.449 INFO request completed, latency_us: 206, response_code: 204, uri: /start/cid/2, method: POST, req_id: 60bb7c31-ee37-4352-98f3-380a0b97d2d8, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:58:45.449 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/1, method: GET, req_id: 772e8bd4-38f0-4621-83b0-7da24d600cd3, remote_addr: 127.0.0.1:39371, 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(1215)
[8830][2] 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
Nov 05 16:59:01.644 INFO request completed, latency_us: 225, response_code: 204, uri: /stop/cid/2, method: POST, req_id: fef52404-e3e1-4746-9748-657a6222d8ac, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:01.644 INFO request completed, latency_us: 53, response_code: 200, uri: /state/cid/2, method: GET, req_id: f63bb8a6-d99b-4cec-b2a5-760aca5f569a, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 05 16:59:05.645 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2c9467e0-5f2d-4453-ab13-00c2b5b3fb38, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 05 16:59:05.685 INFO request completed, latency_us: 216, response_code: 204, uri: /start/cid/2, method: POST, req_id: bf117d1e-b284-4d3d-86e8-74d480e12a9f, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 05 16:59:05.686 INFO request completed, latency_us: 119[8810] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 088cd295-f14a-4036-8bcb-106443f9d7d8, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:05.686 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/2, method: GET, req_id: ab82de64-0c42-40b4-a480-a00d2101fb30, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[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(1216)
[8830][2] reports Running
Nov 05 16:59:09.687 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/2, method: GET, req_id: 57819231-67a6-4767-b860-6e5fc85b7d8d, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:09.688 INFO request completed, latency_us: 45, response_code: 200, uri: /state/cid/0, method: GET, req_id: df565a97-d33c-4d2e-b75d-ff1751b0109d, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 05 16:59:21.693 INFO request completed, latency_us: 203, response_code: 204, uri: /start/cid/0, method: POST, req_id: 2b011996-0a37-4487-a44b-42b674933ebe, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:21.693 INFO request completed, latency_us: 55, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0774d192-8f9f-4f4a-bb7d-d2f83cfdf07d, remote_addr: 127.0.0.1:39371, 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(1217)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 05 16:59:37.894[8810] Got stop action so:false kr:false
 INFO request completed, latency_us: 233, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 2f6f11bb-c42f-4423-aefb-1ab5b42908e6, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:37.895 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/0, method: GET, req_id: edee39ba-28aa-4cf9-9563-819957b972bd, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 05 16:59:41.896 INFO request completed, latency_us: 160, response_code: 200, uri: /state/cid/0, method: GET, req_id: 464ed4f0-e277-4b63-948d-ad4511af5cc2, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 05 16:59:41.937 INFO request completed, latency_us: 169, response_code: 204, uri: /start/cid/0, method: POST, req_id: 95f7059f-22eb-4746-b799-f56be8adb200, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Nov 05 16:59:41.938 INFO request completed, latency_us: 59, response_code: 204, uri: /stop/cid/1, method: POST, [8820] Got stop action so:false kr:false
req_id: 34697b3a-ae7f-43d1-9abf-bae3b5efa85b, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:41.938 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/0, method: GET, req_id: aa115a5f-5643-4e10-a1fd-dd01343e483f, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[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(1218)
[8810][0] reports Running
Nov 05 16:59:45.940 INFO request completed, latency_us: 199, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4c3390bd-776a-4382-bb26-07bf2da73d19, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:45.941 INFO request completed, latency_us: 64, response_code: 200, uri: /state/cid/1, method: GET, req_id: a3bef7c8-3cd1-441c-aa61-06b25f580468, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 05 16:59:57.946 INFO request completed, latency_us: 235, response_code: 204, uri: /start/cid/1, method: POST, req_id: 4717931d-3b4f-4052-8ad1-c9fac6c25e7a, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 16:59:57.946 INFO request completed, latency_us: 56, response_code: 200, uri: /state/cid/0, method: GET, req_id: ae2f4a7e-f0e0-4fd9-8628-c5a6fb046e13, remote_addr: 127.0.0.1:39371, 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(1219)
[8820][1] 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 05 17:00:14.149 INFO request completed, latency_us: 229, response_code: 204, uri: /stop/cid/1, method: POST, req_id: ffed188c-db56-46e5-8b07-111eab5d6ed3, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 17:00:14.150 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8581d364-fe07-4750-b604-6350bbbfed94, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 05 17:00:18.151 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/1, method: GET, req_id: 2c73ec0c-e598-4fc9-9d0a-ab57ee290b31, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 05 17:00:18.191 INFO request completed, latency_us: 129, response_code: 204, uri: /start/cid/1, method: POST, req_id: a41b5378-4b2f-47d2-9e3e-c1fa8789d2fd, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 05 17:00:18.191 INFO request completed, latency_us: 59, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 6c45594e-1963-433d-bf8e-7a5d8e3e3003, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0[8830] Got stop action so:false kr:false
.1:9998
Nov 05 17:00:18.191 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/1, method: GET, req_id: 30ab202c-504e-4795-9928-7308cfead442, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 05 17:00:22.194 INFO request completed, latency_us: 154, response_code: 200, uri: /state/cid/1, method: GET, req_id: 46671c79-d3f6-4469-84b8-467ab8c818ac, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 17:00:26.195 INFO request completed, latency_us: 205, response_code: 200, uri: /state/cid/1, method: GET, req_id: 54d61583-1634-4c45-af67-a814cac045bc, remote_addr: 127.0.0.1:39371, 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(1220)
[8820][1] reports Running
Nov 05 17:00:30.198 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5de06fdb-4a84-4a13-b56b-69ffbd471a51, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 17:00:30.198 INFO request completed, latency_us: 73, response_code: 200, uri: /state/cid/2, method: GET, req_id: 511001e7-465a-4446-b6d2-9bce1e378b20, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 05 17:00:42.201 INFO request completed, latency_us: 218, response_code: 204, uri: /start/cid/2, method: POST, req_id: 5c6f78cf-d9b1-4c8d-81e9-4bdbd3515285, remote_addr: 127.0.0.1:39371, local_addr: 127.0.0.1:9998
Nov 05 17:00:42.202 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1a05c019-1ab6-4c69-8874-7d21182817da, remote_addr: 127.0.0.1:39371, 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(1221)
[8830][2] reports Running
Nov 05 17:00:58.411 INFO accepted connection, remote_addr: 127.0.0.1:38282, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Nov 05 17:00:58.411 INFO request completed, latency_us: 136, response_code: 204, uri: /shutdown, method: POST, req_id: c5e37043-37cd-40b1-9c10-1bcc24bc4d6f, remote_addr: 127.Shut it down
0.0.1:38282, local_addr: 127.0.0.1:9998
[8810] Disable keep_running
[8810] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit