/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.18216568 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.01249689 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.010760828 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.010472778 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010824898 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010410158 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 8810 Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8810][0] initial start wait reports Starting [8820][1] initial start wait reports Starting [8830][2] initial start wait reports Starting [8840][3] initial start wait reports Starting Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8850][4] initial start wait reports Starting Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8860][5] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1142) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1144) Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1141) [8860][5] initial start wait reports Running [8840][3] initial start wait reports Running [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1143) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1145) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1146) [8820][1] initial start wait reports Running [8830][2] initial start wait reports Running [8850][4] initial start wait reports Running All downstairs are running Control access at:127.0.0.1:9998 Sep 18 03:27:55.572 INFO listening, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.579 INFO accepted connection, remote_addr: 127.0.0.1:61654, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.580 INFO request completed, latency_us: 519, response_code: 200, uri: /state/cid/0, method: GET, req_id: d78f1bb6-7222-467e-bea4-b92cf7b66d5e, remote_addr: 127.0.0.1:61654, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.595 INFO accepted connection, remote_addr: 127.0.0.1:64662, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.595 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1e0b5f51-1c45-4487-b486-08b6bc05b3d6, remote_addr: 127.0.0.1:64662, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.608 INFO accepted connection, remote_addr: 127.0.0.1:37539, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.608 INFO request completed, latency_us: 73, response_code: 200, uri: /state/cid/2, method: GET, req_id: 424fe9a7-b2a4-4279-b8c9-71597fef7a33, remote_addr: 127.0.0.1:37539, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.621 INFO accepted connection, remote_addr: 127.0.0.1:48035, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.621 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2b51c909-efc0-4294-aa05-5943067fda0e, remote_addr: 127.0.0.1:48035, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.634 INFO accepted connection, remote_addr: 127.0.0.1:43475, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.634 INFO request completed, latency_us: 71, response_code: 200, uri: /state/cid/4, method: GET, req_id: fa4e5b9c-7f4c-4e9d-923a-5711e89c7527, remote_addr: 127.0.0.1:43475, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.647 INFO accepted connection, remote_addr: 127.0.0.1:45373, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.647 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/5, method: GET, req_id: 9ced2b7b-3be3-429c-a0f0-79bf525580ef, remote_addr: 127.0.0.1:45373, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.660 INFO accepted connection, remote_addr: 127.0.0.1:54853, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Sep 18 03:28:00.660 INFO request completed, latency_us: 88, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 94c14c5b-5aaa-4f07-9b82-8c7ce7c2d938, remote_addr: 127.0.0.1:54853[8810] Disable keep_running , local_addr: 127.0[8830] Disable keep_running .0.1:[8820] Disable keep_running 9998[8840] Disable keep_running [8850] Disable keep_running [8860] Disable keep_running Sep 18 03:28:00.723 INFO accepted connection, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.724 INFO request completed, latency_us: 241, response_code: 200, uri: /regioninfo, method: GET, req_id: 3cfa8fe8-457a-44b2-addf-84ec72096ce7, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.726 INFO request completed, latency_us: 64, response_code: 200, uri: /regioncount, method: GET, req_id: 20fac476-3a1f-4cba-b08c-efc515b0e589, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.726 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/0, method: GET, req_id: 68b64cd2-4446-41c2-9483-541cfb09596e, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.727 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/1, method: GET, req_id: 13a888d9-2ccc-49d6-9ee2-0efe960495ff, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.727 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/2, method: GET, req_id: 37045633-1a4a-448d-9bc2-fab6d9e9222a, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.732 INFO request completed, latency_us: 75, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4423b363-9232-472c-a35a-5f1977a9254b, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.733 INFO request completed, latency_us: 59, response_code: 200, uri: /port/cid/4, method: GET, req_id: 4fccb0e0-5d39-4f00-bc23-c63dcd2f87cd, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:00.733 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5a71ff7e-d6e1-495e-a23a-065c44276877, remote_addr: 127.0.0.1:46870, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.792 INFO accepted connection, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.793 INFO request completed, latency_us: 146, response_code: 200, uri: /regioninfo, method: GET, req_id: 4a8adfe1-fa9b-402a-82be-ddfe9da1840d, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.794 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: 04ddb399-3f72-4bf8-8f57-57db825a7292, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.794 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4c3cc189-02f1-4672-a434-f30a771b2b64, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.794 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: 381e9bb6-11e2-4ec8-8267-762c0151a8b2, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.795 INFO request completed, latency_us: 39, response_code: 200, uri: /port/cid/2, method: GET, req_id: 04874762-bab9-4975-b4d0-7c7781163f83, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.797 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/3, method: GET, req_id: ab7466fc-917c-46b9-94dd-dd0480e34db8, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.797 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/4, method: GET, req_id: d739261f-b236-4360-9a51-4dc41f0122e7, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:09.797 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/5, method: GET, req_id: d8d86e70-076a-4ea2-80c0-f776f4825846, remote_addr: 127.0.0.1:60396, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.099 INFO accepted connection, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.100 INFO request completed, latency_us: 146, response_code: 200, uri: /regioninfo, method: GET, req_id: 7b3745a4-ad42-4d24-a4df-772fc4534141, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.101 INFO request completed, latency_us: 93, response_code: 200, uri: /regioncount, method: GET, req_id: 953deb49-0b1f-4ef7-aa3d-663b0326a6ed, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.101 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: c6b10f96-3f8f-421e-9d4f-289cbeb59d82, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.102 INFO request completed, latency_us: 71, response_code: 200, uri: /port/cid/1, method: GET, req_id: e4b440e1-15c1-4f59-b678-82a09166b382, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.102 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4a677cbd-720d-4a62-8923-afd049f778bd, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.103 INFO request completed, latency_us: 59, response_code: 200, uri: /port/cid/3, method: GET, req_id: 625d244d-1597-4898-bc1a-598276c3cbe0, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.104 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/4, method: GET, req_id: c4db7cff-55e5-4278-825a-4381296c58a2, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:19.104 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: e91b1df8-efdf-4a13-8455-f26a0c317984, remote_addr: 127.0.0.1:48379, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.423 INFO accepted connection, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.424 INFO request completed, latency_us: 182, response_code: 200, uri: /regioninfo, method: GET, req_id: 37229614-6646-4481-8e6e-f56a823dfd25, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.425 INFO request completed, latency_us: 95, response_code: 200, uri: /regioncount, method: GET, req_id: 8cec211e-0f9d-47a5-8773-a0b84cbfa868, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.425 INFO request completed, latency_us: 83, response_code: 200, uri: /port/cid/0, method: GET, req_id: 099f2629-1192-47a5-b6f6-41f287102e19, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.425 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/1, method: GET, req_id: f7a69c10-e5ce-42be-84cc-937cc1786f64, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.426 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/2, method: GET, req_id: fd4efa1d-4c8a-44ec-9f67-755b827fa8ee, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.427 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/3, method: GET, req_id: 174858a6-1b58-4656-b1e9-52326dd80eb8, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.428 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/4, method: GET, req_id: 7f55b48b-0f09-4998-a9bc-d0aa6539177c, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:28:43.428 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/5, method: GET, req_id: 0c017f73-230d-4a51-8feb-485f2c9fc1c0, remote_addr: 127.0.0.1:53468, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.829 INFO accepted connection, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.830 INFO request completed, latency_us: 143, response_code: 200, uri: /regioninfo, method: GET, req_id: 02fd9c3f-0a25-4ebb-956c-ffb38c8b01dc, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.831 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: 6873ce48-f496-4376-aa4b-ed68be23975a, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.831 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/0, method: GET, req_id: 550dc737-2799-468e-9f95-64ce1aa4f574, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.832 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/1, method: GET, req_id: 56bdaae3-c554-4053-8045-c4b3f0b5b55e, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.832 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/2, method: GET, req_id: 500f75de-4211-41bc-80d6-6f4d0df28a52, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.833 INFO request completed, latency_us: 71, response_code: 200, uri: /port/cid/3, method: GET, req_id: 2adec08f-3a19-49fd-b097-e99bdc5bceee, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.834 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0cfd7b33-dfab-4cab-b3a2-fa7d7bd8c029, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:12.834 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/5, method: GET, req_id: 547e392d-c68f-4e9e-9c9c-a752dfc203dd, remote_addr: 127.0.0.1:54680, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.531 INFO accepted connection, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.532 INFO request completed, latency_us: 143, response_code: 200, uri: /regioninfo, method: GET, req_id: e1476590-a3bd-4c1e-b128-ede0c4d701d2, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.532 INFO request completed, latency_us: 76, response_code: 200, uri: /regioncount, method: GET, req_id: e85e3623-6ea0-4e14-acb0-87655a0f6c44, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.533 INFO request completed, latency_us: 70, response_code: 200, uri: /port/cid/0, method: GET, req_id: 41f3aae1-9f82-4449-a9db-0dfcb5802cd9, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.533 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5631f6db-c6c2-490d-b67c-05a218b9e2ed, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.533 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: 908915c2-62fd-41a8-a4be-38e738f05322, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.534 INFO request completed, latency_us: 53, response_code: 200, uri: /port/cid/3, method: GET, req_id: 81cbddf2-6dcf-4c3a-9b48-3e9f8fccdae3, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.535 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/4, method: GET, req_id: d22616c2-f4ce-4268-a67f-eb97d8497ff1, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:29.535 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6d0e7165-6fb2-4ee8-acfc-8e7714db407c, remote_addr: 127.0.0.1:55725, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.642 INFO accepted connection, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.643 INFO request completed, latency_us: 163, response_code: 200, uri: /regioninfo, method: GET, req_id: ace6377d-3f4e-4bb9-a67b-e73b609a2a41, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.643 INFO request completed, latency_us: 82, response_code: 200, uri: /regioncount, method: GET, req_id: d7786622-e793-4f61-a7dd-f71b7f4a7afa, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.644 INFO request completed, latency_us: 82, response_code: 200, uri: /port/cid/0, method: GET, req_id: a1e71436-6551-4041-bbc8-de9e2564bcfd, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.644 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/1, method: GET, req_id: 81922976-bb9e-4455-9dff-f05ef39a6061, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.644 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 51ad8339-222f-4040-85cc-c1e3400c62e3, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.646 INFO request completed, latency_us: 78, response_code: 200, uri: /port/cid/3, method: GET, req_id: 03f66d97-b65c-444d-9dcc-adc5d900e402, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.646 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/4, method: GET, req_id: c62cfd09-f8c6-4180-aedf-e2f3b11844bb, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:33.646 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6d803949-a03e-42b1-b189-7cc48489bb18, remote_addr: 127.0.0.1:44065, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.742 INFO accepted connection, remote_addr: 127.0.0.1:36932, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Sep 18 03:31:37.742 INFO request completed, latency_us: 136, response_code: 204, uri: /disablerestart/all, method: POST, req_id: b30e003d-daef-49b9-8bfc-a404b35acf06, remote_addr: 127.0[8810] Disable keep_running .[8820] Disable keep_running 0[8830] Disable keep_running .[8860] Disable keep_running 1:36932, local_addr: 127.0[8850] Disable keep_running .0.1:9998[8840] Disable keep_running Sep 18 03:31:37.756 INFO accepted connection, remote_addr: 127.0.0.1:64329, local_addr: 127.0.0.1:9998 Main task has work to do, go find it Sep 18 03:31:37.756got dsc Stop(2) INFO request completed, latency_usstop 2 : 108, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 2793f64e-1eb6-4e1f-af8c-3791f888e23e, [8830] Got stop action so:false kr:false remote_addr: 127.0.0.1:64329, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Sep 18 03:31:37.770 INFO accepted connection, remote_addr: 127.0.0.1:58911, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.770 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/2, method: GET, req_id: ae703663-7f4e-4cae-b0e9-003dd54ef3ab, remote_addr: 127.0.0.1:58911, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.786 INFO accepted connection, remote_addr: 127.0.0.1:32906, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Sep 18 03:31:37.786 INFO request completed, latency_us: 84, response_code: 204, uri: /start/cid/2, method: POST, req_id: 781af1ae-ca11-4d2b-9dd4-8b4dea53fb08, remote_addr: 127.0.0.1:32906, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.818 INFO accepted connection, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.819 INFO request completed, latency_us: 101, response_code: 200, uri: /regioninfo, method: GET, req_id: 93267b16-3da9-405c-bdf5-b04a6956ff37, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.819 INFO request completed, latency_us: 78, response_code: 200, uri: /regioncount, method: GET, req_id: 06ad9e05-77fb-453e-abdd-686f4b44d997, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.820 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/0, method: GET, req_id: cbf5c16d-4ad6-46a4-a955-ba2c4a697858, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.820 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/1, method: GET, req_id: 9aabc979-00d4-4ca7-8cd9-d3650291f11c, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.820 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: 587c5f81-8e96-4a30-a056-5a86e789e7f0, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.821 INFO request completed, latency_us: 45, response_code: 200, uri: /port/cid/3, method: GET, req_id: 40cc5042-7ab6-4187-966a-f5f1841db281, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.822 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1f1a2f8e-5ec3-41a7-8672-65e93d498eca, remote_addr: 127.0.0.1:52988, local_addr: 127.0.0.1:9998 Sep 18 03:31:37.822 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: 918e2085-ca8d-4c40-801b-7a9702e13275, remote_addr: 127.0.0.1:52988, 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(1200) [8830][2] reports Running Sep 18 03:31:51.961 INFO accepted connection, remote_addr: 127.0.0.1:63787, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Sep 18 03:31:51.962 INFO [8810] Disable keep_running request completed, [8810] Got stop action so:false kr:false latency_us: [8820] Disable keep_running 128[8830] Disable keep_running , [8830] Got stop action so:false kr:false response_code[8860] Disable keep_running :[8860] Got stop action so:false kr:false 204, uri: /shutdown, method: POST, req_id: cce7d8ca-74c6-4da1-98eb-9d420a923582, remote_addr: 127.0.0.1:63787, local_addr: 127.0.0.1:[8820] Got stop action so:false kr:false 9998[8850] Disable keep_running [8850] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8850] Exited with: ExitStatus(unix_wait_status(9)) [8840] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [8840][3] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit /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.031219264 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.02808892 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.026483128 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.02695544 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.0266027 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024573129 Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.036208708 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 Starting downstairs at port 8810 Starting downstairs at port 8820 start ds: 8870 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.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 Starting downstairs at port 8840 [8830][2] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] initial start wait reports Starting Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8850][4] initial start wait reports Starting Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8860][5] initial start wait reports Starting Starting downstairs at port 8870 Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt" [8870][6] initial start wait reports Starting Control access at:127.0.0.1:9998 Sep 18 03:31:57.187 INFO listening, local_addr: 127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1218) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1217) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1223) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1221) Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1219) Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1220) [8820][1] initial start wait reports Running [8850][4] initial start wait reports Running [8830][2] initial start wait reports Running [8840][3] initial start wait reports Running [8870][6] initial start wait reports Running [8860][5] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1222) [8810][0] initial start wait reports Running All downstairs are running Sep 18 03:32:02.198 INFO accepted connection, remote_addr: 127.0.0.1:52401, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.199 INFO request completed, latency_us: 308, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1ae3e88d-0e11-45b0-8c06-a2a593dd0b0b, remote_addr: 127.0.0.1:52401, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.214 INFO accepted connection, remote_addr: 127.0.0.1:38805, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.215 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/1, method: GET, req_id: 45b7d34b-a48b-4acb-945f-e4dda588e1c4, remote_addr: 127.0.0.1:38805, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.228 INFO accepted connection, remote_addr: 127.0.0.1:40406, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.228 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/2, method: GET, req_id: 94038016-6abc-41a2-96e6-d063b6f78c7a, remote_addr: 127.0.0.1:40406, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.241 INFO accepted connection, remote_addr: 127.0.0.1:42406, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.242 INFO request completed, latency_us: 64, response_code: 200, uri: /state/cid/3, method: GET, req_id: a8d7a15c-eb60-4d67-bab5-923c85742ced, remote_addr: 127.0.0.1:42406, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.255 INFO accepted connection, remote_addr: 127.0.0.1:59241, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.255 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/4, method: GET, req_id: 0ab30e1d-b581-4fca-8f7d-6292cf514f94, remote_addr: 127.0.0.1:59241, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.268 INFO accepted connection, remote_addr: 127.0.0.1:56272, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.268 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/5, method: GET, req_id: 2d413b66-2e1b-4e87-8c69-03e6e8915924, remote_addr: 127.0.0.1:56272, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.281 INFO accepted connection, remote_addr: 127.0.0.1:55319, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.281 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/6, method: GET, req_id: 830a24b9-ebca-4edf-b3c3-c811195cd62e, remote_addr: 127.0.0.1:55319, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.294 INFO accepted connection, remote_addr: 127.0.0.1:33992, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.294 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/6, method: GET, req_id: a2eec7b4-454f-4e3a-b114-e3dbb226ce00, remote_addr: 127.0.0.1:33992, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.313 INFO accepted connection, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.314 INFO request completed, latency_us: 99, response_code: 200, uri: /regioninfo, method: GET, req_id: 03b6e5bf-4418-45a0-ba4f-1c56c3580c4b, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.314 INFO request completed, latency_us: 69, response_code: 200, uri: /regioncount, method: GET, req_id: e686d66c-d71b-460d-a5bb-b49d3187516e, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.315 INFO request completed, latency_us: 64, response_code: 200, uri: /port/cid/0, method: GET, req_id: 41f38fe8-fa9c-471f-8b2f-735b77ad2bb9, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.315 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/1, method: GET, req_id: bb79af86-ef46-48d0-a11b-ea9b28702b7e, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.315 INFO request completed, latency_us: 68, response_code: 200, uri: /port/cid/2, method: GET, req_id: b1cee1a5-f35e-4e45-9220-724f253c8298, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.316 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/3, method: GET, req_id: 84cded1e-ea6a-46de-ba9e-d0ffd0c75414, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.317 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/4, method: GET, req_id: 335716b5-0649-46af-ba5d-62bbd9b3c081, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.317 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4a9bce24-232d-419a-984b-2a29ab731f0e, remote_addr: 127.0.0.1:49198, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.339 INFO accepted connection, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.339 INFO request completed, latency_us: 132, response_code: 200, uri: /regioncount, method: GET, req_id: b3deb368-191d-4a18-8710-0970fd3062b0, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:32:02.725 INFO request completed, latency_us: 231, response_code:[8810] Got stop action so:false kr:false 204, uri: /stop/cid/0, method: POST, req_id: a415f19d-329f-43c8-a337-d206f0db4605, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:02.725 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/0, method: GET, req_id: d875d048-e4d9-47fd-aa0d-a4909c30420b, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:32:06.727 INFO request completed, latency_us: 286, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1efb4a64-b909-4a42-b513-21fcbb2d0187, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) Sep 18 03:32:07.115 start 0 INFO request completed, latency_us: 217, response_code: 204, uri: /start/cid/0, method: POST, req_id: 6dd5a096-07e9-45a4-b8c8-e687112ed8b5, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:07.115 INFO request completed, latency_us: 50, response_code: 200, uri: /state/cid/0, method: GET, req_id: 91b8a80d-f31c-4de6-8eb5-6932aaadaaae, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1234) [8810][0] reports Running Sep 18 03:32:11.116 INFO request completed, latency_us: 246, response_code: 200, uri: /state/cid/0, method: GET, req_id: e2bb21b6-a20a-4d00-9e84-422f847aeec1, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:32:17.501 INFO[8810] Got stop action so:false kr:false request completed, latency_us: 223, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 43bc34e9-4fb8-4af1-bc94-ef2e9e71c767, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:17.501 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/0, method: GET, req_id: 255025a1-356c-4176-9c35-c40bad42c42d, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:32:21.504 INFO request completed, latency_us: 272, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1b73da00-5383-4b41-b288-d8420f859512, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:32:21.896 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/0, method: POST, req_id: e7410b7b-f389-4268-91c3-b5bbcd3f96e8, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:21.896 INFO request completed, latency_us: 80, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9ddf8ad6-cefe-408a-b21c-87496e2ee690, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1235) [8810][0] reports Running Sep 18 03:32:25.899 INFO request completed, latency_us: 266, response_code: 200, uri: /state/cid/0, method: GET, req_id: 143f9461-6f87-4ce2-bd53-935ffc5c974b, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:32:31.284 INFO request completed, [8810] Got stop action so:false kr:false latency_us: 221, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 05709dc4-823d-400f-9f2e-48e0f33f60e1, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:31.285 INFO request completed, latency_us: 72, response_code: 200, uri: /state/cid/0, method: GET, req_id: 939c330d-7cbb-46c6-89d2-2576a44b7fd0, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:32:35.288 INFO request completed, latency_us: 248, response_code: 200, uri: /state/cid/0, method: GET, req_id: 57b3f63b-2654-437c-86b1-7ce9334ea486, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:32:35.686 INFO request completed, latency_us: 339, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8cf71718-2021-4f0e-a15b-18a3935dcc44, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:35.686 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/0, method: GET, req_id: 22f8762d-361a-487d-aeb9-7a3423bffce3, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1236) [8810][0] reports Running Sep 18 03:32:39.689 INFO request completed, latency_us: 275, response_code: 200, uri: /state/cid/0, method: GET, req_id: 262d6f97-f1b7-4e2d-b31f-3609cb0ea90a, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Sep 18 03:32:44.074 INFO request completed[8810] Got stop action so:false kr:false , latency_us: 216, response_code: 204, uri: /stop/cid/0, method: POST, req_id: c138727e-cae4-434d-a76c-b7b15b3d8dac, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:44.074 INFO request completed, latency_us: 73, response_code: 200, uri: /state/cid/0, method: GET, req_id: 54cfb0d0-1959-4951-a9ad-f8f50ef89b92, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:32:48.076 INFO request completed, latency_us: 270, response_code: 200, uri: /state/cid/0, method: GET, req_id: 51cef514-e09c-4f66-99ce-93c42e723750, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:32:48.476 INFO request completed, latency_us: 217, response_code: 204, uri: /start/cid/0, method: POST, req_id: 009b6281-05c3-4a03-96dc-e4427646c3b9, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:48.477 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2b5e6190-260b-4059-ba17-77528868374a, remote_addr: 127.0.0.1:37994, 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(1237) [8810][0] reports Running Sep 18 03:32:52.479 INFO request completed, latency_us: 260, response_code: 200, uri: /state/cid/0, method: GET, req_id: 75a017b3-1aa4-4ee9-bd77-7a47e7c24b0c, remote_addr: 127.0.0.1:37994, 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 Sep 18 03:32:55.862 INFO request completed, latency_us: 217, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 9582b606-eefc-4c4b-8a92-51f23cb25cb8, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:32:55.863 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/0, method: GET, req_id: ccf04a79-7c78-41e8-9e06-2e8feb4e55c7, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:32:59.866 INFO request completed, latency_us: 276, response_code: 200, uri: /state/cid/0, method: GET, req_id: 625b68b4-ef19-46ea-a44f-dba858296c25, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:33:00.263 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/0, method: POST, req_id: 2839bd69-19de-4e39-bdcd-5741994da13f, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:33:00.263 INFO request completed, latency_us: 76, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4b59a025-abed-48d4-a6c8-52efed40bc95, remote_addr: 127.0.0.1:37994, 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 Sep 18 03:33:04.266 INFO request completed, latency_us: 249, response_code: 200, uri: /state/cid/0, method: GET, req_id: 27edc9a4-592c-4228-a6ae-7348f10873b7, remote_addr: 127.0.0.1:37994, 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 Sep 18 03:33:06.649 INFO request completed, latency_us: 227, response_code: 204, uri: /stop/cid/0, method: POST, req_id: a55749a1-8290-4a02-bd90-31241fc242e0, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:33:06.650 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/0, method: GET, req_id: 767d8210-3a38-4bc8-ac91-a4cdf84887ca, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:33:10.652 INFO request completed, latency_us: 276, response_code: 200, uri: /state/cid/0, method: GET, req_id: b44f80b6-e8ee-4f9f-aabd-415424c052f6, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:33:11.050 INFO request completed, latency_us: 222, response_code: 204, uri: /start/cid/0, method: POST, req_id: 52f6699c-6d4d-4b64-b09c-aa3222fba786, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:33:11.050 INFO request completed, latency_us: 70, response_code: 200, uri: /state/cid/0, method: GET, req_id: aec4fc4c-848f-4a17-aba1-219886ff339a, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:33:15.052 INFO request completed, latency_us: 266, response_code: 200, uri: /state/cid/0, method: GET, req_id: 876b5714-3cb8-41f1-98ef-2aa0b79a029a, remote_addr: 127.0.0.1:37994, 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(1239) [8810][0] reports Running Sep 18 03:33:19.054 INFO request completed, latency_us: 249, response_code: 200, uri: /state/cid/0, method: GET, req_id: 75483ce5-b862-4c60-9f72-1e8e4367bd4e, remote_addr: 127.0.0.1:37994, 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 Sep 18 03:33:46.498 INFO request completed, latency_us: 325, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 15e466bf-7f79-4c0e-8c26-9dfaebe3e87c, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:33:46.499 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4adb561c-1fa4-4eac-b7d6-b87140645116, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Sep 18 03:33:50.500 INFO request completed, latency_us: 274, response_code: 200, uri: /state/cid/1, method: GET, req_id: 067f9c76-dd8b-4a4f-bc0f-3e370b525e03, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Sep 18 03:33:50.896 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/1, method: POST, req_id: c064da64-df41-498a-a7f5-625e349873cb, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:33:50.897 INFO request completed, latency_us: 70, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6ead0e38-aa1e-40d2-b006-eee63a136e52, remote_addr: 127.0.0.1:37994, 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(1240) [8820][1] reports Running Sep 18 03:33:54.900 INFO request completed, latency_us: 308, response_code: 200, uri: /state/cid/1, method: GET, req_id: 621e7681-334a-4770-984d-527084447718, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Sep 18 03:34:22.452 INFO request completed, latency_us: 218, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 4525b23b-e590-4149-a9e7-2e53b55f294e, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998[8830] Got stop action so:false kr:false Sep 18 03:34:22.452 INFO request completed, latency_us: 87, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2347e341-2ddd-493b-9370-576ebf47f83f, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Sep 18 03:34:26.454 INFO request completed, latency_us: 280, response_code: 200, uri: /state/cid/2, method: GET, req_id: 379ba445-816d-4219-8361-47804c841406, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Sep 18 03:34:26.852 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/2, method: POST, req_id: 751a8c88-cef1-4d5e-b9aa-d97f6acded3d, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:34:26.853 INFO request completed, latency_us: 48, response_code: 200, uri: /state/cid/2, method: GET, req_id: 781734c0-aafb-461b-b3e0-c913ac2f0187, remote_addr: 127.0.0.1:37994, 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(1241) [8830][2] reports Running Sep 18 03:34:30.855 INFO request completed, latency_us: 260, response_code: 200, uri: /state/cid/2, method: GET, req_id: cb267e73-65b7-41f1-8dfa-385f328b90c9, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Sep 18 03:34:58.626 INFO [8840] Got stop action so:false kr:false request completed, latency_us: 221, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 36c13e7f-17be-42df-aadc-3d5d6330e9fe, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:34:58.627 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/3, method: GET, req_id: 3be9cf42-eca6-4a20-99f5-efbc257d0885, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Sep 18 03:35:02.630 INFO request completed, latency_us: 290, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2ef047db-76de-4856-a718-cab5469248b4, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Sep 18 03:35:03.035 INFO request completed, latency_us: 248, response_code: 204, uri: /start/cid/3, method: POST, req_id: c43ad69f-06a2-409d-8533-a55826477436, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:35:03.036 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/3, method: GET, req_id: 6e3a1f6d-b5a9-4057-ae82-40e105dbcb24, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:35:07.038 INFO request completed, latency_us: 270, response_code: 200, uri: /state/cid/3, method: GET, req_id: d93f4010-ad81-4ea4-8ef8-aa050e7e93ee, remote_addr: 127.0.0.1:37994, 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(1242) [8840][3] reports Running Sep 18 03:35:11.040 INFO request completed, latency_us: 276, response_code: 200, uri: /state/cid/3, method: GET, req_id: c2628039-4d7a-40f7-9710-686c280b5951, remote_addr: 127.0.0.1:37994, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.677 INFO accepted connection, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.678 INFO request completed, latency_us: 139, response_code: 200, uri: /regioninfo, method: GET, req_id: bec03054-a4a9-4472-a106-ddba33911f08, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.678 INFO request completed, latency_us: 64, response_code: 200, uri: /regioncount, method: GET, req_id: 325ecd1b-d915-454d-afd9-303e3c14c4b9, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.679 INFO request completed, latency_us: 62, response_code: 200, uri: /port/cid/0, method: GET, req_id: dd2c4000-d851-4152-945a-c1edc01e7b84, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.679 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: 493ff296-0d5b-40c9-986c-a066280138b9, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.679 INFO request completed, latency_us: 53, response_code: 200, uri: /port/cid/2, method: GET, req_id: f97187df-6f7c-43ca-8124-9ef1f10997ac, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.680 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4d829e19-6ee1-4d89-afda-5e7af3b28534, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.681 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: 65075011-5e89-4d6b-9af6-9db70044a01c, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.681 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: 40472f8a-3c9a-4d25-b763-52a778be7b9f, remote_addr: 127.0.0.1:52384, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.806 INFO accepted connection, remote_addr: 127.0.0.1:57170, local_addr: 127.0.0.1:9998 Sep 18 03:35:38.806 INFO request completed, latency_us: 133, response_code: 200, uri: /regioncount, method: GET, req_id: 87e91313-a61d-43d5-83ce-24894729a701, remote_addr: 127.0.0.1:57170, 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 Sep 18 03:35:44.437 INFO request completed, latency_us: 238, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 147236b0-3d14-4c2f-a9fa-7ee8eb89284d, remote_addr: 127.0.0.1:57170, local_addr: 127.0.0.1:9998 Sep 18 03:35:44.437 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/0, method: GET, req_id: b141a47c-8163-4b9e-8e32-005a3c8a4f25, remote_addr: 127.0.0.1:57170, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Sep 18 03:35:48.439 INFO request completed, latency_us: 244, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6cc51f19-e353-476a-ab24-71e3913b0eee, remote_addr: 127.0.0.1:57170, local_addr: 127.0.0.1:9998 Sep 18 03:36:25.521 INFO accepted connection, remote_addr: 127.0.0.1:46562, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Sep 18 03:36:25.522 INFO request completed, latency_us: 178, response_code: 204, uri: /start/cid/0, method: POST, req_id: ab8d99f7-5380-4968-b577-86542928d548, remote_addr: 127.0.0.1:46562, 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(1244) [8810][0] reports Running Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Sep 18 03:36:29.913 INFO request completed, latency_us: 215, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 75b86e46-fb85-479e-ae3d-583aa95227b9, remote_addr: 127.0.0.1:46562, local_addr: 127.0.0.1:9998 Sep 18 03:36:29.914 INFO request completed, latency_us: 92, response_code: 200, uri: /state/cid/1, method: GET, req_id: bad22e55-80aa-4bdd-9467-f16f8d2695b7, remote_addr: 127.0.0.1:46562, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Sep 18 03:36:33.917 INFO request completed, latency_us: 247, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4d9089d1-93d4-4fa7-8e27-6d141ffba485, remote_addr: 127.0.0.1:46562, local_addr: 127.0.0.1:9998 Sep 18 03:37:11.007 INFO accepted connection, remote_addr: 127.0.0.1:51189, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Sep 18 03:37:11.007 INFO request completed, latency_us: 169, response_code: 204, uri: /start/cid/1, method: POST, req_id: 2bd1dd52-1cf1-48f8-a551-6b571f62feb2, remote_addr: 127.0.0.1:51189, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Sep 18 03:37:15.407 INFO [8830] Got stop action so:false kr:false request completed, latency_us: 212, response_code: 204, uri: /stop/cid/2, method: POST, req_id: d6e403c3-6136-4b44-99fd-e62838447ec6, remote_addr: 127.0.0.1:51189, local_addr: 127.0.0.1:9998 Sep 18 03:37:15.408 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/2, method: GET, req_id: fdac76f4-1a5b-4c61-b9d0-8e2669e5ac2b, remote_addr: 127.0.0.1:51189, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] got start action [8820] I am going to restart Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1245) [8820][1] reports Running Sep 18 03:37:19.410 INFO request completed, latency_us: 246, response_code: 200, uri: /state/cid/2, method: GET, req_id: 301d71d4-e6f4-416f-af74-954cead94508, remote_addr: 127.0.0.1:51189, local_addr: 127.0.0.1:9998 Sep 18 03:37:56.495 INFO accepted connection, remote_addr: 127.0.0.1:60596, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Sep 18 03:37:56.495 INFO request completed, latency_us: 163, response_code: 204, uri: /start/cid/2, method: POST, req_id: 4197d6b3-9a69-4a91-9744-20b68108488d, remote_addr: 127.0.0.1:60596, 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(1246) [8830][2] reports Running Main task has work to do, go find it got dsc Stop(3) stop 3 Sep 18 03:38:00.904 INFO [8840] Got stop action so:false kr:false request completed, latency_us: 216, response_code: 204, uri: /stop/cid/3, method: POST, req_id: f7c33f93-de01-49f1-ad86-2ffff9bdff9e, remote_addr: 127.0.0.1:60596, local_addr: 127.0.0.1:9998 Sep 18 03:38:00.905 INFO request completed, latency_us: 58, response_code: 200, uri: /state/cid/3, method: GET, req_id: a29d2e0f-8f75-4f9f-a03f-35ce76c6b2a6, remote_addr: 127.0.0.1:60596, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Sep 18 03:38:04.906 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/3, method: GET, req_id: da53b940-78b7-4913-8b69-41f6a278e6f7, remote_addr: 127.0.0.1:60596, local_addr: 127.0.0.1:9998 Sep 18 03:38:42.004 INFO accepted connection, remote_addr: 127.0.0.1:36866, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Sep 18 03:38:42.004 INFO request completed, latency_us: 169, response_code: 204, uri: /start/cid/3, method: POST, req_id: 69f6bfd2-e883-4d16-8de0-07d95d7e3f16, remote_addr: 127.0.0.1:36866, 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(1247) [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 Sep 18 03:38:46.563 INFO request completed, latency_us: 287, response_code: 204, uri: /stop/cid/4, method: POST, req_id: eeb85f13-32af-4cff-a6a3-6dbdf3c722bc, remote_addr: 127.0.0.1:36866, local_addr: 127.0.0.1:9998 Sep 18 03:38:46.563 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/4, method: GET, req_id: 08975cca-534b-42db-93c6-03b77f3f4e30, remote_addr: 127.0.0.1:36866, local_addr: 127.0.0.1:9998 [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit Sep 18 03:38:50.565 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/4, method: GET, req_id: 393ffbb8-43e3-434c-994e-4957226a596c, remote_addr: 127.0.0.1:36866, local_addr: 127.0.0.1:9998 Sep 18 03:39:27.661 INFO accepted connection, remote_addr: 127.0.0.1:55545, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(4) Sep 18 03:39:27.661start 4 INFO request completed, latency_us: 164, response_code: 204, uri: /start/cid/4, method: POST, req_id: ae8f1462-23ad-4f4f-9b70-8af42060c197, remote_addr: 127.0.0.1:55545, local_addr: 127.0.0.1:9998 [8850] got start action [8850] I am going to restart Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8850][4] reports Starting Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1248) [8850][4] reports Running Sep 18 03:39:31.709 INFO accepted connection, remote_addr: 127.0.0.1:65306, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Sep 18 03:39:31.710 INFO request completed, latency_us: 141, response_code: 204, uri: /shutdown, method: [8810] Disable keep_running POST, req_id: ec143662-fb40-4db0-b0f2-bae35715d02d, remote_addr[8810] Got stop action so:false kr:false : 127.0.0.1:65306, local_addr: 127.0.0.1:9998 [8820] Disable keep_running [8830] Disable keep_running [8840] Disable keep_running [8830] Got stop action so:false kr:false [8820] Got stop action so:false kr:false [8840] Got stop action so:false kr:false [8860] Disable keep_running [8860] Got stop action so:false kr:false [8850] Disable keep_running [8850] Got stop action so:false kr:false [8870] Disable keep_running [8870] Got stop action so:false kr:false [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8810] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8810][0] reports Exit [8870] Exited with: ExitStatus(unix_wait_status(9)) [8870][6] reports Exit