/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.17921598 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.011596631 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.010515117 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.010329962 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010317653 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010465894 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 start access at:127.0.0.1:9998 Starting downstairs at port 8840 Starting downstairs at port 8820 Starting downstairs at port 8810 Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8840][3] initial start wait reports Starting Starting downstairs at port 8850 [8820][1] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8810][0] initial start wait reports Starting Starting downstairs at port 8860 [8830][2] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8850][4] initial start wait reports Starting [8860][5] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1141) Mar 31 18:33:20.658 INFO listening, local_addr: 127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1143) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1140) Control access at:127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1139) Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1142) Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1138) [8840][3] initial start wait reports Running [8850][4] initial start wait reports Running [8830][2] initial start wait reports Running [8820][1] initial start wait reports Running [8860][5] initial start wait reports Running [8810][0] initial start wait reports Running All downstairs are running Mar 31 18:33:25.670 INFO accepted connection, remote_addr: 127.0.0.1:48581, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.672 INFO request completed, latency_us: 394, response_code: 200, uri: /state/cid/0, method: GET, req_id: 548c2ca8-c26e-493d-8112-ea850345a23e, remote_addr: 127.0.0.1:48581, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.685 INFO accepted connection, remote_addr: 127.0.0.1:64576, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.686 INFO request completed, latency_us: 80, response_code: 200, uri: /state/cid/1, method: GET, req_id: f835e173-814d-4bb2-804f-0a7f7dd56199, remote_addr: 127.0.0.1:64576, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.699 INFO accepted connection, remote_addr: 127.0.0.1:59119, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.699 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/2, method: GET, req_id: adec6805-68a7-4147-adde-644e985af69f, remote_addr: 127.0.0.1:59119, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.712 INFO accepted connection, remote_addr: 127.0.0.1:35166, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.712 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/3, method: GET, req_id: 4a52546f-ca9a-4010-9a96-f430ad44bc4c, remote_addr: 127.0.0.1:35166, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.725 INFO accepted connection, remote_addr: 127.0.0.1:53070, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.725 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/4, method: GET, req_id: 2310436e-3139-46c0-808d-93827befa431, remote_addr: 127.0.0.1:53070, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.738 INFO accepted connection, remote_addr: 127.0.0.1:62709, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.739 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/5, method: GET, req_id: d0874f2f-4b17-4ed0-8c73-6ede018bb4f2, remote_addr: 127.0.0.1:62709, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.751 INFO accepted connection, remote_addr: 127.0.0.1:38489, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Mar 31 18:33:25.752 INFO request completed, latency_us: 109, response_code: 204, uri: /disablerestart/all, method: POST, req_id: e22f6395-3e3b-4324-af5b-6a3a1f6b720f, remote_addr: 127.0[8820] Disable keep_running .0.[8810] Disable keep_running 1[8840] Disable keep_running :[8850] Disable keep_running 38489, local_addr: [8860] Disable keep_running 127.0.0.1:9998 [8830] Disable keep_running Mar 31 18:33:25.815 INFO accepted connection, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.816 INFO request completed, latency_us: 288, response_code: 200, uri: /regioninfo, method: GET, req_id: 8c685184-3764-4278-8403-2abc89f7f1fd, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.818 INFO request completed, latency_us: 32, response_code: 200, uri: /regioncount, method: GET, req_id: d0552a4c-cf28-4b5c-a0e1-fb2554c992ac, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.818 INFO request completed, latency_us: 52, response_code: 200, uri: /port/cid/0, method: GET, req_id: aeb77196-dad4-4e12-baff-8af77fbe383e, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.818 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/1, method: GET, req_id: f5878081-36bb-4b08-9185-85b0ec40eb59, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.818 INFO request completed, latency_us: 22, response_code: 200, uri: /port/cid/2, method: GET, req_id: ae5d1cf7-ad12-4ee7-b768-37e8824c0cbb, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.823 INFO request completed, latency_us: 50, response_code: 200, uri: /port/cid/3, method: GET, req_id: 75264fb4-b090-44a9-a15f-fbedb2036319, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.823 INFO request completed, latency_us: 66, response_code: 200, uri: /port/cid/4, method: GET, req_id: b7ce0813-b669-4691-bc3c-d98ed4b868c3, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:25.823 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: cabb1af6-643b-4768-9fdb-1a4a3369e2d9, remote_addr: 127.0.0.1:46430, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.884 INFO accepted connection, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.884 INFO request completed, latency_us: 179, response_code: 200, uri: /regioninfo, method: GET, req_id: 24f9b821-7f94-45ad-b8d9-e3e189e272a8, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.885 INFO request completed, latency_us: 72, response_code: 200, uri: /regioncount, method: GET, req_id: 17a529e0-ebde-4b79-b822-f8201521fa76, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.885 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0d78206d-52eb-4126-89b4-39e80c516cf5, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.886 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2a7edff8-bf75-422b-84b1-28ca46828fd3, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.886 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/2, method: GET, req_id: fd2d5e03-5090-48e3-a4b0-b215552800ac, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.887 INFO request completed, latency_us: 80, response_code: 200, uri: /port/cid/3, method: GET, req_id: 20bb4a8f-91c4-485c-bdaa-105329b09159, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.887 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/4, method: GET, req_id: 8c2513e7-cce1-4f60-afde-d6694dfd2c09, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:34.888 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: f055d014-6aa7-4cb1-8d0d-ee2827f3c21e, remote_addr: 127.0.0.1:63638, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.195 INFO accepted connection, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.196 INFO request completed, latency_us: 193, response_code: 200, uri: /regioninfo, method: GET, req_id: b3dbefaf-b294-4a2b-bbdb-ac1f5db4ab68, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.197 INFO request completed, latency_us: 68, response_code: 200, uri: /regioncount, method: GET, req_id: 3a123861-08c5-4cd9-8f87-62bfab01f51f, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.197 INFO request completed, latency_us: 72, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0acccf89-9110-4dcb-9447-b66376274da2, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.197 INFO request completed, latency_us: 60, response_code: 200, uri: /port/cid/1, method: GET, req_id: 70d10a17-9419-4615-a7a5-5358973d7652, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.198 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/2, method: GET, req_id: da57516d-0d6b-43fa-8ddc-824e44a7dc48, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.199 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/3, method: GET, req_id: 44348bb8-c47b-4d2e-a510-994798733035, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.199 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0a945827-eccd-4b30-8c0b-7263319bec74, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:33:44.200 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/5, method: GET, req_id: b001fd75-9cdd-48bb-94e6-db10cf5ba218, remote_addr: 127.0.0.1:64353, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.888 INFO accepted connection, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.889 INFO request completed, latency_us: 193, response_code: 200, uri: /regioninfo, method: GET, req_id: 01e932f9-ac9b-43b1-8c4c-0c757b361236, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.890 INFO request completed, latency_us: 82, response_code: 200, uri: /regioncount, method: GET, req_id: 12b2368e-bc3f-4171-b57d-dd46bbf07baf, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.891 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/0, method: GET, req_id: d0c8f32d-90ea-42a1-8c27-e8b820857857, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.891 INFO request completed, latency_us: 46, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6d7825ac-973c-4cea-af0a-a76d2259b222, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.891 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: c1d11b24-a519-4f19-92eb-0727d5576250, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.893 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/3, method: GET, req_id: 71d0de23-9e8c-4d19-a08f-2ab236cd8663, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.893 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/4, method: GET, req_id: e703957d-be81-4c56-a258-3fd2cb03aea2, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:34:08.894 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: 25d4a2fa-2ba6-472d-bd85-df0d1c275459, remote_addr: 127.0.0.1:61342, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.200 INFO accepted connection, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.201 INFO request completed, latency_us: 192, response_code: 200, uri: /regioninfo, method: GET, req_id: 8ff3b6b1-fc9e-4ac1-9c8c-d897a8070016, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.202 INFO request completed, latency_us: 56, response_code: 200, uri: /regioncount, method: GET, req_id: a9e42075-760e-4546-a333-18d365a78178, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.202 INFO request completed, latency_us: 68, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9e4dc8b4-1528-4d7f-b664-2f96427a3fe5, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.202 INFO request completed, latency_us: 46, response_code: 200, uri: /port/cid/1, method: GET, req_id: a7d72ba5-8af3-475b-ac65-78c51c2ecc89, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.203 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/2, method: GET, req_id: 555a0fec-0540-4db0-951b-de56ff4afd40, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.204 INFO request completed, latency_us: 52, response_code: 200, uri: /port/cid/3, method: GET, req_id: 91769648-5a89-4f52-a8cc-d87bec581f32, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.204 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/4, method: GET, req_id: a0be3ecc-f408-467e-b52b-3d76557dc06c, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:41.205 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/5, method: GET, req_id: be54f8b8-eba6-4fe2-ac7a-b451f4573577, remote_addr: 127.0.0.1:65353, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.891 INFO accepted connection, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.891 INFO request completed, latency_us: 141, response_code: 200, uri: /regioninfo, method: GET, req_id: 49848a9f-baed-4f85-86a7-6a83fc91284d, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.892 INFO request completed, latency_us: 31, response_code: 200, uri: /regioncount, method: GET, req_id: 4065e9e7-c2c0-42ef-abe0-48a30521c75c, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.892 INFO request completed, latency_us: 50, response_code: 200, uri: /port/cid/0, method: GET, req_id: bf542c74-65a3-453d-8c2d-4aef8aa14d03, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.892 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5004c30e-3ea5-4c64-b26a-4db138ac822e, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.892 INFO request completed, latency_us: 21, response_code: 200, uri: /port/cid/2, method: GET, req_id: 595cede1-be3c-4109-b02d-c7080cd56975, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.894 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/3, method: GET, req_id: d0a27ac5-9dfd-49fa-8371-8db1b5e19b6d, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.894 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/4, method: GET, req_id: 36be97f1-ba60-47eb-b4d0-bc027f51953e, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:36:57.894 INFO request completed, latency_us: 22, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1d8fa467-d6d4-4087-9f00-e00f69d1befc, remote_addr: 127.0.0.1:35905, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.002 INFO accepted connection, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.003 INFO request completed, latency_us: 168, response_code: 200, uri: /regioninfo, method: GET, req_id: cf5d6574-4052-4f13-83f1-327edd1a4459, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.003 INFO request completed, latency_us: 40, response_code: 200, uri: /regioncount, method: GET, req_id: fe47bc99-d563-4eba-9873-9a90644e8714, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.004 INFO request completed, latency_us: 79, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0f2d688e-3d8f-42bf-bcd4-180aac0e1c53, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.004 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/1, method: GET, req_id: 08599c6a-dc1e-4452-851d-a222392e11a7, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.004 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7a27e24b-93a6-4716-874e-d82c5bcc0a2d, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.006 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/3, method: GET, req_id: 958c2954-3cfd-4dc9-b17d-1c02b81d96cb, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.006 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/4, method: GET, req_id: 81c64a28-72a6-4421-b4c7-558e7af8ba75, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:02.006 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/5, method: GET, req_id: addbf6c0-2f59-4a07-9c7e-750ab161391f, remote_addr: 127.0.0.1:50783, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.104 INFO accepted connection, remote_addr: 127.0.0.1:33744, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Mar 31 18:37:06.104 INFO request completed, latency_us: 126, response_code: 204, uri: /disablerestart/all, method: POST, req_id: e2e8981e-8e90-4d3e-8410-b6dc214d6fac, remote_addr: 127.0.0.1:33744, local_addr: 127.0.0.[8820] Disable keep_running 1[8810] Disable keep_running :[8840] Disable keep_running 9998[8860] Disable keep_running [8850] Disable keep_running [8830] Disable keep_running Mar 31 18:37:06.118 INFO accepted connection, remote_addr: 127.0.0.1:56994, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) Mar 31 18:37:06.119 stop 2 INFO request completed, latency_us: 102, response_code: 204, uri: /stop/cid/2, method: POST, req_id: fb9fe78e-b854-496b-8917-3a25e80404db, remote_addr: 127.0.0.1:56994, local_addr: 127.0.0.1:9998 [8830] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Mar 31 18:37:06.133 INFO accepted connection, remote_addr: 127.0.0.1:33960, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.133 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2f6ebb9f-1cdd-4b14-a05d-c3aba5e31b2c, remote_addr: 127.0.0.1:33960, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.149 INFO accepted connection, remote_addr: 127.0.0.1:50906, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Mar 31 18:37:06.149 INFO request completed, latency_us: 73, response_code: 204, uri: /start/cid/2, method: POST, req_id: 176ae1be-e5b4-4a47-8e5a-55dd987dffbc, remote_addr: 127.0.0.1:50906, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.182 INFO accepted connection, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.182 INFO request completed, latency_us: 91, response_code: 200, uri: /regioninfo, method: GET, req_id: da1b158e-46ad-4d9b-8dcf-1f828202aeac, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.183 INFO request completed, latency_us: 66, response_code: 200, uri: /regioncount, method: GET, req_id: dd16670a-72c9-456f-88e6-9f3eb99bd4ad, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.183 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2d9c5da1-2b86-47a4-9ae4-ab3edf86772f, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.184 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/1, method: GET, req_id: b2235ccc-6495-4aa3-a5c5-ede670ae48b4, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.184 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 71fdc880-681e-4551-82d6-39f5b53942ca, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.185 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/3, method: GET, req_id: d3352e0a-4275-45b9-abbd-d24316dbb99c, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.185 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/4, method: GET, req_id: 73f77b71-f8a9-4ddc-ba3f-ca853855e04d, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 Mar 31 18:37:06.186 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/5, method: GET, req_id: c0374472-4527-4bac-8398-adae754d2bf9, remote_addr: 127.0.0.1:53646, local_addr: 127.0.0.1:9998 [8830] got start action [8830] I am going to restart Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1194) [8830][2] reports Running Mar 31 18:37:30.328 INFO accepted connection, remote_addr: 127.0.0.1:52843, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Mar 31 18:37:30.328 INFOShut it down request completed, latency_us: 129, response_code: 204, uri: /shutdown, method: [8810] Disable keep_running POST[8810] Got stop action so:false kr:false , req_id[8830] Disable keep_running :[8830] Got stop action so:false kr:false [8840] Disable keep_running 83460fad-3457-4538-b3d1-abec80c5df76[8850] Disable keep_running , [8850] Got stop action so:false kr:false remote_addr: 127.0.0.1:52843, local_addr: 127.0.0.1:9998 [8820] Disable keep_running [8820] Got stop action so:false kr:false [8860] Disable keep_running [8860] Got stop action so:false kr:false [8840] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8850] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [8810][0] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] 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.030355083 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.027575448 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.026734602 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.026200444 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.025441237 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024509175 Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.032617815 Created 7 regions /var/tmp/bins/dsc start --region-count 7 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Using existing output directory "/tmp/test_up-build/dsc" Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 400 }) start ds: 8810 start access at:127.0.0.1:9998 start ds: 8820 start ds: 8830 start ds: 8840 start ds: 8850 start ds: 8860 start ds: 8870 Starting downstairs at port 8810 Starting downstairs at port 8820 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 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] initial start wait reports Starting Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8850][4] initial start wait reports Starting 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 Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1212) Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1213) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1217) Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1211) [8860][5] initial start wait reports Running [8810][0] initial start wait reports Running [8850][4] initial start wait reports Running [8870][6] initial start wait reports Running Control access at:127.0.0.1:9998 Mar 31 18:37:35.546 INFO listening, local_addr: 127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1216) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1215) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1214) [8840][3] initial start wait reports Running All downstairs are running Mar 31 18:37:40.557 INFO accepted connection, remote_addr: 127.0.0.1:57378, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.558 INFO request completed, latency_us: 260, response_code: 200, uri: /state/cid/0, method: GET, req_id: e6675dce-0947-43ef-8217-97de71216e5b, remote_addr: 127.0.0.1:57378, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.573 INFO accepted connection, remote_addr: 127.0.0.1:46206, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.573 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/1, method: GET, req_id: fbf81f18-1824-4085-baaf-a8aec34cd6fe, remote_addr: 127.0.0.1:46206, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.587 INFO accepted connection, remote_addr: 127.0.0.1:45618, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.587 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/2, method: GET, req_id: 25432892-93b1-48a7-8887-7388ed0209af, remote_addr: 127.0.0.1:45618, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.600 INFO accepted connection, remote_addr: 127.0.0.1:45333, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.601 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/3, method: GET, req_id: dbcd7072-7178-4b5a-9498-26258dee06e1, remote_addr: 127.0.0.1:45333, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.614 INFO accepted connection, remote_addr: 127.0.0.1:47432, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.614 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/4, method: GET, req_id: edd6893b-83ac-45cd-aede-60b17ccc6c1f, remote_addr: 127.0.0.1:47432, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.627 INFO accepted connection, remote_addr: 127.0.0.1:43399, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.628 INFO request completed, latency_us: 56, response_code: 200, uri: /state/cid/5, method: GET, req_id: 4ccfc43e-6e63-4e8c-82fe-7b9faf38936a, remote_addr: 127.0.0.1:43399, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.641 INFO accepted connection, remote_addr: 127.0.0.1:61631, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.641 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/6, method: GET, req_id: ea747738-dd47-422d-9670-7bf196332de5, remote_addr: 127.0.0.1:61631, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.654 INFO accepted connection, remote_addr: 127.0.0.1:39300, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.654 INFO request completed, latency_us: 77, response_code: 200, uri: /port/cid/6, method: GET, req_id: 83a8dbfe-fd77-4fdf-89e9-2eb7a87c9a2a, remote_addr: 127.0.0.1:39300, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.672 INFO accepted connection, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.673 INFO request completed, latency_us: 113, response_code: 200, uri: /regioninfo, method: GET, req_id: 15a9213d-222b-453d-83f3-f9cfcc879972, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.674 INFO request completed, latency_us: 45, response_code: 200, uri: /regioncount, method: GET, req_id: 59f71e07-19ae-4273-a3a6-dc9d7b911cf3, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.674 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/0, method: GET, req_id: 88b64b11-be87-438c-b34b-772b560d9b5b, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.674 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7cdb0f77-1884-4b58-8a99-95395abaa63b, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.674 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: 47a59194-b8d3-4325-a6bc-2b13eb0238a5, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.675 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/3, method: GET, req_id: b8d36be6-383d-44dc-8787-7beb5ff750ba, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.676 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/4, method: GET, req_id: 77cc9250-ee1b-49e6-ba30-d9d0a8fd9b34, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.676 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/5, method: GET, req_id: e27679d2-c9c6-48ab-9059-803193853214, remote_addr: 127.0.0.1:43075, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.698 INFO accepted connection, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:37:40.699 INFO request completed, latency_us: 128, response_code: 200, uri: /regioncount, method: GET, req_id: 7886e400-a450-47ac-b61c-bae36f6d48e3, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Mar 31 18:37:41.087 [8810] Got stop action so:false kr:false INFO request completed, latency_us: 237, response_code: 204, uri: /stop/cid/0, method: POST, req_id: ef27d236-ab1c-40c4-8ccb-6a3e0fdd7eba, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:37:41.087 INFO request completed, latency_us: 90, response_code: 200, uri: /state/cid/0, method: GET, req_id: c21ca89b-5c30-4643-b3b9-1c38ddc1a4a5, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Mar 31 18:37:45.090 INFO request completed, latency_us: 283, response_code: 200, uri: /state/cid/0, method: GET, req_id: b6c4f0f5-4d50-4e3d-ac8f-932d8f8b7edf, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Mar 31 18:37:45.485 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/0, method: POST, req_id: 4f784cf0-481d-4d89-97f0-1edcec901357, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:37:45.486 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6fc8c112-5009-4d1c-b2da-954db43e5444, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1228) [8810][0] reports Running Mar 31 18:37:49.489 INFO request completed, latency_us: 241, response_code: 200, uri: /state/cid/0, method: GET, req_id: b61192dc-2e70-4a71-a092-996774250e60, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Mar 31 18:37:55.882 INFO request completed, latency_us: 228, response_code: 204, uri: /stop/cid/0, method[8810] Got stop action so:false kr:false : POST, req_id: 0ad3eec8-f4e7-49dc-9ca4-51923c341ba9, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:37:55.882 INFO request completed, latency_us: 116, response_code: 200, uri: /state/cid/0, method: GET, req_id: 956fcdf7-84be-42d4-9640-ec1d87a17609, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Mar 31 18:37:59.884 INFO request completed, latency_us: 332, response_code: 200, uri: /state/cid/0, method: GET, req_id: fd4eb767-569b-42b9-887a-d050c92775c0, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Mar 31 18:38:00.286 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/0, method: POST, req_id: b972dd9e-4df6-4eac-bddb-e6cd4fb6a058, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:00.286 INFO request completed, latency_us: 46, response_code: 200, uri: /state/cid/0, method: GET, req_id: 27dcd51e-c076-4044-ab2c-5f5ee539b780, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1229) [8810][0] reports Running Mar 31 18:38:04.288 INFO request completed, latency_us: 261, response_code: 200, uri: /state/cid/0, method: GET, req_id: 59fcd7ad-2038-42f8-bbec-243442bbf0a6, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Mar 31 18:38:09.681 INFO request completed, latency_us: 211, response_code[8810] Got stop action so:false kr:false : 204, uri: /stop/cid/0, method: POST, req_id: 2bbda852-ab46-4961-8b02-bde6e11a8b3e, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:09.681 INFO request completed, latency_us: 84, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0546b355-1556-4e19-b0b6-25ff85313d7d, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Mar 31 18:38:13.684 INFO request completed, latency_us: 297, response_code: 200, uri: /state/cid/0, method: GET, req_id: f0f898ec-27ba-445b-bcb8-f029f88e8ecb, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Mar 31 18:38:14.089 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/0, method: POST, req_id: 1fd39b07-8c83-489b-8986-139ea25d7501, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:14.090 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/0, method: GET, req_id: ca532f98-7d45-44bb-920a-6871dbd12799, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1230) [8810][0] reports Running Mar 31 18:38:18.093 INFO request completed, latency_us: 245, response_code: 200, uri: /state/cid/0, method: GET, req_id: 73ba3ed8-b276-4118-b0a4-3613c8d47687, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Mar 31 18:38:22.487[8810] Got stop action so:false kr:false INFO request completed, latency_us: 219, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 95da368c-32be-45fb-a412-ee47458ef570, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:22.488 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8303bbca-be2a-40b6-be70-3ed5b46424e1, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Mar 31 18:38:26.490 INFO request completed, latency_us: 255, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4d45c518-e131-4ae2-9363-82d66b1e2e80, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Mar 31 18:38:26.897 INFO request completed, latency_us: 222, response_code: 204, uri: /start/cid/0, method: POST, req_id: 95c45664-4b15-4aae-ba39-0b7125903002, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:26.898 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/0, method: GET, req_id: 44f65c31-c71d-4488-9870-5b2520f123ac, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:30.900 INFO request completed, latency_us: 258, response_code: 200, uri: /state/cid/0, method: GET, req_id: 299b31ce-3825-4705-9a03-84431c199463, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1231) [8810][0] reports Running Mar 31 18:38:34.902 INFO request completed, latency_us: 238, response_code: 200, uri: /state/cid/0, method: GET, req_id: 63e257fa-8796-4f9c-a345-0d27bf5a0231, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 [8810] Got stop action so:false kr:false Mar 31 18:38:38.296 INFO request completed, latency_us: 219, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 03bf6bf4-878d-4d51-9484-e9b020734019, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:38.296 INFO request completed, latency_us: 94, response_code: 200, uri: /state/cid/0, method: GET, req_id: acb89f53-323c-435a-82bc-a637cce9bd1d, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Mar 31 18:38:42.298 INFO request completed, latency_us: 280, response_code: 200, uri: /state/cid/0, method: GET, req_id: 24025569-386a-4f80-b956-d9a789b5e257, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Mar 31 18:38:42.703 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/0, method: POST, req_id: 48573f98-58a4-46b5-8b28-78e98d214036, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:42.704 INFO request completed, latency_us: 48, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7eb6f205-aa05-4aea-810a-3f6e16ff26aa, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1232) [8810][0] reports Running Mar 31 18:38:46.706 INFO request completed, latency_us: 270, response_code: 200, uri: /state/cid/0, method: GET, req_id: cca7b461-2ee6-4b82-9744-bad34f53ab71, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Mar 31 18:38:49.098 [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: 6718d4f2-6a52-4859-b3a7-11577e06095e, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:49.099 INFO request completed, latency_us: 50, response_code: 200, uri: /state/cid/0, method: GET, req_id: 74c0ae54-e7fd-4c40-9c9a-8901e24d2ec3, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Mar 31 18:38:53.101 INFO request completed, latency_us: 268, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7e7afe46-64fe-427c-82e0-5584526d2dd9, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Mar 31 18:38:53.506 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/0, method: POST, req_id: c6bad1bb-1d48-4157-823a-4032ccd7af24, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:38:53.507 INFO request completed, latency_us: 194, response_code: 200, uri: /state/cid/0, method: GET, req_id: c6a6879b-e7bf-432e-8cb4-04de91b5f627, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1233) [8810][0] reports Running Mar 31 18:38:57.509 INFO request completed, latency_us: 264, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5d14a419-8cc7-49a4-8cf7-101b00cc4cfa, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Mar 31 18:39:24.987[8820] Got stop action so:false kr:false INFO request completed, latency_us: 232, response_code: 204, uri: /stop/cid/1, method: POST, req_id: faa2e5f0-2870-4694-8318-62820222fc16, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:39:24.987 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/1, method: GET, req_id: a2eca598-1e1b-45c2-84d3-ca1a08a6baa1, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Mar 31 18:39:28.990 INFO request completed, latency_us: 268, response_code: 200, uri: /state/cid/1, method: GET, req_id: a0d6d1ee-d3f5-47e4-bcc6-1bffe6c0ec8d, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Mar 31 18:39:29.394 INFO request completed, latency_us: 240, response_code: 204, uri: /start/cid/1, method: POST, req_id: 2e09e73e-fd6c-4c5b-bd68-c3cf4948e855, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:39:29.394 INFO request completed, latency_us: 72, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5d82c7b1-85dd-4617-ad01-58bfc6822d23, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8820] got start action [8820] I am going to restart Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1234) [8820][1] reports Running Mar 31 18:39:33.396 INFO request completed, latency_us: 230, response_code: 200, uri: /state/cid/1, method: GET, req_id: 69921a16-a629-46f5-a107-852f9784ec42, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 [8830] Got stop action so:false kr:false Mar 31 18:40:00.990 INFO request completed, latency_us: 214, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 14c10ee3-87c6-4212-ad3d-0a6e44772976, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:40:00.990 INFO request completed, latency_us: 79, response_code: 200, uri: /state/cid/2, method: GET, req_id: bca864c0-8000-4bba-a65a-2783199857f3, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Mar 31 18:40:04.992 INFO request completed, latency_us: 268, response_code: 200, uri: /state/cid/2, method: GET, req_id: b34408ab-6ce2-4003-9ade-d6294c29eae5, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Mar 31 18:40:05.395 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/2, method: POST, req_id: 97b6c315-093d-409a-99a8-5c39f7901e3e, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:40:05.395 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3dea049a-3260-4050-856a-7000c4efd80a, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:40:09.398 INFO request completed, latency_us: 293, response_code: 200, uri: /state/cid/2, method: GET, req_id: c7d7f33a-61cd-45cf-aecd-947ef47c744e, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8830] got start action [8830] I am going to restart Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1235) [8830][2] reports Running Mar 31 18:40:13.400 INFO request completed, latency_us: 241, response_code: 200, uri: /state/cid/2, method: GET, req_id: e39d5b00-4d76-4094-bd85-802f74442697, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 [8840] Got stop action so:false kr:false Mar 31 18:40:41.233 INFO request completed, latency_us: 225, response_code: 204, uri: /stop/cid/3, method: POST, req_id: fcdee6d5-3e81-452d-a27c-3cb3a03b0aa4, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:40:41.234 INFO request completed, latency_us: 70, response_code: 200, uri: /state/cid/3, method: GET, req_id: 09ad1036-2cf9-465a-bf2e-2423c819cd86, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Mar 31 18:40:45.236 INFO request completed, latency_us: 246, response_code: 200, uri: /state/cid/3, method: GET, req_id: 3666557e-874e-4b16-a702-97e4aca35800, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Mar 31 18:40:45.649 INFO request completed, latency_us: 213, response_code: 204, uri: /start/cid/3, method: POST, req_id: b0420ca5-c6a5-432e-8a41-360f4805c56d, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:40:45.649 INFO request completed, latency_us: 46, response_code: 200, uri: /state/cid/3, method: GET, req_id: b5b25df1-fcb3-43ef-a6d9-0f7ab5bd9d93, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 [8840] got start action [8840] I am going to restart Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] reports Starting Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1236) [8840][3] reports Running Mar 31 18:40:49.651 INFO request completed, latency_us: 270, response_code: 200, uri: /state/cid/3, method: GET, req_id: 516056f4-13df-4b33-a9b6-c6fc97ad0ae5, remote_addr: 127.0.0.1:46991, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.348 INFO accepted connection, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.348 INFO request completed, latency_us: 153, response_code: 200, uri: /regioninfo, method: GET, req_id: 04a6cc63-546c-43be-a153-5f6eddbd13c5, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.349 INFO request completed, latency_us: 33, response_code: 200, uri: /regioncount, method: GET, req_id: f3321fc7-6320-430c-8494-769672cf6c0c, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.349 INFO request completed, latency_us: 49, response_code: 200, uri: /port/cid/0, method: GET, req_id: 56b2941a-4be5-4b85-b20e-33ccedac4480, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.349 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/1, method: GET, req_id: 00a40e3f-f5d1-43af-b4e6-8e0efd477ce6, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.349 INFO request completed, latency_us: 22, response_code: 200, uri: /port/cid/2, method: GET, req_id: f92f20f3-6cd4-4fa8-924e-241762d63b4a, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.351 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7ffb6161-35fd-4e96-89ea-6a7514c35da9, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.351 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: af0d849c-99bf-4620-98b2-34a4522e7d7e, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.351 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/5, method: GET, req_id: 27d2b394-74c4-47d6-9aab-6d0f5b3f8c59, remote_addr: 127.0.0.1:62897, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.534 INFO accepted connection, remote_addr: 127.0.0.1:45004, local_addr: 127.0.0.1:9998 Mar 31 18:41:17.534 INFO request completed, latency_us: 125, response_code: 200, uri: /regioncount, method: GET, req_id: 68582e1b-f484-4060-8ae7-7398af6f33e5, remote_addr: 127.0.0.1:45004, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Mar 31 18:41:23.246 INFO [8810] Got stop action so:false kr:false request completed, latency_us: 224, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 5d806cdd-f9b1-43d1-a1f6-986e3233d715, remote_addr: 127.0.0.1:45004, local_addr: 127.0.0.1:9998 Mar 31 18:41:23.246 INFO request completed, latency_us: 55, response_code: 200, uri: /state/cid/0, method: GET, req_id: abbcca93-425b-4a28-808c-192f0e173bc5, remote_addr: 127.0.0.1:45004, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Mar 31 18:41:27.249 INFO request completed, latency_us: 233, response_code: 200, uri: /state/cid/0, method: GET, req_id: d5378c76-f4b4-40c8-b6ed-89f46e310e9f, remote_addr: 127.0.0.1:45004, local_addr: 127.0.0.1:9998 Mar 31 18:42:04.674 INFO accepted connection, remote_addr: 127.0.0.1:41021, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) Mar 31 18:42:04.674 INFO request completed, start 0 latency_us: 177, response_code: 204, uri: /start/cid/0, method: POST, req_id: 6405061f-d617-473b-a8bf-1bb8982836fe, remote_addr: 127.0.0.1:41021, local_addr: 127.0.0.1:9998 [8810] got start action [8810] I am going to restart Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1238) [8810][0] reports Running Main task has work to do, go find it got dsc Stop(1) stop 1 Mar 31 18:42:09.076 INFO request completed, [8820] Got stop action so:false kr:false latency_us: 243, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 8fbd59f6-121c-4484-87d1-5abf3ccba507, remote_addr: 127.0.0.1:41021, local_addr: 127.0.0.1:9998 Mar 31 18:42:09.077 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1c3fd569-2a84-4364-95fd-23a7e03166b4, remote_addr: 127.0.0.1:41021, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Mar 31 18:42:13.079 INFO request completed, latency_us: 261, response_code: 200, uri: /state/cid/1, method: GET, req_id: ed7016c8-662a-412d-9362-aa0c06aacbd3, remote_addr: 127.0.0.1:41021, local_addr: 127.0.0.1:9998 Mar 31 18:42:50.493 INFO accepted connection, remote_addr: 127.0.0.1:33880, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Mar 31 18:42:50.494 INFO request completed, latency_us: 163, response_code: 204, uri: /start/cid/1, method: POST, req_id: fd40a273-25d1-4da7-aa74-49d4a1c69796, remote_addr: 127.0.0.1:33880, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Mar 31 18:42:54.904 INFO request completed, [8830] Got stop action so:false kr:false latency_us: 217, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 857eabc3-7048-4433-933a-617a34e65e39, remote_addr: 127.0.0.1:33880, local_addr: 127.0.0.1:9998 Mar 31 18:42:54.904 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2cd475af-a44c-4f2a-a67c-c35845bfcd96, remote_addr: 127.0.0.1:33880, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] got start action [8820] I am going to restart Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1239) [8820][1] reports Running Mar 31 18:42:58.907 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/2, method: GET, req_id: ecf9fa1b-a9e2-407b-b922-e2d339493e3e, remote_addr: 127.0.0.1:33880, local_addr: 127.0.0.1:9998 Mar 31 18:43:36.347 INFO accepted connection, remote_addr: 127.0.0.1:56754, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Mar 31 18:43:36.347 INFO request completed, latency_us: 160, response_code: 204, uri: /start/cid/2, method: POST, req_id: dcb26af1-8e9c-45c3-82ef-9616166cf038, remote_addr: 127.0.0.1:56754, local_addr: 127.0.0.1:9998 [8830] got start action [8830] I am going to restart Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1240) [8830][2] reports Running Main task has work to do, go find it got dsc Stop(3) stop 3 Mar 31 18:43:40.765 INFO request completed, [8840] Got stop action so:false kr:false latency_us: 211, response_code: 204, uri: /stop/cid/3, method: POST, req_id: ef2ac8ff-736b-48e6-ab5c-455266eb9f0b, remote_addr: 127.0.0.1:56754, local_addr: 127.0.0.1:9998 Mar 31 18:43:40.765 INFO request completed, latency_us: 55, response_code: 200, uri: /state/cid/3, method: GET, req_id: a65a70fb-4ade-4650-8118-161219a5c14b, remote_addr: 127.0.0.1:56754, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Mar 31 18:43:44.767 INFO request completed, latency_us: 234, response_code: 200, uri: /state/cid/3, method: GET, req_id: b129fb24-5ac8-41fd-87ad-23adc43df59e, remote_addr: 127.0.0.1:56754, local_addr: 127.0.0.1:9998 Mar 31 18:44:22.202 INFO accepted connection, remote_addr: 127.0.0.1:54981, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Mar 31 18:44:22.202 INFO request completed, latency_us: 163, response_code: 204, uri: /start/cid/3, method: POST, req_id: c0baaa25-3b9d-448f-a878-30830324ad9f, remote_addr: 127.0.0.1:54981, local_addr: 127.0.0.1:9998 [8840] got start action [8840] I am going to restart Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] reports Starting Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1241) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(4) stop 4 Mar 31 18:44:26.765[8850] Got stop action so:false kr:false INFO request completed, latency_us: 230, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 6b601e05-b2f4-4596-aa9c-6c420a7af2b9, remote_addr: 127.0.0.1:54981, local_addr: 127.0.0.1:9998 Mar 31 18:44:26.765 INFO request completed, latency_us: 55, response_code: 200, uri: /state/cid/4, method: GET, req_id: 90b86938-5431-45fb-a0c2-92a075d174d3, remote_addr: 127.0.0.1:54981, local_addr: 127.0.0.1:9998 [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit Mar 31 18:44:30.768 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/4, method: GET, req_id: 0dfed0a4-fd65-483d-8d10-de490aaf4139, remote_addr: 127.0.0.1:54981, local_addr: 127.0.0.1:9998 Mar 31 18:45:08.169 INFO accepted connection, remote_addr: 127.0.0.1:45212, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(4) start 4 Mar 31 18:45:08.169 INFO request completed, latency_us: 162, response_code: 204, uri: /start/cid/4, method: POST, req_id: 30703b92-058e-4607-8b59-e4478b56079d, remote_addr: 127.0.0.1:45212, local_addr: 127.0.0.1:9998 Mar 31 18:45:12.215 INFO accepted connection, remote_addr: 127.0.0.1:54831, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Mar 31 18:45:12.216 INFO request completed, latency_us: 142, response_code: 204, uri: /shutdown, method: POST, req_id: 68e97aff-1748-4366-ba1c-73290d7feba6, remote_addr: 127.0.0.1:54831, local_addr: 127.0[8820] Disable keep_running .[8810] Disable keep_running 0[8810] Got stop action so:false kr:false .[8830] Disable keep_running 1[8830] Got stop action so:false kr:false :[8820] Got stop action so:false kr:false 9998[8860] Disable keep_running [8860] Got stop action so:false kr:false [8870] Disable keep_running [8870] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8870] Exited with: ExitStatus(unix_wait_status(9)) [8870][6] reports Exit