/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.30892858
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.035563383
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.033121716
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.0347608
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.03367301
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.03188812
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
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Starting downstairs at port 8830
[8820][1] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8810][0] initial start wait reports Starting
[8830][2] initial start wait reports Starting
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8840][3] initial start wait reports Starting
Starting downstairs at port 8850
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1203)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1204)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1206)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1207)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1205)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1208)
[8820][1] initial start wait reports Running
All downstairs are running
May 27 21:13:00.111 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
May 27 21:13:05.160 INFO accepted connection, remote_addr: 127.0.0.1:54317, local_addr: 127.0.0.1:9998
May 27 21:13:05.163 INFO request completed, latency_us: 702, response_code: 200, uri: /state/cid/0, method: GET, req_id: 46ecb915-6724-4347-963f-554af9679646, remote_addr: 127.0.0.1:54317, local_addr: 127.0.0.1:9998
May 27 21:13:05.245 INFO accepted connection, remote_addr: 127.0.0.1:37704, local_addr: 127.0.0.1:9998
May 27 21:13:05.246 INFO request completed, latency_us: 143, response_code: 200, uri: /state/cid/1, method: GET, req_id: be29c602-ea15-4a93-bd13-b06ce75bc883, remote_addr: 127.0.0.1:37704, local_addr: 127.0.0.1:9998
May 27 21:13:05.325 INFO accepted connection, remote_addr: 127.0.0.1:59909, local_addr: 127.0.0.1:9998
May 27 21:13:05.326 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/2, method: GET, req_id: 10d9a81d-81c5-4d41-8e8e-099f31e41a6a, remote_addr: 127.0.0.1:59909, local_addr: 127.0.0.1:9998
May 27 21:13:05.403 INFO accepted connection, remote_addr: 127.0.0.1:38109, local_addr: 127.0.0.1:9998
May 27 21:13:05.404 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8b2f0075-4a55-4169-8071-ed5268c5a792, remote_addr: 127.0.0.1:38109, local_addr: 127.0.0.1:9998
May 27 21:13:05.480 INFO accepted connection, remote_addr: 127.0.0.1:46841, local_addr: 127.0.0.1:9998
May 27 21:13:05.481 INFO request completed, latency_us: 263, response_code: 200, uri: /state/cid/4, method: GET, req_id: 00a467e0-a1bf-46c1-b369-880c16732570, remote_addr: 127.0.0.1:46841, local_addr: 127.0.0.1:9998
May 27 21:13:05.559 INFO accepted connection, remote_addr: 127.0.0.1:42528, local_addr: 127.0.0.1:9998
May 27 21:13:05.559 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/5, method: GET, req_id: f7e95c3d-0bb4-4da7-b794-c4f2157dbbda, remote_addr: 127.0.0.1:42528, local_addr: 127.0.0.1:9998
May 27 21:13:05.637 INFO accepted connection, remote_addr: 127.0.0.1:52965, 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 27 21:13:05.638 INFO request completed, latency_us: 310, response_code: 204, uri: /disablerestart/all[8810] Disable keep_running
, [8820] Disable keep_running
method[8840] Disable keep_running
:[8830] Disable keep_running
 [8850] Disable keep_running
POST, req_id: e9bcd054-3d81-4537-ab70-9aac8048bfe2, remote_addr: 127.0.0.1:52965, [8860] Disable keep_running
local_addr: 127.0.0.1:9998
May 27 21:13:05.863 INFO accepted connection, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.865 INFO request completed, latency_us: 370, response_code: 200, uri: /regioninfo, method: GET, req_id: 772be7b4-efbe-4f54-8819-90cd9bc97475, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.870 INFO request completed, latency_us: 192, response_code: 200, uri: /regioncount, method: GET, req_id: 66388009-1bf6-492f-809e-8f3140f5ae4c, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.874 INFO request completed, latency_us: 259, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0f470c10-5bba-41e8-8833-55991881e2f7, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.876 INFO request completed, latency_us: 241, response_code: 200, uri: /port/cid/1, method: GET, req_id: da32f7e5-71e6-4c6d-bb93-c5e1979bd6dd, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.876 INFO request completed, latency_us: 223, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2823da10-9feb-4a3f-9efc-07e194394858, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.887 INFO request completed, latency_us: 165, response_code: 200, uri: /port/cid/3, method: GET, req_id: 3726a212-a4ac-46b3-a9af-e5e1f7fdbbe2, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.888 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/4, method: GET, req_id: 83e0363c-7f8c-453a-b49a-f1b350d8ac0a, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:05.889 INFO request completed, latency_us: 251, response_code: 200, uri: /port/cid/5, method: GET, req_id: e7c01d62-63ba-46d6-9357-56e7d9ffbe8b, remote_addr: 127.0.0.1:51767, local_addr: 127.0.0.1:9998
May 27 21:13:15.071 INFO accepted connection, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.072 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: 2b37a84b-7cd1-4741-bee1-8fb76dabae7f, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.073 INFO request completed, latency_us: 130, response_code: 200, uri: /regioncount, method: GET, req_id: db3e028e-5ae6-4fbb-a18c-4b91abcf06d4, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.074 INFO request completed, latency_us: 130, response_code: 200, uri: /port/cid/0, method: GET, req_id: 08d72722-fefc-4724-bc89-9e4efcb5a08b, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.075 INFO request completed, latency_us: 218, response_code: 200, uri: /port/cid/1, method: GET, req_id: a6871f6c-9e96-46c9-9368-bade00ca53be, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.076 INFO request completed, latency_us: 137, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3874bf6a-0040-435e-afed-dd4027ea34df, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.080 INFO request completed, latency_us: 240, response_code: 200, uri: /port/cid/3, method: GET, req_id: ce009fd2-b8ae-4b54-81b9-2adc83c693f8, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.081 INFO request completed, latency_us: 132, response_code: 200, uri: /port/cid/4, method: GET, req_id: 3ad9e6a2-ac27-4247-be63-5c3d0da85a61, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:15.082 INFO request completed, latency_us: 119, response_code: 200, uri: /port/cid/5, method: GET, req_id: f766fea4-75fa-4129-a874-219a73c04c8c, remote_addr: 127.0.0.1:37380, local_addr: 127.0.0.1:9998
May 27 21:13:24.860 INFO accepted connection, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.861 INFO request completed, latency_us: 188, response_code: 200, uri: /regioninfo, method: GET, req_id: dc9e14f7-1d71-4b13-8a32-fcaef8838e65, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.863 INFO request completed, latency_us: 114, response_code: 200, uri: /regioncount, method: GET, req_id: 6aefaa15-d60f-4b58-bcf4-bf3ddd944fc5, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.864 INFO request completed, latency_us: 133, response_code: 200, uri: /port/cid/0, method: GET, req_id: ea47a86a-63b6-4405-9a31-15f96370aa3e, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.865 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/1, method: GET, req_id: 57abaace-1bec-4273-bb58-eec09c76f17a, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.866 INFO request completed, latency_us: 288, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5773675e-bf2a-4e37-a32d-6df2bc717016, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.871 INFO request completed, latency_us: 142, response_code: 200, uri: /port/cid/3, method: GET, req_id: ccbf3005-4c18-4a14-99f4-d8866b2e89a2, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.871 INFO request completed, latency_us: 144, response_code: 200, uri: /port/cid/4, method: GET, req_id: d8004d1f-6bb1-445a-b2a6-9add7ed4bcb0, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:13:24.872 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8c4c1f54-a33d-4128-a87c-95812237760a, remote_addr: 127.0.0.1:52806, local_addr: 127.0.0.1:9998
May 27 21:14:05.721 INFO accepted connection, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.722 INFO request completed, latency_us: 180, response_code: 200, uri: /regioninfo, method: GET, req_id: 4e1eef11-99fa-4acc-8f1a-ad6f20fc9fd4, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.724 INFO request completed, latency_us: 107, response_code: 200, uri: /regioncount, method: GET, req_id: 33c54948-1cd4-4526-9896-371504db65db, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.725 INFO request completed, latency_us: 131, response_code: 200, uri: /port/cid/0, method: GET, req_id: 43a9249d-dacd-4006-b011-b9d4add1163c, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.726 INFO request completed, latency_us: 112, response_code: 200, uri: /port/cid/1, method: GET, req_id: eba53ca6-a1b0-4018-b9f1-950e791bcd9e, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.727 INFO request completed, latency_us: 119, response_code: 200, uri: /port/cid/2, method: GET, req_id: a3a5ea10-65f9-4382-a9ab-dcc391984ed2, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.730 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8aedef80-f07c-48d2-8eae-7d27acc64e65, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.731 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/4, method: GET, req_id: de05ca34-ed0d-4fc1-bd58-897f394b6e49, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:14:05.732 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/5, method: GET, req_id: c4929f92-9903-4cdc-bb10-3fbe71e83776, remote_addr: 127.0.0.1:33575, local_addr: 127.0.0.1:9998
May 27 21:19:17.672 INFO accepted connection, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.673 INFO request completed, latency_us: 187, response_code: 200, uri: /regioninfo, method: GET, req_id: 6719b720-62b1-495c-bf16-6816670660fc, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.674 INFO request completed, latency_us: 117, response_code: 200, uri: /regioncount, method: GET, req_id: 0a775139-d899-4d52-9b6e-584b6f6a2039, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.675 INFO request completed, latency_us: 170, response_code: 200, uri: /port/cid/0, method: GET, req_id: 676e096b-cbc6-432e-87c7-d45b22301e6f, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.676 INFO request completed, latency_us: 174, response_code: 200, uri: /port/cid/1, method: GET, req_id: 32187429-3069-4417-8707-cdd01d3827f0, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.677 INFO request completed, latency_us: 254, response_code: 200, uri: /port/cid/2, method: GET, req_id: 53987885-3b78-45a9-9ce9-09f96fa77191, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.680 INFO request completed, latency_us: 136, response_code: 200, uri: /port/cid/3, method: GET, req_id: dbd88fe7-ddde-4aca-84de-42c1d84381d2, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.681 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/4, method: GET, req_id: 55c4516b-b0bc-4f0c-bbd3-4ff0793c7663, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:19:17.682 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/5, method: GET, req_id: 9c2f7a45-e4b5-41e9-ba3e-cf96d338f81c, remote_addr: 127.0.0.1:64682, local_addr: 127.0.0.1:9998
May 27 21:20:39.079 INFO accepted connection, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.080 INFO request completed, latency_us: 197, response_code: 200, uri: /regioninfo, method: GET, req_id: c8d4f65f-f604-42ce-90e6-bae9e02854c8, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.081 INFO request completed, latency_us: 116, response_code: 200, uri: /regioncount, method: GET, req_id: 220909d8-b241-4542-9077-05b985b23190, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.082 INFO request completed, latency_us: 135, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1502462d-df4d-4d0b-9d1c-38c0a5652596, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.083 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/1, method: GET, req_id: d5c47e8c-a18b-44b0-acb7-40244aa819d6, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.084 INFO request completed, latency_us: 121, response_code: 200, uri: /port/cid/2, method: GET, req_id: 35a1c3e8-48cd-4fdb-b80d-e8447bd21ebe, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.087 INFO request completed, latency_us: 235, response_code: 200, uri: /port/cid/3, method: GET, req_id: 22d6bba3-5a36-45d5-930d-0017d092ad78, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.088 INFO request completed, latency_us: 128, response_code: 200, uri: /port/cid/4, method: GET, req_id: be1d762f-7b7a-446a-b232-e923e9db38c6, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:39.089 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/5, method: GET, req_id: d5cebf1c-b1b7-4985-b267-46ef6d9b6e92, remote_addr: 127.0.0.1:37225, local_addr: 127.0.0.1:9998
May 27 21:20:43.337 INFO accepted connection, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.338 INFO request completed, latency_us: 198, response_code: 200, uri: /regioninfo, method: GET, req_id: 2c5dd47b-6466-4fab-a453-ecd957427356, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.339 INFO request completed, latency_us: 119, response_code: 200, uri: /regioncount, method: GET, req_id: 0cbd05e1-a987-424d-a61b-48ebee6067d8, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.341 INFO request completed, latency_us: 199, response_code: 200, uri: /port/cid/0, method: GET, req_id: 481d7c6c-9e84-4978-b56f-178ded0420a4, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.341 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/1, method: GET, req_id: 4a8d3a2e-5bb7-48fc-80cc-e5ac5ad4c10a, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.342 INFO request completed, latency_us: 113, response_code: 200, uri: /port/cid/2, method: GET, req_id: 6acdc5b9-8e1d-4982-b70b-f19ea4b94fd5, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.346 INFO request completed, latency_us: 277, response_code: 200, uri: /port/cid/3, method: GET, req_id: ee46b612-a373-4320-acd9-9e35842ad06f, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.347 INFO request completed, latency_us: 128, response_code: 200, uri: /port/cid/4, method: GET, req_id: b2bb22e3-3f6f-41b2-babe-3906b44dd9a2, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:43.347 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/5, method: GET, req_id: afba67dd-cb6a-46f2-b07e-2aa66fb5d50f, remote_addr: 127.0.0.1:65117, local_addr: 127.0.0.1:9998
May 27 21:20:47.578 INFO accepted connection, remote_addr: 127.0.0.1:50949, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
[8820] Disable keep_running
[8830] Disable keep_running
[8840] Disable keep_running
[8850] Disable keep_running
May 27 21:20:47.579 INFO [8810] Disable keep_running
request completed[8860] Disable keep_running
, latency_us: 218, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 6531a1bf-50d4-47f2-8f54-151ca33d33c3, remote_addr: 127.0.0.1:50949, local_addr: 127.0.0.1:9998
May 27 21:20:47.648 INFO accepted connection, remote_addr: 127.0.0.1:51503, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
May 27 21:20:47.649 INFO request completed, latency_us: 253, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 4d919953-c48c-4b2a-b882-ec27e51752ff, remote_addr: 127.0.0.1:51503, 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
May 27 21:20:47.721 INFO accepted connection, remote_addr: 127.0.0.1:33666, local_addr: 127.0.0.1:9998
May 27 21:20:47.722 INFO request completed, latency_us: 231, response_code: 200, uri: /state/cid/2, method: GET, req_id: 21247b7d-cd91-454d-9151-48d8c41f6212, remote_addr: 127.0.0.1:33666, local_addr: 127.0.0.1:9998
May 27 21:20:47.799 INFO accepted connection, remote_addr: 127.0.0.1:33493, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 27 21:20:47.801 INFO request completed, latency_us: 322, response_code: 204, uri: /start/cid/2, method: POST, req_id: 762fc6d0-37cf-43af-9183-cad6a969646c, remote_addr: 127.0.0.1:33493, local_addr: 127.0.0.1:9998
May 27 21:20:47.904 INFO accepted connection, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.905 INFO request completed, latency_us: 191, response_code: 200, uri: /regioninfo, method: GET, req_id: 66fba60c-962a-4a9f-9e85-4550dd193f1e, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.907 INFO request completed, latency_us: 119, response_code: 200, uri: /regioncount, method: GET, req_id: bd133813-18e4-4a2c-a7df-e615047c6d9b, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.908 INFO request completed, latency_us: 133, response_code: 200, uri: /port/cid/0, method: GET, req_id: e2226cc3-32cc-44f0-8ce0-2c8dd9b7f248, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.909 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/1, method: GET, req_id: f6ebe4d3-97c3-49ed-ade1-ada867e63d10, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.910 INFO request completed, latency_us: 133, response_code: 200, uri: /port/cid/2, method: GET, req_id: adc048df-a4b3-45eb-ae81-0f2ee803a18f, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.913 INFO request completed, latency_us: 167, response_code: 200, uri: /port/cid/3, method: GET, req_id: 6578a579-0d51-46ae-a11a-7b55bde9ef60, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.914 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/4, method: GET, req_id: a931fcd2-9c2b-426d-8e75-424cbc310e06, remote_addr: 127.0.0.1:55463, local_addr: 127.0.0.1:9998
May 27 21:20:47.914 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8cbe3406-b0fb-488a-a6bd-128fa8b6072b, remote_addr: 127.0.0.1:55463, 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(1259)
[8830][2] reports Running
May 27 21:21:02.244 INFO accepted connection, remote_addr: 127.0.0.1:45006, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
May 27 21:21:02.245 INFO request completed, latency_us: 262, response_code: 204, uri: /shutdown, method: POST, req_id: 1f065db2-703d-4d33-bedc-29b5b70c4d14, remote_addr: 127.0.0.1:45006, local_addr: 127.0.0.1:9998
Shut it down
[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
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8830] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[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
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] 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.062237505
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.059747808
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.058468573
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.057973336
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.05998173
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.07772065
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.10955571
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 ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start ds: 8870
start access at:127.0.0.1:9998
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8810][0] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8840][3] initial start wait reports Starting
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8850][4] initial start wait reports Starting
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8860][5] initial start wait reports Starting
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8870][6] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1276)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1277)
[8810][0] initial start wait reports Running
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1278)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1279)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1280)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1281)
[8860][5] initial start wait reports Running
Control access at:127.0.0.1:9998
May 27 21:21:07.847 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1282)
[8870][6] initial start wait reports Running
All downstairs are running
May 27 21:21:12.879 INFO accepted connection, remote_addr: 127.0.0.1:38673, local_addr: 127.0.0.1:9998
May 27 21:21:12.882 INFO request completed, latency_us: 448, response_code: 200, uri: /state/cid/0, method: GET, req_id: 77868a77-92f9-416e-b705-1ed069e5ee33, remote_addr: 127.0.0.1:38673, local_addr: 127.0.0.1:9998
May 27 21:21:12.953 INFO accepted connection, remote_addr: 127.0.0.1:63762, local_addr: 127.0.0.1:9998
May 27 21:21:12.954 INFO request completed, latency_us: 189, response_code: 200, uri: /state/cid/1, method: GET, req_id: 2a855863-6f77-4805-b052-decf086d9e36, remote_addr: 127.0.0.1:63762, local_addr: 127.0.0.1:9998
May 27 21:21:13.024 INFO accepted connection, remote_addr: 127.0.0.1:59066, local_addr: 127.0.0.1:9998
May 27 21:21:13.025 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/2, method: GET, req_id: 76a10b07-7451-4515-b0f4-7886f2a9070e, remote_addr: 127.0.0.1:59066, local_addr: 127.0.0.1:9998
May 27 21:21:13.098 INFO accepted connection, remote_addr: 127.0.0.1:48957, local_addr: 127.0.0.1:9998
May 27 21:21:13.099 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/3, method: GET, req_id: c88707ef-76d9-44ec-9b13-9bfbced2d43b, remote_addr: 127.0.0.1:48957, local_addr: 127.0.0.1:9998
May 27 21:21:13.172 INFO accepted connection, remote_addr: 127.0.0.1:42064, local_addr: 127.0.0.1:9998
May 27 21:21:13.173 INFO request completed, latency_us: 207, response_code: 200, uri: /state/cid/4, method: GET, req_id: d9ee41be-6f45-40ab-8e98-c875e9448a33, remote_addr: 127.0.0.1:42064, local_addr: 127.0.0.1:9998
May 27 21:21:13.247 INFO accepted connection, remote_addr: 127.0.0.1:54975, local_addr: 127.0.0.1:9998
May 27 21:21:13.248 INFO request completed, latency_us: 255, response_code: 200, uri: /state/cid/5, method: GET, req_id: e8aa9a5b-f426-4920-865d-91d0e3533d4b, remote_addr: 127.0.0.1:54975, local_addr: 127.0.0.1:9998
May 27 21:21:13.316 INFO accepted connection, remote_addr: 127.0.0.1:48386, local_addr: 127.0.0.1:9998
May 27 21:21:13.317 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/6, method: GET, req_id: 6060eb3f-9e6b-4f0e-86e9-f8b8b190b794, remote_addr: 127.0.0.1:48386, local_addr: 127.0.0.1:9998
May 27 21:21:13.388 INFO accepted connection, remote_addr: 127.0.0.1:47012, local_addr: 127.0.0.1:9998
May 27 21:21:13.389 INFO request completed, latency_us: 267, response_code: 200, uri: /port/cid/6, method: GET, req_id: 5f005161-b067-4d5b-bd42-b391134e95be, remote_addr: 127.0.0.1:47012, local_addr: 127.0.0.1:9998
May 27 21:21:13.469 INFO accepted connection, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.470 INFO request completed, latency_us: 256, response_code: 200, uri: /regioninfo, method: GET, req_id: d1e35a60-2fd9-4e5d-9415-3412821c39c8, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.472 INFO request completed, latency_us: 162, response_code: 200, uri: /regioncount, method: GET, req_id: 6fb1d4ad-acbc-4c83-ae00-653f2f22ba81, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.473 INFO request completed, latency_us: 136, response_code: 200, uri: /port/cid/0, method: GET, req_id: ec625748-e6d1-4c77-bdd7-4111a11153f1, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.474 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/1, method: GET, req_id: a72f4589-dda5-45d5-8e18-2136ca7cee55, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.474 INFO request completed, latency_us: 135, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9238729a-708e-4816-b22d-37cbb29b42c1, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.478 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/3, method: GET, req_id: ed949209-c616-417c-a69d-9e9244ba4aee, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.479 INFO request completed, latency_us: 178, response_code: 200, uri: /port/cid/4, method: GET, req_id: 140256a4-d22b-43bc-9629-d6fcf7c78983, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.480 INFO request completed, latency_us: 113, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3ee59b84-e9ac-4887-b386-4b18e20b6bdf, remote_addr: 127.0.0.1:33807, local_addr: 127.0.0.1:9998
May 27 21:21:13.537 INFO accepted connection, remote_addr: 127.0.0.1:41914, local_addr: 127.0.0.1:9998
May 27 21:21:13.538 INFO request completed, latency_us: 200, response_code: 200, uri: /regioncount, method: GET, req_id: f61a7598-127c-476e-a4ec-b026524deec6, remote_addr: 127.0.0.1:41914, 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 27 21:21:14.429 INFO request completed, latency_us: 2834, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 318dc814-f5dd-46d1-a592-23af8d480b02, remote_addr: 127.0.0.1:41914, local_addr: 127.0.0.1:9998
May 27 21:21:14.445 INFO request completed, latency_us: 1030, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4333d2c2-eef4-4e7f-82fb-32ad6a9a625f, remote_addr: 127.0.0.1:41914, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 21:21:18.448 INFO request completed, latency_us: 274, response_code: 200, uri: /state/cid/0, method: GET, req_id: eda9276f-c34f-4f2c-8567-42b2d9192130, remote_addr: 127.0.0.1:41914, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 21:21:19.348 INFO request completed, latency_us: 283, response_code: 204, uri: /start/cid/0, method: POST, req_id: 2cfde922-7bf9-4afd-bc66-11e2e17f9927, remote_addr: 127.0.0.1:41914, local_addr: 127.0.0.1:9998
May 27 21:21:19.349 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3db6468b-a774-4117-81c9-9c7f766a2b0e, remote_addr: 127.0.0.1:41914, local_addr: 127.0.0.1:9998
May 27 21:21:23.351 INFO request completed, latency_us: 297, response_code: 200, uri: /state/cid/0, method: GET, req_id: b7d90915-4fba-4900-8a7f-c8d86d5e8d89, remote_addr: 127.0.0.1:41914, 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(1293)
[8810][0] reports Running
May 27 21:21:27.355 INFO request completed, latency_us: 477, response_code: 200, uri: /state/cid/0, method: GET, req_id: 244a14e4-6655-4e60-a150-b7a8b905f637, remote_addr: 127.0.0.1:41914, local_addr: 127.0.0.1:9998
May 27 21:22:00.108 INFO accepted connection, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
May 27 21:22:00.112 INFO request completed, latency_us: 247, response_code: 204, uri: /stop/cid/1, method: POST, req_id: c3f4ba66-2e02-47bc-bf2f-143ffe4f9cf9, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
[8820] Got stop action so:false kr:false
May 27 21:22:00.122 INFO request completed, latency_us: 263, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0f471b1c-c34b-4aeb-aaf9-44bfcdf40354, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
May 27 21:22:04.126 INFO request completed, latency_us: 376, response_code: 200, uri: /state/cid/1, method: GET, req_id: 531d6503-bf5f-4cf8-b0c8-cfb9abe683b4, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
May 27 21:22:04.985 INFO request completed, latency_us: 299, response_code: 204, uri: /start/cid/1, method: POST, req_id: abbacb12-7d8e-4941-aaa0-06d910b4ee6b, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:22:04.986 INFO request completed, latency_us: 377, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0aeb46bd-6d33-4586-92fc-6e66e087edf7, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:22:08.989 INFO request completed, latency_us: 345, response_code: 200, uri: /state/cid/1, method: GET, req_id: b19f94e0-bbc3-4d51-b8bd-0bfcc9045a01, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:22:12.992 INFO request completed, latency_us: 258, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3f18540d-d822-48e5-b021-6089fafed4de, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:22:16.995 INFO request completed, latency_us: 311, response_code: 200, uri: /state/cid/1, method: GET, req_id: 11abaae4-a757-4f4c-9d57-15018a8b5aed, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:22:20.998 INFO request completed, latency_us: 446, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6bd7135d-4d55-416f-b925-ccf098ad0d37, remote_addr: 127.0.0.1:41145, 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(1294)
[8820][1] reports Running
May 27 21:22:25.001 INFO request completed, latency_us: 467, response_code: 200, uri: /state/cid/1, method: GET, req_id: c04f93b2-7d70-4d1b-b626-5138257d04df, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
[8820] Got stop action so:false kr:false
May 27 21:22:31.895 INFO request completed, latency_us: 247, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 8fa4851e-27d1-4fcb-8d92-1dbba3ca9e2a, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:22:31.896 INFO request completed, latency_us: 236, response_code: 200, uri: /state/cid/1, method: GET, req_id: 51e728fd-a9fa-4244-a7e0-cf44bfd88861, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
May 27 21:22:35.902 INFO request completed, latency_us: 311, response_code: 200, uri: /state/cid/1, method: GET, req_id: aa8cd7b0-593f-4a19-85ea-fc1501a0fa8b, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
May 27 21:22:36.774 INFO request completed, latency_us: 276, response_code: 204, uri: /start/cid/1, method: POST, req_id: 7ce3d56c-9e1f-411f-8b18-beb498b0b3fa, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:22:36.775 INFO request completed, latency_us: 132, response_code: 200, uri: /state/cid/1, method: GET, req_id: 82f13328-71ac-4399-b961-dd7b98b146bd, remote_addr: 127.0.0.1:41145, 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(1295)
[8820][1] reports Running
May 27 21:22:40.778 INFO request completed, latency_us: 315, response_code: 200, uri: /state/cid/1, method: GET, req_id: 686d33f2-6ccd-4a6c-9c70-030f1908cdb8, remote_addr: 127.0.0.1:41145, local_addr: 127.0.0.1:9998
May 27 21:23:13.637 INFO accepted connection, remote_addr: 127.0.0.1:65139, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
May 27 21:23:13.638 INFO request completed, latency_us: 234, response_code: 204, uri: /stop/cid/2, method: POST, req_id:stop 2
 01a5a981-80ba-47a8-8c0e-152c2763c830, remote_addr: 127.0.0.1:65139, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
May 27 21:23:13.639 INFO request completed, latency_us: 163, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2cd99e1a-68df-4e90-9b16-f6304ac122fa, remote_addr: 127.0.0.1:65139, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 27 21:23:17.642 INFO request completed, latency_us: 388, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9d101252-dd9c-4976-b2b6-43b3c2768155, remote_addr: 127.0.0.1:65139, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 27 21:23:18.526 INFO request completed, latency_us: 283, response_code: 204, uri: /start/cid/2, method: POST, req_id: 839144f8-b100-41a7-8cb0-c52154ec5594, remote_addr: 127.0.0.1:65139, local_addr: 127.0.0.1:9998
May 27 21:23:18.527 INFO request completed, latency_us: 284, response_code: 200, uri: /state/cid/2, method: GET, req_id: a7e9ee8c-058c-43f7-8048-3e1bb6eaee5d, remote_addr: 127.0.0.1:65139, local_addr: 127.0.0.1:9998
May 27 21:23:22.530 INFO request completed, latency_us: 311, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2c7e62e5-02ef-459c-aafd-8c93a0e89c03, remote_addr: 127.0.0.1:65139, 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(1296)
[8830][2] reports Running
May 27 21:23:26.533 INFO request completed, latency_us: 436, response_code: 200, uri: /state/cid/2, method: GET, req_id: 35178611-3ddf-495c-8935-709958e445df, remote_addr: 127.0.0.1:65139, local_addr: 127.0.0.1:9998
May 27 21:23:59.693 INFO accepted connection, remote_addr: 127.0.0.1:57383, 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 27 21:23:59.696 INFO request completed, latency_us: 402, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 89899f17-c8dc-4e15-b2ec-6c6b9e136290, remote_addr: 127.0.0.1:57383, local_addr: 127.0.0.1:9998
May 27 21:23:59.701 INFO request completed, latency_us: 822, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7820c5b0-da84-4b2d-9388-981d650974fe, remote_addr: 127.0.0.1:57383, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
May 27 21:24:03.704 INFO request completed, latency_us: 297, response_code: 200, uri: /state/cid/3, method: GET, req_id: 28399ba9-c374-41bb-91b5-d59e2e11371f, remote_addr: 127.0.0.1:57383, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
May 27 21:24:04.620 INFO request completed, latency_us: 276, response_code: 204, uri: /start/cid/3, method: POST, req_id: 6bfb5d6e-08ee-4850-ab82-9eca44be81de, remote_addr: 127.0.0.1:57383, local_addr: 127.0.0.1:9998
May 27 21:24:04.621 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/3, method: GET, req_id: e0736dfe-8e57-46ef-9761-342a2a0d8a06, remote_addr: 127.0.0.1:57383, 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(1297)
[8840][3] reports Running
May 27 21:24:08.624 INFO request completed, latency_us: 370, response_code: 200, uri: /state/cid/3, method: GET, req_id: cf892e23-5c88-49a0-b0db-e5530108db73, remote_addr: 127.0.0.1:57383, local_addr: 127.0.0.1:9998
May 27 21:24:41.402 INFO accepted connection, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.404 INFO request completed, latency_us: 235, response_code: 200, uri: /regioninfo, method: GET, req_id: 6dd7b152-d1d9-4f43-829c-2c535e948df7, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.405 INFO request completed, latency_us: 118, response_code: 200, uri: /regioncount, method: GET, req_id: 4bebb332-f59c-4af9-95c9-58acb7014eb9, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.406 INFO request completed, latency_us: 135, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2fbd61ca-fb04-4db4-b18a-357c27a223a5, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.407 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2c587de8-16bd-4d0a-bca9-ce2c9f469296, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.408 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/2, method: GET, req_id: 69b97e2c-4a89-46c5-9346-2c51147e8605, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.411 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/3, method: GET, req_id: e3cd2285-e72d-44b4-ad78-4eb97468e898, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.413 INFO request completed, latency_us: 379, response_code: 200, uri: /port/cid/4, method: GET, req_id: a0d9b726-7ca7-4d92-b624-73537e6dd49e, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:41.413 INFO request completed, latency_us: 129, response_code: 200, uri: /port/cid/5, method: GET, req_id: 7411574a-a986-435b-bb37-1f411ce60a3d, remote_addr: 127.0.0.1:61010, local_addr: 127.0.0.1:9998
May 27 21:24:45.960 INFO accepted connection, remote_addr: 127.0.0.1:51670, local_addr: 127.0.0.1:9998
May 27 21:24:45.961 INFO request completed, latency_us: 256, response_code: 200, uri: /regioncount, method: GET, req_id: b4231a76-a985-4aad-a2a1-ebc3c82d269e, remote_addr: 127.0.0.1:51670, 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 27 21:24:56.951 INFO request completed, latency_us: 682, response_code: 204, uri: /stop/cid/0, method: POST, req_id: a1acf8f1-81d1-416d-a59a-0c4c452055e5, remote_addr: 127.0.0.1:51670, local_addr: 127.0.0.1:9998
May 27 21:24:56.953 INFO request completed, latency_us: 247, response_code: 200, uri: /state/cid/0, method: GET, req_id: 076d669b-3699-47ae-a0c1-a5e93c3bd75a, remote_addr: 127.0.0.1:51670, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 21:25:00.956 INFO request completed, latency_us: 288, response_code: 200, uri: /state/cid/0, method: GET, req_id: 040e7544-08c3-4b9f-8a4e-aa0545bc7d97, remote_addr: 127.0.0.1:51670, local_addr: 127.0.0.1:9998
May 27 21:25:49.559 INFO accepted connection, remote_addr: 127.0.0.1:39029, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 21:25:49.560 INFO request completed, latency_us: 237, response_code: 204, uri: /start/cid/0, method: POST, req_id: 7429460a-6f1a-4cbd-b324-e32bbdf339ff, remote_addr: 127.0.0.1:39029, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
May 27 21:25:54.456stop 1
 INFO request completed, latency_us: 285, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 45d33544-23c0-407c-aa09-4bff841a41a7, remote_addr: 127.0.0.1:39029, local_addr: 127.0.0.1:9998
[8820] Got stop action so:false kr:false
May 27 21:25:54.457 INFO request completed, latency_us: 312, response_code: 200, uri: /state/cid/1, method: GET, req_id: e22151fc-34cf-4dc2-8024-921e2924a613, remote_addr: 127.0.0.1:39029, 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(1299)
[8810][0] reports Running
May 27 21:25:58.461 INFO request completed, latency_us: 575, response_code: 200, uri: /state/cid/1, method: GET, req_id: b99db026-b2d2-4088-87e2-4a8cccad4e0f, remote_addr: 127.0.0.1:39029, local_addr: 127.0.0.1:9998
May 27 21:26:46.998 INFO accepted connection, remote_addr: 127.0.0.1:49644, local_addr: 127.0.0.1:9998
May 27 21:26:46.999 INFO request completed, latency_us: 262, response_code: 204, uri: /start/cid/1, method: POST, req_id: 30337c55-793d-4825-a27f-eb5f3f4101cb, remote_addr: Main task has work to do, go find it
127got dsc Start(1)
.0.0.1:49644, local_addr: 127.0.0.1:9998
start 1
Main task has work to do, go find it
got dsc Stop(2)
stop 2
May 27 21:26:51.901 INFO request completed, latency_us: 265, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 9dec4fe7-4dcb-47bc-9ec5-9832ecae7409, [8830] Got stop action so:false kr:false
remote_addr: 127.0.0.1:49644, local_addr: 127.0.0.1:9998
May 27 21:26:51.902 INFO request completed, latency_us: 231, response_code: 200, uri: /state/cid/2, method: GET, req_id: b31c6c62-6086-4cc9-a998-0ee9539a66ba, remote_addr: 127.0.0.1:49644, 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(1300)
[8820][1] reports Running
May 27 21:26:55.905 INFO request completed, latency_us: 525, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0ea80248-c891-4019-b935-cd3c1c948a45, remote_addr: 127.0.0.1:49644, local_addr: 127.0.0.1:9998
May 27 21:27:44.347 INFO accepted connection, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
May 27 21:27:44.348got dsc Start(2)
 start 2
INFO request completed, latency_us: 368, response_code: 204, uri: /start/cid/2, method: POST, req_id: 3b42faa3-bc1d-4121-8640-327b0d481bac, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
May 27 21:27:49.297 INFO request completed, latency_us: 392, response_code: 204, uri: /stop/cid/3, method: POST, req_id: e72c5427-9f10-493f-93f3-e987cde8ffe9, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998
[8840] Got stop action so:false kr:false
May 27 21:27:49.299 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/3, method: GET, req_id: 554df970-1c7d-4084-a75d-c6d0dd8cfad1, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] 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(1301)
[8830][2] reports Running
May 27 21:27:53.302 INFO request completed, latency_us: 457, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7bb598dc-17c2-4c0c-ad33-04a82756dbfe, remote_addr: 127.0.0.1:54717, local_addr: 127.0.0.1:9998
May 27 21:28:41.780 INFO accepted connection, remote_addr: 127.0.0.1:33096, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
May 27 21:28:41.780 INFO request completed, latency_us: 244, response_code: 204, uri: /start/cid/3, method: POST, req_id: b4e710aa-c916-4f7c-af39-82f083d646ad, remote_addr: 127.0.0.1:33096, 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(1302)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
May 27 21:28:46.992 INFO[8850] Got stop action so:false kr:false
 request completed, latency_us: 469, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 2ad94771-437a-47e9-b2fd-b87db386f247, remote_addr: 127.0.0.1:33096, local_addr: 127.0.0.1:9998
May 27 21:28:46.994 INFO request completed, latency_us: 254, response_code: 200, uri: /state/cid/4, method: GET, req_id: 9827421e-6879-4b7b-8c50-a2de6d740b7b, remote_addr: 127.0.0.1:33096, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
May 27 21:28:50.996 INFO request completed, latency_us: 345, response_code: 200, uri: /state/cid/4, method: GET, req_id: a5f0126d-ac87-464c-bb89-22744373960f, remote_addr: 127.0.0.1:33096, local_addr: 127.0.0.1:9998
May 27 21:29:39.574 INFO accepted connection, remote_addr: 127.0.0.1:41325, local_addr: 127.0.0.1:9998
May 27 21:29:39.575 INFO request completed, latency_us: 321, response_code: 204, Main task has work to do, go find it
urigot dsc Start(4)
: /start/cid/4, method: POSTstart 4
, req_id: a3b0dcc5-f579-4a4e-9251-412997cdaa31, remote_addr: 127.0.0.1:41325, 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(1303)
[8850][4] reports Running
May 27 21:29:43.687 INFO accepted connection, remote_addr: 127.0.0.1:48362, local_addr: 127.0.0.1:9998
May 27 21:29:43.688Main task has work to do, go find it
 got dsc Shutdown
INFOShutdown
 request completed, latency_us: 275, response_code: 204, uri: /shutdown, method: POST, req_id: df06ee27-1f28-4fa5-9e3c-2621691e8867, remote_addr: 127.0.0.1:48362, local_addr: 127.0.0.1:9998
Shut it down
[8810] Disable keep_running
[8810] Got stop action so:false kr:false
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8860] Disable keep_running
[8840] Disable keep_running
[8860] Got stop action so:false kr:false
[8840] Got stop action so:false kr:false
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit