/var/tmp/bins/dsc create --encrypted --cleanup --region-count 6 --extent-size 10 --extent-count 5 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Removing existing dsc directory "/tmp/test_up-build/dsc"
Creating region directory at: /var/tmp/test_up-build
Creating dsc directory at: /tmp/test_up-build/dsc
Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.15123475
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.012100849
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.010763625
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.010472882
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010200898
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010431204
Created 6 regions
/var/tmp/bins/dsc start --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build --region-count 6
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 })
start ds: 8810
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start access at:127.0.0.1:9998
Starting downstairs at port 8820
Starting downstairs at port 8810
Starting downstairs at port 8840
Starting downstairs at port 8860
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8820][1] initial start wait reports Starting
[8810][0] initial start wait reports Starting
[8840][3] initial start wait reports Starting
[8860][5] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8850][4] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1141)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1143)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1142)
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1144)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1145)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1146)
[8810][0] initial start wait reports Running
[8840][3] initial start wait reports Running
[8860][5] initial start wait reports Running
[8850][4] initial start wait reports Running
[8820][1] initial start wait reports Running
[8830][2] initial start wait reports Running
All downstairs are running
May 19 05:07:30.071 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
May 19 05:07:35.078 INFO accepted connection, remote_addr: 127.0.0.1:43667, local_addr: 127.0.0.1:9998
May 19 05:07:35.080 INFO request completed, latency_us: 373, response_code: 200, uri: /state/cid/0, method: GET, req_id: 47d07794-28e8-48ac-94f5-165cfc8aba0e, remote_addr: 127.0.0.1:43667, local_addr: 127.0.0.1:9998
May 19 05:07:35.094 INFO accepted connection, remote_addr: 127.0.0.1:36902, local_addr: 127.0.0.1:9998
May 19 05:07:35.094 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/1, method: GET, req_id: 49883ad0-cc6c-442e-92c9-ad3da6302bce, remote_addr: 127.0.0.1:36902, local_addr: 127.0.0.1:9998
May 19 05:07:35.108 INFO accepted connection, remote_addr: 127.0.0.1:37776, local_addr: 127.0.0.1:9998
May 19 05:07:35.108 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4ab6f97b-b646-4bdc-a71c-91dbdacc5ca8, remote_addr: 127.0.0.1:37776, local_addr: 127.0.0.1:9998
May 19 05:07:35.121 INFO accepted connection, remote_addr: 127.0.0.1:48653, local_addr: 127.0.0.1:9998
May 19 05:07:35.121 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/3, method: GET, req_id: 0c563c9e-3331-44d5-8eab-ab3011060658, remote_addr: 127.0.0.1:48653, local_addr: 127.0.0.1:9998
May 19 05:07:35.134 INFO accepted connection, remote_addr: 127.0.0.1:58012, local_addr: 127.0.0.1:9998
May 19 05:07:35.135 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/4, method: GET, req_id: 4ca32e8b-4e9d-4e2b-b155-eb16e8573325, remote_addr: 127.0.0.1:58012, local_addr: 127.0.0.1:9998
May 19 05:07:35.148 INFO accepted connection, remote_addr: 127.0.0.1:48253, local_addr: 127.0.0.1:9998
May 19 05:07:35.148 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/5, method: GET, req_id: 4b869bfc-d37a-43cd-9854-4a9b497b4b05, remote_addr: 127.0.0.1:48253, local_addr: 127.0.0.1:9998
May 19 05:07:35.160 INFO accepted connection, remote_addr: 127.0.0.1:36210, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
May 19 05:07:35.161 INFO request completed, latency_us: 101, response_code: 204, uri: /disablerestart/all, method: POST, req_id: c47d0fdf-4c36-4afe-a388-cda34ce3ba62, remote_addr: 127.0.0.1[8810] Disable keep_running
:36210, local_addr: [8830] Disable keep_running
127[8820] Disable keep_running
.[8840] Disable keep_running
0[8860] Disable keep_running
.0.1:9998
[8850] Disable keep_running
May 19 05:07:35.229 INFO accepted connection, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.230 INFO request completed, latency_us: 257, response_code: 200, uri: /regioninfo, method: GET, req_id: 0c7b3225-49d8-4bfc-ae87-34935812634f, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.232 INFO request completed, latency_us: 74, response_code: 200, uri: /regioncount, method: GET, req_id: b8abcc38-774c-4c41-82d9-fd86854fe0b4, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.233 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/0, method: GET, req_id: 557fe6de-34c8-4ae4-a4f0-2b0dfd3584d6, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.233 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6f487ce5-088b-465b-b8f9-c7f09d67a5d2, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.233 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/2, method: GET, req_id: 64523293-5158-4461-aed7-89861e0691a2, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.239 INFO request completed, latency_us: 60, response_code: 200, uri: /port/cid/3, method: GET, req_id: 009bd5dd-ebf8-4ccd-aab2-1f8c0b6e5589, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.239 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/4, method: GET, req_id: 88786188-1cd5-419e-b7d3-8d2630e0f4ba, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:35.239 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: a861b33d-65e6-4b6c-9ae3-40d67cce690e, remote_addr: 127.0.0.1:59587, local_addr: 127.0.0.1:9998
May 19 05:07:44.299 INFO accepted connection, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.300 INFO request completed, latency_us: 188, response_code: 200, uri: /regioninfo, method: GET, req_id: 369ce659-895a-47e0-9fd5-5b262736359f, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.301 INFO request completed, latency_us: 83, response_code: 200, uri: /regioncount, method: GET, req_id: 9797b3c9-b2ca-4fe3-92b9-23c43de00246, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.301 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0ac1e8ba-0d4a-4ef9-ae6e-f52af0d3a9cb, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.302 INFO request completed, latency_us: 45, response_code: 200, uri: /port/cid/1, method: GET, req_id: ac0280db-8395-465d-96f9-1ffde2329b71, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.302 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3e577b97-6c5b-4ce4-823c-05f99c5ed3be, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.304 INFO request completed, latency_us: 79, response_code: 200, uri: /port/cid/3, method: GET, req_id: 39a1725f-bc47-48df-b54b-ce98322103ad, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.304 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/4, method: GET, req_id: cc7a9ae8-b4e0-4ae8-8c6d-c9a30a35feb5, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:44.304 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8e3aac9b-dbda-49e1-b15a-700e98b2937c, remote_addr: 127.0.0.1:51834, local_addr: 127.0.0.1:9998
May 19 05:07:53.608 INFO accepted connection, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.609 INFO request completed, latency_us: 190, response_code: 200, uri: /regioninfo, method: GET, req_id: 4a832765-a1b2-4ca1-831f-aab9a30e98cf, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.610 INFO request completed, latency_us: 54, response_code: 200, uri: /regioncount, method: GET, req_id: 595c8ddd-33bc-437a-b0fd-4317f0424d95, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.610 INFO request completed, latency_us: 78, response_code: 200, uri: /port/cid/0, method: GET, req_id: ad8da15d-b7f5-4f91-b4f5-076091e712e7, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.611 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/1, method: GET, req_id: 54da3336-5ba4-4390-8fa9-2909fdc580c2, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.611 INFO request completed, latency_us: 39, response_code: 200, uri: /port/cid/2, method: GET, req_id: 34768907-0bda-44da-a4be-e01e354f990b, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.613 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/3, method: GET, req_id: 9980a9bd-7978-4a96-965d-b19c45d573bc, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.613 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/4, method: GET, req_id: fd90162c-e439-4c69-b68b-9f586a54f8b2, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:07:53.613 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6a6a2fb0-c0db-4c75-b78c-b2152aff94d3, remote_addr: 127.0.0.1:42756, local_addr: 127.0.0.1:9998
May 19 05:08:18.009 INFO accepted connection, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.009 INFO request completed, latency_us: 208, response_code: 200, uri: /regioninfo, method: GET, req_id: 796803ae-3e8d-471a-bb8d-8875547b1f8e, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.010 INFO request completed, latency_us: 59, response_code: 200, uri: /regioncount, method: GET, req_id: daee6182-65da-462c-a3f6-dca3f9c25af3, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.010 INFO request completed, latency_us: 74, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8fdbdf3a-6979-4a0b-a581-c7de6006af21, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.011 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/1, method: GET, req_id: d6a8c0ae-0ba4-4352-950b-1090e7b88dbc, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.011 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/2, method: GET, req_id: 356bce54-3505-4e98-b6b5-1e8097518324, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.012 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/3, method: GET, req_id: 51ff55fc-8373-4b52-b6ea-549958d7e5b1, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.013 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/4, method: GET, req_id: 04704c87-aebe-4735-8c73-f2cb2db207aa, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:08:18.013 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5c6ae5dd-54e0-4bd5-8568-65560969ede7, remote_addr: 127.0.0.1:63084, local_addr: 127.0.0.1:9998
May 19 05:10:47.733 INFO accepted connection, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.734 INFO request completed, latency_us: 233, response_code: 200, uri: /regioninfo, method: GET, req_id: 9bb6ab0e-7579-40f6-9d77-caa4762fb0be, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.734 INFO request completed, latency_us: 54, response_code: 200, uri: /regioncount, method: GET, req_id: 9e1dd8f4-4db2-4a1b-a0ad-346f2c7963aa, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.735 INFO request completed, latency_us: 76, response_code: 200, uri: /port/cid/0, method: GET, req_id: ce4da199-9454-40c1-b9b9-f8ae9f8172a3, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.735 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/1, method: GET, req_id: 041414d6-25d5-450d-8054-4ab2aec4199b, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.735 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/2, method: GET, req_id: 222e0c42-081e-45df-a347-0e4f9b723749, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.737 INFO request completed, latency_us: 53, response_code: 200, uri: /port/cid/3, method: GET, req_id: 46903500-5841-4ff4-ac86-f6907a502e2a, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.737 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/4, method: GET, req_id: e220949c-0efc-4b86-bbb6-b22624d8ee0e, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:10:47.737 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/5, method: GET, req_id: d94613d0-626f-40be-a43b-0bdb81f6be7d, remote_addr: 127.0.0.1:47371, local_addr: 127.0.0.1:9998
May 19 05:11:09.260 INFO accepted connection, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.261 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: 703c4f63-de24-4294-9423-fbf189fa9098, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.262 INFO request completed, latency_us: 39, response_code: 200, uri: /regioncount, method: GET, req_id: 82c76379-bffb-4ac7-a300-5831508f6cff, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.262 INFO request completed, latency_us: 67, response_code: 200, uri: /port/cid/0, method: GET, req_id: a2200a13-ba59-47fe-a51e-91ebe88a6f8b, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.262 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3616510b-97c7-49a7-92e3-1ce3a0732d02, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.262 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: a9678373-0fd4-4b27-9c02-ceaf34b5721d, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.264 INFO request completed, latency_us: 49, response_code: 200, uri: /port/cid/3, method: GET, req_id: 3c371597-dbce-4257-88ea-43cd8b572bbb, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.264 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/4, method: GET, req_id: 18aab4f6-6e12-40e3-8b15-60128828b609, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:09.264 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: d99522c6-f7f8-4c6f-8726-ac8870a0cbf8, remote_addr: 127.0.0.1:36357, local_addr: 127.0.0.1:9998
May 19 05:11:13.372 INFO accepted connection, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.373 INFO request completed, latency_us: 170, response_code: 200, uri: /regioninfo, method: GET, req_id: 513ebe31-6442-4e0d-a419-89be8bc804ff, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.374 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: 2d4f82ab-c57f-442a-92f9-bf7a7e735e0d, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.374 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6cd23e3a-21eb-43f8-bc16-40329326f395, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.374 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: c62f29a3-ec90-4b8e-951c-9f13e205be05, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.374 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 997317b2-3762-4084-af77-0ea55354cdcf, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.376 INFO request completed, latency_us: 53, response_code: 200, uri: /port/cid/3, method: GET, req_id: 40f65d9d-c9e1-463c-bf21-c52101da0847, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.376 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/4, method: GET, req_id: 5d013d9f-06ef-422d-a167-23f0e6db1196, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:13.376 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/5, method: GET, req_id: 453f4be2-43fc-4f5f-afa1-7c187b5407b3, remote_addr: 127.0.0.1:49829, local_addr: 127.0.0.1:9998
May 19 05:11:17.473 INFO accepted connection, remote_addr: 127.0.0.1:59291, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
May 19 05:11:17.474 INFO request completed, latency_us: 129, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 4308bc38-deb1-4bea-8498-69677dd668a9, remote_addr: 127.0.0[8820] Disable keep_running
.[8810] Disable keep_running
1:[8830] Disable keep_running
59291, local_addr: 127[8840] Disable keep_running
.0.0.1:9998
[8860] Disable keep_running
[8850] Disable keep_running
May 19 05:11:17.487 INFO accepted connection, remote_addr: 127.0.0.1:42980, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
May 19 05:11:17.487 INFO request completed, latency_us: 113, response_code: 204, uri: /stop/cid/2, method: POST, req_id: ff607c6b-aa2d-456b-a211-14970a812776, remote_addr: 127.0.0.1:42980, local_addr: 127.0.0.1:9998
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 19 05:11:17.501 INFO accepted connection, remote_addr: 127.0.0.1:49889, local_addr: 127.0.0.1:9998
May 19 05:11:17.501 INFO request completed, latency_us: 90, response_code: 200, uri: /state/cid/2, method: GET, req_id: 275d792c-2f5a-4aab-9215-bea4fc46ca7e, remote_addr: 127.0.0.1:49889, local_addr: 127.0.0.1:9998
May 19 05:11:17.517 INFO accepted connection, remote_addr: 127.0.0.1:47456, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 19 05:11:17.517 INFO request completed, latency_us: 72, response_code: 204, uri: /start/cid/2, method: POST, req_id: 72d9431d-22e9-4e77-a7fc-ea7501c2306c, remote_addr: 127.0.0.1:47456, local_addr: 127.0.0.1:9998
May 19 05:11:17.550 INFO accepted connection, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.551 INFO request completed, latency_us: 106, response_code: 200, uri: /regioninfo, method: GET, req_id: f0a6b3e3-ccc5-45e2-852a-15d597fc2436, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.552 INFO request completed, latency_us: 68, response_code: 200, uri: /regioncount, method: GET, req_id: 0a436986-c844-422c-aed8-b6e64e5ab956, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.552 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/0, method: GET, req_id: d1d71a8e-239d-4082-8c79-00a4f889c42e, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.552 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/1, method: GET, req_id: 03590758-089f-4358-a2df-9aabe67b31b2, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.552 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: bb683fa3-cc4b-4625-b990-98a4d2cfc8c6, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.554 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/3, method: GET, req_id: dfae20ff-d149-4b60-92b9-ceb34c947b90, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.554 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/4, method: GET, req_id: a06ecd2b-5962-4630-b626-f7c6975b0b40, remote_addr: 127.0.0.1:55175, local_addr: 127.0.0.1:9998
May 19 05:11:17.554 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/5, method: GET, req_id: 0f3f992f-b47d-4e49-bc0f-7863989bf0d5, remote_addr: 127.0.0.1:55175, 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(1197)
[8830][2] reports Running
May 19 05:11:31.694 INFO accepted connection, remote_addr: 127.0.0.1:49959, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
May 19 05:11:31.695 INFO request completed, latency_us: Shut it down
141, response_code: 204, uri: /shutdown, method: POST, req_id: 3878faac-2493-4e44-b89c-cfc3197cb9ec[8820] Disable keep_running
, [8810] Disable keep_running
remote_addr[8830] Disable keep_running
:[8810] Got stop action so:false kr:false
 [8850] Disable keep_running
127[8860] Disable keep_running
.[8860] Got stop action so:false kr:false
0[8850] Got stop action so:false kr:false
.0.1:49959, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[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))
[8820][1] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8810][0] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --extent-count 400 --block-size 4096 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Removing existing dsc directory "/tmp/test_up-build/dsc"
Removing existing region "/var/tmp/test_up-build"
Creating region directory at: /var/tmp/test_up-build
Creating dsc directory at: /tmp/test_up-build/dsc
Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.031100774
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.028081035
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.026798988
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.025092348
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.024498112
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024298033
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.032882083
Created 7 regions
/var/tmp/bins/dsc start --region-count 7 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 400 })
start ds: 8810
start access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start ds: 8870
Starting downstairs at port 8810
Starting downstairs at port 8820
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8840
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Starting downstairs at port 8850
[8840][3] initial start wait reports Starting
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Starting downstairs at port 8870
[8850][4] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8860][5] initial start wait reports Starting
[8870][6] initial start wait reports Starting
Control access at:127.0.0.1:9998
May 19 05:11:36.913 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1214)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1215)
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1220)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1219)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1218)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1216)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1217)
[8870][6] initial start wait reports Running
[8840][3] initial start wait reports Running
[8850][4] initial start wait reports Running
[8810][0] initial start wait reports Running
[8830][2] initial start wait reports Running
[8860][5] initial start wait reports Running
[8820][1] initial start wait reports Running
All downstairs are running
May 19 05:11:41.924 INFO accepted connection, remote_addr: 127.0.0.1:61511, local_addr: 127.0.0.1:9998
May 19 05:11:41.926 INFO request completed, latency_us: 382, response_code: 200, uri: /state/cid/0, method: GET, req_id: cf31b167-6459-43c7-838e-e068ec7e773c, remote_addr: 127.0.0.1:61511, local_addr: 127.0.0.1:9998
May 19 05:11:41.940 INFO accepted connection, remote_addr: 127.0.0.1:38517, local_addr: 127.0.0.1:9998
May 19 05:11:41.940 INFO request completed, latency_us: 72, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7e4c28ee-4684-4138-b0e2-efd95b1e38dc, remote_addr: 127.0.0.1:38517, local_addr: 127.0.0.1:9998
May 19 05:11:41.953 INFO accepted connection, remote_addr: 127.0.0.1:58218, local_addr: 127.0.0.1:9998
May 19 05:11:41.954 INFO request completed, latency_us: 69, response_code: 200, uri: /state/cid/2, method: GET, req_id: a492e8e0-5018-4603-903c-a8a3e82545fb, remote_addr: 127.0.0.1:58218, local_addr: 127.0.0.1:9998
May 19 05:11:41.967 INFO accepted connection, remote_addr: 127.0.0.1:60226, local_addr: 127.0.0.1:9998
May 19 05:11:41.967 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/3, method: GET, req_id: c92d39e3-9843-4cf5-8f93-5cda024381f5, remote_addr: 127.0.0.1:60226, local_addr: 127.0.0.1:9998
May 19 05:11:41.980 INFO accepted connection, remote_addr: 127.0.0.1:42113, local_addr: 127.0.0.1:9998
May 19 05:11:41.980 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/4, method: GET, req_id: c5000d36-86ae-4cb6-9516-80adf609234f, remote_addr: 127.0.0.1:42113, local_addr: 127.0.0.1:9998
May 19 05:11:41.993 INFO accepted connection, remote_addr: 127.0.0.1:39280, local_addr: 127.0.0.1:9998
May 19 05:11:41.993 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/5, method: GET, req_id: d5332cba-2cd2-479b-97d3-a074d7f21843, remote_addr: 127.0.0.1:39280, local_addr: 127.0.0.1:9998
May 19 05:11:42.006 INFO accepted connection, remote_addr: 127.0.0.1:52605, local_addr: 127.0.0.1:9998
May 19 05:11:42.006 INFO request completed, latency_us: 71, response_code: 200, uri: /state/cid/6, method: GET, req_id: 46bb85e1-6ceb-4c97-aafc-2055bbc03cd7, remote_addr: 127.0.0.1:52605, local_addr: 127.0.0.1:9998
May 19 05:11:42.019 INFO accepted connection, remote_addr: 127.0.0.1:41912, local_addr: 127.0.0.1:9998
May 19 05:11:42.020 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/6, method: GET, req_id: c2e2fd4e-5b3e-4514-a00b-ed4db279a103, remote_addr: 127.0.0.1:41912, local_addr: 127.0.0.1:9998
May 19 05:11:42.038 INFO accepted connection, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.039 INFO request completed, latency_us: 116, response_code: 200, uri: /regioninfo, method: GET, req_id: 1d8dcb2b-8d45-4ff9-a4ec-b4adf6f250da, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.040 INFO request completed, latency_us: 67, response_code: 200, uri: /regioncount, method: GET, req_id: 3fd4da65-cbc2-4592-90ad-a5bb97c0cfd3, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.040 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/0, method: GET, req_id: e4b7f369-5bfe-4618-b92c-c691133e1175, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.040 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5c505220-452b-439e-806e-f31e74f82708, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.040 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/2, method: GET, req_id: 10d2941c-3c80-49ca-b61c-498985519420, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.041 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/3, method: GET, req_id: 426a6dcc-650b-4d2a-9c34-3447164fb0da, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.042 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/4, method: GET, req_id: 746865ee-b4fa-4bc3-ae0d-898c2356f3d1, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.042 INFO request completed, latency_us: 22, response_code: 200, uri: /port/cid/5, method: GET, req_id: 60abdac5-0e8f-42c8-ace5-4871e1475c96, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
May 19 05:11:42.064 INFO accepted connection, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:11:42.064 INFO request completed, latency_us: 135, response_code: 200, uri: /regioncount, method: GET, req_id: 1f3fe4df-fb66-4eff-b1bd-aac0a20fd852, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 19 05:11:42.450 INFO request completed[8810] Got stop action so:false kr:false
, latency_us: 237, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 366d698a-eeb8-42da-8fb5-de8dcbea002a, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:11:42.451 INFO request completed, latency_us: 114, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4e9be58b-b75c-4a13-b4d4-87c542328b79, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 19 05:11:46.453 INFO request completed, latency_us: 336, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9c31e125-6182-4575-8266-649a7cdd0d81, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 19 05:11:46.845 INFO request completed, latency_us: 235, response_code: 204, uri: /start/cid/0, method: POST, req_id: 56b8b04f-148d-486d-a2d7-f50d0a154370, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:11:46.846 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/0, method: GET, req_id: bbccfa3e-30e0-42bd-93c3-62c0427c5c7f, remote_addr: 127.0.0.1:42350, 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(1231)
[8810][0] reports Running
May 19 05:11:50.848 INFO request completed, latency_us: 282, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8e15c992-a679-4b79-8f08-f2b9de7e3cda, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 19 05:11:57.235 INFO request completed, latency_us: 237[8810] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/0, method: POST, req_id: e6d057ae-e7a8-491f-a878-6fd54e827f42, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:11:57.236 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/0, method: GET, req_id: 47beb1f3-b6c7-4c61-8cc8-be9fddf712da, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 19 05:12:01.239 INFO request completed, latency_us: 325, response_code: 200, uri: /state/cid/0, method: GET, req_id: f1b1421a-42e3-4510-aba0-be145e1e2958, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 19 05:12:01.634 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8ab7dd5f-58ce-4d21-bb85-d2b9795e796a, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:01.634 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5b3f78ce-f1bb-4008-bd9a-a78a29140302, remote_addr: 127.0.0.1:42350, 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(1232)
[8810][0] reports Running
May 19 05:12:05.636 INFO request completed, latency_us: 243, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6c3e9f62-ef9f-4939-815f-127cc8604a7e, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 19 05:12:11.023[8810] Got stop action so:false kr:false
 INFO request completed, latency_us: 230, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 32aee25f-5574-4100-9ee7-7b6b03a5d56a, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:11.024 INFO request completed, latency_us: 228, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5979fedf-86c1-488e-9f54-2c4b63c1cb7f, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 19 05:12:15.027 INFO request completed, latency_us: 300, response_code: 200, uri: /state/cid/0, method: GET, req_id: 88195cb7-d9f6-4ca1-878f-9e50f2588399, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 19 05:12:15.427 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/0, method: POST, req_id: 31967c82-4903-428e-a069-d045e1da364b, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:15.427 INFO request completed, latency_us: 47, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2562dc5f-5087-4469-92f9-4ffe3f63708b, remote_addr: 127.0.0.1:42350, 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(1233)
[8810][0] reports Running
May 19 05:12:19.430 INFO request completed, latency_us: 281, response_code: 200, uri: /state/cid/0, method: GET, req_id: 21e37128-a5b7-48a1-86d7-94a609fce34d, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 19 05:12:23.817[8810] Got stop action so:false kr:false
 INFO request completed, latency_us: 226, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 6d4e8f26-1ba6-4fca-ad63-9cfcbb362438, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:23.817 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: e2bc227f-52c9-4e4c-9d81-a2267b9559a9, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 19 05:12:27.820 INFO request completed, latency_us: 232, response_code: 200, uri: /state/cid/0, method: GET, req_id: 90bfe03b-f265-4e92-a338-4815d43ed113, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 19 05:12:28.223 INFO request completed, latency_us: 248, response_code: 204, uri: /start/cid/0, method: POST, req_id: e50b0eb5-50c8-46b0-b580-cd8e596488ff, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:28.223 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/0, method: GET, req_id: b5be27e5-7c8e-455b-aef8-2da102f875ce, remote_addr: 127.0.0.1:42350, 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(1234)
[8810][0] reports Running
May 19 05:12:32.225 INFO request completed, latency_us: 260, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6ee71411-f414-4395-b4e9-cc422be63877, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 19 05:12:35.614 INFO[8810] Got stop action so:false kr:false
 request completed, latency_us: 240, response_code: 204, uri: /stop/cid/0, method: POST, req_id: ef6f887e-d8a1-4df4-90ee-371ded79fd20, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:35.614 INFO request completed, latency_us: 114, response_code: 200, uri: /state/cid/0, method: GET, req_id: b1698268-9e85-4309-beb9-e19d63f8cb08, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 19 05:12:39.616 INFO request completed, latency_us: 291, response_code: 200, uri: /state/cid/0, method: GET, req_id: 741b0804-b563-4f40-a72e-f3e97b9821b3, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 19 05:12:40.014 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: 682221d2-d385-4f0a-b226-288ef3ff5e8f, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:40.014 INFO request completed, latency_us: 75, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4c78de28-67ca-4e07-bf59-fb473a2bb4b0, remote_addr: 127.0.0.1:42350, 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(1235)
[8810][0] reports Running
May 19 05:12:44.017 INFO request completed, latency_us: 280, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0bfee664-23f0-4b32-9eb2-9c150de4ac04, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
[8810] Got stop action so:false kr:false
May 19 05:12:46.402 INFO request completed, latency_us: 229, response_code: 204, uri: /stop/cid/0, method: POST, req_id: e0817ecf-7277-4416-a8cf-1f368cf010ed, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:46.403 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/0, method: GET, req_id: 126e62c9-c129-4cdb-ab9f-c2cb7bd9b9c4, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 19 05:12:50.405 INFO request completed, latency_us: 303, response_code: 200, uri: /state/cid/0, method: GET, req_id: 53e8c5a2-2d22-4601-9012-e16d12fb621e, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 19 05:12:50.808 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: e581b3b7-cf6f-4e5f-9361-53514fd5b5a2, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:12:50.808 INFO request completed, latency_us: 48, response_code: 200, uri: /state/cid/0, method: GET, req_id: 393097c2-2df1-45b2-9114-256d4c8ce90f, remote_addr: 127.0.0.1:42350, 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(1236)
[8810][0] reports Running
May 19 05:12:54.810 INFO request completed, latency_us: 245, response_code: 200, uri: /state/cid/0, method: GET, req_id: cdab1863-1bf3-43f4-a8b5-4165c442390d, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
May 19 05:13:22.244 INFO request completed[8820] Got stop action so:false kr:false
, latency_us: 225, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 0f0ddf2c-4f0b-418e-a981-e3d11e01933d, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
May 19 05:13:22.261 INFO request completed, latency_us: 170, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0e716e07-02a2-4820-8ee2-8f4f9eb99c2d, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
May 19 05:13:22.652 INFO request completed, latency_us: 254, response_code: 204, uri: /start/cid/1, method: POST, req_id: 040d8a8b-da30-45d2-8cc0-d7004aa130ae, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:13:22.652 INFO request completed, latency_us: 74, response_code: 200, uri: /state/cid/1, method: GET, req_id: 88c3da67-c2e6-4d3c-a709-fc0b3c4ce4de, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:13:26.654 INFO request completed, latency_us: 287, response_code: 200, uri: /state/cid/1, method: GET, req_id: df5aedf1-0b3c-46bd-b2f3-23be08e4bbc4, remote_addr: 127.0.0.1:42350, 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(1237)
[8820][1] reports Running
May 19 05:13:30.656 INFO request completed, latency_us: 273, response_code: 200, uri: /state/cid/1, method: GET, req_id: 66fe2217-a701-4b3f-8ed7-75d474589844, remote_addr: 127.0.0.1:42350, 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
May 19 05:13:58.204 INFO request completed, latency_us: 226, response_code: 204, uri: /stop/cid/2, method: POST, req_id: b373b35f-46b7-424b-ae3b-a50a63b738d5, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:13:58.205 INFO request completed, latency_us: 89, response_code: 200, uri: /state/cid/2, method: GET, req_id: b7ea7190-01cb-4690-bf07-75e0a3e16a8d, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 19 05:14:02.207 INFO request completed, latency_us: 301, response_code: 200, uri: /state/cid/2, method: GET, req_id: ff7072f2-33a9-4f60-88ee-1052a93dbe19, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 19 05:14:02.606 INFO request completed, latency_us: 244, response_code: 204, uri: /start/cid/2, method: POST, req_id: 53bb4d75-752b-4d5a-9733-806b615c10bd, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:14:02.606 INFO request completed, latency_us: 89, response_code: 200, uri: /state/cid/2, method: GET, req_id: 89c79b59-5baf-4277-b603-8a85688b69cf, remote_addr: 127.0.0.1:42350, 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(1238)
[8830][2] reports Running
May 19 05:14:06.608 INFO request completed, latency_us: 273, response_code: 200, uri: /state/cid/2, method: GET, req_id: ea75fbd1-1323-4307-93cb-618573e87fa7, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
[8840] Got stop action so:false kr:false
May 19 05:14:34.371 INFO request completed, latency_us: 364, response_code: 204, uri: /stop/cid/3, method: POST, req_id: b3ec357d-1e0f-4b02-afe7-17c217db4188, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:14:34.372 INFO request completed, latency_us: 86, response_code: 200, uri: /state/cid/3, method: GET, req_id: 39981de8-1697-4bce-869a-b4c446f5c8ed, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
May 19 05:14:38.374 INFO request completed, latency_us: 289, response_code: 200, uri: /state/cid/3, method: GET, req_id: 998c0aad-d29e-4ecd-a918-c84439766786, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
May 19 05:14:38.782 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/3, method: POST, req_id: fd37be0d-33e6-41d8-bf61-4a687b2869db, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:14:38.783 INFO request completed, latency_us: 84, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8f8816a7-4e6f-4573-83cc-ef72258c0fac, remote_addr: 127.0.0.1:42350, 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(1239)
[8840][3] reports Running
May 19 05:14:42.786 INFO request completed, latency_us: 243, response_code: 200, uri: /state/cid/3, method: GET, req_id: 4d081ec5-9fd5-45fd-ad52-029ab926d80a, remote_addr: 127.0.0.1:42350, local_addr: 127.0.0.1:9998
May 19 05:15:10.435 INFO accepted connection, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.436 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: 2da34514-0abb-4578-9e51-21265623833c, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.436 INFO request completed, latency_us: 47, response_code: 200, uri: /regioncount, method: GET, req_id: ec49f9fd-8cae-47d4-ba12-51c911e2f7a0, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.437 INFO request completed, latency_us: 54, response_code: 200, uri: /port/cid/0, method: GET, req_id: 64c36c8e-b352-4853-b9ed-3159d40df03c, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.437 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/1, method: GET, req_id: 03ae60e3-35bd-4d22-9e99-b9aac326035b, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.437 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/2, method: GET, req_id: 33bdabfd-caa6-4512-bb45-69fb0ebebfdf, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.438 INFO request completed, latency_us: 45, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5d6cbd0b-a9de-4294-a9d7-0c023ea49013, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.439 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: 4abdc676-507a-4917-935f-709858a22ad7, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.439 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: 25810a29-9f94-4f8e-8dea-e3c3005094d9, remote_addr: 127.0.0.1:61406, local_addr: 127.0.0.1:9998
May 19 05:15:10.633 INFO accepted connection, remote_addr: 127.0.0.1:33230, local_addr: 127.0.0.1:9998
May 19 05:15:10.633 INFO request completed, latency_us: 137, response_code: 200, uri: /regioncount, method: GET, req_id: e22e1e19-bb79-454f-a977-ef5555c53de8, remote_addr: 127.0.0.1:33230, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 19 05:15:16.251 [8810] Got stop action so:false kr:false
INFO request completed, latency_us: 240, response_code: 204, uri: /stop/cid/0, method: POST, req_id: ccf0931d-7d5b-4e1e-9ec8-8b78da76644c, remote_addr: 127.0.0.1:33230, local_addr: 127.0.0.1:9998
May 19 05:15:16.251 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3e68a2e4-7ffe-46eb-bdd1-961be8831b53, remote_addr: 127.0.0.1:33230, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 19 05:15:20.253 INFO request completed, latency_us: 242, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5c4e0b54-38ed-4093-ac42-d1b995fbe0b7, remote_addr: 127.0.0.1:33230, local_addr: 127.0.0.1:9998
May 19 05:15:57.332 INFO accepted connection, remote_addr: 127.0.0.1:43751, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
May 19 05:15:57.333 INFO request completedstart 0
, latency_us: 170, response_code: 204, uri: /start/cid/0, method: POST, req_id: 6155981f-2d2a-4b0e-ba80-c9a0b41c0b13, remote_addr: 127.0.0.1:43751, 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(1241)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
May 19 05:16:01.728 INFO request completed[8820] Got stop action so:false kr:false
, latency_us: 225, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 49ab6fd3-055f-40a1-8fa6-de436a3119f8, remote_addr: 127.0.0.1:43751, local_addr: 127.0.0.1:9998
May 19 05:16:01.729 INFO request completed, latency_us: 64, response_code: 200, uri: /state/cid/1, method: GET, req_id: fc7941f7-a4cd-499e-8491-e9bdb159346d, remote_addr: 127.0.0.1:43751, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
May 19 05:16:05.730 INFO request completed, latency_us: 274, response_code: 200, uri: /state/cid/1, method: GET, req_id: 94d49e7d-cf3c-4c55-b806-2a170b0871c1, remote_addr: 127.0.0.1:43751, local_addr: 127.0.0.1:9998
May 19 05:16:42.818 INFO accepted connection, remote_addr: 127.0.0.1:45399, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
May 19 05:16:42.818 INFO request completed, latency_us: 189, response_code: 204, uri: /start/cid/1, method: POST, req_id: ac772eee-8804-4d5d-ab43-627ecabab7ba, remote_addr: 127.0.0.1:45399, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
May 19 05:16:47.216 INFO request completed[8830] Got stop action so:false kr:false
, latency_us: 246, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 662b6bbf-eee9-45ee-9918-6834b5cf7df8, remote_addr: 127.0.0.1:45399, local_addr: 127.0.0.1:9998
May 19 05:16:47.217 INFO request completed, latency_us: 78, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9423daba-8022-44f1-b102-a2fd46310591, remote_addr: 127.0.0.1:45399, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[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(1242)
[8820][1] reports Running
May 19 05:16:51.218 INFO request completed, latency_us: 237, response_code: 200, uri: /state/cid/2, method: GET, req_id: f8be054b-990e-4d98-8146-334258226817, remote_addr: 127.0.0.1:45399, local_addr: 127.0.0.1:9998
May 19 05:17:28.301 INFO accepted connection, remote_addr: 127.0.0.1:34519, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
May 19 05:17:28.302 INFO request completed, latency_usgot dsc Start(2)
: 174, response_code: 204, uri: /start/cid/2, method: POST, req_id: 0cd873a4-f8cf-43f4-ab27-dfa9b0e8d27d, remote_addr: 127.0.0.1start 2
:34519, 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(1243)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
May 19 05:17:32.712[8840] Got stop action so:false kr:false
 INFO request completed, latency_us: 227, response_code: 204, uri: /stop/cid/3, method: POST, req_id: b75df9c5-fd43-44ea-955a-814c4a35e3b7, remote_addr: 127.0.0.1:34519, local_addr: 127.0.0.1:9998
May 19 05:17:32.712 INFO request completed, latency_us: 55, response_code: 200, uri: /state/cid/3, method: GET, req_id: f59161fd-b6da-498f-a809-89a1ae707cbe, remote_addr: 127.0.0.1:34519, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
May 19 05:17:36.714 INFO request completed, latency_us: 233, response_code: 200, uri: /state/cid/3, method: GET, req_id: 4fc5143b-aa90-4886-811d-046885520ac5, remote_addr: 127.0.0.1:34519, local_addr: 127.0.0.1:9998
May 19 05:18:13.890 INFO accepted connection, remote_addr: 127.0.0.1:34794, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
May 19 05:18:13.890start 3
 INFO request completed, latency_us: 181, response_code: 204, uri: /start/cid/3, method: POST, req_id: 1e3e7e66-025c-44c3-ad4c-4cb3f76c5c41, remote_addr: 127.0.0.1:34794, 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(1244)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
May 19 05:18:18.441[8850] Got stop action so:false kr:false
 INFO request completed, latency_us: 234, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 6caaa744-1a34-480f-af48-273eff26d1ca, remote_addr: 127.0.0.1:34794, local_addr: 127.0.0.1:9998
May 19 05:18:18.442 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/4, method: GET, req_id: 096822c9-9549-49fe-b5e3-c6821b80f60c, remote_addr: 127.0.0.1:34794, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
May 19 05:18:22.444 INFO request completed, latency_us: 248, response_code: 200, uri: /state/cid/4, method: GET, req_id: 9fd537ee-69f9-4d4a-8ac1-dc2dd1a20307, remote_addr: 127.0.0.1:34794, local_addr: 127.0.0.1:9998
May 19 05:18:59.521 INFO accepted connection, remote_addr: 127.0.0.1:34012, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
May 19 05:18:59.522 INFO request completed, latency_us: 172, response_code: 204, uri: /start/cid/4, method: POST, req_id: 5190bd16-ee21-494f-a3f8-e852bf67c84d, remote_addr: 127.0.0.1:34012, local_addr: 127.0.0.1:9998
[8850] got start action
[8850] I am going to restart
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] reports Starting
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1245)
[8850][4] reports Running
May 19 05:19:03.569 INFO accepted connection, remote_addr: 127.0.0.1:61934, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
May 19 05:19:03.570[8810] Disable keep_running
 INFO request completed, latency_us: 141, response_code:[8810] Got stop action so:false kr:false
 204[8820] Disable keep_running
, [8820] Got stop action so:false kr:false
[8830] Disable keep_running
[8850] Disable keep_running
[8840] Disable keep_running
[8850] Got stop action so:false kr:false
[8830] Got stop action so:false kr:false
[8840] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
uri: /shutdown, method: POST, req_id: 43daa614-cab7-4e9b-a901-c18bc3aaaf40, remote_addr: 127.0.0.1:61934, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit