/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.26963136
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018106766
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.018985426
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.021717481
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.01836094
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.018613197
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 access at:127.0.0.1:9998
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
Starting downstairs at port 8840
Starting downstairs at port 8810
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-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
Starting downstairs at port 8850
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.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
[8810][0] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1206)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1210)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1209)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1207)
[8840][3] initial start wait reports Running
[8810][0] initial start wait reports Running
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1208)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1205)
[8860][5] initial start wait reports Running
All downstairs are running
Oct 15 15:56:45.863 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Oct 15 15:56:50.888 INFO accepted connection, remote_addr: 127.0.0.1:59278, local_addr: 127.0.0.1:9998
Oct 15 15:56:50.890 INFO request completed, latency_us: 485, response_code: 200, uri: /state/cid/0, method: GET, req_id: aa41e69f-a5ef-48ae-ad7e-4fd43b0ee1c4, remote_addr: 127.0.0.1:59278, local_addr: 127.0.0.1:9998
Oct 15 15:56:50.946 INFO accepted connection, remote_addr: 127.0.0.1:47407, local_addr: 127.0.0.1:9998
Oct 15 15:56:50.947 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/1, method: GET, req_id: 9b5a4e2d-514f-45e3-b1ae-b3e62427073b, remote_addr: 127.0.0.1:47407, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.002 INFO accepted connection, remote_addr: 127.0.0.1:62074, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.003 INFO request completed, latency_us: 170, response_code: 200, uri: /state/cid/2, method: GET, req_id: a5d0b7e5-b8a5-4c4b-82a2-9c0dff3abb63, remote_addr: 127.0.0.1:62074, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.060 INFO accepted connection, remote_addr: 127.0.0.1:55934, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.061 INFO request completed, latency_us: 185, response_code: 200, uri: /state/cid/3, method: GET, req_id: f5c05c50-8dab-497a-a33f-96f468ea326e, remote_addr: 127.0.0.1:55934, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.118 INFO accepted connection, remote_addr: 127.0.0.1:50851, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.118 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/4, method: GET, req_id: 09e6628c-af8a-4891-a542-e953fc495933, remote_addr: 127.0.0.1:50851, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.174 INFO accepted connection, remote_addr: 127.0.0.1:53153, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.175 INFO request completed, latency_us: 163, response_code: 200, uri: /state/cid/5, method: GET, req_id: fde61976-7d91-4a90-af32-6ef379c2e382, remote_addr: 127.0.0.1:53153, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.231 INFO accepted connection, remote_addr: 127.0.0.1:51683, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Oct 15 15:56:51.231 INFO request completed, latency_us: 220, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 9b91be52-bd2a-435a-9ca9-0f232ae49251, remote_addr:[8810] Disable keep_running
 [8830] Disable keep_running
127[8820] Disable keep_running
.[8840] Disable keep_running
0[8860] Disable keep_running
.0.1:51683, local_addr: 127.0.0.1[8850] Disable keep_running
:9998
Oct 15 15:56:51.363 INFO accepted connection, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.365 INFO request completed, latency_us: 282, response_code: 200, uri: /regioninfo, method: GET, req_id: 138a4226-5ae9-4622-b871-e4291b2821e2, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.367 INFO request completed, latency_us: 138, response_code: 200, uri: /regioncount, method: GET, req_id: 6b4e336c-2c10-47d4-9a07-105d742d772a, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.369 INFO request completed, latency_us: 145, response_code: 200, uri: /port/cid/0, method: GET, req_id: a3cd8c65-dc91-4e1a-8e98-54497c3d4a01, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.369 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: e1108cff-2eb2-4114-96a4-ebd620878e6a, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.370 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3be72e78-43d9-40a9-80b1-56dbccdec565, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.375 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/3, method: GET, req_id: c607b7bb-8eb5-40ec-86ce-7adc071a4bcf, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.376 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: fd23002a-843f-4652-9679-242099403127, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:56:51.377 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: c7590704-b964-4b7e-9070-fb40f51ecdd4, remote_addr: 127.0.0.1:48144, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.499 INFO accepted connection, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.500 INFO request completed, latency_us: 150, response_code: 200, uri: /regioninfo, method: GET, req_id: d51a6cc2-6adf-4053-9a9a-4c80b88ff61b, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.501 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: 9cb1a771-5050-438c-8ba8-5f176ae4f93d, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.502 INFO request completed, latency_us: 120, response_code: 200, uri: /port/cid/0, method: GET, req_id: a21a2395-1e15-443c-b3c7-a94339b13d90, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.502 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/1, method: GET, req_id: 430fa56c-4c54-49af-a8cc-72df4550dd0e, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.503 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/2, method: GET, req_id: c5ab7fb9-623f-4db0-8c5b-0f1e23ec5c8e, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.505 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: 2f9cd3f2-d499-40cd-b34e-5cd401688902, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.506 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/4, method: GET, req_id: 98bdbaaf-52eb-4261-be27-275380e231dc, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:00.506 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3a65f919-3fa3-4fc9-9f45-b116f8b3b598, remote_addr: 127.0.0.1:41051, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.090 INFO accepted connection, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.091 INFO request completed, latency_us: 187, response_code: 200, uri: /regioninfo, method: GET, req_id: b96a78ac-f24d-4709-8d61-64cfa8365f62, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.092 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: 1e8b3a6e-f53b-4459-bdb1-130ad37f5f0c, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.093 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0d08734c-162f-4493-9422-e5080bed8981, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.094 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: f34d1b97-bb12-41ea-b052-5d4b3f7cc3c7, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.094 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: d3fbeb48-8ddd-456d-87b3-94dd4c20aea0, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.096 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/3, method: GET, req_id: 88fc286e-5204-40f2-b795-03b8b3d1c82a, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.097 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/4, method: GET, req_id: d7ac1aaf-4ecc-4c66-a0ab-e80eddb0d094, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:10.097 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4247389f-2ad3-4240-ac16-c7d5240da5d9, remote_addr: 127.0.0.1:58263, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.818 INFO accepted connection, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.819 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: e3ed6c83-0cb4-42db-8acd-513dd9bbf894, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.820 INFO request completed, latency_us: 121, response_code: 200, uri: /regioncount, method: GET, req_id: 68001340-bea6-4490-be64-ae7046f561f4, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.821 INFO request completed, latency_us: 133, response_code: 200, uri: /port/cid/0, method: GET, req_id: 87acd0d6-3124-43b1-9aee-67ea8af33221, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.821 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6e737169-afa4-4277-bd15-4dc0e1a315ee, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.822 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/2, method: GET, req_id: 59ae6fa7-bae7-40ac-87c5-95b2723b3790, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.824 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: b3e2ec33-a45b-4fc0-92ce-9ac019cebc16, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.824 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/4, method: GET, req_id: dd50d0bd-3fc6-450a-aa89-7f149ac4c4fa, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 15:57:48.825 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 71beee2e-21f3-41c8-ae11-b71f8d437438, remote_addr: 127.0.0.1:64638, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.851 INFO accepted connection, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.852 INFO request completed, latency_us: 170, response_code: 200, uri: /regioninfo, method: GET, req_id: 98f7f6cb-9b10-445f-ac6d-35818f350caf, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.853 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: 22f406da-cc2f-4f2e-af9c-99716ac5b8b5, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.854 INFO request completed, latency_us: 150, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1d3d9331-9007-4ba4-a594-1e4b62b6194a, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.855 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7cabb7cb-68f1-4ebd-b738-3e86f2e621ae, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.855 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: e234a0b6-fdae-40cc-93c5-6c1909afe3a6, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.857 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/3, method: GET, req_id: cc03a551-996d-48ef-bb19-535410b29e9d, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.858 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/4, method: GET, req_id: 51dfb8ff-c239-4c3a-9c3d-91d02ff9d14e, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:08.859 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/5, method: GET, req_id: 8887705f-7cc1-4496-8b1b-6e278b9e2e57, remote_addr: 127.0.0.1:63871, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.641 INFO accepted connection, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.641 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: 78873d00-3b59-4de1-be55-51612faf8022, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.643 INFO request completed, latency_us: 117, response_code: 200, uri: /regioncount, method: GET, req_id: cf224cbc-33ff-4335-9901-c2b45174c804, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.643 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: c1eddc14-cbea-4b8e-9c3a-54af20afecdc, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.644 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: a02ef0d9-8647-4532-af2a-c426ee76d1c8, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.644 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: d71d4e74-ec1a-46a7-83c0-e9cf8e1429d4, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.647 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: eabdfde2-d1bd-4237-a5e1-bfbd0c889d6d, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.647 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1a2ca36a-175b-4b81-96fc-97a6d5daf5cd, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:31.648 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/5, method: GET, req_id: 01ede758-21e8-4a54-af90-a589b1ab371a, remote_addr: 127.0.0.1:45359, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.853 INFO accepted connection, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.854 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: aa162b79-2844-4b8e-a22a-d616a7fade7a, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.855 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: 717b66d7-ee08-4473-881c-4898eb5e69c1, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.856 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/0, method: GET, req_id: f07a8d1a-8137-4e71-9e80-c771dad79907, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.856 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7357f412-49fe-42b5-90aa-56f2f5951d9b, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.857 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: b2c9fcdf-4f8c-4908-904a-a75d44c64641, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.859 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: 66e12a1b-f3d7-4ee8-b257-bf1cba68597a, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.859 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: bbe85dca-9cdd-485c-ba00-c3fd8c969327, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:35.860 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/5, method: GET, req_id: f401e599-553a-417d-9c84-d19144fe52a1, remote_addr: 127.0.0.1:37929, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.050 INFO accepted connection, remote_addr: 127.0.0.1:56023, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Oct 15 16:02:40.051 INFO request completed, latency_us: 176[8820] Disable keep_running
, [8810] Disable keep_running
response_code[8860] Disable keep_running
: [8850] Disable keep_running
204, uri: /disablerestart/all, method: [8830] Disable keep_running
POST, req_id: ac41bd8f-939e-4d65-b87d-6c561ed9b0c0, remote_addr: 127.0.0.1:56023, local_addr: 127[8840] Disable keep_running
.0.0.1:9998
Oct 15 16:02:40.107 INFO accepted connection, remote_addr: 127.0.0.1:37320, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Oct 15 16:02:40.108 INFO request completed, latency_us: 246, response_code: 204, uri: /stop/cid/2, method: POST, req_id: bac4c3f6-6695-4ad2-bc75-2c17df0c9b67[8830] Got stop action so:false kr:false
, remote_addr: 127.0.0.1:37320, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Oct 15 16:02:40.167 INFO accepted connection, remote_addr: 127.0.0.1:49318, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.168 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/2, method: GET, req_id: a4be141b-bbcd-4d3a-ac15-715c10a82813, remote_addr: 127.0.0.1:49318, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.230 INFO accepted connection, remote_addr: 127.0.0.1:46873, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Oct 15 16:02:40.230 INFO request completed, latency_us: 175, response_code: 204, uri: /start/cid/2, method: POST, req_id: 68caebce-2103-4d45-8c44-278e89c745e1, remote_addr: 127.0.0.1:46873, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.318 INFO accepted connection, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.319 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: 1578e843-89f1-45cb-99be-090323a1c786, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.320 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: 42e4ff8f-788f-4f59-b761-b574ab9819ce, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.320 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 32f26ac6-47c0-4696-b8b3-96d41b70cfc6, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.321 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: 23f92212-f7bd-4fb4-bfa1-53dbe9f1f449, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.322 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: a569e0c8-c23b-49e7-8e50-a1f19d331194, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.324 INFO request completed, latency_us: 120, response_code: 200, uri: /port/cid/3, method: GET, req_id: 551a5ce9-232c-4b58-a8da-5331f59cf15e, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.324 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: aaa84481-abe4-4630-88fc-fb39b0bb8c45, remote_addr: 127.0.0.1:64803, local_addr: 127.0.0.1:9998
Oct 15 16:02:40.325 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/5, method: GET, req_id: df7b8204-a358-4694-9a4b-219cf2c0fac4, remote_addr: 127.0.0.1:64803, 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(1261)
[8830][2] reports Running
Oct 15 16:02:54.590 INFO accepted connection, remote_addr: 127.0.0.1:42439, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Oct 15 16:02:54.591 INFO request completed, latency_us: 174, response_code:[8810] Disable keep_running
 [8810] Got stop action so:false kr:false
204[8820] Disable keep_running
, [8820] Got stop action so:false kr:false
uri: /shutdown, method: POST, req_id: 2274c537-d385-4f0e-bede-55de77e9ccb0, remote_addr: 127.0.0.1:42439, local_addr: 127.0.0.1:9998
[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
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8850][4] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8840][3] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] 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.046027496
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.04514685
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.044462368
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.045335297
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.04575987
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.057732683
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.073049314
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 access at:127.0.0.1:9998
start ds: 8850
start ds: 8860
start ds: 8870
Starting downstairs at port 8810
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8830
[8820][1] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] initial start wait reports Starting
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
[8840][3] initial start wait reports Starting
[8850][4] initial start wait reports Starting
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1283)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1282)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1281)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1278)
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1280)
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1284)
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1279)
[8860][5] initial start wait reports Starting
[8860][5] initial start wait reports Running
[8810][0] initial start wait reports Running
[8830][2] initial start wait reports Running
[8820][1] initial start wait reports Running
[8870][6] initial start wait reports Starting
[8850][4] initial start wait reports Running
[8870][6] initial start wait reports Running
[8840][3] initial start wait reports Running
All downstairs are running
Oct 15 16:02:59.992 INFO listening, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.041 INFO accepted connection, remote_addr: 127.0.0.1:56122, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.043 INFO request completed, latency_us: 343, response_code: 200, uri: /state/cid/0, method: GET, req_id: b792d844-e2c2-4713-a67d-5bf6ff420a13, remote_addr: 127.0.0.1:56122, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.104 INFO accepted connection, remote_addr: 127.0.0.1:44839, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.104 INFO request completed, latency_us: 172, response_code: 200, uri: /state/cid/1, method: GET, req_id: 74d3f84b-dc80-491d-a908-d4fc5a354661, remote_addr: 127.0.0.1:44839, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.164 INFO accepted connection, remote_addr: 127.0.0.1:60472, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.165 INFO request completed, latency_us: 168, response_code: 200, uri: /state/cid/2, method: GET, req_id: f4f74368-f833-4fee-a21e-2224b889642e, remote_addr: 127.0.0.1:60472, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.223 INFO accepted connection, remote_addr: 127.0.0.1:64346, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.224 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/3, method: GET, req_id: b9e6b4cb-7118-4e3d-83e8-4a86c2574846, remote_addr: 127.0.0.1:64346, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.282 INFO accepted connection, remote_addr: 127.0.0.1:63588, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.283 INFO request completed, latency_us: 186, response_code: 200, uri: /state/cid/4, method: GET, req_id: d9cace48-3697-4957-b4e5-0f0c2b1df29a, remote_addr: 127.0.0.1:63588, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.341 INFO accepted connection, remote_addr: 127.0.0.1:62954, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.342 INFO request completed, latency_us: 192, response_code: 200, uri: /state/cid/5, method: GET, req_id: 57fd5817-0f07-447b-9e1c-ea4e80d4fb21, remote_addr: 127.0.0.1:62954, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.402 INFO accepted connection, remote_addr: 127.0.0.1:56327, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.402 INFO request completed, latency_us: 173, response_code: 200, uri: /state/cid/6, method: GET, req_id: bc950aeb-8613-45d0-bbab-e7f1f13c0063, remote_addr: 127.0.0.1:56327, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.461 INFO accepted connection, remote_addr: 127.0.0.1:40102, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.462 INFO request completed, latency_us: 171, response_code: 200, uri: /port/cid/6, method: GET, req_id: ff054fd4-9af5-4af7-a166-983c071013be, remote_addr: 127.0.0.1:40102, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.526 INFO accepted connection, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.527 INFO request completed, latency_us: 206, response_code: 200, uri: /regioninfo, method: GET, req_id: 398e9d1a-5c91-4df6-999e-781a43b9e80d, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.528 INFO request completed, latency_us: 100, response_code: 200, uri: /regioncount, method: GET, req_id: 6154a51a-2b01-418d-bae0-1abbb57c4409, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.529 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: e16d0822-5894-4523-a9cd-d9d18e66f2a0, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.529 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 150073a2-a0c6-4285-9b87-140998c3e7ea, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.530 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: f77128db-fea1-455e-9427-39d5259e024d, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.532 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7f2fe4c0-49fa-49c8-ac2a-1fb6eca9defd, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.533 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 11c6152c-d262-477d-ac40-b8e8abaf2d39, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.533 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/5, method: GET, req_id: 0282bbac-241b-4e7c-b1ce-0f6d3957a598, remote_addr: 127.0.0.1:36693, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.591 INFO accepted connection, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:05.592 INFO request completed, latency_us: 154, response_code: 200, uri: /regioncount, method: GET, req_id: 95b25ef0-3eaa-4a0a-8f1b-0ef25bc12126, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Oct 15 16:03:06.339 INFO [8810] Got stop action so:false kr:false
request completed, latency_us: 252, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 6bc3607d-5061-48ec-81b9-4719d8c5610c, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:06.339 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8053a0c7-34f2-4cc9-8eaa-291c7acc161f, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 15 16:03:10.342 INFO request completed, latency_us: 259, response_code: 200, uri: /state/cid/0, method: GET, req_id: ea1cf767-c18c-419a-836e-b4d3d1fac43f, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 15 16:03:11.063 INFO request completed, latency_us: 289, response_code: 204, uri: /start/cid/0, method: POST, req_id: 565d1e4d-b955-4388-80fe-e6ea9a4c7221, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:11.063 INFO request completed, latency_us: 150, response_code: 200, uri: /state/cid/0, method: GET, req_id: c419669d-1689-44cb-95cc-9aaa9af2af81, remote_addr: 127.0.0.1:50704, 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(1295)
[8810][0] reports Running
Oct 15 16:03:15.066 INFO request completed, latency_us: 225, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5d051632-5108-4c49-a312-4d0c46f1bbdf, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Oct 15 16:03:21.810 INFO request completed[8810] Got stop action so:false kr:false
, latency_us: 270, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 4303ac39-3b11-49cc-9acf-6fcff2ac498b, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:21.811 INFO request completed, latency_us: 136, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3f9402e6-0df7-43f6-8ee9-8b00afd7d7d9, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 15 16:03:25.813 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1645d993-b986-4a58-a771-d0444f04fe9e, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 15 16:03:26.546 INFO request completed, latency_us: 220, response_code: 204, uri: /start/cid/0, method: POST, req_id: c5434baf-ec4c-4005-96b6-e056c2fcc70e, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:26.546 INFO request completed, latency_us: 118, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7bf0d643-6dc3-4dcb-a127-7b091cc645c6, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:30.548 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/0, method: GET, req_id: 03dca0cc-20aa-433b-81b2-82fe41b533cf, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:34.551 INFO request completed, latency_us: 224, response_code: 200, uri: /state/cid/0, method: GET, req_id: a0cc948f-dbec-4f91-9a3f-4f1f1f225be6, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:38.554 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/0, method: GET, req_id: b488d26e-3c78-4046-9445-add280b077a6, remote_addr: 127.0.0.1:50704, 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(1296)
[8810][0] reports Running
Oct 15 16:03:42.556 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/0, method: GET, req_id: 62a8b7ed-762f-4fc7-8cab-bcbd3ebfc0da, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Oct 15 16:03:48.316[8810] Got stop action so:false kr:false
 INFO request completed, latency_us: 248, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 715385cc-bdc9-4dff-a926-cd541084dc99, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:48.317 INFO request completed, latency_us: 124, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9c99f647-d0bb-4fcc-a16b-3889a7defa64, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 15 16:03:52.320 INFO request completed, latency_us: 241, response_code: 200, uri: /state/cid/0, method: GET, req_id: b23ab9c0-fa9a-4782-8a4b-00e2fb394c48, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 15 16:03:53.067 INFO request completed, latency_us: 211, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8f275043-79a6-49eb-b928-1e7c977651e6, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:03:53.068 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6ab8d34e-7047-4822-8dc5-cb9416fab42c, remote_addr: 127.0.0.1:50704, 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(1297)
[8810][0] reports Running
Oct 15 16:03:57.070 INFO request completed, latency_us: 233, response_code: 200, uri: /state/cid/0, method: GET, req_id: 325c6238-7ce9-48a9-93ea-422bc2c03c47, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Oct 15 16:04:01.810 INFO request completed, latency_us: 240, response_code: [8810] Got stop action so:false kr:false
204, uri: /stop/cid/0, method: POST, req_id: 874dc891-4b30-485a-af8c-1ff1c661cacb, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:04:01.810 INFO request completed, latency_us: 118, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6b8921e6-4201-4f8b-91ac-97a278526b49, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 15 16:04:05.813 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2d04d4b5-40de-48cf-bd3e-60af6c66596e, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 15 16:04:06.550 INFO request completed, latency_us: 209, response_code: 204, uri: /start/cid/0, method: POST, req_id: 843aae84-4327-41ae-a2f2-410f06db332f, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:04:06.550 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/0, method: GET, req_id: eb6bf302-3cfa-43a1-9d99-5eb6955e3a45, remote_addr: 127.0.0.1:50704, 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(1298)
[8810][0] reports Running
Oct 15 16:04:10.553 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/0, method: GET, req_id: 57eb5ccf-fbc5-4351-987d-b4f0044581f7, remote_addr: 127.0.0.1:50704, local_addr: 127.0.0.1:9998
Oct 15 16:04:42.910 INFO accepted connection, remote_addr: 127.0.0.1:43032, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Oct 15 16:04:42.910 INFO request completed, latency_us: 186, response_code: 204, uri: /stop/cid/1[8820] Got stop action so:false kr:false
, method: POST, req_id: 5e72c6a7-911b-49ac-9630-6c63359b80bf, remote_addr: 127.0.0.1:43032, local_addr: 127.0.0.1:9998
Oct 15 16:04:42.911 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4c97c261-8ea8-4677-a3de-5986e1fd712f, remote_addr: 127.0.0.1:43032, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Oct 15 16:04:46.914 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/1, method: GET, req_id: f1fbf1e6-ad5e-4b92-8c25-ebe1358cb811, remote_addr: 127.0.0.1:43032, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Oct 15 16:04:47.654 INFO request completed, latency_us: 254, response_code: 204, uri: /start/cid/1, method: POST, req_id: 8ded2bc5-0fbf-414f-8529-ab8f12434122, remote_addr: 127.0.0.1:43032, local_addr: 127.0.0.1:9998
Oct 15 16:04:47.655 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/1, method: GET, req_id: 2d361c69-934a-4371-82ab-16bb0a680014, remote_addr: 127.0.0.1:43032, local_addr: 127.0.0.1:9998
Oct 15 16:04:51.656 INFO request completed, latency_us: 219, response_code: 200, uri: /state/cid/1, method: GET, req_id: 61dc14cf-6245-4c4c-b352-150253765b5d, remote_addr: 127.0.0.1:43032, 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(1299)
[8820][1] reports Running
Oct 15 16:04:55.659 INFO request completed, latency_us: 243, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3e9f1a31-548f-4c72-a160-ca9df7baf119, remote_addr: 127.0.0.1:43032, local_addr: 127.0.0.1:9998
Oct 15 16:05:28.492 INFO accepted connection, remote_addr: 127.0.0.1:62596, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Oct 15 16:05:28.512 INFO request completed, latency_us: 210, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 5983219c-05d5-4fe0-9192-90765f1d033e, remote_addr: 127.0.0.1:62596, local_addr: 127.0.0.1:9998
[8830] Got stop action so:false kr:false
Oct 15 16:05:28.513 INFO request completed, latency_us: 166, response_code: 200, uri: /state/cid/2, method: GET, req_id: d4cb03ad-9623-4579-bb17-0ae2fb133d2e, remote_addr: 127.0.0.1:62596, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Oct 15 16:05:32.515 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/2, method: GET, req_id: bd586501-3e43-4fc2-b0ba-84894488f383, remote_addr: 127.0.0.1:62596, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Oct 15 16:05:33.255 INFO request completed, latency_us: 211, response_code: 204, uri: /start/cid/2, method: POST, req_id: 1bc42352-0741-4bf6-90e6-8d2adccde00c, remote_addr: 127.0.0.1:62596, local_addr: 127.0.0.1:9998
Oct 15 16:05:33.256 INFO request completed, latency_us: 118, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3a5e3a5d-f9ac-459f-b935-af6c8d900994, remote_addr: 127.0.0.1:62596, local_addr: 127.0.0.1:9998
Oct 15 16:05:37.258 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/2, method: GET, req_id: 188a14cb-dd6c-47a4-b04d-f3792b675b45, remote_addr: 127.0.0.1:62596, 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(1300)
[8830][2] reports Running
Oct 15 16:05:41.260 INFO request completed, latency_us: 233, response_code: 200, uri: /state/cid/2, method: GET, req_id: 27117dc4-e5c6-4174-93ec-9b0eebd44487, remote_addr: 127.0.0.1:62596, local_addr: 127.0.0.1:9998
Oct 15 16:06:14.723 INFO accepted connection, remote_addr: 127.0.0.1:48489, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Oct 15 16:06:14.724 INFO request completed, latency_us: 190, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 1c0ba1bd-b90f-46a8-ab41-4cf583183afa, remote_addr: 127.0.0.1:48489, local_addr: 127.[8840] Got stop action so:false kr:false
0.0.1:9998
Oct 15 16:06:14.725 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/3, method: GET, req_id: 440ffa56-6a4b-4f75-94fe-a97af046590c, remote_addr: 127.0.0.1:48489, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Oct 15 16:06:18.727 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/3, method: GET, req_id: e1519533-daf8-48ff-8d91-34f68843b285, remote_addr: 127.0.0.1:48489, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Oct 15 16:06:19.487 INFO request completed, latency_us: 212, response_code: 204, uri: /start/cid/3, method: POST, req_id: a0778c6c-ec92-4e77-b656-4ef0afe1e00f, remote_addr: 127.0.0.1:48489, local_addr: 127.0.0.1:9998
Oct 15 16:06:19.487 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/3, method: GET, req_id: 59bb8370-94ff-4856-966a-ee8d81153652, remote_addr: 127.0.0.1:48489, 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(1301)
[8840][3] reports Running
Oct 15 16:06:23.490 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/3, method: GET, req_id: b80146f0-37b9-4b81-8ef2-e7fa58f4ef8a, remote_addr: 127.0.0.1:48489, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.939 INFO accepted connection, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.940 INFO request completed, latency_us: 189, response_code: 200, uri: /regioninfo, method: GET, req_id: 624faa42-0132-4522-ab72-427f0c348fb8, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.941 INFO request completed, latency_us: 113, response_code: 200, uri: /regioncount, method: GET, req_id: 3839972e-2cb2-4d0b-aa4b-ef9852618218, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.942 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: c848e41a-eea1-45c5-90e7-a82b9377679c, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.943 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5b1c33a2-8c66-447c-b9c1-b4971748debf, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.943 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 760f7952-e38e-4f60-9700-c57d9c15958e, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.945 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/3, method: GET, req_id: e9d356ab-5eea-40ee-bed2-c6cdeee2ca2d, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.946 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/4, method: GET, req_id: cdbf3ba1-71e0-4a7d-8346-c2fff7ff1e78, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:56.946 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: cf049282-ae8f-48cc-a062-f57de447405f, remote_addr: 127.0.0.1:63199, local_addr: 127.0.0.1:9998
Oct 15 16:06:57.034 INFO accepted connection, remote_addr: 127.0.0.1:64229, local_addr: 127.0.0.1:9998
Oct 15 16:06:57.035 INFO request completed, latency_us: 163, response_code: 200, uri: /regioncount, method: GET, req_id: 46f8baec-ac08-4185-bf8d-fda5f0d11a2f, remote_addr: 127.0.0.1:64229, 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
Oct 15 16:07:12.543 INFO request completed, latency_us: 227, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 12fd7d15-fc8a-4380-92f6-ce5224f24473, remote_addr: 127.0.0.1:64229, local_addr: 127.0.0.1:9998
Oct 15 16:07:12.544 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/0, method: GET, req_id: a0c19dc2-5d87-47f9-b6ba-c759274bec88, remote_addr: 127.0.0.1:64229, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Oct 15 16:07:16.546 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6bede24a-d195-4ea8-a38e-c1c129c50a1e, remote_addr: 127.0.0.1:64229, local_addr: 127.0.0.1:9998
Oct 15 16:08:17.860 INFO accepted connection, remote_addr: 127.0.0.1:44013, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Oct 15 16:08:17.860 INFO request completed, latency_us: 183, response_code: 204, uri: /start/cid/0, method: POST, req_id: 85c82486-aa3a-47f3-8892-5841c6e5bbc8, remote_addr: 127.0.0.1:44013, 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(1303)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Oct 15 16:08:22.617 INFO request completed, latency_us[8820] Got stop action so:false kr:false
: 310, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 61724f80-431b-46f4-b243-54825f4bd39f, remote_addr: 127.0.0.1:44013, local_addr: 127.0.0.1:9998
Oct 15 16:08:22.618 INFO request completed, latency_us: 120, response_code: 200, uri: /state/cid/1, method: GET, req_id: a20d9e2d-e3fd-4a98-9cc0-d0099e0e85ad, remote_addr: 127.0.0.1:44013, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Oct 15 16:08:26.620 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/1, method: GET, req_id: f525e8ae-08b4-4724-a3e4-fd58f48f25ff, remote_addr: 127.0.0.1:44013, local_addr: 127.0.0.1:9998
Oct 15 16:09:27.943 INFO accepted connection, remote_addr: 127.0.0.1:54949, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Oct 15 16:09:27.944 INFO request completed, latency_us: 193, response_code: 204, uri: /start/cid/1, method: POST, req_id: 3a6c458d-6411-4404-b53d-acb5493b728d, remote_addr: 127.0.0.1:54949, 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(1304)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Oct 15 16:09:32.694 [8830] Got stop action so:false kr:false
INFO request completed, latency_us: 350, response_code: 204, uri: /stop/cid/2, method: POST, req_id: f5416f86-cee6-4975-8a84-192553e50af5, remote_addr: 127.0.0.1:54949, local_addr: 127.0.0.1:9998
Oct 15 16:09:32.695 INFO request completed, latency_us: 191, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3b0b9bc0-16e8-4c90-9823-19f6902634a7, remote_addr: 127.0.0.1:54949, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Oct 15 16:09:36.697 INFO request completed, latency_us: 243, response_code: 200, uri: /state/cid/2, method: GET, req_id: e41eb5f5-50da-4075-9c90-4d7b7f954750, remote_addr: 127.0.0.1:54949, local_addr: 127.0.0.1:9998
Oct 15 16:10:38.029 INFO accepted connection, remote_addr: 127.0.0.1:38630, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Oct 15 16:10:38.030 INFO request completed, latency_us: 179, response_code: 204, uri: /start/cid/2, method: POST, req_id: c496befc-74c3-4c61-b0be-fdb0a300ce22, remote_addr: 127.0.0.1:38630, 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(1305)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Oct 15 16:10:42.830 INFO[8840] Got stop action so:false kr:false
 request completed, latency_us: 213, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 6888c466-cf94-451c-ac02-e55d126b48a9, remote_addr: 127.0.0.1:38630, local_addr: 127.0.0.1:9998
Oct 15 16:10:42.831 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/3, method: GET, req_id: cc625a0a-8925-4b08-9e5f-a28f3fd68445, remote_addr: 127.0.0.1:38630, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Oct 15 16:10:46.833 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/3, method: GET, req_id: afee03bb-a499-4eef-98c8-513046086e29, remote_addr: 127.0.0.1:38630, local_addr: 127.0.0.1:9998
Oct 15 16:11:48.177 INFO accepted connection, remote_addr: 127.0.0.1:42807, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Oct 15 16:11:48.178 INFO request completed, latency_us: 206, response_code: 204, uri: /start/cid/3, method: POST, req_id: d86f8e96-fcd0-4ae2-82b4-b44f578dddce, remote_addr: 127.0.0.1:42807, 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(1306)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Oct 15 16:11:53.209 INFO request completed, latency_us: 227, response_code: [8850] Got stop action so:false kr:false
204, uri: /stop/cid/4, method: POST, req_id: ea8b95ee-c394-4c6b-8017-043b4a167a24, remote_addr: 127.0.0.1:42807, local_addr: 127.0.0.1:9998
Oct 15 16:11:53.210 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/4, method: GET, req_id: 552dc352-f008-4032-98d3-77f6b8e9f474, remote_addr: 127.0.0.1:42807, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Oct 15 16:11:57.212 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/4, method: GET, req_id: c7d1925e-9b84-48d2-bd4f-f3173e5dc958, remote_addr: 127.0.0.1:42807, local_addr: 127.0.0.1:9998
Oct 15 16:12:58.534 INFO accepted connection, remote_addr: 127.0.0.1:55779, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Oct 15 16:12:58.535 INFO request completed, latency_us: 203, response_code: 204, uri: /start/cid/4, method: POST, req_id: 47520918-1e14-4437-aa16-ca3d1236d65e, remote_addr: 127.0.0.1:55779, local_addr: 127.0.0.1:9998
Oct 15 16:13:02.625 INFO accepted connection, remote_addr: 127.0.0.1:63415, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Oct 15 16:13:02.626 INFO request completed, latency_us: 179, [8810] Disable keep_running
response_code[8830] Disable keep_running
:[8830] Got stop action so:false kr:false
 204, uri: /shutdown, method:[8870] Disable keep_running
 POST, req_id[8840] Disable keep_running
:[8840] Got stop action so:false kr:false
 9ed4e5de-17d9-497c-b317-b1cc743858e4, remote_addr: 127.0.0.1:63415, local_addr: 127.0.0.1:9998
[8870] Got stop action so:false kr:false
[8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8810] 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
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] 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