/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.24531461 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.019240819 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017905397 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.017050505 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.017987326 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.020761976 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 8850 Starting downstairs at port 8830 Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8850][4] initial start wait reports Starting [8830][2] initial start wait reports Starting [8860][5] initial start wait reports Starting [8810][0] initial start wait reports Starting [8840][3] initial start wait reports Starting [8820][1] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1197) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1198) [8860][5] initial start wait reports Running Control access at:127.0.0.1:9998 Feb 27 17:23:04.288 INFO listening, local_addr: 127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1201) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1200) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1202) [8850][4] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1199) [8830][2] initial start wait reports Running All downstairs are running Feb 27 17:23:09.325 INFO accepted connection, remote_addr: 127.0.0.1:35682, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.326 INFO request completed, latency_us: 510, response_code: 200, uri: /state/cid/0, method: GET, req_id: 89201857-e609-4cae-976c-0dcd7d97df91, remote_addr: 127.0.0.1:35682, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.379 INFO accepted connection, remote_addr: 127.0.0.1:41775, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.380 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/1, method: GET, req_id: 946165ca-f3ef-4283-8514-ad908f0e6ed5, remote_addr: 127.0.0.1:41775, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.432 INFO accepted connection, remote_addr: 127.0.0.1:55026, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.433 INFO request completed, latency_us: 120, response_code: 200, uri: /state/cid/2, method: GET, req_id: d1d6324c-625f-403e-aa46-0f414edc29ba, remote_addr: 127.0.0.1:55026, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.486 INFO accepted connection, remote_addr: 127.0.0.1:33556, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.486 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/3, method: GET, req_id: 1d00a8a4-7c48-41ea-aebd-b6d0cd8d35e3, remote_addr: 127.0.0.1:33556, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.537 INFO accepted connection, remote_addr: 127.0.0.1:59913, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.538 INFO request completed, latency_us: 116, response_code: 200, uri: /state/cid/4, method: GET, req_id: c62aceec-dacd-49cb-bbd7-f58ea444a25a, remote_addr: 127.0.0.1:59913, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.589 INFO accepted connection, remote_addr: 127.0.0.1:42381, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.590 INFO request completed, latency_us: 129, response_code: 200, uri: /state/cid/5, method: GET, req_id: 2cadf2e4-c37b-4a45-9954-259c8ab0089a, remote_addr: 127.0.0.1:42381, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.641 INFO accepted connection, remote_addr: 127.0.0.1:59628, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Feb 27 17:23:09.642 INFO request completed, latency_us: 172, response_code: 204, uri: /disablerestart/all, method:[8810] Disable keep_running [8820] Disable keep_running POST[8830] Disable keep_running , req_id: 0ae37045-9b03-4baf-bf1b-c8e03fbc494e, remote_addr: 127.0.0.1:59628, local_addr: 127.0.0.1:9998 [8860] Disable keep_running [8840] Disable keep_running [8850] Disable keep_running Feb 27 17:23:09.724 INFO accepted connection, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.725 INFO request completed, latency_us: 226, response_code: 200, uri: /regioninfo, method: GET, req_id: 6668afb8-e5eb-4566-8214-6884f987165e, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.726 INFO request completed, latency_us: 110, response_code: 200, uri: /regioncount, method: GET, req_id: 2f30d911-a303-4e82-be1f-73c3d30b1b09, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.727 INFO request completed, latency_us: 130, response_code: 200, uri: /port/cid/0, method: GET, req_id: fd7fb2be-fe84-430e-bdba-ea3bfda6c8bc, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.727 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 9a0d1ebd-6113-40de-92d0-7e3d94779a47, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.728 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 591472c0-f655-4d62-ba91-a9fb87d4598d, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.731 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/3, method: GET, req_id: 6d5cb1dc-588a-44e9-a964-fa5958208c85, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.732 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/4, method: GET, req_id: b119dbb8-514e-44f4-9836-acb1d8d6afd2, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:09.732 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: 4e766865-53ae-4eb4-b605-98fe8115d39e, remote_addr: 127.0.0.1:38930, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.845 INFO accepted connection, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.846 INFO request completed, latency_us: 164, response_code: 200, uri: /regioninfo, method: GET, req_id: 68a87488-a49a-46e4-8db4-202bc9d1246b, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.847 INFO request completed, latency_us: 95, response_code: 200, uri: /regioncount, method: GET, req_id: f9a77019-6beb-4217-9a23-44a42602792e, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.847 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: d8736bf9-93a7-4651-9eb6-1c426d413154, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.848 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: dada91d3-5268-40f0-abd1-9c8daa34243b, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.848 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2a9883cb-606c-4827-9118-56b15fa03025, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.850 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/3, method: GET, req_id: 00e9b3a7-cb7f-4c18-8e09-2124b3c7a6b5, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.851 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/4, method: GET, req_id: 78763983-5652-4a5a-8ff7-2a37a689d214, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:18.851 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/5, method: GET, req_id: c29b9545-b6f0-44d9-b857-af52580cf8ad, remote_addr: 127.0.0.1:49011, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.432 INFO accepted connection, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.432 INFO request completed, latency_us: 155, response_code: 200, uri: /regioninfo, method: GET, req_id: 990c6051-03c2-4b76-bb1f-5193fa10bc4d, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.433 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: 3af2c3ed-0427-42f3-88c7-da0c09f3860e, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.434 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 94acc480-1af1-4c41-9801-574121cdb1d0, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.434 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6a827f50-798c-4094-b3ca-6ed3b368fe5d, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.435 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2bd79968-5dad-43c9-8463-194c34676938, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.437 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/3, method: GET, req_id: 028c8f3d-a859-4b74-a6f4-4bf61a7b2b44, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.437 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: 31e88bd9-cd78-4106-9ae2-5f4b7244234a, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:23:28.438 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: b19a2eb2-9524-42af-afb0-4dfb542ae41b, remote_addr: 127.0.0.1:39396, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.764 INFO accepted connection, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.764 INFO request completed, latency_us: 147, response_code: 200, uri: /regioninfo, method: GET, req_id: 44e31182-e4f2-434d-b13b-976be218fb26, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.765 INFO request completed, latency_us: 114, response_code: 200, uri: /regioncount, method: GET, req_id: 1a4e5fcf-d5aa-45c7-9e9b-94bb3c767854, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.766 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 23f3ff69-c6ed-41bf-b706-ca1eb5d2d86e, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.767 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 64ff282c-dded-404a-bab0-238ce17a0cd5, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.767 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: 8d85b8b1-f5ae-4d4a-9d2b-5a1779e84383, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.769 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/3, method: GET, req_id: e6ee849a-0476-4db6-9919-b77d3470814e, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.769 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 59787246-92d8-4ba6-855a-cff7a93abe52, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:24:06.770 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/5, method: GET, req_id: 2bf0012b-9742-49f7-8389-c3fa7c37481d, remote_addr: 127.0.0.1:57029, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.890 INFO accepted connection, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.891 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: 38bf5759-ce48-4454-afe4-966da1083f54, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.891 INFO request completed, latency_us: 84, response_code: 200, uri: /regioncount, method: GET, req_id: 345430da-4b18-4982-b84b-7ad247bdfe15, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.892 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2515f77a-6b32-4b65-9387-8634ba465e9e, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.893 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/1, method: GET, req_id: d2c40dc5-6fd4-4af8-b95b-dd564fa28a8a, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.893 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/2, method: GET, req_id: c21a4728-80bd-4539-b364-530de44e8c1f, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.895 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/3, method: GET, req_id: 39fe3148-d2b6-45bb-9abd-da9fa1202d12, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.895 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/4, method: GET, req_id: 5e958dc9-c899-4f9b-8a59-5edbe91d0962, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:28:24.896 INFO request completed, latency_us: 113, response_code: 200, uri: /port/cid/5, method: GET, req_id: cb29eec8-7e90-45c9-b934-2bd3e95c48e8, remote_addr: 127.0.0.1:60028, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.624 INFO accepted connection, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.624 INFO request completed, latency_us: 164, response_code: 200, uri: /regioninfo, method: GET, req_id: 29e280f1-f9c6-4a50-a6b4-459d5b2803ad, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.625 INFO request completed, latency_us: 112, response_code: 200, uri: /regioncount, method: GET, req_id: 8b84a3b1-66a4-47f4-b05b-46e1662bd369, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.626 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/0, method: GET, req_id: 45ecc62b-7d1b-4cec-87aa-cacca5543c95, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.627 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/1, method: GET, req_id: 07948488-3753-4c98-8337-13b492b24fc8, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.627 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: ac68013c-7bf0-483d-9353-052fa3ba5983, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.629 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/3, method: GET, req_id: c3518601-b5fc-4c5c-ada4-fd46718b4ce6, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.630 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: 87c4b66e-6242-403a-a3d8-d3e0b64008dc, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:42.630 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6d68431c-63ea-4217-af2c-7ecc356cb687, remote_addr: 127.0.0.1:39884, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.835 INFO accepted connection, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.836 INFO request completed, latency_us: 165, response_code: 200, uri: /regioninfo, method: GET, req_id: 59005f3d-0034-48fd-aca9-0f3640fc68c4, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.837 INFO request completed, latency_us: 124, response_code: 200, uri: /regioncount, method: GET, req_id: b400e6b1-ec49-495f-8849-09e1579c5a1a, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.837 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 7471eb75-1580-4a44-83cc-951501854bd3, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.838 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/1, method: GET, req_id: 4402c742-e40d-40e5-8a9c-2296c74e1532, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.838 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7484b14e-9f36-4609-ac79-834a96c53b90, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.840 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/3, method: GET, req_id: d636e29c-7c04-44f3-a4fb-c9666dd0ba37, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.841 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/4, method: GET, req_id: ebde324b-c758-4941-bdbd-1cec3eaec73e, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:46.841 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1deb86dc-319c-4b6f-81f9-0db51f91d95a, remote_addr: 127.0.0.1:40525, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.035 INFO accepted connection, remote_addr: 127.0.0.1:45367, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Feb 27 17:29:51.036 INFO request completed, latency_us: 173, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 30593af3-3181-476f-a743-68c1a889ac5f, remote_addr: [8820] Disable keep_running 127[8810] Disable keep_running .[8840] Disable keep_running 0.0.1:45367[8860] Disable keep_running , [8850] Disable keep_running local_addr: 127.0.0.1:9998[8830] Disable keep_running Feb 27 17:29:51.090 INFO accepted connection, remote_addr: 127.0.0.1:54931, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Feb 27 17:29:51.091 INFO request completed, latency_us: 167[8830] Got stop action so:false kr:false , response_code: 204, uri: /stop/cid/2, method: POST, req_id: d885da2a-6266-4a3d-aafd-38e6849d396a, remote_addr: 127.0.0.1:54931, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Feb 27 17:29:51.144 INFO accepted connection, remote_addr: 127.0.0.1:63360, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.145 INFO request completed, latency_us: 153, response_code: 200, uri: /state/cid/2, method: GET, req_id: 33243ee7-1830-4f98-967b-3ce4363832ec, remote_addr: 127.0.0.1:63360, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.201 INFO accepted connection, remote_addr: 127.0.0.1:60877, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Feb 27 17:29:51.202 INFO request completed, latency_us: 157, response_code: 204, uri: /start/cid/2, method: POST, req_id: 7661c741-de51-48b5-a0ff-3851aef81cb6, remote_addr: 127.0.0.1:60877, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.281 INFO accepted connection, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.282 INFO request completed, latency_us: 162, response_code: 200, uri: /regioninfo, method: GET, req_id: c0954990-1e84-43fb-ae0a-2c2142a4167a, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.283 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 536071ce-8dbe-415b-95e2-b3395272b81d, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.283 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1a9c84e9-e0ba-4293-bc59-ea1125f6aaa0, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.284 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: f747b0a1-a779-4b91-aeb3-f84cd06b9449, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.284 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: c6c75839-93ce-4dac-a126-67b957757188, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.286 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/3, method: GET, req_id: 6eafdb99-342e-4522-8f6b-daf4fc62684a, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.287 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/4, method: GET, req_id: aa422ec0-7561-4525-af3e-11c486620208, remote_addr: 127.0.0.1:52437, local_addr: 127.0.0.1:9998 Feb 27 17:29:51.287 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: 96fa7dbb-7379-476b-af45-cb3bd8a1eb3e, remote_addr: 127.0.0.1:52437, 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(1253) [8830][2] reports Running Feb 27 17:30:05.553 INFO accepted connection, remote_addr: 127.0.0.1:50579, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Feb 27 17:30:05.553 INFO request completed, latency_us: 219, response_code: 204, uri: /shutdown, method: POST, req_id: 171223ac-e423-403c-9b97-b03475aadc4b, remote_addr: 127.0.0[8810] Disable keep_running .[8820] Disable keep_running 1:50579, local_addr[8810] Got stop action so:false kr:false :[8820] Got stop action so:false kr:false 127.0.0.1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8850] Disable keep_running [8850] Got stop action so:false kr:false [8860] Disable keep_running [8860] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8820] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8820][1] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit /var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --extent-count 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.026728181 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.0241311 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.023398565 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.02302766 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.023168989 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.022641052 Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.02283297 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 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-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8810][0] initial start wait reports Starting [8820][1] initial start wait reports Starting Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8840 [8830][2] initial start wait reports Starting [8840][3] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8850][4] initial start wait reports Starting Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8860][5] initial start wait reports Starting Starting downstairs at port 8870 Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt" [8870][6] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1270) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1271) [8850][4] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1272) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1273) [8870][6] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1274) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1275) [8860][5] initial start wait reports Running Feb 27 17:30:10.775 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1276) [8820][1] initial start wait reports Running All downstairs are running Feb 27 17:30:15.806 INFO accepted connection, remote_addr: 127.0.0.1:38254, local_addr: 127.0.0.1:9998 Feb 27 17:30:15.807 INFO request completed, latency_us: 309, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2bedcb53-de72-4d71-85c8-32f8bacae215, remote_addr: 127.0.0.1:38254, local_addr: 127.0.0.1:9998 Feb 27 17:30:15.862 INFO accepted connection, remote_addr: 127.0.0.1:58397, local_addr: 127.0.0.1:9998 Feb 27 17:30:15.862 INFO request completed, latency_us: 140, response_code: 200, uri: /state/cid/1, method: GET, req_id: 407e661b-2296-4a85-ac78-f5c8d1ca58b6, remote_addr: 127.0.0.1:58397, local_addr: 127.0.0.1:9998 Feb 27 17:30:15.915 INFO accepted connection, remote_addr: 127.0.0.1:39777, local_addr: 127.0.0.1:9998 Feb 27 17:30:15.916 INFO request completed, latency_us: 126, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1daaf737-4660-4b98-b3c4-2c8d1093b824, remote_addr: 127.0.0.1:39777, local_addr: 127.0.0.1:9998 Feb 27 17:30:15.969 INFO accepted connection, remote_addr: 127.0.0.1:37034, local_addr: 127.0.0.1:9998 Feb 27 17:30:15.969 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/3, method: GET, req_id: 57dd6079-0a2e-4a09-9d1a-df95c67dafcf, remote_addr: 127.0.0.1:37034, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.023 INFO accepted connection, remote_addr: 127.0.0.1:52267, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.024 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/4, method: GET, req_id: 2cc9a3b5-5b00-4713-8c0d-9a27879ad7d1, remote_addr: 127.0.0.1:52267, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.077 INFO accepted connection, remote_addr: 127.0.0.1:41500, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.078 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/5, method: GET, req_id: 9ba020b9-e9ce-4846-818b-b6f243bcfcb7, remote_addr: 127.0.0.1:41500, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.130 INFO accepted connection, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.131 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/6, method: GET, req_id: aea0c0a1-c885-424b-835d-ec40b4433d90, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.182 INFO accepted connection, remote_addr: 127.0.0.1:46243, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.183 INFO request completed, latency_us: 140, response_code: 200, uri: /port/cid/6, method: GET, req_id: d197df64-2237-4d81-b654-2d7943fcfd1f, remote_addr: 127.0.0.1:46243, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.242 INFO accepted connection, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.243 INFO request completed, latency_us: 153, response_code: 200, uri: /regioninfo, method: GET, req_id: e9d2da11-1c07-4532-b333-5d261b593dba, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.244 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: c7a20147-7be7-41a8-81a4-04142e912621, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.244 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8c284516-1a12-4ecc-8045-6355e4eaee40, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.245 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7da7bea2-417b-46df-96bb-bedf4f258306, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.245 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/2, method: GET, req_id: ce0f8cc7-93e6-4046-bbbd-09bcc1d9e5aa, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.247 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/3, method: GET, req_id: 93298865-ed4f-46a9-b325-b13cfde83a18, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.248 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/4, method: GET, req_id: e9ffbd1f-55e0-4cb9-a4c2-d77e0588bb94, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.248 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/5, method: GET, req_id: 36e8397f-9be7-4e88-9171-73bead41253d, remote_addr: 127.0.0.1:46012, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.287 INFO accepted connection, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.287 INFO request completed, latency_us: 123, response_code: 200, uri: /regioncount, method: GET, req_id: 7fb5c3b6-163f-49e3-9b17-78478e255050, remote_addr: 127.0.0.1:39974, 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 Feb 27 17:30:16.466 INFO request completed, latency_us: 258, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 0ca89d62-df51-4571-a745-7ba5b707e6ad, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:30:16.467 INFO request completed, latency_us: 177, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9f496c01-982d-4e9b-983e-8b501a51eab0, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Feb 27 17:30:20.468 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5b43ead5-c49d-45a4-89d5-f324083894aa, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Feb 27 17:30:20.640 INFO request completed, latency_us: 198, response_code: 204, uri: /start/cid/0, method: POST, req_id: 395a000d-c25b-40dc-b564-e0fc02980c48, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:30:20.640 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/0, method: GET, req_id: 99f27575-9675-46bf-badf-feb7fa71e514, remote_addr: 127.0.0.1:39974, 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(1287) [8810][0] reports Running Feb 27 17:30:24.643 INFO request completed, latency_us: 320, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1e0cfff5-a981-4448-9735-d958d34c52f7, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Feb 27 17:30:55.495 INFO [8820] Got stop action so:false kr:false request completed, latency_us: 252, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 0ae2a09b-8ae7-4b54-966c-ea52fc861112, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:30:55.497 INFO request completed, latency_us: 194, response_code: 200, uri: /state/cid/1, method: GET, req_id: 2f590bba-e7d3-42b2-b644-f19aae356b4e, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Feb 27 17:30:59.500 INFO request completed, latency_us: 254, response_code: 200, uri: /state/cid/1, method: GET, req_id: bed534ee-7192-4bd7-824f-d97d6d67b4ce, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Feb 27 17:30:59.676 INFO request completed, latency_us: 191, response_code: 204, uri: /start/cid/1, method: POST, req_id: fe6eade2-ba93-44b8-98a8-3517138bf503, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:30:59.676 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4ec9a086-a7f7-4a6c-9142-b8c7ebca6316, remote_addr: 127.0.0.1:39974, 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(1288) [8820][1] reports Running Feb 27 17:31:03.680 INFO request completed, latency_us: 570, response_code: 200, uri: /state/cid/1, method: GET, req_id: d75304e2-fc3e-4888-ae4a-0daf7cadbeb4, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Feb 27 17:31:34.718[8830] Got stop action so:false kr:false INFO request completed, latency_us: 211, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 2c235c44-df29-4959-bdde-a640a44c06cd, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:31:34.719 INFO request completed, latency_us: 266, response_code: 200, uri: /state/cid/2, method: GET, req_id: 746cbdc5-f001-4ece-b91a-9a90b53281f6, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Feb 27 17:31:38.722 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/2, method: GET, req_id: e7d64a7b-bb10-4481-a34d-d44d56212da9, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Feb 27 17:31:38.897 INFO request completed, latency_us: 201, response_code: 204, uri: /start/cid/2, method: POST, req_id: 9cc22807-ee7b-479e-a62b-44c6ef5ff012, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:31:38.898 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2e53617c-bfb5-4d13-8ea5-2fb7a2c62986, remote_addr: 127.0.0.1:39974, 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(1289) [8830][2] reports Running Feb 27 17:31:42.900 INFO request completed, latency_us: 323, response_code: 200, uri: /state/cid/2, method: GET, req_id: 24c0c6ab-dd0d-4cc2-b174-ed332b143ee5, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Feb 27 17:32:14.112 INFO request completed, latency_us: [8840] Got stop action so:false kr:false 215, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 04316559-10f5-4ed5-b6cc-2b1ad963c8dd, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:32:14.112 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/3, method: GET, req_id: 114050d8-4dae-4f3d-bb5d-be97bdacb167, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Feb 27 17:32:18.115 INFO request completed, latency_us: 219, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8d2eae2c-72b3-43f0-8694-f73d55c2cf75, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Feb 27 17:32:18.287 INFO request completed, latency_us: 157, response_code: 204, uri: /start/cid/3, method: POST, req_id: 8ff775e6-9845-4428-8b4f-283dbbec0dbf, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:32:18.288 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/3, method: GET, req_id: b7704b4a-f93f-406d-a865-93b4fe2dec8e, remote_addr: 127.0.0.1:39974, 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(1290) [8840][3] reports Running Feb 27 17:32:22.290 INFO request completed, latency_us: 302, response_code: 200, uri: /state/cid/3, method: GET, req_id: ac2608ac-660a-41ed-b04d-46ceb7bb2412, remote_addr: 127.0.0.1:39974, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.555 INFO accepted connection, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.556 INFO request completed, latency_us: 140, response_code: 200, uri: /regioninfo, method: GET, req_id: 7d4de365-be12-4c0a-9b96-ecc12488de0c, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.557 INFO request completed, latency_us: 97, response_code: 200, uri: /regioncount, method: GET, req_id: d0e82d43-96cd-450b-a7c9-e0a10cdedd85, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.557 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/0, method: GET, req_id: 68d3d920-d814-4fd0-a3f8-50bf86c26866, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.558 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/1, method: GET, req_id: ba059477-2405-4ced-a0b5-25e4ed89c931, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.558 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: 867fd5b4-8d62-410f-ac6c-52adadd43aaa, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.561 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/3, method: GET, req_id: 64c134a5-3274-400f-a2b6-db0652a96872, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.561 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/4, method: GET, req_id: 193fa865-22d5-4006-9b88-e120da71f68b, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:53.562 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/5, method: GET, req_id: e7ad2285-2b04-484e-98ff-5b6cd93039d0, remote_addr: 127.0.0.1:55484, local_addr: 127.0.0.1:9998 Feb 27 17:32:54.365 INFO accepted connection, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Feb 27 17:32:54.366 INFO request completed, latency_us: 155, response_code: 200, uri: /regioncount, method: GET, req_id: 65b089dd-5658-4ad2-bccb-ff433fdbe446, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Feb 27 17:32:58.347 INFO request completed, latency_us: 220, response_code:[8810] Got stop action so:false kr:false 204, uri: /stop/cid/0, method: POST, req_id: 849a6944-9b1c-4e04-b1c9-8fab9ace254d, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Feb 27 17:32:58.348 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7fb8957b-5634-48f3-8602-23f8415cbeb7, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Feb 27 17:33:02.350 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/0, method: GET, req_id: baf7a212-18e6-4b11-853c-e5f2ccb7ef03, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Feb 27 17:33:36.007 INFO request completed, latency_us: 207, response_code: 204, uri: /start/cid/0, method: POST, req_id: 6484b51e-c447-4a69-adc7-0663dcbd488f, remote_addr: 127.0.0.1:60999, 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(1292) [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 Feb 27 17:33:40.188 INFO request completed, latency_us: 308, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 80fcdede-9ca0-4a4c-882f-86e29d713294, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Feb 27 17:33:40.189 INFO request completed, latency_us: 233, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1d8314d8-9bfc-4a66-af9c-923997168c28, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Feb 27 17:33:44.192 INFO request completed, latency_us: 367, response_code: 200, uri: /state/cid/1, method: GET, req_id: b7242de9-dcb3-46a3-a5e5-42aa11bc6ad8, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Feb 27 17:34:17.873 INFO request completed, latency_us: 204, response_code: 204, uri: /start/cid/1, method: POST, req_id: 570a8fc2-9851-43dc-af01-57a0af602c7c, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Feb 27 17:34:22.054 INFO request completed, latency_us: 323, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 038d8ff5-8d4f-4303-870b-7ff3112206fc[8830] Got stop action so:false kr:false , remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Feb 27 17:34:22.055 INFO request completed, latency_us: 106, response_code: 200, uri: /state/cid/2, method: GET, req_id: 968dc907-32f8-4381-a12e-70d81cb7c27f, remote_addr: 127.0.0.1:60999, 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(1293) [8820][1] reports Running Feb 27 17:34:26.056 INFO request completed, latency_us: 332, response_code: 200, uri: /state/cid/2, method: GET, req_id: 773679db-5e7f-4aea-b531-a79e34581866, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Feb 27 17:34:59.727 INFO request completed, latency_us: 246, response_code: 204, uri: /start/cid/2, method: POST, req_id: 7001f5d8-c9b5-4c7d-8cdc-21b6af2f178f, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Feb 27 17:35:03.922 INFO request completed, latency_us[8840] Got stop action so:false kr:false : 203, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 3fbe64af-18b8-4296-b48f-936f5d35804f, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Feb 27 17:35:03.923 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/3, method: GET, req_id: 4efe507d-23de-4838-85b1-7a7b233bfeed, remote_addr: 127.0.0.1:60999, 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(1294) [8830][2] reports Running Feb 27 17:35:07.926 INFO request completed, latency_us: 387, response_code: 200, uri: /state/cid/3, method: GET, req_id: cdb0017f-2b23-4499-9922-1c741ee44e30, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Feb 27 17:35:41.609 INFO request completed, latency_us: 216, response_code: 204, uri: /start/cid/3, method: POST, req_id: 2683e6a1-f0c6-4f19-8789-07dab30e0d6d, remote_addr: 127.0.0.1:60999, 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(1295) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(4) stop 4 Feb 27 17:35:45.829 INFO request completed[8850] Got stop action so:false kr:false , latency_us: 345, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 11ebed85-6c60-458a-9851-e1ce11bc4811, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Feb 27 17:35:45.830 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/4, method: GET, req_id: 825fb7ee-f2ca-403e-9fb3-a39885dc980b, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit Feb 27 17:35:49.833 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/4, method: GET, req_id: 97587bc1-3ef0-498f-9e6b-a312364cedd9, remote_addr: 127.0.0.1:60999, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(4) start 4 Feb 27 17:36:23.519 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/4, method: POST, req_id: 4676e16a-1cf8-40a1-99e5-b06790d578f1, remote_addr: 127.0.0.1:60999, 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(1296) [8850][4] reports Running Feb 27 17:36:27.591 INFO accepted connection, remote_addr: 127.0.0.1:49564, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Feb 27 17:36:27.592 INFO request completed, latency_us: 212, response_code: 204, uri[8810] Disable keep_running :[8810] Got stop action so:false kr:false /shutdown, method: POST, req_id: b1a63ec1-98fd-472c-9ad3-37b0a5ece8f1, remote_addr: 127.0.0.1:49564, local_addr: 127.0.0.1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8850] Disable keep_running [8860] Disable keep_running [8850] Got stop action so:false kr:false [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)) [8830] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830][2] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8810] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8810][0] reports Exit [8870] Exited with: ExitStatus(unix_wait_status(9)) [8870][6] reports Exit