/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.18613896
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.011795875
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.01050431
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.0108679
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010703584
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010581278
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 access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
Starting downstairs at port 8840
Starting downstairs at port 8850
Starting downstairs at port 8830
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8840][3] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8810][0] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1139)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1140)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1138)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1141)
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1142)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1143)
[8860][5] initial start wait reports Running
[8840][3] initial start wait reports Running
[8810][0] initial start wait reports Running
[8850][4] initial start wait reports Running
[8820][1] initial start wait reports Running
All downstairs are running
Control access at:127.0.0.1:9998
May 27 03:14:00.699 INFO listening, local_addr: 127.0.0.1:9998
May 27 03:14:05.698 INFO accepted connection, remote_addr: 127.0.0.1:56242, local_addr: 127.0.0.1:9998
May 27 03:14:05.699 INFO request completed, latency_us: 337, response_code: 200, uri: /state/cid/0, method: GET, req_id: 359ad9d5-4971-4a61-9818-3b2286115234, remote_addr: 127.0.0.1:56242, local_addr: 127.0.0.1:9998
May 27 03:14:05.713 INFO accepted connection, remote_addr: 127.0.0.1:41626, local_addr: 127.0.0.1:9998
May 27 03:14:05.713 INFO request completed, latency_us: 68, response_code: 200, uri: /state/cid/1, method: GET, req_id: 32a05046-1160-4714-b78e-76ba7035dd7f, remote_addr: 127.0.0.1:41626, local_addr: 127.0.0.1:9998
May 27 03:14:05.726 INFO accepted connection, remote_addr: 127.0.0.1:49798, local_addr: 127.0.0.1:9998
May 27 03:14:05.727 INFO request completed, latency_us: 72, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0ac8bfc2-c5ad-446c-b418-c3b80bb8ea41, remote_addr: 127.0.0.1:49798, local_addr: 127.0.0.1:9998
May 27 03:14:05.740 INFO accepted connection, remote_addr: 127.0.0.1:32821, local_addr: 127.0.0.1:9998
May 27 03:14:05.740 INFO request completed, latency_us: 56, response_code: 200, uri: /state/cid/3, method: GET, req_id: ea9e2652-db1b-4f5e-83e7-c4e7a8af9b48, remote_addr: 127.0.0.1:32821, local_addr: 127.0.0.1:9998
May 27 03:14:05.753 INFO accepted connection, remote_addr: 127.0.0.1:58466, local_addr: 127.0.0.1:9998
May 27 03:14:05.753 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/4, method: GET, req_id: 4a57f517-6255-49ea-9953-033bbf0253b4, remote_addr: 127.0.0.1:58466, local_addr: 127.0.0.1:9998
May 27 03:14:05.766 INFO accepted connection, remote_addr: 127.0.0.1:52985, local_addr: 127.0.0.1:9998
May 27 03:14:05.767 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/5, method: GET, req_id: 6f126568-69dd-4f2d-9744-61ffae684aef, remote_addr: 127.0.0.1:52985, local_addr: 127.0.0.1:9998
May 27 03:14:05.779 INFO accepted connection, remote_addr: 127.0.0.1:37685, 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 03:14:05.779 INFO request completed, latency_us: 77, response_code: 204, uri: /disablerestart/all, method: POST, req_id: afb5a9c3-2e75-4a76-8091-90038c70f6f7, remote_addr: 127.0.0.[8810] Disable keep_running
1:37685[8820] Disable keep_running
, [8830] Disable keep_running
local_addr[8840] Disable keep_running
:[8860] Disable keep_running
 [8850] Disable keep_running
127.0.0.1:9998
May 27 03:14:05.837 INFO accepted connection, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.838 INFO request completed, latency_us: 249, response_code: 200, uri: /regioninfo, method: GET, req_id: be648567-b3a1-437c-a4e9-cd8135b161e9, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.839 INFO request completed, latency_us: 62, response_code: 200, uri: /regioncount, method: GET, req_id: cd53dd41-3ed2-4009-983c-614f3f44caef, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.840 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/0, method: GET, req_id: 88a73706-a4f0-40d7-972a-e624fc43439b, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.840 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0ce26249-b5e8-4271-9c17-d0aaa9d898c3, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.840 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9f1cc70e-4208-4596-b3f1-dbd833cebb02, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.845 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/3, method: GET, req_id: 86757a85-9031-40a8-b680-3e7b1379873e, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.845 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: cfbb34df-c985-46a9-ba07-52c7a689388d, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:05.845 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/5, method: GET, req_id: eca9afda-5e1d-49ee-8594-f469acd18a6e, remote_addr: 127.0.0.1:43992, local_addr: 127.0.0.1:9998
May 27 03:14:14.901 INFO accepted connection, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.902 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: 72480cb8-8d80-4b14-ac97-7c484bc7e35f, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.902 INFO request completed, latency_us: 39, response_code: 200, uri: /regioncount, method: GET, req_id: ef183677-4560-4f4d-8f65-4ede1db85b64, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.903 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1fa6e074-5792-469a-86a0-0e335cbc79a8, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.903 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: 452696dc-9b72-423c-b1c2-d4f76c5f9ec3, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.903 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: c73d4120-4652-439a-84a0-e0a21b594d95, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.904 INFO request completed, latency_us: 46, response_code: 200, uri: /port/cid/3, method: GET, req_id: 3c1fbe78-bf97-4b03-b168-2a37fdcc6694, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.905 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/4, method: GET, req_id: c6970b8f-5d73-413b-9291-0b73d4a80f85, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:14.905 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: d63fc345-7d97-4fee-b37d-e1b581585171, remote_addr: 127.0.0.1:51502, local_addr: 127.0.0.1:9998
May 27 03:14:24.214 INFO accepted connection, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.214 INFO request completed, latency_us: 159, response_code: 200, uri: /regioninfo, method: GET, req_id: 4aeeb4b6-b94f-485f-8ed6-187f7d199e91, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.215 INFO request completed, latency_us: 70, response_code: 200, uri: /regioncount, method: GET, req_id: d862c5be-f2a4-4130-bb09-4a87aac19bfd, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.216 INFO request completed, latency_us: 70, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6ce1aec3-cd0d-4881-b6d7-b6a42c8f5539, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.216 INFO request completed, latency_us: 47, response_code: 200, uri: /port/cid/1, method: GET, req_id: 285bf0c7-0ba7-4bd4-b58d-e2e53ce5799c, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.216 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1c2a8ea6-0bd1-4b5a-9524-9b7b3d98b333, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.217 INFO request completed, latency_us: 67, response_code: 200, uri: /port/cid/3, method: GET, req_id: 9c5f24d1-6c83-4690-bcff-d93936216606, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.218 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/4, method: GET, req_id: fd062068-0fa9-4fde-9fe7-591bb726ee62, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:24.218 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: 169acfb5-4ad8-4492-9b21-10417e83194c, remote_addr: 127.0.0.1:47146, local_addr: 127.0.0.1:9998
May 27 03:14:49.277 INFO accepted connection, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.277 INFO request completed, latency_us: 152, response_code: 200, uri: /regioninfo, method: GET, req_id: 307dbcec-8f19-4c3c-be43-d9376fd65d6a, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.278 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: a982863b-b605-46dd-8bf5-eb7adafffbd9, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.278 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: 7273d98a-2de1-4d77-98e3-fba6635fed93, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.278 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: ddfdea05-f169-437a-b9e1-66ce9375a0db, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.278 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 74194ff1-9426-4f83-82f3-a0a190a0a593, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.280 INFO request completed, latency_us: 52, response_code: 200, uri: /port/cid/3, method: GET, req_id: d7ce10d2-d87c-4dd1-8edc-e66a5a997a04, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.280 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/4, method: GET, req_id: 336f45fc-d351-435d-833a-58fd0ed9cddf, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:14:49.280 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: f4972e4e-07d4-44d1-b234-f70671ee172b, remote_addr: 127.0.0.1:40910, local_addr: 127.0.0.1:9998
May 27 03:17:23.496 INFO accepted connection, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.497 INFO request completed, latency_us: 142, response_code: 200, uri: /regioninfo, method: GET, req_id: fd879708-1a6c-4a69-b52e-16ae72a08ad6, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.498 INFO request completed, latency_us: 33, response_code: 200, uri: /regioncount, method: GET, req_id: 5d3b7f3d-ac74-4165-a3c0-4fa32909a25e, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.498 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/0, method: GET, req_id: d20ffbbd-49ed-4f78-9e5e-32455b667287, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.498 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3e2d872d-219c-4fa5-b39a-173392e99bdc, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.498 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2be02082-d369-4217-bbad-4bb83c426e44, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.500 INFO request completed, latency_us: 46, response_code: 200, uri: /port/cid/3, method: GET, req_id: de46d50b-c800-43b8-a2a6-8fd5b83b0140, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.500 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/4, method: GET, req_id: 68e97421-c990-4c65-b371-0fe1dacd83ff, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:23.500 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/5, method: GET, req_id: f61c7586-d4ae-4aa3-9618-fc8e989ea58b, remote_addr: 127.0.0.1:60216, local_addr: 127.0.0.1:9998
May 27 03:17:39.995 INFO accepted connection, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.995 INFO request completed, latency_us: 143, response_code: 200, uri: /regioninfo, method: GET, req_id: 6c6e91ef-031c-43ae-9894-e6a5c9f69750, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.996 INFO request completed, latency_us: 34, response_code: 200, uri: /regioncount, method: GET, req_id: 3d426874-10dd-4d81-bb38-8e752becc577, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.996 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/0, method: GET, req_id: bba653de-c73f-4333-8336-9e09bb0b722b, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.997 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/1, method: GET, req_id: c9c2963b-e8a7-4316-917e-08f7a93e1033, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.997 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: d7c131bc-6282-4e62-bb66-43752bc44119, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.998 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/3, method: GET, req_id: 07316993-1916-4d45-a35a-6474a22eff01, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.998 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/4, method: GET, req_id: 47741901-4d2e-4a86-830b-688140b862c0, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:39.999 INFO request completed, latency_us: 39, response_code: 200, uri: /port/cid/5, method: GET, req_id: bb0bf47c-a08b-41f8-b37a-1da96646c29a, remote_addr: 127.0.0.1:56538, local_addr: 127.0.0.1:9998
May 27 03:17:44.108 INFO accepted connection, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.108 INFO request completed, latency_us: 148, response_code: 200, uri: /regioninfo, method: GET, req_id: fdd1987f-6f51-45f5-ae7f-c1234ae2848b, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.109 INFO request completed, latency_us: 69, response_code: 200, uri: /regioncount, method: GET, req_id: d510f962-cbc0-4ce5-b8d4-cd0a6fa1c3bf, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.109 INFO request completed, latency_us: 72, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9e47ddf9-fc74-4bc2-a89d-2889ee21ab08, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.110 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/1, method: GET, req_id: 291aee9c-3518-4595-888b-e02c95653fcf, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.110 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: dad7d473-be21-45ec-97dc-44e57594d194, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.111 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/3, method: GET, req_id: 062b3a7b-3371-4a29-85a1-e1ab79f0127f, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.111 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2067e0bc-4208-49d5-b514-7b8f5ab86220, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:44.112 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4fec5819-907d-418c-8b51-d80526e24d8f, remote_addr: 127.0.0.1:38619, local_addr: 127.0.0.1:9998
May 27 03:17:48.209 INFO accepted connection, remote_addr: 127.0.0.1:53596, 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 03:17:48.209 INFO request completed, latency_us: 142, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 17190db2-de2c-4b21-86bd-97f507913cb0, remote_addr: 127.0.0.1:53596, local_addr: 127.[8820] Disable keep_running
0.0.1:9998
[8810] Disable keep_running
[8830] Disable keep_running
[8850] Disable keep_running
[8860] Disable keep_running
[8840] Disable keep_running
May 27 03:17:48.223 INFO accepted connection, remote_addr: 127.0.0.1:50137, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
May 27 03:17:48.224 INFO request completedstop 2
, latency_us: 146, response_code: 204, uri: /stop/cid/2, method: POST, req_id: c559073c-809c-445c-8f73-97cf0ff76295, remote_addr: 127.0.0.1:50137, local_addr: 127.0[8830] Got stop action so:false kr:false
.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 27 03:17:48.238 INFO accepted connection, remote_addr: 127.0.0.1:43479, local_addr: 127.0.0.1:9998
May 27 03:17:48.238 INFO request completed, latency_us: 75, response_code: 200, uri: /state/cid/2, method: GET, req_id: b60591cd-53a0-40fb-b31b-49631c7f78f6, remote_addr: 127.0.0.1:43479, local_addr: 127.0.0.1:9998
May 27 03:17:48.254 INFO accepted connection, remote_addr: 127.0.0.1:51547, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 27 03:17:48.255 INFO request completed, latency_us: 88, response_code: 204, uri: /start/cid/2, method: POST, req_id: c8f7045f-eaaf-41ad-b159-40f1e2f1c348, remote_addr: 127.0.0.1:51547, local_addr: 127.0.0.1:9998
May 27 03:17:48.289 INFO accepted connection, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.289 INFO request completed, latency_us: 89, response_code: 200, uri: /regioninfo, method: GET, req_id: d9643a12-762e-49ae-8098-fa5bdd88de21, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.290 INFO request completed, latency_us: 36, response_code: 200, uri: /regioncount, method: GET, req_id: 9e59f4f9-d32a-49be-96ec-3e987d2e8448, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.290 INFO request completed, latency_us: 47, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8c5d064e-59df-4ff4-bba6-9503e0f35610, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.291 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3fbc6018-9514-4f5a-8409-2274ea0c6619, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.291 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: a79fc4dc-f7eb-4991-b16e-8f7d89895a3a, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.292 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/3, method: GET, req_id: 6f24066b-083e-4f70-91d1-b2fcba8cafad, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.292 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/4, method: GET, req_id: f4b601fe-9855-40f9-afa3-607cee1a8e54, remote_addr: 127.0.0.1:55768, local_addr: 127.0.0.1:9998
May 27 03:17:48.292 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: d4672bd9-8abd-4586-a1ed-54bddcabf3bb, remote_addr: 127.0.0.1:55768, 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(1194)
[8830][2] reports Running
May 27 03:18:02.433 INFO accepted connection, remote_addr: 127.0.0.1:51923, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
May 27 03:18:02.433 INFO request completed, latency_usShut it down
: 134, response_code: 204, uri: /shutdown, method: POST, req_id: cbc22c4c-906f-41d0-b30c-9b2a3e7e921d, remote_addr: 127.0.0.1:51923, local_addr[8810] Disable keep_running
:[8830] Disable keep_running
 127.0.0.1[8820] Disable keep_running
:[8830] Got stop action so:false kr:false
9998[8820] Got stop action so:false kr:false

[8850] Disable keep_running
[8860] Disable keep_running
[8850] Got stop action so:false kr:false
[8860] Got stop action so:false kr:false
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8810] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8820][1] reports Exit
[8850][4] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] 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.029183622
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.027934676
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.0263036
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.024892597
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.024701152
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.02549353
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.036163576
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-8810.txt"
[8810][0] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8820][1] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8830][2] initial start wait reports Starting
Starting downstairs at port 8840
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8840][3] initial start wait reports Starting
Starting downstairs at port 8860
[8850][4] initial start wait reports Starting
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8870][6] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1211)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1215)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1212)
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1214)
[8820][1] initial start wait reports Running
[8810][0] initial start wait reports Running
[8860][5] initial start wait reports Running
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1213)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1216)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1217)
[8840][3] initial start wait reports Running
All downstairs are running
Control access at:127.0.0.1:9998
May 27 03:18:07.651 INFO listening, local_addr: 127.0.0.1:9998
May 27 03:18:12.662 INFO accepted connection, remote_addr: 127.0.0.1:64093, local_addr: 127.0.0.1:9998
May 27 03:18:12.663 INFO request completed, latency_us: 383, response_code: 200, uri: /state/cid/0, method: GET, req_id: 36679640-580b-43be-915a-029d7f3cfbd5, remote_addr: 127.0.0.1:64093, local_addr: 127.0.0.1:9998
May 27 03:18:12.677 INFO accepted connection, remote_addr: 127.0.0.1:40941, local_addr: 127.0.0.1:9998
May 27 03:18:12.677 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0989af7e-eed4-45c6-957e-c7ca645a7568, remote_addr: 127.0.0.1:40941, local_addr: 127.0.0.1:9998
May 27 03:18:12.690 INFO accepted connection, remote_addr: 127.0.0.1:58409, local_addr: 127.0.0.1:9998
May 27 03:18:12.691 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/2, method: GET, req_id: 38b93068-74ee-4cbd-9972-f0562e71e4c6, remote_addr: 127.0.0.1:58409, local_addr: 127.0.0.1:9998
May 27 03:18:12.703 INFO accepted connection, remote_addr: 127.0.0.1:60776, local_addr: 127.0.0.1:9998
May 27 03:18:12.704 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/3, method: GET, req_id: 50cbd0c5-71e1-41de-a00f-ab268ce8bf88, remote_addr: 127.0.0.1:60776, local_addr: 127.0.0.1:9998
May 27 03:18:12.716 INFO accepted connection, remote_addr: 127.0.0.1:33526, local_addr: 127.0.0.1:9998
May 27 03:18:12.717 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/4, method: GET, req_id: fdcf7764-983f-4cce-8429-81c86adc277c, remote_addr: 127.0.0.1:33526, local_addr: 127.0.0.1:9998
May 27 03:18:12.729 INFO accepted connection, remote_addr: 127.0.0.1:57134, local_addr: 127.0.0.1:9998
May 27 03:18:12.729 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/5, method: GET, req_id: dc593d23-3647-4a58-9b02-3ec41fd064a2, remote_addr: 127.0.0.1:57134, local_addr: 127.0.0.1:9998
May 27 03:18:12.742 INFO accepted connection, remote_addr: 127.0.0.1:55936, local_addr: 127.0.0.1:9998
May 27 03:18:12.742 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/6, method: GET, req_id: 65b004ba-9816-49dc-aa9e-de07e7fa1aa6, remote_addr: 127.0.0.1:55936, local_addr: 127.0.0.1:9998
May 27 03:18:12.755 INFO accepted connection, remote_addr: 127.0.0.1:41792, local_addr: 127.0.0.1:9998
May 27 03:18:12.755 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/6, method: GET, req_id: 8dc26540-b7c9-433a-a57f-a830b2a01490, remote_addr: 127.0.0.1:41792, local_addr: 127.0.0.1:9998
May 27 03:18:12.774 INFO accepted connection, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.774 INFO request completed, latency_us: 98, response_code: 200, uri: /regioninfo, method: GET, req_id: 706382ab-b1e0-4ff9-81c6-b31bf36c2065, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.775 INFO request completed, latency_us: 32, response_code: 200, uri: /regioncount, method: GET, req_id: 5f13df21-9616-49ed-8af4-e33d0869a8ec, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.775 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/0, method: GET, req_id: 7f8bbd7f-6df7-4e62-a3ca-07fed97647e9, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.775 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/1, method: GET, req_id: 8b863720-8f98-4a65-96b6-2c6593da4aa6, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.775 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/2, method: GET, req_id: 46fdbfb1-e4ff-4144-86d2-2b2435674e67, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.777 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/3, method: GET, req_id: 61e6626b-3a9e-467c-9fec-a205c811807f, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.777 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/4, method: GET, req_id: ccca12c7-02cc-4c29-aef0-211b09f8b09c, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.777 INFO request completed, latency_us: 22, response_code: 200, uri: /port/cid/5, method: GET, req_id: f6434c6f-e6c5-4755-939d-f2af44bd963e, remote_addr: 127.0.0.1:39162, local_addr: 127.0.0.1:9998
May 27 03:18:12.800 INFO accepted connection, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:12.800 INFO request completed, latency_us: 134, response_code: 200, uri: /regioncount, method: GET, req_id: b528b8dd-5bed-4247-ba07-3003094fe306, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 27 03:18:13.194 INFO request completed, latency_us: 395, response_code: [8810] Got stop action so:false kr:false
204, uri: /stop/cid/0, method: POST, req_id: 6e60ffdd-e479-43a1-8382-d97abd7963bd, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:13.195 INFO request completed, latency_us: 166, response_code: 200, uri: /state/cid/0, method: GET, req_id: b7e8f7f8-4cd7-4034-852c-a58fb091df29, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 03:18:17.197 INFO request completed, latency_us: 234, response_code: 200, uri: /state/cid/0, method: GET, req_id: d2d642a0-d9b4-460c-8235-cc2bfdb6681b, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 03:18:17.596 INFO request completed, latency_us: 243, response_code: 204, uri: /start/cid/0, method: POST, req_id: 9184d066-b74b-458e-b895-35daf1422a84, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:17.597 INFO request completed, latency_us: 77, response_code: 200, uri: /state/cid/0, method: GET, req_id: d6793321-8e73-4028-891b-b9bb29755ab1, remote_addr: 127.0.0.1:45804, 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(1228)
[8810][0] reports Running
May 27 03:18:21.598 INFO request completed, latency_us: 190, response_code: 200, uri: /state/cid/0, method: GET, req_id: c6632fa4-4c9c-4eea-9d53-b1690a0e9fc8, remote_addr: 127.0.0.1:45804, 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 03:18:27.991 INFO request completed, latency_us: 240, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 2ae198e9-1656-4697-8525-a193937cc6e0, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:27.991 INFO request completed, latency_us: 168, response_code: 200, uri: /state/cid/0, method: GET, req_id: a761a00e-e222-4232-88f8-2d219223fcb1, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 03:18:31.993 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2ec567b1-e6f1-4360-9a94-4009acd803d8, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 03:18:32.391 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: db937bba-3e71-4300-86cb-0b3aa402da95, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:32.392 INFO request completed, latency_us: 185, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6484ff19-b569-4d92-a871-fc9365d6a805, remote_addr: 127.0.0.1:45804, 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(1229)
[8810][0] reports Running
May 27 03:18:36.394 INFO request completed, latency_us: 204, response_code: 200, uri: /state/cid/0, method: GET, req_id: ff3ddcbf-f145-4602-8e99-a077ea6e98c4, remote_addr: 127.0.0.1:45804, 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 03:18:41.787 INFO request completed, latency_us: 237, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 6eee90c0-d97e-4249-a504-eb9bbca90eff, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:41.787 INFO request completed, latency_us: 150, response_code: 200, uri: /state/cid/0, method: GET, req_id: 58d04824-8c31-4de1-a4ac-df98c829d7db, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 03:18:45.789 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/0, method: GET, req_id: 864479da-5eab-49d1-b305-ad5d854bc737, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 03:18:46.196 INFO request completed, latency_us: 218, response_code: 204, uri: /start/cid/0, method: POST, req_id: 82b21a3e-b49a-47c8-a9bc-7e8efdce4063, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:46.196 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: e22c4e02-ae8a-4695-b622-d817aa845ba2, remote_addr: 127.0.0.1:45804, 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(1230)
[8810][0] reports Running
May 27 03:18:50.198 INFO request completed, latency_us: 194, response_code: 200, uri: /state/cid/0, method: GET, req_id: bcba598d-b45c-4fff-9c13-9735769b2b3b, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 27 03:18:54.594 INFO request completed, latency_us: 230[8810] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 7e51caf4-1ab9-4089-99e0-4c0992850848, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:54.594 INFO request completed, latency_us: 56, response_code: 200, uri: /state/cid/0, method: GET, req_id: ff83eb14-87a2-44e0-9c51-60c4b048d512, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 03:18:58.597 INFO request completed, latency_us: 231, response_code: 200, uri: /state/cid/0, method: GET, req_id: 957b9e64-5275-4e87-bd7c-497f88e83027, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 03:18:59.003 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: 073bec30-5eb4-4b3c-ae66-a5004434e9bc, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:18:59.004 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2b30dfd8-81a7-49da-9f07-a01d85a8cbd9, remote_addr: 127.0.0.1:45804, 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 27 03:19:03.006 INFO request completed, latency_us: 191, response_code: 200, uri: /state/cid/0, method: GET, req_id: 60a4ad0b-8bb1-452d-ae19-181d809d55ba, remote_addr: 127.0.0.1:45804, 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 03:19:06.401 INFO request completed, latency_us: 225, response_code: 204, uri: /stop/cid/0, method: POST, req_id: adfdc772-a59d-477c-b294-cbad35872179, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:19:06.402 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9b86d0a8-02c4-475c-9788-036bf4ba38a1, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 03:19:10.403 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/0, method: GET, req_id: 17cbd7a1-1c0a-4319-b33f-c1bcda78bab4, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 03:19:10.811 INFO request completed, latency_us: 257, response_code: 204, uri: /start/cid/0, method: POST, req_id: 377608e0-06c3-448c-9e85-976c8aec2e18, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:19:10.811 INFO request completed, latency_us: 47, response_code: 200, uri: /state/cid/0, method: GET, req_id: 62df0cb5-a42d-4cac-a937-3458051a670d, remote_addr: 127.0.0.1:45804, 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 27 03:19:14.813 INFO request completed, latency_us: 185, response_code: 200, uri: /state/cid/0, method: GET, req_id: fe6f4aeb-772b-4b82-a2a4-1a86e779baf7, remote_addr: 127.0.0.1:45804, 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 03:19:17.205 INFO request completed, latency_us: 231, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 2c2468b4-6a59-42b4-8973-e89bf630ba6c, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:19:17.205 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/0, method: GET, req_id: b40c32e7-68d1-4361-b27c-26063d90bb7a, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 03:19:21.207 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/0, method: GET, req_id: d7ce8189-bd8a-4d3a-ab7d-bb0a2e489a13, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
May 27 03:19:21.615 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/0, method: POST, req_id: 791dbde9-15fb-4fc1-95a2-743e018d90ce, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:19:21.616 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3a51f17e-3259-49e2-89d2-27af9acc289e, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:19:25.617 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/0, method: GET, req_id: d3b23532-ce75-4bed-8060-665217f32061, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:19:29.619 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/0, method: GET, req_id: eecb27da-1927-405c-955b-a4b54401156d, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:19:33.621 INFO request completed, latency_us: 224, response_code: 200, uri: /state/cid/0, method: GET, req_id: 97fe8eba-e2f8-4b38-ad96-948a3a3f887c, remote_addr: 127.0.0.1:45804, 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 27 03:19:37.623 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/0, method: GET, req_id: c0ef0b42-d4d5-4790-80bf-51295ed42c03, remote_addr: 127.0.0.1:45804, 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 03:20:05.128 INFO request completed, latency_us: 459, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 592bfb37-d7cf-470e-80be-8b26f7e6ac02, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:20:05.129 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/1, method: GET, req_id: 59580bc9-a061-4572-a4e7-afb8e75ab22c, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
May 27 03:20:09.131 INFO request completed, latency_us: 204, response_code: 200, uri: /state/cid/1, method: GET, req_id: 98d9c4c0-0d83-47b1-846a-311e1c2cb640, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
May 27 03:20:09.537 INFO request completed, latency_us: 242, response_code: 204, uri: /start/cid/1, method: POST, req_id: fd865f83-a396-4fb5-b797-a541b6e60c93, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:20:09.538 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/1, method: GET, req_id: b6f33ee8-962e-4aa4-9366-89e06580c99f, remote_addr: 127.0.0.1:45804, 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(1234)
[8820][1] reports Running
May 27 03:20:13.539 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/1, method: GET, req_id: fadd5eb5-4a3d-4a3b-920c-f2fc367649a8, remote_addr: 127.0.0.1:45804, 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 27 03:20:41.154 INFO request completed, latency_us: 247, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 09d6d054-82a3-436a-9436-ba6245de37be, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:20:41.155 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3114166a-3f10-4166-8e5a-719251e66373, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 27 03:20:45.157 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/2, method: GET, req_id: f246add7-7a99-4e34-beba-a98a1eeb11d9, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 27 03:20:45.563 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/2, method: POST, req_id: e0dd252c-4b6a-4d5f-891f-3e3cc5c3e674, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:20:45.563 INFO request completed, latency_us: 80, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3a2a15d5-0027-4ccb-8cb8-cbf9805f1730, remote_addr: 127.0.0.1:45804, 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(1235)
[8830][2] reports Running
May 27 03:20:49.565 INFO request completed, latency_us: 183, response_code: 200, uri: /state/cid/2, method: GET, req_id: d72186c9-d141-4438-83f0-1b2bcd797c92, remote_addr: 127.0.0.1:45804, 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 03:21:17.411 INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 5435ecb2-3c04-4d62-8fb3-a3effc3aaa58, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:21:17.412 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/3, method: GET, req_id: bcba6c30-42d0-4aeb-8139-f191bfb91bd2, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
May 27 03:21:21.414 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/3, method: GET, req_id: 79afe309-a258-4846-8db3-4144e79e02c6, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
May 27 03:21:21.827 INFO request completed, latency_us: 238, response_code: 204, uri: /start/cid/3, method: POST, req_id: f5aff398-5200-49c9-8f2a-6f9b719f0276, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:21:21.828 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/3, method: GET, req_id: 94931915-0e4f-4c81-acc6-753bc59ecb1c, remote_addr: 127.0.0.1:45804, 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(1236)
[8840][3] reports Running
May 27 03:21:25.830 INFO request completed, latency_us: 191, response_code: 200, uri: /state/cid/3, method: GET, req_id: 30fa5c70-baac-444c-9495-ef10037f49fd, remote_addr: 127.0.0.1:45804, local_addr: 127.0.0.1:9998
May 27 03:21:53.548 INFO accepted connection, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.548 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: 44c54ef5-ce3e-41ce-a89d-13532f83b3f7, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.549 INFO request completed, latency_us: 45, response_code: 200, uri: /regioncount, method: GET, req_id: fdebf66e-7d7b-4e10-a051-7703c4e54fac, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.549 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9fc3f657-b540-48d2-9fb8-215a1792d9ba, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.549 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/1, method: GET, req_id: 92ec5712-ec08-450c-9a7a-bf40365cda77, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.550 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/2, method: GET, req_id: f5510404-53dc-4934-9508-27ba541f7c78, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.551 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/3, method: GET, req_id: 310004dc-032c-4e6a-ae4b-2164b0993fca, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.551 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/4, method: GET, req_id: 352d57df-a5e3-41d0-9aef-0b74f216f22d, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.551 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3e38c62f-25b5-454a-a9a8-18117d90375b, remote_addr: 127.0.0.1:34266, local_addr: 127.0.0.1:9998
May 27 03:21:53.729 INFO accepted connection, remote_addr: 127.0.0.1:60361, local_addr: 127.0.0.1:9998
May 27 03:21:53.729 INFO request completed, latency_us: 133, response_code: 200, uri: /regioncount, method: GET, req_id: 639029e3-52c1-4fb0-b511-f29e2e7a5054, remote_addr: 127.0.0.1:60361, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
May 27 03:21:59.526[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: 82f0fa49-418c-4daf-b2d8-5d068eb88fe3, remote_addr: 127.0.0.1:60361, local_addr: 127.0.0.1:9998
May 27 03:21:59.527 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8227d69b-56fe-4f14-8b6d-90bb073313f4, remote_addr: 127.0.0.1:60361, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
May 27 03:22:03.529 INFO request completed, latency_us: 219, response_code: 200, uri: /state/cid/0, method: GET, req_id: 29f12e10-49e5-400c-b914-f6b61629355f, remote_addr: 127.0.0.1:60361, local_addr: 127.0.0.1:9998
May 27 03:22:41.188 INFO accepted connection, remote_addr: 127.0.0.1:37474, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
May 27 03:22:41.189 INFOstart 0
 request completed, latency_us: 188, response_code: 204, uri: /start/cid/0, method: POST, req_id: 067a8afe-67ff-47d4-bb21-9c53ac18687b, remote_addr: 127.0.0.1:37474, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
May 27 03:22:45.590 INFO request completed[8820] Got stop action so:false kr:false
, latency_us: 236, response_code: 204, uri: /stop/cid/1, method: POST, req_id: ac8e4f2c-08f0-4415-a367-e06a2c4fc69e, remote_addr: 127.0.0.1:37474, local_addr: 127.0.0.1:9998
May 27 03:22:45.590 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4feb20ef-f80b-4f35-a6c5-5b918b1f7f9e, remote_addr: 127.0.0.1:37474, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
May 27 03:22:49.592 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/1, method: GET, req_id: 870181ef-6b2b-45e3-9284-4da96b1b2f57, remote_addr: 127.0.0.1:37474, 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(1238)
[8810][0] reports Running
May 27 03:23:27.232 INFO accepted connection, remote_addr: 127.0.0.1:36660, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
May 27 03:23:27.232 INFO request completed, latency_us: 178, response_code: 204, uri:start 1
 /start/cid/1, method: POST, req_id: 1300aa74-8ae7-45d6-9d19-d897eda23fb0, remote_addr: 127.0.0.1:36660, 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(1239)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
May 27 03:23:31.639 INFO request completed, latency_us: 256, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 74c754de-c0e8-47d1-aefb-676c5bf89f28, remote_addr: 127.0.0.1:36660, local_addr: 127.0.0.1:9998
May 27 03:23:31.640 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/2, method: GET, req_id: a3d661d4-cf38-459c-8757-fce552b65d2e, remote_addr: 127.0.0.1:36660, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
May 27 03:23:35.642 INFO request completed, latency_us: 223, response_code: 200, uri: /state/cid/2, method: GET, req_id: b318c413-2a08-4320-99c0-69d997afd751, remote_addr: 127.0.0.1:36660, local_addr: 127.0.0.1:9998
May 27 03:24:13.260 INFO accepted connection, remote_addr: 127.0.0.1:33210, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
May 27 03:24:13.260 INFO request completed, latency_us: 169, response_code: 204, uri: /start/cid/2, method: POST, req_id: 28797f31-7ba3-4c0d-8cc7-11ddf3e15a2b, remote_addr: 127.0.0.1:33210, 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(1240)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
May 27 03:24:17.679 INFO request completed[8840] Got stop action so:false kr:false
, latency_us: 218, response_code: 204, uri: /stop/cid/3, method: POST, req_id: ea8932a9-50f6-44f8-9be3-b0d493a6dae6, remote_addr: 127.0.0.1:33210, local_addr: 127.0.0.1:9998
May 27 03:24:17.680 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/3, method: GET, req_id: e9224496-6608-43ef-9be6-d383c26db498, remote_addr: 127.0.0.1:33210, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
May 27 03:24:21.681 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/3, method: GET, req_id: 45705306-3ebd-4cac-853e-f373ec2175b3, remote_addr: 127.0.0.1:33210, local_addr: 127.0.0.1:9998
May 27 03:24:59.313 INFO accepted connection, remote_addr: 127.0.0.1:65389, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
May 27 03:24:59.313 INFO request completed, latency_us: 167, response_code: 204, uri: /start/cid/3, method: POST, req_id: 9bf30bf2-b4c7-424f-9701-fa72a8d42f56, remote_addr: 127.0.0.1:65389, 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(1241)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
[8850] Got stop action so:false kr:false
May 27 03:25:03.873 INFO request completed, latency_us: 288, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 23fc0095-e18a-459c-9e55-8e31cebd7075, remote_addr: 127.0.0.1:65389, local_addr: 127.0.0.1:9998
May 27 03:25:03.873 INFO request completed, latency_us: 80, response_code: 200, uri: /state/cid/4, method: GET, req_id: d2e17235-8c52-4402-96fb-1467d6085f9a, remote_addr: 127.0.0.1:65389, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
May 27 03:25:07.875 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/4, method: GET, req_id: 648f83c9-c162-47c5-9989-e973f0fc44f1, remote_addr: 127.0.0.1:65389, local_addr: 127.0.0.1:9998
May 27 03:25:45.519 INFO accepted connection, remote_addr: 127.0.0.1:41463, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
May 27 03:25:45.520 INFO request completed, latency_us: 188, response_code: 204, uri: /start/cid/4, method: POST, req_id: c0858610-a803-437e-9842-71986e189459, remote_addr: 127.0.0.1:41463, local_addr: 127.0.0.1:9998
May 27 03:25:49.565 INFO accepted connection, remote_addr: 127.0.0.1:63111, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
May 27 03:25:49.565 INFO request completed, latency_us: 144, response_code: 204, uri: /shutdown, method: POST, req_id: ca8c5ea1-d6fd-42c4-bac5-a7f38fc2e2c8, remote_addr: 127[8810] Disable keep_running
.[8820] Disable keep_running
0[8820] Got stop action so:false kr:false
.[8830] Disable keep_running
0[8840] Disable keep_running
.[8840] Got stop action so:false kr:false
1:63111[8830] Got stop action so:false kr:false
, local_addr: 127.0.0.1:9998
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
[8860] Disable keep_running
[8810] Got stop action so:false kr:false
[8860] Got stop action so:false kr:false
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8820][1] reports Exit
[8810][0] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit