/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.24412173
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.017567119
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.015943484
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.01617442
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.016302256
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.015957873
Created 6 regions
/var/tmp/bins/dsc start --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build --region-count 6
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 })
start ds: 8810
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start access at:127.0.0.1:9998
start ds: 8860
Starting downstairs at port 8810
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
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 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"
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
[8810][0] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8820][1] initial start wait reports Starting
[8840][3] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1210)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1213)
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1212)
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1208)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1211)
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1209)
[8820][1] initial start wait reports Running
[8840][3] initial start wait reports Running
[8810][0] initial start wait reports Running
[8860][5] initial start wait reports Running
[8830][2] initial start wait reports Running
[8850][4] initial start wait reports Running
All downstairs are running
Nov 06 20:10:41.291 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Nov 06 20:10:46.333 INFO accepted connection, remote_addr: 127.0.0.1:49807, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.335 INFO request completed, latency_us: 417, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6d56abcb-73ad-49cf-8c21-ff15137aaa6b, remote_addr: 127.0.0.1:49807, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.389 INFO accepted connection, remote_addr: 127.0.0.1:51230, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.390 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7bba47db-e082-4272-80a9-ef05cf2cdce0, remote_addr: 127.0.0.1:51230, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.444 INFO accepted connection, remote_addr: 127.0.0.1:54232, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.444 INFO request completed, latency_us: 169, response_code: 200, uri: /state/cid/2, method: GET, req_id: 15bcc8b9-8ceb-4512-84ef-a3cd0fd8c44d, remote_addr: 127.0.0.1:54232, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.498 INFO accepted connection, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.498 INFO request completed, latency_us: 165, response_code: 200, uri: /state/cid/3, method: GET, req_id: bdd717aa-9e51-4e3e-884d-be7e3be901bb, remote_addr: 127.0.0.1:42894, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.554 INFO accepted connection, remote_addr: 127.0.0.1:51855, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.555 INFO request completed, latency_us: 159, response_code: 200, uri: /state/cid/4, method: GET, req_id: f6e7d8e7-b537-4b39-a927-e1a84e8235e4, remote_addr: 127.0.0.1:51855, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.609 INFO accepted connection, remote_addr: 127.0.0.1:38961, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.610 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/5, method: GET, req_id: 1ed9d940-3952-4815-90ef-df7345a64594, remote_addr: 127.0.0.1:38961, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.662 INFO accepted connection, remote_addr: 127.0.0.1:37128, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Nov 06 20:10:46.663 INFO request completed, latency_us: 214[8810] Disable keep_running
, [8820] Disable keep_running
response_code: 204, uri[8850] Disable keep_running
: /disablerestart/all, method: POST, req_id:[8860] Disable keep_running
 5c13eecf-16fb-4bef-8ed3-d7bca3893668, remote_addr: 127.0.0.1:37128[8830] Disable keep_running
, local_addr: 127.0.0.1:9998
[8840] Disable keep_running
Nov 06 20:10:46.762 INFO accepted connection, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.763 INFO request completed, latency_us: 264, response_code: 200, uri: /regioninfo, method: GET, req_id: ad056883-e3cd-4c11-9f1a-6efbde784e20, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.764 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: 55a24a36-bdf5-4e1a-a374-acee294d3432, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.765 INFO request completed, latency_us: 139, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5daa69f1-886c-448c-9cb8-4ec01004bd5f, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.766 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: a0e4aefd-1581-4010-91f4-352f5140698d, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.766 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: ae5cca18-533a-469b-9ea5-7d828cacc378, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.770 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/3, method: GET, req_id: b580a0a8-6835-4d60-8f56-a75354674def, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.770 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 62bac156-f2db-4ade-a9df-77f3bf89ecc9, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:46.771 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 0f388ee5-4d9f-40fa-8c88-118c2e66b7c9, remote_addr: 127.0.0.1:34740, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.887 INFO accepted connection, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.887 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: b844e2c4-547c-45a3-bcba-7b338d8d945f, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.888 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 834012db-80da-4108-818a-1eb2794025ca, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.889 INFO request completed, latency_us: 138, response_code: 200, uri: /port/cid/0, method: GET, req_id: c3011bf0-8cdd-41c7-bcb2-6d5b24730f05, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.890 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/1, method: GET, req_id: ec93e7a9-ab41-4faa-bf84-233303826073, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.890 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/2, method: GET, req_id: bdc1d14e-5db4-4081-8ca8-b54f4a7c91a7, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.892 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/3, method: GET, req_id: c51c1aad-8aa5-4383-b3b7-2bf0c0e5dd1b, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.893 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/4, method: GET, req_id: c3824939-b282-40c9-8206-e16d8bd1adbf, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:10:55.894 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/5, method: GET, req_id: 17d374cd-82d9-46df-bfe9-4b375bba08ba, remote_addr: 127.0.0.1:32958, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.480 INFO accepted connection, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.481 INFO request completed, latency_us: 153, response_code: 200, uri: /regioninfo, method: GET, req_id: 7ff74a74-4e31-414e-b412-5c6414b3a7d8, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.482 INFO request completed, latency_us: 101, response_code: 200, uri: /regioncount, method: GET, req_id: 79b942e1-9aa9-4512-8ae8-7a73330ae3e3, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.483 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/0, method: GET, req_id: fddf1684-530d-4c8e-9d15-cefe86d5b250, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.483 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/1, method: GET, req_id: df33be4a-62ad-4faf-9a3a-9fb896caae7e, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.484 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/2, method: GET, req_id: b143b8b0-7db3-45c7-ade8-211293760f39, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.486 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: c5d44ca7-f0cd-41cb-850b-bb1300b4bb3b, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.486 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9b6def5a-a42b-4967-9742-1e01ee947755, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:05.487 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/5, method: GET, req_id: 2a71e67a-2387-426f-ba5c-30b896003579, remote_addr: 127.0.0.1:57194, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.077 INFO accepted connection, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.077 INFO request completed, latency_us: 166, response_code: 200, uri: /regioninfo, method: GET, req_id: f4cafb3f-908d-4ed2-9cf1-b10123574a66, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.078 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: a6a79b6b-5b7e-4950-a9c2-fe978ff20fc9, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.079 INFO request completed, latency_us: 137, response_code: 200, uri: /port/cid/0, method: GET, req_id: 01a899bf-410f-4ec9-9ca1-ea847104f94b, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.080 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: a8648360-71cd-46f3-8fc2-e46959ead169, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.080 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 07f82311-ad22-400b-8c35-6a71f62085a0, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.082 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7266bdc8-e815-4a53-aaea-0a5888750e5c, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.083 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 020ce810-e487-4f7e-8ec8-d13382f68f89, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:11:44.084 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6a8da2a3-698a-4cd1-8758-8a62f58eee02, remote_addr: 127.0.0.1:62828, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.830 INFO accepted connection, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.831 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: 771f3b1f-0804-4512-870b-35c651b3b0c9, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.832 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: f11c8163-7fcb-4f5b-afc2-4f40f95ddaf4, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.833 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0d3d452d-1a96-4954-bd4c-bd2708d4f064, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.833 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6212c4d2-2a9e-45d3-942b-c3e3ec1b5c9d, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.834 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3f31ec60-bad4-4d5a-8506-7b20f9fe4952, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.836 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/3, method: GET, req_id: 0dc49942-e234-44a2-8a2d-10207d6bfb64, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.836 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 6f4e4041-2014-4d6a-b6c7-610b5c1c0057, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:00.837 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 371ff48e-255a-4e24-a4e2-8bde8f4a877b, remote_addr: 127.0.0.1:48632, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.430 INFO accepted connection, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.431 INFO request completed, latency_us: 146, response_code: 200, uri: /regioninfo, method: GET, req_id: 31c815e7-88b8-46a2-b81c-9daef3789470, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.432 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: dfdadc41-d8ae-4fad-9e78-3f7278fc16e6, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.432 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5741774a-5b23-48ae-9175-bca9773c7162, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.433 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: ec338739-f5fd-4e0f-9979-39da7eeda1f0, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.434 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 42f37582-7a54-46c8-942f-ff784b28332f, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.436 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/3, method: GET, req_id: 76733d35-31ca-4102-8c05-006d834700ee, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.436 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: c2e18a45-706e-4a08-9afb-2d7f922d1e84, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:28.437 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4f01cce5-02ad-4825-a891-27a006c5de29, remote_addr: 127.0.0.1:55297, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.646 INFO accepted connection, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.647 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: f34358ab-7c60-40bd-bc85-e89b75882046, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.648 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: c5d61123-34fc-452a-83b3-33a816d6b1ae, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.649 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 63f74fea-e055-4192-b264-9d7d178f1305, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.649 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 284eceaa-ed28-446d-9eb6-4fadde4ba838, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.650 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: c4bf3b27-cb20-41c3-a0c2-dd25d38ea859, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.652 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8536cc4b-3958-4811-9a94-0cdd935d15b1, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.653 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0dc55db5-c5f1-4b0b-9de0-6f0702cb0195, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:32.653 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4259f9f6-8432-4448-a618-840b62da5dd6, remote_addr: 127.0.0.1:44712, local_addr: 127.0.0.1:9998
Nov 06 20:16:36.840 INFO accepted connection, remote_addr: 127.0.0.1:37363, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Nov 06 20:16:36.841 INFO request completed[8810] Disable keep_running
, [8820] Disable keep_running
latency_us[8830] Disable keep_running
:[8860] Disable keep_running
 186, response_code:[8840] Disable keep_running
 204, uri: /disablerestart/all, method: [8850] Disable keep_running
POST, req_id: 91a7b3b8-f0c3-4173-bbce-f7938edfbd2e, remote_addr: 127.0.0.1:37363, local_addr: 127.0.0.1:9998
Nov 06 20:16:36.895 INFO accepted connection, remote_addr: 127.0.0.1:44415, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 06 20:16:36.896 INFO request completed, latency_us: 164, response_code: 204, uri: /stop/cid/2[8830] Got stop action so:false kr:false
, method: POST, req_id: a8d11ea4-9d6a-4e79-a2da-9345d44246e6, remote_addr: 127.0.0.1:44415, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 06 20:16:36.951 INFO accepted connection, remote_addr: 127.0.0.1:61545, local_addr: 127.0.0.1:9998
Nov 06 20:16:36.952 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/2, method: GET, req_id: a504dbcc-64d4-4ac4-863f-d60f7fc9d378, remote_addr: 127.0.0.1:61545, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.010 INFO accepted connection, remote_addr: 127.0.0.1:49988, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 06 20:16:37.011 INFO request completed, latency_us: 203, response_code: 204, uri: /start/cid/2, method: POST, req_id: 8adee072-35c3-41ee-852e-51b7e42ec268, remote_addr: 127.0.0.1:49988, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.097 INFO accepted connection, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.098 INFO request completed, latency_us: 173, response_code: 200, uri: /regioninfo, method: GET, req_id: 81ea7029-293c-4a3d-ae79-a2b29a5931cf, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.099 INFO request completed, latency_us: 120, response_code: 200, uri: /regioncount, method: GET, req_id: 9fccfe99-6c05-446b-b176-d06b0250f485, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.100 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 39d10883-cea0-4474-a3e3-dcb4606b2832, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.100 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 13692d2a-21f8-40cb-a744-56991dfd1956, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.101 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: e1111948-04e1-42ea-957b-ba9a6d7866b5, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.103 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/3, method: GET, req_id: d8967a0d-f083-4a2c-ae4c-d5b7ab65e188, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.104 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 60cd13c6-6b46-4714-975b-fed719b3bd82, remote_addr: 127.0.0.1:62016, local_addr: 127.0.0.1:9998
Nov 06 20:16:37.104 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/5, method: GET, req_id: a1dae567-ef36-44f1-9227-8b85a1e375b7, remote_addr: 127.0.0.1:62016, 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(1264)
[8830][2] reports Running
Nov 06 20:16:51.364 INFO accepted connection, remote_addr: 127.0.0.1:65197, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Nov 06 20:16:51.364 INFO request completed, latency_us: Shut it down
147[8810] Disable keep_running
, [8810] Got stop action so:false kr:false
response_code: 204, uri: /shutdown, method: POST[8820] Disable keep_running
, req_id: a12a9e41-3ef5-4c23-a4b1-e67545c74676, remote_addr:[8840] Disable keep_running
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8830] Disable keep_running
[8860] Disable keep_running
[8830] Got stop action so:false kr:false
[8860] Got stop action so:false kr:false
[8840] Got stop action so:false kr:false
[8820] Got stop action so:false kr:false
 127.0.0.1:65197, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8860][5] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
[8820][1] reports Exit
[8810][0] reports Exit
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --extent-count 400 --block-size 4096 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Removing existing dsc directory "/tmp/test_up-build/dsc"
Removing existing region "/var/tmp/test_up-build"
Creating region directory at: /var/tmp/test_up-build
Creating dsc directory at: /tmp/test_up-build/dsc
Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.046787094
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.04538398
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.04531972
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.04520414
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.04523059
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.04446059
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.06996918
Created 7 regions
/var/tmp/bins/dsc start --region-count 7 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 400 })
start ds: 8810
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
start ds: 8870
start access at:127.0.0.1:9998
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Starting downstairs at port 8820
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[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
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Starting downstairs at port 8860
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Starting downstairs at port 8870
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8840][3] initial start wait reports Starting
[8850][4] initial start wait reports Starting
[8860][5] initial start wait reports Starting
[8870][6] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1282)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1285)
[8820][1] initial start wait reports Running
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1286)
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1284)
[8860][5] initial start wait reports Running
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1283)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1281)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1287)
Control access at:127.0.0.1:9998
Nov 06 20:16:56.748 INFO listening, local_addr: 127.0.0.1:9998
[8830][2] initial start wait reports Running
All downstairs are running
Nov 06 20:17:01.797 INFO accepted connection, remote_addr: 127.0.0.1:62543, local_addr: 127.0.0.1:9998
Nov 06 20:17:01.798 INFO request completed, latency_us: 301, response_code: 200, uri: /state/cid/0, method: GET, req_id: 607ae8ed-69ff-46ea-ab53-fbf58658c4f9, remote_addr: 127.0.0.1:62543, local_addr: 127.0.0.1:9998
Nov 06 20:17:01.854 INFO accepted connection, remote_addr: 127.0.0.1:64788, local_addr: 127.0.0.1:9998
Nov 06 20:17:01.854 INFO request completed, latency_us: 147, response_code: 200, uri: /state/cid/1, method: GET, req_id: d7223901-9bfa-4200-aa47-57504c5c8d20, remote_addr: 127.0.0.1:64788, local_addr: 127.0.0.1:9998
Nov 06 20:17:01.910 INFO accepted connection, remote_addr: 127.0.0.1:34312, local_addr: 127.0.0.1:9998
Nov 06 20:17:01.911 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2115c990-a5f1-4c3c-bd04-ffc8eb27934c, remote_addr: 127.0.0.1:34312, local_addr: 127.0.0.1:9998
Nov 06 20:17:01.965 INFO accepted connection, remote_addr: 127.0.0.1:56101, local_addr: 127.0.0.1:9998
Nov 06 20:17:01.965 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/3, method: GET, req_id: 937041f3-aabd-4404-9543-58d796b5ca23, remote_addr: 127.0.0.1:56101, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.019 INFO accepted connection, remote_addr: 127.0.0.1:41569, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.020 INFO request completed, latency_us: 180, response_code: 200, uri: /state/cid/4, method: GET, req_id: 932c6fca-6a0c-46d0-bb94-8999b6b15c8e, remote_addr: 127.0.0.1:41569, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.076 INFO accepted connection, remote_addr: 127.0.0.1:58967, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.077 INFO request completed, latency_us: 179, response_code: 200, uri: /state/cid/5, method: GET, req_id: d96caf2f-761c-4137-94a5-19335d657dcf, remote_addr: 127.0.0.1:58967, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.132 INFO accepted connection, remote_addr: 127.0.0.1:44380, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.133 INFO request completed, latency_us: 167, response_code: 200, uri: /state/cid/6, method: GET, req_id: d949fd9e-732d-4ea4-9503-3f1aa621e9eb, remote_addr: 127.0.0.1:44380, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.189 INFO accepted connection, remote_addr: 127.0.0.1:61049, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.190 INFO request completed, latency_us: 175, response_code: 200, uri: /port/cid/6, method: GET, req_id: c6bfbca7-f88f-4b3a-954d-179e68c34d4f, remote_addr: 127.0.0.1:61049, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.253 INFO accepted connection, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.254 INFO request completed, latency_us: 218, response_code: 200, uri: /regioninfo, method: GET, req_id: f6febdb8-a4f2-4190-bb52-0a6912266715, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.255 INFO request completed, latency_us: 101, response_code: 200, uri: /regioncount, method: GET, req_id: a7fd0451-3088-4fad-bb87-a8ead27f3612, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.256 INFO request completed, latency_us: 113, response_code: 200, uri: /port/cid/0, method: GET, req_id: 94950057-0c2f-4037-9365-e430eb19f56a, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.256 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: aff0486e-2c1d-44b1-b031-cf35e8468172, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.257 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: c038a668-1b9a-461e-88e1-3b65d9b8dabc, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.259 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: ee9a4162-fdd0-4a42-9b4f-e01b84e0d227, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.260 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/4, method: GET, req_id: a168de57-a0c2-4b36-a9d4-78a0337f3881, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.260 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 3f19e145-a718-46c3-9c75-b59bb8f2f211, remote_addr: 127.0.0.1:43843, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.321 INFO accepted connection, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:02.322 INFO request completed, latency_us: 174, response_code: 200, uri: /regioncount, method: GET, req_id: 047f702e-f690-40e5-b2a9-15cc5cd8fdc5, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 06 20:17:03.064 INFO request completed, latency_us: 232, response_code: 204, uri: [8810] Got stop action so:false kr:false
/stop/cid/0, method: POST, req_id: d5c93124-8001-4e3e-a123-9e58a8c99ae2, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:03.065 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/0, method: GET, req_id: db6cb780-ffa0-4679-89f0-04c6cd2cf08a, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 06 20:17:07.067 INFO request completed, latency_us: 194, response_code: 200, uri: /state/cid/0, method: GET, req_id: fe19a9ba-4ce5-4e34-8b0a-e9b87a074f50, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 06 20:17:07.785 INFO request completed, latency_us: 236, response_code: 204, uri: /start/cid/0, method: POST, req_id: aa3cc123-afdb-45dd-bb55-1b5607639be5, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:07.786 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/0, method: GET, req_id: 09596af3-0d86-4a96-9366-356a472294a3, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:11.789 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/0, method: GET, req_id: c0d16768-3f70-4fd5-88da-5c4b3b4ff46d, remote_addr: 127.0.0.1:64394, 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
Nov 06 20:17:15.792 INFO request completed, latency_us: 222, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3cf73a79-8701-4759-8d42-82a659fd87c7, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 06 20:17:22.542 INFO request completed, latency_us[8810] Got stop action so:false kr:false
: 231, response_code: 204, uri: /stop/cid/0, method: POST, req_id: f44647fd-9c4b-4223-849a-baef246096ab, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:22.543 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/0, method: GET, req_id: b20be75d-d653-4d6c-aeb5-78e40336df61, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 06 20:17:26.546 INFO request completed, latency_us: 240, response_code: 200, uri: /state/cid/0, method: GET, req_id: 68af6ce7-c1c3-4eba-8b03-c90b35c10456, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 06 20:17:27.275 INFO request completed, latency_us: 264, response_code: 204, uri: /start/cid/0, method: POST, req_id: 2b7c0335-73f2-4069-990a-4741796fe947, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:27.276 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/0, method: GET, req_id: 91dfa841-88a2-4115-b979-50aca4369dc1, remote_addr: 127.0.0.1:64394, 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(1299)
[8810][0] reports Running
Nov 06 20:17:31.279 INFO request completed, latency_us: 230, response_code: 200, uri: /state/cid/0, method: GET, req_id: d4c847bd-b9c7-4ae9-89e0-b8325c8e0412, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 06 20:17:37.029 [8810] Got stop action so:false kr:false
INFO request completed, latency_us: 213, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 45b87188-5d25-44c4-8872-96f40ba6f9be, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:37.030 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/0, method: GET, req_id: 44eb348b-c15d-448b-9052-14e91881da14, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 06 20:17:41.032 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/0, method: GET, req_id: ffc3aba4-9c27-4eff-81b9-8431a89d29f3, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 06 20:17:41.771 INFO request completed, latency_us: 257, response_code: 204, uri: /start/cid/0, method: POST, req_id: abd16565-f1c1-4f25-9231-b71e60fe5c65, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:41.771 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/0, method: GET, req_id: 08d6b282-11fd-4070-978f-28cff8788e85, remote_addr: 127.0.0.1:64394, 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(1300)
[8810][0] reports Running
Nov 06 20:17:45.773 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9b0644ed-bae6-464d-ac8a-4a383237f97a, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 06 20:17:50.521[8810] Got stop action so:false kr:false
 INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/0, method: POST, req_id: d23129b7-1e86-48b7-9520-052baec51d42, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:50.522 INFO request completed, latency_us: 116, response_code: 200, uri: /state/cid/0, method: GET, req_id: 080e56fb-e374-4ae9-97a5-c0a07173f3d9, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 06 20:17:54.524 INFO request completed, latency_us: 204, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2147fa99-c44f-400b-b6f3-06543db70c5f, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 06 20:17:55.267 INFO request completed, latency_us: 224, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0e8f1094-ace2-4e3e-8551-f4e5805c5995, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:55.267 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/0, method: GET, req_id: 96db9ac8-0f78-4fc6-a703-c8b8b1777cd0, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:17:59.269 INFO request completed, latency_us: 191, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5f87796c-d637-4291-8077-820cb4f636de, remote_addr: 127.0.0.1:64394, 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(1301)
[8810][0] reports Running
Nov 06 20:18:03.272 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5e80b70d-2a74-4747-9d0e-b3f7a2bb26cd, remote_addr: 127.0.0.1:64394, local_addr: 127.0.0.1:9998
Nov 06 20:18:35.566 INFO accepted connection, remote_addr: 127.0.0.1:37240, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Nov 06 20:18:35.593 INFO request completed, latency_us: 205, response_code: 204, uri[8820] Got stop action so:false kr:false
: /stop/cid/1, method: POST, req_id: 4bcaa66e-b7cc-4b1e-b6f0-644306defeb9, remote_addr: 127.0.0.1:37240, local_addr: 127.0.0.1:9998
Nov 06 20:18:35.594 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3fb2b98b-f244-4ba7-af48-2ae9bbb8828d, remote_addr: 127.0.0.1:37240, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 06 20:18:39.596 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/1, method: GET, req_id: f1d59158-1347-4220-a5fb-9b8146c681b8, remote_addr: 127.0.0.1:37240, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 06 20:18:40.321 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/1, method: POST, req_id: e64b6e95-3091-4b66-a7e7-296d74cebefc, remote_addr: 127.0.0.1:37240, local_addr: 127.0.0.1:9998
Nov 06 20:18:40.321 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/1, method: GET, req_id: ccb78d68-ebfd-4b3a-ac1c-0f0cd3a8503e, remote_addr: 127.0.0.1:37240, 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(1302)
[8820][1] reports Running
Nov 06 20:18:44.323 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/1, method: GET, req_id: f268c646-5798-4acc-8309-9222fdea5c28, remote_addr: 127.0.0.1:37240, local_addr: 127.0.0.1:9998
Nov 06 20:19:17.124 INFO accepted connection, remote_addr: 127.0.0.1:34057, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 06 20:19:17.125 INFO request completed, latency_us: 473, response_code: 204, uri: /stop/cid/2, method: POST, req_id: d05b1fd1-9df9-4db7-8725-b9d78c1eb5e6, remote_addr:[8830] Got stop action so:false kr:false
 127.0.0.1:34057, local_addr: 127.0.0.1:9998
Nov 06 20:19:17.126 INFO request completed, latency_us: 153, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0ca1a5c7-ff08-493a-bbdf-37f93a721a7b, remote_addr: 127.0.0.1:34057, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 06 20:19:21.129 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4887e06a-f993-4e60-843d-006f742116f5, remote_addr: 127.0.0.1:34057, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 06 20:19:21.867 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/2, method: POST, req_id: b86eb50c-5663-4e57-85e4-14ca07ec966b, remote_addr: 127.0.0.1:34057, local_addr: 127.0.0.1:9998
Nov 06 20:19:21.868 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/2, method: GET, req_id: bafa0f3d-3e7a-4e14-8bda-246552952979, remote_addr: 127.0.0.1:34057, 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(1303)
[8830][2] reports Running
Nov 06 20:19:25.871 INFO request completed, latency_us: 286, response_code: 200, uri: /state/cid/2, method: GET, req_id: 86e2c9f6-f8cc-4094-a428-910518917490, remote_addr: 127.0.0.1:34057, local_addr: 127.0.0.1:9998
Nov 06 20:19:59.300 INFO accepted connection, remote_addr: 127.0.0.1:47292, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Nov 06 20:19:59.300 INFO request completed, latency_us:[8840] Got stop action so:false kr:false
 184, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 7ad5ac14-3951-48d6-8fab-7fb5d475c9af, remote_addr: 127.0.0.1:47292, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Nov 06 20:19:59.316 INFO request completed, latency_us: 349, response_code: 200, uri: /state/cid/3, method: GET, req_id: 175a2afc-60d3-460f-b943-74b2abfa449b, remote_addr: 127.0.0.1:47292, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Nov 06 20:20:00.099 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/3, method: POST, req_id: 5a2044ea-0782-4cb1-b662-148b154e8cc0, remote_addr: 127.0.0.1:47292, local_addr: 127.0.0.1:9998
Nov 06 20:20:00.099 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/3, method: GET, req_id: c440350d-cd4c-4c1d-8165-0b77c286d899, remote_addr: 127.0.0.1:47292, 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(1304)
[8840][3] reports Running
Nov 06 20:20:04.102 INFO request completed, latency_us: 229, response_code: 200, uri: /state/cid/3, method: GET, req_id: 61a7a92b-3178-4a77-986c-69ed16fad961, remote_addr: 127.0.0.1:47292, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.520 INFO accepted connection, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.521 INFO request completed, latency_us: 181, response_code: 200, uri: /regioninfo, method: GET, req_id: 975d6674-2841-4d82-aa5e-a6d962b585e0, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.522 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 99015f49-be26-4274-97ff-00a1003a725f, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.522 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 33881d9c-0d87-431f-b8f7-eab0cdaa2f95, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.523 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/1, method: GET, req_id: 070f7651-8037-43a3-b686-af87f27aba34, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.524 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/2, method: GET, req_id: 74cfb248-b0a5-4b89-b363-9c5964737b33, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.526 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: aab8db7e-e22b-4f7b-a0b0-a7919dab05db, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.526 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 250e0124-9d05-4f81-ad72-1f6e87f9e146, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.527 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: b6bebea9-15d9-4d98-9af2-66b78821cde0, remote_addr: 127.0.0.1:45583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.621 INFO accepted connection, remote_addr: 127.0.0.1:57583, local_addr: 127.0.0.1:9998
Nov 06 20:20:37.621 INFO request completed, latency_us: 156, response_code: 200, uri: /regioncount, method: GET, req_id: 6e23e33a-20c7-42b5-a966-a86565af4a63, remote_addr: 127.0.0.1:57583, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 06 20:20:53.081 INFO [8810] Got stop action so:false kr:false
request completed, latency_us: 258, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 6a15beed-ed84-4643-a9db-fa35455c7fff, remote_addr: 127.0.0.1:57583, local_addr: 127.0.0.1:9998
Nov 06 20:20:53.082 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/0, method: GET, req_id: 83b73bb5-a356-4d34-9f60-8093def94559, remote_addr: 127.0.0.1:57583, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 06 20:20:57.084 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/0, method: GET, req_id: ac1029ed-f178-4189-b73c-82fb0ea96afe, remote_addr: 127.0.0.1:57583, local_addr: 127.0.0.1:9998
Nov 06 20:21:58.357 INFO accepted connection, remote_addr: 127.0.0.1:63767, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 06 20:21:58.358 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/0, method: POST, req_id: 2769b6a1-cbca-4538-b44f-89b0b4af254f, remote_addr: 127.0.0.1:63767, 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(1306)
[8810][0] reports Running
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Nov 06 20:22:03.111 INFO request completed, latency_us: [8820] Got stop action so:false kr:false
222, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 237ebf18-dfe8-4bd6-99c7-b1d7a0b94e61, remote_addr: 127.0.0.1:63767, local_addr: 127.0.0.1:9998
Nov 06 20:22:03.112 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/1, method: GET, req_id: f9fcf5c2-547a-481b-83bd-dbd4b54bfe19, remote_addr: 127.0.0.1:63767, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 06 20:22:07.115 INFO request completed, latency_us: 255, response_code: 200, uri: /state/cid/1, method: GET, req_id: fc58a2f2-e64f-4a0a-ab47-e61874a7285f, remote_addr: 127.0.0.1:63767, local_addr: 127.0.0.1:9998
Nov 06 20:23:08.369 INFO accepted connection, remote_addr: 127.0.0.1:36026, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 06 20:23:08.369 INFO request completed, latency_us: 185, response_code: 204, uri: /start/cid/1, method: POST, req_id: e8d30ae5-0c1d-4eb4-883b-c4db30447712, remote_addr: 127.0.0.1:36026, 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(1307)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 06 20:23:13.145 INFO request completed[8830] Got stop action so:false kr:false
, latency_us: 221, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 5949e8db-9df8-4952-8e6f-2ad4c63ab73f, remote_addr: 127.0.0.1:36026, local_addr: 127.0.0.1:9998
Nov 06 20:23:13.146 INFO request completed, latency_us: 115, response_code: 200, uri: /state/cid/2, method: GET, req_id: 39419296-5ba6-4beb-bcfa-fcee3e9adb6f, remote_addr: 127.0.0.1:36026, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 06 20:23:17.149 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/2, method: GET, req_id: f7784066-fe78-42b5-8736-835e221612a2, remote_addr: 127.0.0.1:36026, local_addr: 127.0.0.1:9998
Nov 06 20:24:18.449 INFO accepted connection, remote_addr: 127.0.0.1:41528, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 06 20:24:18.449 INFO request completed, latency_us: 186, response_code: 204, uri: /start/cid/2, method: POST, req_id: dae7b60e-d53d-43f3-9d38-6021589d3726, remote_addr: 127.0.0.1:41528, 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(1308)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Nov 06 20:24:23.243 INFO request completed, latency_us: 231, [8840] Got stop action so:false kr:false
response_code: 204, uri: /stop/cid/3, method: POST, req_id: 6e1f4c1a-0c42-4ed7-84b0-73e8794f56bf, remote_addr: 127.0.0.1:41528, local_addr: 127.0.0.1:9998
Nov 06 20:24:23.244 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/3, method: GET, req_id: 02d4bf69-279a-4fc3-98d3-b30b008c60ae, remote_addr: 127.0.0.1:41528, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Nov 06 20:24:27.246 INFO request completed, latency_us: 200, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2379da11-eff0-4849-9824-320705aa2e87, remote_addr: 127.0.0.1:41528, local_addr: 127.0.0.1:9998
Nov 06 20:25:28.467 INFO accepted connection, remote_addr: 127.0.0.1:45950, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Nov 06 20:25:28.467 INFO request completed, latency_us: 187, response_code: 204, uri: /start/cid/3, method: POST, req_id: 3090fe1e-83eb-4bd7-bb82-7c52cf933c85, remote_addr: 127.0.0.1:45950, 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(1309)
[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
Nov 06 20:25:33.500 INFO request completed, latency_us: 232, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 0974d226-af92-4379-8f1d-29cd46d941cb, remote_addr: 127.0.0.1:45950, local_addr: 127.0.0.1:9998
Nov 06 20:25:33.501 INFO request completed, latency_us: 102, response_code: 200, uri: /state/cid/4, method: GET, req_id: 3294f713-6825-41b7-b92a-00894a33f66a, remote_addr: 127.0.0.1:45950, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Nov 06 20:25:37.504 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/4, method: GET, req_id: d8ab84f8-a4d8-4e8b-8a2b-fca1239f34cd, remote_addr: 127.0.0.1:45950, local_addr: 127.0.0.1:9998
Nov 06 20:26:38.727 INFO accepted connection, remote_addr: 127.0.0.1:48450, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Nov 06 20:26:38.728 INFO request completed, latency_us: 208, response_code: 204, uri: /start/cid/4, method: POST, req_id: 769c053e-929b-4f1a-8ca9-0aacaece8d83, remote_addr: 127.0.0.1:48450, 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(1310)
[8850][4] reports Running
Nov 06 20:26:42.817 INFO accepted connection, remote_addr: 127.0.0.1:59656, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Nov 06 20:26:42.818 INFO request completed, latency_us: 155, [8820] Disable keep_running
response_code[8810] Disable keep_running
:[8830] Disable keep_running
 204, uri: [8830] Got stop action so:false kr:false
/shutdown[8840] Disable keep_running
, [8860] Disable keep_running
[8860] Got stop action so:false kr:false
[8840] Got stop action so:false kr:false
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
[8810] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
method: POST, req_id: b5db9754-c25f-4d36-a128-6fcdd4d1e29f, remote_addr: 127.0.0.1:59656, local_addr: 127.0.0.1:9998
[8820] 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
[8860] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit