/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.23922393
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.020879917
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017794564
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.01724059
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.0173096
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.01674117
Created 6 regions
/var/tmp/bins/dsc start --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build --region-count 6
Using existing output directory "/tmp/test_up-build/dsc"
Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 10, extent_count: 5 })
start ds: 8810
start ds: 8820
start ds: 8830
start ds: 8840
start ds: 8850
start ds: 8860
Starting downstairs at port 8810
Starting downstairs at port 8820
Starting downstairs at port 8840
start access at:127.0.0.1:9998
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
Starting downstairs at port 8850
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
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"
[8820][1] initial start wait reports Starting
[8810][0] 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
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1191)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1192)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1193)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1194)
[8840][3] initial start wait reports Running
Control access at:127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1195)
[8850][4] initial start wait reports Running
Jan 28 17:09:14.077 INFO listening, local_addr: 127.0.0.1:9998
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1196)
[8860][5] initial start wait reports Running
All downstairs are running
Jan 28 17:09:19.113 INFO accepted connection, remote_addr: 127.0.0.1:44524, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.115 INFO request completed, latency_us: 418, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6fe018da-6480-45ac-b859-6154563752b6, remote_addr: 127.0.0.1:44524, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.168 INFO accepted connection, remote_addr: 127.0.0.1:38431, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.169 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/1, method: GET, req_id: 44153027-b523-4884-9798-2fbc3f9b95c9, remote_addr: 127.0.0.1:38431, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.222 INFO accepted connection, remote_addr: 127.0.0.1:33381, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.223 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/2, method: GET, req_id: e8e10327-0f5a-4c72-be9c-2e8d33657470, remote_addr: 127.0.0.1:33381, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.276 INFO accepted connection, remote_addr: 127.0.0.1:43099, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.277 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8d59b819-b38e-413f-9bb1-1fad44e4149e, remote_addr: 127.0.0.1:43099, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.329 INFO accepted connection, remote_addr: 127.0.0.1:35584, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.329 INFO request completed, latency_us: 124, response_code: 200, uri: /state/cid/4, method: GET, req_id: 6bdccd37-a4a6-4286-ab7a-4538690680fb, remote_addr: 127.0.0.1:35584, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.382 INFO accepted connection, remote_addr: 127.0.0.1:61630, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.382 INFO request completed, latency_us: 129, response_code: 200, uri: /state/cid/5, method: GET, req_id: be1753a2-7022-42b6-83dc-6dec2a632e3d, remote_addr: 127.0.0.1:61630, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.435 INFO accepted connection, remote_addr: 127.0.0.1:48354, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Jan 28 17:09:19.436 INFO request completed, latency_us: 146, response_code: 204, uri[8810] Disable keep_running
: /disablerestart/all, method: POST, req_id: dd83f36c-08be-4823-8fc5-65abda5359ab, remote_addr: [8820] Disable keep_running
127.[8840] Disable keep_running
0.0.1:48354, local_addr: 127.0.[8830] Disable keep_running
0[8850] Disable keep_running
.1:9998
[8860] Disable keep_running
Jan 28 17:09:19.544 INFO accepted connection, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.546 INFO request completed, latency_us: 280, response_code: 200, uri: /regioninfo, method: GET, req_id: 66508013-c30e-4350-b18f-c52e925b3a4e, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.548 INFO request completed, latency_us: 130, response_code: 200, uri: /regioncount, method: GET, req_id: aee6733a-2e99-455c-8563-ee4dfefa4bde, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.549 INFO request completed, latency_us: 167, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3312d9f7-ba23-467f-a66a-ee628542f5d5, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.549 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/1, method: GET, req_id: 60b14aaf-1ed3-4651-8d2c-66768f4e7481, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.550 INFO request completed, latency_us: 117, response_code: 200, uri: /port/cid/2, method: GET, req_id: 09dd7adf-31e2-4e61-a91a-60b20deb3f1e, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.555 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/3, method: GET, req_id: c2955e34-23e0-42ae-9876-a2037ad8dee4, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.556 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/4, method: GET, req_id: eac61909-6fa9-4374-9706-c0851ea6969f, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:19.556 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/5, method: GET, req_id: 612ac223-708b-4e8f-b4f3-3fee419979ce, remote_addr: 127.0.0.1:43436, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.672 INFO accepted connection, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.673 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: 11d11bee-85d8-4857-bcde-f16731f6588b, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.674 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: 473a1b71-e77d-49ff-9404-b48628cce57c, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.675 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4cfb4d6b-310e-46e5-b9bc-2b2346abfb49, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.675 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 21760703-5ec9-45a0-b200-6262909a1b5a, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.676 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2260212b-bc46-475e-b7e8-2f7a2400276f, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.678 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/3, method: GET, req_id: 58e2b81f-9513-43c9-a58f-73575047af66, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.678 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/4, method: GET, req_id: 40a7a3a6-f191-42a3-92cb-0ed7d1f8863d, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:28.679 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/5, method: GET, req_id: aa1e4622-9bd2-481d-a644-dd0efb6d98af, remote_addr: 127.0.0.1:41737, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.258 INFO accepted connection, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.259 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: cf8e042f-74a7-4ce0-87f3-facd0fe43074, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.260 INFO request completed, latency_us: 118, response_code: 200, uri: /regioncount, method: GET, req_id: 71e1f2d2-f100-4c6a-b32a-f7ccf9a84fab, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.261 INFO request completed, latency_us: 127, response_code: 200, uri: /port/cid/0, method: GET, req_id: edb1c9f8-eb84-4517-b450-efce1c7e8a42, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.261 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/1, method: GET, req_id: b88f6184-7af2-48d7-848f-ff654a5954aa, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.262 INFO request completed, latency_us: 126, response_code: 200, uri: /port/cid/2, method: GET, req_id: 93ec4952-160b-4d59-b5e7-3f0d3e3e7bf9, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.264 INFO request completed, latency_us: 113, response_code: 200, uri: /port/cid/3, method: GET, req_id: ffb52440-b706-413a-967d-eaabaccedada, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.265 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/4, method: GET, req_id: 71d42958-0478-4804-a881-0fdb1bb54904, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:09:38.265 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/5, method: GET, req_id: cef0a58b-f215-46fb-823e-3b1ae9152fc0, remote_addr: 127.0.0.1:37639, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.842 INFO accepted connection, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.843 INFO request completed, latency_us: 165, response_code: 200, uri: /regioninfo, method: GET, req_id: 2ce71053-8c9e-4e91-9f2e-e763b04586a5, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.844 INFO request completed, latency_us: 116, response_code: 200, uri: /regioncount, method: GET, req_id: f02ebf3b-48ff-41c5-a37e-ab953e8b33e8, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.844 INFO request completed, latency_us: 118, response_code: 200, uri: /port/cid/0, method: GET, req_id: 35429b2f-a9e6-4dd2-9be2-cd900bd858e3, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.845 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: 8c4d2253-dea8-4855-b0ca-c15648f2b762, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.845 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5243707c-fdad-4dfd-94d9-c539af7657dc, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.848 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/3, method: GET, req_id: c019bbbe-a36d-43a1-822b-b504c1d30bbb, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.848 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/4, method: GET, req_id: 43b82693-1a55-4849-8617-328cd5f770c7, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:10:16.849 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/5, method: GET, req_id: 246eb02c-f2e5-42bc-a166-0065f3234727, remote_addr: 127.0.0.1:34136, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.774 INFO accepted connection, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.775 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: c10ffc36-42ed-40fb-bdf9-463587b949f4, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.776 INFO request completed, latency_us: 108, response_code: 200, uri: /regioncount, method: GET, req_id: 15c6fa4d-2a8e-41c5-98e6-1ea775f5e193, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.776 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 140d72b9-afa8-4739-ac1e-f67082812d80, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.777 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/1, method: GET, req_id: 02fb2ce1-c65d-4f92-bb20-3f5ec8b83494, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.777 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 6559593b-6d96-4100-86d2-75094ae6cd51, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.780 INFO request completed, latency_us: 115, response_code: 200, uri: /port/cid/3, method: GET, req_id: acf10bfc-42c4-4410-9d13-47ca452bf974, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.780 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 456825a6-a401-4528-b6d4-22fa0e0db318, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:14:39.781 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6df50c7b-4033-4283-998e-a1b94c5767ba, remote_addr: 127.0.0.1:33983, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.537 INFO accepted connection, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.538 INFO request completed, latency_us: 203, response_code: 200, uri: /regioninfo, method: GET, req_id: df9d65a3-56b7-4367-9568-e2d29fb506b6, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.539 INFO request completed, latency_us: 112, response_code: 200, uri: /regioncount, method: GET, req_id: e9fd1130-8b04-470f-b1cb-83a20ffa730f, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.539 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/0, method: GET, req_id: e3a67e50-09da-4456-85a4-5ba6f1d06d7d, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.540 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2640d895-e7d6-42b9-9027-8f703665cdbf, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.541 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4e50f9b1-1b04-42be-a463-eba8de1e855d, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.543 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/3, method: GET, req_id: d008e9b7-c4fe-4ab6-8354-6b44e707d72b, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.543 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/4, method: GET, req_id: b6a0ff59-6821-43e7-81ab-2626de64462b, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:52.544 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: cc093ebd-266f-480d-b11c-c04f356ba935, remote_addr: 127.0.0.1:50376, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.758 INFO accepted connection, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.759 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: 0b0df977-4a80-47e3-bf8f-ea65511eb5d9, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.760 INFO request completed, latency_us: 111, response_code: 200, uri: /regioncount, method: GET, req_id: e91fd679-6723-475c-bef3-c228e82608af, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.761 INFO request completed, latency_us: 120, response_code: 200, uri: /port/cid/0, method: GET, req_id: 016f1b02-bb19-409a-a19f-7aea6323c2cd, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.761 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 72db4960-1102-413b-b769-b237a97039e0, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.762 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: e9c39815-1751-4d2c-93d8-e161f1fbeabc, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.764 INFO request completed, latency_us: 112, response_code: 200, uri: /port/cid/3, method: GET, req_id: 9676db92-5b8d-465c-818a-b61d5b8689a8, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.764 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 47c8c1e0-b27e-4829-bd29-bb830a8d00d0, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:15:56.765 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/5, method: GET, req_id: 885100a3-6dd1-4dd1-ac43-8b521022132f, remote_addr: 127.0.0.1:33628, local_addr: 127.0.0.1:9998
Jan 28 17:16:00.960 INFO accepted connection, remote_addr: 127.0.0.1:63540, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 6
Jan 28 17:16:00.961 INFO request completed, latency_us: 155, response_code: 204, uri: /disablerestart/all, method: POST, [8810] Disable keep_running
req_id: 0b6a52e0-d6e5-42bb-b329-389a4a4aa0c1, remote_addr:[8830] Disable keep_running
 [8820] Disable keep_running
127.0.0.1:63540, local_addr: 127.0.0[8850] Disable keep_running
.[8860] Disable keep_running
1:9998
[8840] Disable keep_running
Jan 28 17:16:01.022 INFO accepted connection, remote_addr: 127.0.0.1:41547, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 28 17:16:01.022 INFO request completed, latency_us: 188, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 8793c2e3-dc1e-4374-a7ae-e036d9f72163, remote_addr: 127.0.0.1:41547, local_addr:[8830] Got stop action so:false kr:false
 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 28 17:16:01.086 INFO accepted connection, remote_addr: 127.0.0.1:43510, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.087 INFO request completed, latency_us: 173, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5167bbde-fc9c-474f-aab9-2377a540b3f5, remote_addr: 127.0.0.1:43510, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.153 INFO accepted connection, remote_addr: 127.0.0.1:39461, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 28 17:16:01.154 INFO request completed, latency_us: 183, response_code: 204, uri: /start/cid/2, method: POST, req_id: 1b71c8c3-7f1b-4899-b852-33db2bfe3e5c, remote_addr: 127.0.0.1:39461, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.246 INFO accepted connection, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.247 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: 31decf86-e47b-4e68-8aca-b8136a087784, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.248 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: 94c38402-77a2-40a8-8752-691e902846e7, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.249 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: 967c0fa5-1b9c-4388-a563-a926fef55c77, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.249 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: cb22b646-9900-4f47-a048-8102445258e5, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.249 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: a41dbfa5-ad23-4e7d-8817-835ae9583fd0, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.251 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8f7d7667-3dee-417d-8ff3-6e386a62f723, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.252 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9f73e527-f999-4a13-aae4-c95a1abcbdd2, remote_addr: 127.0.0.1:47245, local_addr: 127.0.0.1:9998
Jan 28 17:16:01.252 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: e5f863cf-5e7a-4e17-b21a-32abdf44efcb, remote_addr: 127.0.0.1:47245, 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(1247)
[8830][2] reports Running
Jan 28 17:16:15.523 INFO accepted connection, remote_addr: 127.0.0.1:54582, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Jan 28 17:16:15.524 INFO request completed, latency_us: [8810] Disable keep_running
262[8810] Got stop action so:false kr:false
, response_code: 204, uri: /shutdown, method: POST, req_id: cb60645c-d0f8-4138-9961-02656e12a1ac, remote_addr: 127.0.0.1:54582, local_addr: 127.0.0.1:9998
[8840] Disable keep_running
[8830] Disable keep_running
[8840] Got stop action so:false kr:false
[8830] Got stop action so:false kr:false
[8850] Disable keep_running
[8850] Got stop action so:false kr:false
[8860] Disable keep_running
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8860] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8850][4] 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
/var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --extent-count 300 --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.029364739
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.028036289
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.028443333
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.028289218
Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.028040396
Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.02745718
Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.027409976
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: 100 })
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
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
[8810][0] initial start wait reports Starting
[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
[8840][3] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt"
Starting downstairs at port 8860
[8850][4] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt"
Starting downstairs at port 8870
[8860][5] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt"
[8870][6] initial start wait reports Starting
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1264)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1265)
[8860][5] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1266)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1267)
[8870][6] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1268)
[8850][4] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1269)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1270)
[8810][0] initial start wait reports Running
All downstairs are running
Jan 28 17:16:20.790 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Jan 28 17:16:25.816 INFO accepted connection, remote_addr: 127.0.0.1:38648, local_addr: 127.0.0.1:9998
Jan 28 17:16:25.818 INFO request completed, latency_us: 368, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0211d0f3-c0b2-46ab-9f58-fe7af7812dbd, remote_addr: 127.0.0.1:38648, local_addr: 127.0.0.1:9998
Jan 28 17:16:25.881 INFO accepted connection, remote_addr: 127.0.0.1:62949, local_addr: 127.0.0.1:9998
Jan 28 17:16:25.881 INFO request completed, latency_us: 179, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3b55236c-e1b4-43bc-bbc9-989f3dda1c3e, remote_addr: 127.0.0.1:62949, local_addr: 127.0.0.1:9998
Jan 28 17:16:25.945 INFO accepted connection, remote_addr: 127.0.0.1:50381, local_addr: 127.0.0.1:9998
Jan 28 17:16:25.946 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5911f33f-352a-4373-ad79-0ba8393e386a, remote_addr: 127.0.0.1:50381, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.010 INFO accepted connection, remote_addr: 127.0.0.1:36692, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.011 INFO request completed, latency_us: 186, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7251dab6-4701-4beb-927a-c478dcb5cf22, remote_addr: 127.0.0.1:36692, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.073 INFO accepted connection, remote_addr: 127.0.0.1:51939, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.074 INFO request completed, latency_us: 175, response_code: 200, uri: /state/cid/4, method: GET, req_id: 6ce0a963-8875-42d5-a983-1c09e4e4bbba, remote_addr: 127.0.0.1:51939, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.135 INFO accepted connection, remote_addr: 127.0.0.1:42116, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.136 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/5, method: GET, req_id: 9d243836-d7b3-478b-b867-8ccd9f5ed387, remote_addr: 127.0.0.1:42116, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.198 INFO accepted connection, remote_addr: 127.0.0.1:50136, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.199 INFO request completed, latency_us: 191, response_code: 200, uri: /state/cid/6, method: GET, req_id: 4ae993a2-86bd-466f-98bb-7d9ced31ccab, remote_addr: 127.0.0.1:50136, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.262 INFO accepted connection, remote_addr: 127.0.0.1:39345, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.263 INFO request completed, latency_us: 201, response_code: 200, uri: /port/cid/6, method: GET, req_id: 1ea4898c-6972-4a47-b286-df8a4b332037, remote_addr: 127.0.0.1:39345, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.331 INFO accepted connection, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.331 INFO request completed, latency_us: 205, response_code: 200, uri: /regioninfo, method: GET, req_id: 802b9f84-92ab-4a2d-86bc-0911d3556afb, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.332 INFO request completed, latency_us: 114, response_code: 200, uri: /regioncount, method: GET, req_id: 7d714600-0e14-4b8f-92bc-f7bdd166ab08, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.333 INFO request completed, latency_us: 107, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1df101bd-8fce-4aa1-b44f-35c6f42ebb63, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.334 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/1, method: GET, req_id: 4f93ed9f-90d3-49f8-af31-639f0aaef66e, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.334 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/2, method: GET, req_id: dd3719fe-8650-43f9-b5b8-1662af2e3927, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.336 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5f3237cd-334a-46fc-8ed1-82d8e804aeb0, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.337 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: d7edc5ea-d498-40f5-ac2d-cc6bba6e622d, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.337 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/5, method: GET, req_id: 19a3049a-9c91-45cd-972c-06ade46723c5, remote_addr: 127.0.0.1:63601, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.377 INFO accepted connection, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:16:26.378 INFO request completed, latency_us: 154, response_code: 200, uri: /regioncount, method: GET, req_id: 11b192b0-8a44-412b-8462-4519e8372f40, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Jan 28 17:16:26.564 INFO request completed, latency_us: 236, response_code: 204, uri: /stop/cid/0, method: POST, req_id: d0840f40-36ac-4bc9-8218-c17c66ced9d7, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1[8810] Got stop action so:false kr:false
:9998
Jan 28 17:16:26.565 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/0, method: GET, req_id: 26a44b24-7708-4394-a137-40806274d267, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Jan 28 17:16:30.568 INFO request completed, latency_us: 248, response_code: 200, uri: /state/cid/0, method: GET, req_id: be27ed3e-1289-4611-aac0-746c00b1dbb0, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Jan 28 17:16:30.745 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/0, method: POST, req_id: 6238b950-60f2-4d9f-885c-bf40bdb8b6a8, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:16:30.745 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7cf9df04-e67d-4b2f-a491-e1debefed7ca, remote_addr: 127.0.0.1:63080, 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(1281)
[8810][0] reports Running
Jan 28 17:16:34.748 INFO request completed, latency_us: 339, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3b2111d0-0ae0-4e24-9d71-e8a80a27d8fc, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Jan 28 17:17:05.604 INFO [8820] Got stop action so:false kr:false
request completed, latency_us: 249, response_code: 204, uri: /stop/cid/1, method: POST, req_id: caedba08-b9ae-4ac0-bed5-cd3191bf0200, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:17:05.605 INFO request completed, latency_us: 342, response_code: 200, uri: /state/cid/1, method: GET, req_id: 2a97b54e-67de-4c5f-8a8f-93d61f335a7e, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Jan 28 17:17:09.608 INFO request completed, latency_us: 318, response_code: 200, uri: /state/cid/1, method: GET, req_id: 93cc3d91-5a8b-4531-b63b-d20b47f0a253, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Jan 28 17:17:09.781 INFO request completed, latency_us: 208, response_code: 204, uri: /start/cid/1, method: POST, req_id: 953fe1a7-2960-4c7f-80ac-1efeb7dd9f59, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:17:09.782 INFO request completed, latency_us: 124, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7d2162e2-19c6-4f10-8856-acfc872945e8, remote_addr: 127.0.0.1:63080, 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(1282)
[8820][1] reports Running
Jan 28 17:17:13.785 INFO request completed, latency_us: 520, response_code: 200, uri: /state/cid/1, method: GET, req_id: 92985691-06cb-44c9-aca3-bc0f567ecd56, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 28 17:17:44.816 INFO request completed, latency_us: 210[8830] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 5e216a2f-c3ff-49a8-a145-469708b33fe1, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:17:44.816 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4a601fd0-1d2a-40cd-9b27-2330c11b2bb6, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 28 17:17:48.818 INFO request completed, latency_us: 252, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2952911a-cddb-4743-a4d0-7b712cb974e9, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 28 17:17:48.992 INFO request completed, latency_us: 157, response_code: 204, uri: /start/cid/2, method: POST, req_id: 4e9fe118-0b2f-4744-9306-e9e6834df191, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:17:48.993 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/2, method: GET, req_id: 8fb16f67-71b8-4737-a5d3-55d998cb784f, remote_addr: 127.0.0.1:63080, 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(1283)
[8830][2] reports Running
Jan 28 17:17:52.995 INFO request completed, latency_us: 585, response_code: 200, uri: /state/cid/2, method: GET, req_id: b976ae7b-c19d-4430-857f-2ce0e1ad34d9, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Jan 28 17:18:24.190[8840] Got stop action so:false kr:false
 INFO request completed, latency_us: 231, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 55bbaa51-85f6-44e1-a966-5240d6af8a4f, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:18:24.191 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/3, method: GET, req_id: 01b79694-0761-4e12-89c7-ee06ac2db874, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Jan 28 17:18:28.193 INFO request completed, latency_us: 313, response_code: 200, uri: /state/cid/3, method: GET, req_id: e6a5c762-c6d2-4057-b742-5b9285b709b0, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Jan 28 17:18:28.372 INFO request completed, latency_us: 155, response_code: 204, uri: /start/cid/3, method: POST, req_id: 4c34da18-1b80-4b94-a0ac-7b55df191205, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:18:28.373 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/3, method: GET, req_id: 619fd01e-1f1e-45f1-9d6e-4077873854a3, remote_addr: 127.0.0.1:63080, 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(1284)
[8840][3] reports Running
Jan 28 17:18:32.376 INFO request completed, latency_us: 348, response_code: 200, uri: /state/cid/3, method: GET, req_id: bd25c4b5-31d0-4529-9602-9d992495964a, remote_addr: 127.0.0.1:63080, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.629 INFO accepted connection, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.630 INFO request completed, latency_us: 164, response_code: 200, uri: /regioninfo, method: GET, req_id: d8c92eed-5948-4334-b45c-b3fbeea39b35, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.631 INFO request completed, latency_us: 123, response_code: 200, uri: /regioncount, method: GET, req_id: 895d56c1-92fe-468a-8c92-a3afca861d9f, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.631 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: e6468e9a-4ede-47b5-8340-835a9ec3d500, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.632 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/1, method: GET, req_id: a3a5a26b-16e8-46f3-a9cc-1b0598392546, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.633 INFO request completed, latency_us: 137, response_code: 200, uri: /port/cid/2, method: GET, req_id: 42d1f42f-9eeb-4cfa-87f4-080dc9f5f54b, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.634 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/3, method: GET, req_id: 4974b8cf-2e31-423e-b2e6-44d849751637, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.635 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/4, method: GET, req_id: 41ef9347-d0c5-4342-8ae9-8053260d8b6e, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:03.636 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/5, method: GET, req_id: 616997be-4a86-4a58-92c8-ffe0fc10c154, remote_addr: 127.0.0.1:44309, local_addr: 127.0.0.1:9998
Jan 28 17:19:04.439 INFO accepted connection, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Jan 28 17:19:04.439 INFO request completed, latency_us: 161, response_code: 200, uri: /regioncount, method: GET, req_id: f22870e9-3fe5-49f2-91e8-49aa7c32c9e9, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Jan 28 17:19:08.343 INFO request completed, latency_us: 221, response_code:[8810] Got stop action so:false kr:false
 204, uri: /stop/cid/0, method: POST, req_id: 4db50121-6f00-4464-8469-bbef0a2dd5cd, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Jan 28 17:19:08.344 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/0, method: GET, req_id: e03f5a5f-15cb-4ac5-b3e7-97a302a4945b, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Jan 28 17:19:12.347 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6cd58bc8-c164-493b-8299-04a01d112856, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Jan 28 17:19:45.903 INFO request completed, latency_us: 230, response_code: 204, uri: /start/cid/0, method: POST, req_id: b64e3dee-cc05-4834-bd57-2bee17272a79, remote_addr: 127.0.0.1:33123, 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(1286)
[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
Jan 28 17:19:50.083 INFO request completed, latency_us: 305, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 6541799e-bab8-4484-b73b-988f31f2775a, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Jan 28 17:19:50.084 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/1, method: GET, req_id: aa38ac02-d263-4317-8160-9930d1cca724, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Jan 28 17:19:54.086 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/1, method: GET, req_id: d7685624-64d9-46ce-9d7d-de3220a9aa7f, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Jan 28 17:20:27.628 INFO request completed, latency_us: 279, response_code: 204, uri: /start/cid/1, method: POST, req_id: 5ba554ef-b012-43d5-9f4b-223d706608dc, remote_addr: 127.0.0.1:33123, 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(1287)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Jan 28 17:20:31.810 [8830] Got stop action so:false kr:false
INFO request completed, latency_us: 323, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 5e482a1f-d564-437f-9989-168ba92d9a0e, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Jan 28 17:20:31.811 INFO request completed, latency_us: 140, response_code: 200, uri: /state/cid/2, method: GET, req_id: bb1d75bc-dcd7-4496-8374-6e4c20e98d78, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Jan 28 17:20:35.814 INFO request completed, latency_us: 374, response_code: 200, uri: /state/cid/2, method: GET, req_id: f8536a7a-41d5-44f6-a5c3-cda02098b967, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Jan 28 17:21:09.383 INFO request completed, latency_us: 242, response_code: 204, uri: /start/cid/2, method: POST, req_id: 61414423-bf57-431f-b3dc-97590c41f80f, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Jan 28 17:21:13.571 INFO request completed, latency_us: 195, response_code: 204, uri: /stop/cid/3, method: POST, req_id: e3e87f5b-d868-4ca2-92ea-ef29feb151b7, [8840] Got stop action so:false kr:false
remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Jan 28 17:21:13.572 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/3, method: GET, req_id: cc6bf6e7-ea02-4f75-8d8b-57eb9e2ede9b, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830] got start action
[8830] I am going to restart
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] reports Starting
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1288)
[8830][2] reports Running
Jan 28 17:21:17.575 INFO request completed, latency_us: 324, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8585da5e-f796-4a73-b5eb-7202e1b9dacc, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Jan 28 17:21:51.141 INFO request completed, latency_us: 214, response_code: 204, uri: /start/cid/3, method: POST, req_id: 743948d8-45f8-4a6b-b3cf-04776bb895af, remote_addr: 127.0.0.1:33123, 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(1289)
[8840][3] reports Running
Main task has work to do, go find it
got dsc Stop(4)
stop 4
Jan 28 17:21:55.373[8850] Got stop action so:false kr:false
 INFO request completed, latency_us: 357, response_code: 204, uri: /stop/cid/4, method: POST, req_id: a4ee56c2-b7fc-4fea-a4e1-9379b1bea9c7, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Jan 28 17:21:55.374 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/4, method: GET, req_id: e65b5e32-7322-48a9-8f22-ca42dfdb010f, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
[8850] Exited with: ExitStatus(unix_wait_status(9))
[8850][4] reports Exit
Jan 28 17:21:59.377 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/4, method: GET, req_id: 824d9838-92e7-4479-9265-182098a936e6, remote_addr: 127.0.0.1:33123, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(4)
start 4
Jan 28 17:22:32.947 INFO request completed, latency_us: 292, response_code: 204, uri: /start/cid/4, method: POST, req_id: b59eb121-db21-449b-a68e-2f6dd23aebfd, remote_addr: 127.0.0.1:33123, 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(1290)
[8850][4] reports Running
Jan 28 17:22:37.018 INFO accepted connection, remote_addr: 127.0.0.1:42194, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Jan 28 17:22:37.019 INFO request completed, latency_us: 192, response_code: 204, uri: /shutdown, method: POSTShut it down
, [8810] Disable keep_running
req_id[8810] Got stop action so:false kr:false
: f3f58a58-2272-4558-a60b-a89bab4f6fb9, remote_addr: 127.0.0.1:42194, local_addr: 127.0.0.1:9998
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8850] Disable keep_running
[8840] Disable keep_running
[8850] 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
[8870] Disable keep_running
[8870] Got stop action so:false kr:false
[8820] Disable keep_running
[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))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8860][5] reports Exit
[8810][0] reports Exit
[8820][1] reports Exit
[8870] Exited with: ExitStatus(unix_wait_status(9))
[8870][6] reports Exit