/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.18123356 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.01224021 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.011701896 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.011530988 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010727672 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010385865 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 8810 Starting downstairs at port 8830 Starting downstairs at port 8820 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" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8810][0] initial start wait reports Starting [8830][2] initial start wait reports Starting [8820][1] initial start wait reports Starting [8840][3] initial start wait reports Starting [8850][4] initial start wait reports Starting [8860][5] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1139) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1140) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1138) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1142) [8860][5] initial start wait reports Running [8830][2] initial start wait reports Running [8850][4] initial start wait reports Running [8840][3] initial start wait reports Running Control access at:127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1143) Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1141) [8810][0] initial start wait reports Running [8820][1] initial start wait reports Running All downstairs are running Jul 22 22:19:15.540 INFO listening, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.551 INFO accepted connection, remote_addr: 127.0.0.1:37091, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.552 INFO request completed, latency_us: 452, response_code: 200, uri: /state/cid/0, method: GET, req_id: f991c051-887a-40db-8b0d-996b67bc80c3, remote_addr: 127.0.0.1:37091, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.566 INFO accepted connection, remote_addr: 127.0.0.1:42257, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.566 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4d5620d9-7ce5-4af6-9aba-f3c9928d795d, remote_addr: 127.0.0.1:42257, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.580 INFO accepted connection, remote_addr: 127.0.0.1:59525, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.580 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/2, method: GET, req_id: f4c7cc20-26fd-4703-8925-2736f61427a7, remote_addr: 127.0.0.1:59525, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.593 INFO accepted connection, remote_addr: 127.0.0.1:35811, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.593 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/3, method: GET, req_id: 880586f7-00dd-4d5f-9db2-c4c3d95448cf, remote_addr: 127.0.0.1:35811, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.606 INFO accepted connection, remote_addr: 127.0.0.1:34010, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.606 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/4, method: GET, req_id: 1725363c-9dd2-4f2f-b80c-039b066c934d, remote_addr: 127.0.0.1:34010, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.619 INFO accepted connection, remote_addr: 127.0.0.1:37971, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.619 INFO request completed, latency_us: 72, response_code: 200, uri: /state/cid/5, method: GET, req_id: ba71f1a9-b834-4340-86a9-99c310994144, remote_addr: 127.0.0.1:37971, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.632 INFO accepted connection, remote_addr: 127.0.0.1:60006, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll Jul 22 22:19:20.632 INFO request completed, latency_us:disable restart on all: 6 76, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 242ecc30-a4d8-4543-8c68-085b5e3e111c, remote_addr: 127.0.0.1:60006, local_addr: 127[8810] Disable keep_running .0.0.1:9998 [8820] Disable keep_running [8840] Disable keep_running [8850] Disable keep_running [8830] Disable keep_running [8860] Disable keep_running Jul 22 22:19:20.697 INFO accepted connection, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.698 INFO request completed, latency_us: 255, response_code: 200, uri: /regioninfo, method: GET, req_id: 98960bff-a3ab-4c5a-b30d-95ec6d05d803, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.700 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 49bc4df9-5ce6-41e8-a6e7-231a73b0bb4f, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.700 INFO request completed, latency_us: 133, response_code: 200, uri: /port/cid/0, method: GET, req_id: 83fe3db8-1e73-432c-93af-6d26a20b885c, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.701 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/1, method: GET, req_id: 05f70d43-fe4a-4727-b8d1-9f3fbb16b9ea, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.701 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/2, method: GET, req_id: 47be13a8-60a4-4b8c-a0a7-e2c5c8cd94d5, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.706 INFO request completed, latency_us: 59, response_code: 200, uri: /port/cid/3, method: GET, req_id: c378d0b1-5a37-4881-9efb-29bb96b951df, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.707 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/4, method: GET, req_id: f6b0865d-2492-4629-bd1a-b4eedaccd1e8, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:20.707 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/5, method: GET, req_id: 08823cf1-1345-4a45-92fa-a47aab48a527, remote_addr: 127.0.0.1:43315, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.765 INFO accepted connection, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.765 INFO request completed, latency_us: 147, response_code: 200, uri: /regioninfo, method: GET, req_id: 109db241-1641-478e-aead-494441d2b4a1, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.766 INFO request completed, latency_us: 33, response_code: 200, uri: /regioncount, method: GET, req_id: b3052f74-319a-49a0-8935-f836d9d3f5f0, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.766 INFO request completed, latency_us: 53, response_code: 200, uri: /port/cid/0, method: GET, req_id: e8ec4617-161e-4486-9a4a-e0b521760014, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.767 INFO request completed, latency_us: 71, response_code: 200, uri: /port/cid/1, method: GET, req_id: 2022bdf2-e089-46f9-8fec-ef70af60e4fb, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.767 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/2, method: GET, req_id: 597758e0-7944-4134-bc7f-d63d1e47f703, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.768 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/3, method: GET, req_id: 437c3fe2-a132-43c7-9aed-b9c4e2004b2f, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.768 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/4, method: GET, req_id: 6ff5ee1a-b12b-4866-8be3-6efe868004ed, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:29.769 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/5, method: GET, req_id: bdee2b95-a315-43d5-842a-e40a4d55cd50, remote_addr: 127.0.0.1:49884, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.073 INFO accepted connection, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.074 INFO request completed, latency_us: 149, response_code: 200, uri: /regioninfo, method: GET, req_id: f132910a-42b8-41f2-b195-2600b48c6f4b, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.074 INFO request completed, latency_us: 32, response_code: 200, uri: /regioncount, method: GET, req_id: d81a6e63-1847-4436-a3cf-edffe6c4e424, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.075 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0123a848-5504-4173-9f33-2f42e594ca1e, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.075 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/1, method: GET, req_id: c4bfe501-9966-4732-884e-7f14c6475199, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.075 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: 31edc7ce-9223-4ec0-9e2b-e3a1fefae256, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.077 INFO request completed, latency_us: 49, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7a6d4b76-2534-4dcb-8c40-80dc8fa21e66, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.077 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/4, method: GET, req_id: 7dc8367e-45be-4b5a-973c-4bb8d90c63db, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:19:39.077 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: 9f8dbdff-6684-4171-8b7a-a3f4fcb600af, remote_addr: 127.0.0.1:60299, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.868 INFO accepted connection, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.868 INFO request completed, latency_us: 146, response_code: 200, uri: /regioninfo, method: GET, req_id: d3b14516-c57c-43e5-ada3-5d927b9dabee, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.869 INFO request completed, latency_us: 32, response_code: 200, uri: /regioncount, method: GET, req_id: 0a8b6989-2125-464b-8bcb-14225e074a8f, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.869 INFO request completed, latency_us: 52, response_code: 200, uri: /port/cid/0, method: GET, req_id: b70f0623-9d6e-4867-8e1e-e5e1dbcf1a0b, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.870 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/1, method: GET, req_id: 406a7874-cb26-4345-b236-f8ec00c61b9b, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.870 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/2, method: GET, req_id: 86fd1b9e-dff3-4113-899e-810391d0cdec, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.871 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/3, method: GET, req_id: 39a36f19-ff76-495e-ab56-0f3bef5a5eae, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.871 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/4, method: GET, req_id: b605892c-d0f4-4df8-a8cf-b95c3dfabea5, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:20:03.872 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: 9401a6b8-22e9-4eb1-b997-d55321765c00, remote_addr: 127.0.0.1:58713, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.238 INFO accepted connection, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.239 INFO request completed, latency_us: 150, response_code: 200, uri: /regioninfo, method: GET, req_id: d63b3ffe-dfab-4666-b5f5-5d805054628b, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.239 INFO request completed, latency_us: 33, response_code: 200, uri: /regioncount, method: GET, req_id: 840a7271-59a4-4c5a-945c-9c348b655803, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.240 INFO request completed, latency_us: 54, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5ce9afb0-5adf-4911-a24b-92dc0b5cb2a4, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.240 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/1, method: GET, req_id: 9675643a-3e04-4c09-add4-0677d1473956, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.240 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: b2114f85-8073-44c9-bdd1-8345d35ef9a0, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.241 INFO request completed, latency_us: 44, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8cd4d450-11af-4a40-b779-cd4b621fd227, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.242 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/4, method: GET, req_id: a4c5205e-26e1-4550-91ae-a4b0e0f099ef, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:36.242 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/5, method: GET, req_id: f1a2ecc4-ca60-459c-924e-cabff548da1a, remote_addr: 127.0.0.1:57668, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.782 INFO accepted connection, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.783 INFO request completed, latency_us: 143, response_code: 200, uri: /regioninfo, method: GET, req_id: 1c7a6c23-dd9d-44c3-b89c-fc8c2e070950, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.784 INFO request completed, latency_us: 65, response_code: 200, uri: /regioncount, method: GET, req_id: 560d13f5-b86d-4e90-ba4f-6403e92736b3, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.784 INFO request completed, latency_us: 83, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5def5866-6326-4d6e-befb-98abbc82082f, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.785 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/1, method: GET, req_id: fb7e9d5a-ecf1-4778-8711-ba32538d8425, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.785 INFO request completed, latency_us: 60, response_code: 200, uri: /port/cid/2, method: GET, req_id: 818a62f9-8f6e-4f3c-852e-5824c5c758ef, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.786 INFO request completed, latency_us: 62, response_code: 200, uri: /port/cid/3, method: GET, req_id: 1fadc875-b3b9-4e47-b2a5-72e77c3cebb9, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.786 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/4, method: GET, req_id: 48e722b7-044b-4c12-bff9-f10cfae40914, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:52.787 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/5, method: GET, req_id: da3c16ae-4c50-48b7-bd50-80fa06db8421, remote_addr: 127.0.0.1:59225, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.895 INFO accepted connection, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.895 INFO request completed, latency_us: 150, response_code: 200, uri: /regioninfo, method: GET, req_id: e8559c35-ed96-47bc-85a3-da98c51ea3f7, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.896 INFO request completed, latency_us: 68, response_code: 200, uri: /regioncount, method: GET, req_id: 1830ea61-3695-4a75-a948-fe9f90f58c35, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.896 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/0, method: GET, req_id: ae6747cd-c298-4629-8188-d63c0b0cfa3f, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.896 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/1, method: GET, req_id: 68b9e3be-f77e-41f9-a380-7dd8cb7bc254, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.896 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: fa9dbf44-b26b-4cd1-b1bc-ecfa10a37bd6, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.898 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7397c66b-ebb9-4a9e-b1fd-beab38222ff5, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.898 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0334d3a1-644b-4895-acf2-ce44ff5db729, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:22:56.898 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: b191e7ed-b2bb-4739-8d39-357c6d7cdd12, remote_addr: 127.0.0.1:34258, local_addr: 127.0.0.1:9998 Jul 22 22:23:00.993 INFO accepted connection, remote_addr: 127.0.0.1:64086, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Jul 22 22:23:00.993 INFO request completed, latency_us: 127, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 138ccbd6-3cb1-42fc-851d-988d81077803, remote_addr: 127.0.0.1:64086, local_addr: [8820] Disable keep_running 127[8810] Disable keep_running .[8840] Disable keep_running 0[8860] Disable keep_running .0.1:9998 [8850] Disable keep_running [8830] Disable keep_running Jul 22 22:23:01.007 INFO accepted connection, remote_addr: 127.0.0.1:35585, local_addr: 127.0.0.1:9998 Main task has work to do, go find it Jul 22 22:23:01.007 INFO request completedgot dsc Stop(2) , latency_us: 103, response_code: 204, uri: /stop/cid/2stop 2 , method: POST, req_id: 5f82227d-0263-45dd-abf6-2760646c61b9, remote_addr: 127.0.0.1:35585, 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 Jul 22 22:23:01.020 INFO accepted connection, remote_addr: 127.0.0.1:36688, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.021 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0dcccd30-0845-454c-8685-18e8371a0812, remote_addr: 127.0.0.1:36688, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.037 INFO accepted connection, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jul 22 22:23:01.037 INFO request completed, latency_us: 74, response_code: 204, uri: /start/cid/2, method: POST, req_id: 3b8ff94b-b073-4446-8114-8101af926d0f, remote_addr: 127.0.0.1:48642, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.070 INFO accepted connection, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.071 INFO request completed, latency_us: 95, response_code: 200, uri: /regioninfo, method: GET, req_id: a30ef8ec-02b6-4df8-9a1d-02d5db24e872, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.071 INFO request completed, latency_us: 44, response_code: 200, uri: /regioncount, method: GET, req_id: 511b5d98-7bb2-46d1-b885-e58d418ad0c5, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.072 INFO request completed, latency_us: 52, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2adc47b6-4bbb-4188-9f46-88cd8b8aaad5, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.072 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: 46f2ae20-e1e0-4ef0-9a55-92e431404c38, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.072 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/2, method: GET, req_id: a2a39a07-c7da-4d72-8eee-afb48df5438a, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.073 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7a1ac268-0e88-4492-a091-8417d8d744b5, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.074 INFO request completed, latency_us: 74, response_code: 200, uri: /port/cid/4, method: GET, req_id: 75cb182b-836d-42ff-b173-98533bbe8710, remote_addr: 127.0.0.1:45171, local_addr: 127.0.0.1:9998 Jul 22 22:23:01.074 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/5, method: GET, req_id: 824250d0-3a2d-4a39-a4a7-2c9c3c86a7c8, remote_addr: 127.0.0.1:45171, 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 Jul 22 22:23:15.216 INFO accepted connection, remote_addr: 127.0.0.1:46823, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Jul 22 22:23:15.216 INFO request completed, latency_us: 136Shut it down , response_code: 204, uri: /shutdown, method: POST, req_id: 0c82bcd6-3eca-44da-97ec-8d0c927314ba, remote_addr: 127.0.0.1:46823, local_addr: 127.0.0.1:9998 [8820] Disable keep_running [8810] Disable keep_running [8820] Got stop action so:false kr:false [8810] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8850] Disable keep_running [8830] Disable keep_running [8860] Disable keep_running [8830] Got stop action so:false kr:false [8850] Got stop action so:false kr:false [8860] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8860] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8860][5] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8840] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8840][3] reports Exit [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] 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.029730804 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.028239233 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.027662793 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.027093923 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.027033417 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.025556568 Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.032710433 Created 7 regions /var/tmp/bins/dsc start --region-count 7 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Using existing output directory "/tmp/test_up-build/dsc" Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 400 }) start ds: 8810 start access at:127.0.0.1:9998 start ds: 8820 start ds: 8830 start ds: 8840 start ds: 8850 start ds: 8860 Starting downstairs at port 8820 Starting downstairs at port 8810 start ds: 8870 Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8840 [8810][0] initial start wait reports Starting [8820][1] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8830][2] initial start wait reports Starting Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8840][3] initial start wait reports Starting [8850][4] initial start wait reports Starting Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" Starting downstairs at port 8870 Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt" [8860][5] initial start wait reports Starting [8870][6] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1217) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1212) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1214) Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1211) [8820][1] initial start wait reports Running [8830][2] 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 Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1213) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1216) [8810][0] initial start wait reports Running [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1215) Jul 22 22:23:20.437 INFO listening, local_addr: 127.0.0.1:9998 [8860][5] initial start wait reports Running All downstairs are running Jul 22 22:23:25.449 INFO accepted connection, remote_addr: 127.0.0.1:45532, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.450 INFO request completed, latency_us: 313, response_code: 200, uri: /state/cid/0, method: GET, req_id: 589841ef-4a74-4096-b504-a429a06f0d61, remote_addr: 127.0.0.1:45532, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.464 INFO accepted connection, remote_addr: 127.0.0.1:47570, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.465 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/1, method: GET, req_id: 41212e02-72dd-453e-a902-b23f6b704672, remote_addr: 127.0.0.1:47570, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.478 INFO accepted connection, remote_addr: 127.0.0.1:60503, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.478 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/2, method: GET, req_id: dad25abf-0247-4d48-a297-0a79237c3273, remote_addr: 127.0.0.1:60503, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.491 INFO accepted connection, remote_addr: 127.0.0.1:45464, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.491 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/3, method: GET, req_id: 56530c52-596b-4582-afa1-f3b2b3df49fc, remote_addr: 127.0.0.1:45464, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.504 INFO accepted connection, remote_addr: 127.0.0.1:46706, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.505 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/4, method: GET, req_id: d49a5f7b-4258-4210-88cd-1548f4f16bec, remote_addr: 127.0.0.1:46706, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.517 INFO accepted connection, remote_addr: 127.0.0.1:39641, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.518 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/5, method: GET, req_id: 0b3ad3c7-0181-4b67-b81e-37c6eee2fcc3, remote_addr: 127.0.0.1:39641, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.530 INFO accepted connection, remote_addr: 127.0.0.1:59992, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.531 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/6, method: GET, req_id: 36b516f6-adde-458b-96da-2ef89747b329, remote_addr: 127.0.0.1:59992, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.543 INFO accepted connection, remote_addr: 127.0.0.1:46659, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.544 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/6, method: GET, req_id: fb09bdee-4682-43f3-befb-57d6efc846ae, remote_addr: 127.0.0.1:46659, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.563 INFO accepted connection, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.563 INFO request completed, latency_us: 90, response_code: 200, uri: /regioninfo, method: GET, req_id: f4b9ca40-3d70-4fb3-ab21-b34bfaf9e538, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.564 INFO request completed, latency_us: 40, response_code: 200, uri: /regioncount, method: GET, req_id: 2a8e2bd2-e1ac-4600-a2f4-bcae9d2e1269, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.564 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/0, method: GET, req_id: a7c16e49-f613-452d-803f-6ea85568d7ec, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.564 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/1, method: GET, req_id: b7dd9afb-b444-4f21-902a-0e49a9be0a98, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.564 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: adb75709-d768-4c5c-be3d-84340fca1660, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.565 INFO request completed, latency_us: 62, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7bf7d80c-65bf-4dca-acdc-811a5e5c3716, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.566 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/4, method: GET, req_id: e27bbdae-fa68-41eb-9131-81975040e191, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.566 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/5, method: GET, req_id: 06f213ee-f7d9-43f7-a950-0d019ddaea93, remote_addr: 127.0.0.1:38428, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.588 INFO accepted connection, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.588 INFO request completed, latency_us: 137, response_code: 200, uri: /regioncount, method: GET, req_id: 960cc397-36f6-4f00-ace2-97c3578df9e9, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:23:25.978 INFO request completed, latency_us: 232, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 8b099ba7-7ba6-46c5-b628-9121a8cabfcd, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:23:25.978 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1affc79a-85f1-4b80-8002-101f1bb38a3f, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 22 22:23:29.980 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0a71e22d-5d6b-42c1-bd5a-2196ae50d6d5, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 22 22:23:30.374 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/0, method: POST, req_id: c070f19d-9ed2-4d99-9f87-88873a8a7293, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:23:30.374 INFO request completed, latency_us: 91, response_code: 200, uri: /state/cid/0, method: GET, req_id: 70d6d674-2ec0-4657-aa7d-9cb0b8697d53, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:23:34.376 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2393e11a-0ba6-421c-99c8-5a141a5ce213, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:23:38.378 INFO request completed, latency_us: 207, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7c12ac52-ac03-44d2-801f-e0571d601fac, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 22 22:23:44.767 INFO request completed[8810] Got stop action so:false kr:false , latency_us: 224, response_code: 204, uri: /stop/cid/0, method: POST, req_id: e47824b2-c560-4c2b-8388-0422fd433c68, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:23:44.768 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2b6fc005-434e-4e46-89f0-b2ff243a6965, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 22 22:23:48.770 INFO request completed, latency_us: 238, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7ceff43d-0e2e-4bb7-82ea-b7a0c181a962, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 22 22:23:49.170 INFO request completed, latency_us: 220, response_code: 204, uri: /start/cid/0, method: POST, req_id: 08ff4f40-f7e8-47e3-967c-533ff23af96a, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:23:49.171 INFO request completed, latency_us: 81, response_code: 200, uri: /state/cid/0, method: GET, req_id: 47b12c26-1e50-4fdd-8720-a81b6d93e601, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:23:53.173 INFO request completed, latency_us: 202, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3d01fa1c-daea-40f5-ad3f-e2dd581ea631, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 22 22:23:58.561 INFO request completed[8810] Got stop action so:false kr:false , latency_us: 223, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 43cb784b-337c-4dcf-a6fa-6b3b7de64d68, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:23:58.562 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/0, method: GET, req_id: 667e79d5-3102-425d-952f-07ceda6429a8, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 22 22:24:02.564 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/0, method: GET, req_id: b3014b31-94a0-48e4-9738-9054b3cb6e66, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 22 22:24:02.970 INFO request completed, latency_us: 222, response_code: 204, uri: /start/cid/0, method: POST, req_id: 1581242e-370f-4cea-a68b-296c50f3a0e8, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:02.970 INFO request completed, latency_us: 71, response_code: 200, uri: /state/cid/0, method: GET, req_id: e07c96b8-a194-48c6-a0df-1dfeba00a5c7, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:24:06.972 INFO request completed, latency_us: 187, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1aac5c45-b587-447e-9935-1800dee1a55f, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 22 22:24:11.363[8810] Got stop action so:false kr:false INFO request completed, latency_us: 230, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 73123c7a-75ef-4ecd-a992-d4b6465334c3, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:11.364 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: 366fa338-09f1-4b8c-9300-1345f96ae0e0, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 22 22:24:15.365 INFO request completed, latency_us: 207, response_code: 200, uri: /state/cid/0, method: GET, req_id: 34e07ab1-0a00-4d1b-9d8e-ee2c093b8489, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 22 22:24:15.767 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/0, method: POST, req_id: 40784ab3-f16d-48c9-8582-09e12735d6ed, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:15.767 INFO request completed, latency_us: 47, response_code: 200, uri: /state/cid/0, method: GET, req_id: 085bd577-48a7-40ff-9524-484369a7df3f, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:19.769 INFO request completed, latency_us: 189, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3074d4f2-fc28-4703-847e-c34e9fc69f27, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:24:23.772 INFO request completed, latency_us: 179, response_code: 200, uri: /state/cid/0, method: GET, req_id: 51177118-115b-4c0a-8729-8168bef72533, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 22 22:24:27.164 INFO request completed, latency_us: 234, response_code[8810] Got stop action so:false kr:false : 204, uri: /stop/cid/0, method: POST, req_id: 2c73efab-a242-47dc-8280-03331780d765, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:27.165 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: 847cd7cb-8962-4782-9736-c1d7a6b8da9e, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 22 22:24:31.167 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2457bd65-caf8-4277-b293-89a7df65c325, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 22 22:24:31.570 INFO request completed, latency_us: 222, response_code: 204, uri: /start/cid/0, method: POST, req_id: 598081e8-0b3e-443b-ab83-1cd19d0c9167, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:31.570 INFO request completed, latency_us: 53, response_code: 200, uri: /state/cid/0, method: GET, req_id: aab530a9-8d0d-427b-8bf9-bf9f19b50fa5, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:24:35.572 INFO request completed, latency_us: 187, response_code: 200, uri: /state/cid/0, method: GET, req_id: 04fcbf5c-6b53-4bfe-84a1-e20985101187, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 22 22:24:37.963[8810] Got stop action so:false kr:false INFO request completed, latency_us: 273, response_code: 204, uri: /stop/cid/0, method: POST, req_id: f66186c8-09ca-4256-9170-328b8b314ad0, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:37.964 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/0, method: GET, req_id: b8e63486-1b38-4971-89c8-58efe056ef32, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 22 22:24:41.966 INFO request completed, latency_us: 225, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6c0d872c-107f-447c-8482-57ffeb9925b5, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 22 22:24:42.370 INFO request completed, latency_us: 217, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0c5a945d-84f3-42d4-a1ef-6e0f8645ec0d, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:24:42.370 INFO request completed, latency_us: 91, response_code: 200, uri: /state/cid/0, method: GET, req_id: 192ccd74-a990-4a01-9af7-7a7f1de89018, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:24:46.373 INFO request completed, latency_us: 201, response_code: 200, uri: /state/cid/0, method: GET, req_id: cf26498c-f08d-4229-9f91-ee812c0b6938, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Jul 22 22:25:13.870 INFO request completed, latency_us: 277, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 5983dfe1-88a2-4787-91fe-41d2cbd4d602, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:25:13.871 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8f26501c-0f12-458a-a69c-259aabbb58b4, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jul 22 22:25:17.873 INFO request completed, latency_us: 207, response_code: 200, uri: /state/cid/1, method: GET, req_id: eaf36b9f-9093-44ad-8468-696dd89d2381, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jul 22 22:25:18.280 INFO request completed, latency_us: 239, response_code: 204, uri: /start/cid/1, method: POST, req_id: 23549390-afb8-4376-9219-fcfcf8805da6, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:25:18.280 INFO request completed, latency_us: 86, response_code: 200, uri: /state/cid/1, method: GET, req_id: 62849c0f-1679-4ff3-8148-4b7640e9425c, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:25:22.282 INFO request completed, latency_us: 190, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3e24526b-a81f-4bf3-b096-2a44c54fcab4, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jul 22 22:25:49.899 INFO request completed[8830] Got stop action so:false kr:false , latency_us: 220, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 2710c61d-ee63-47d2-b365-70c0cfa2ae75, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:25:49.899 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6db4fa8c-6d92-4607-8e66-4549b4254d25, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 22 22:25:53.902 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/2, method: GET, req_id: 94a1408e-8e68-46cc-aee2-f252d3d52421, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jul 22 22:25:54.306 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/2, method: POST, req_id: 08e0eced-3845-4ac2-8962-6dc1956a43b4, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:25:54.306 INFO request completed, latency_us: 160, response_code: 200, uri: /state/cid/2, method: GET, req_id: f231fa58-9748-4b09-a4d4-cc593d0610ef, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:25:58.308 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/2, method: GET, req_id: ce491259-fe86-45d7-95d0-ceae37c4a7eb, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Jul 22 22:26:26.132 INFO request completed[8840] Got stop action so:false kr:false , latency_us: 221, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 03949e98-ec67-464c-b916-074264e97005, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:26:26.133 INFO request completed, latency_us: 79, response_code: 200, uri: /state/cid/3, method: GET, req_id: ef04a03b-e38a-4e42-8e56-b3fd914e847c, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jul 22 22:26:30.135 INFO request completed, latency_us: 227, response_code: 200, uri: /state/cid/3, method: GET, req_id: d2cc3d2c-0c90-4219-bd79-77931db33aba, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jul 22 22:26:30.545 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/3, method: POST, req_id: a0599d9f-39e9-42d0-8d70-fc1358a3f6f9, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:26:30.546 INFO request completed, latency_us: 50, response_code: 200, uri: /state/cid/3, method: GET, req_id: 3208d9ff-5f8d-40d6-b038-e3705b2b8b55, remote_addr: 127.0.0.1:36771, 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 Jul 22 22:26:34.547 INFO request completed, latency_us: 183, response_code: 200, uri: /state/cid/3, method: GET, req_id: 69fda03d-93f2-43d5-851e-7f65775169b7, remote_addr: 127.0.0.1:36771, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.232 INFO accepted connection, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.232 INFO request completed, latency_us: 156, response_code: 200, uri: /regioninfo, method: GET, req_id: be28f3b4-e8fe-4544-ac8f-c3c49cc7bd80, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.233 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: 5bfb599f-a80a-438e-8981-9613a676bec8, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.233 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4bc84597-df34-40bb-9c4f-4b3c615104dd, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.233 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/1, method: GET, req_id: 653640d3-172a-479d-9f76-232c86be52f0, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.233 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: 562e3406-0acf-427b-a152-0a3169c3b02c, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.235 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/3, method: GET, req_id: 278718c5-7f06-4291-b78e-f5f3108e2071, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.235 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1684e70e-7a75-4d9e-afb6-496a293582bb, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.235 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: 9e26a5a1-bafc-4096-924a-ed172189bb92, remote_addr: 127.0.0.1:61163, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.419 INFO accepted connection, remote_addr: 127.0.0.1:41312, local_addr: 127.0.0.1:9998 Jul 22 22:27:02.419 INFO request completed, latency_us: 131, response_code: 200, uri: /regioncount, method: GET, req_id: 3fb5ad93-3f67-4979-ab51-96fee6f6fd24, remote_addr: 127.0.0.1:41312, 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 Jul 22 22:27:08.113 INFO request completed, latency_us: 290, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 982b33ad-c7da-428d-9f4a-5948695b443b, remote_addr: 127.0.0.1:41312, local_addr: 127.0.0.1:9998 Jul 22 22:27:08.113 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/0, method: GET, req_id: 565468e3-bdcb-424c-a60f-e2805400e94a, remote_addr: 127.0.0.1:41312, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 22 22:27:12.116 INFO request completed, latency_us: 256, response_code: 200, uri: /state/cid/0, method: GET, req_id: 86857e63-ccd1-44ab-b6cd-d77fc9547aeb, remote_addr: 127.0.0.1:41312, local_addr: 127.0.0.1:9998 Jul 22 22:27:49.468 INFO accepted connection, remote_addr: 127.0.0.1:43752, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 22 22:27:49.469 INFO request completed, latency_us: 173, response_code: 204, uri: /start/cid/0, method: POST, req_id: 62b2f5bd-4430-4df1-a7c4-c4e50ee9af98, remote_addr: 127.0.0.1:43752, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Jul 22 22:27:53.868 INFO[8820] Got stop action so:false kr:false request completed, latency_us: 233, response_code: 204, uri: /stop/cid/1, method: POST, req_id: de3f1697-5b51-4134-be6d-7f06bcb9c6e2, remote_addr: 127.0.0.1:43752, local_addr: 127.0.0.1:9998 Jul 22 22:27:53.868 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1cab5e6d-b5ea-479c-833b-be4e7ec914f3, remote_addr: 127.0.0.1:43752, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [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 Jul 22 22:27:57.871 INFO request completed, latency_us: 239, response_code: 200, uri: /state/cid/1, method: GET, req_id: e8e1e790-3fc4-430b-8bf5-f7ec2d6d6536, remote_addr: 127.0.0.1:43752, local_addr: 127.0.0.1:9998 Jul 22 22:28:35.203 INFO accepted connection, remote_addr: 127.0.0.1:39854, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jul 22 22:28:35.204 INFO request completed, latency_us: 169, response_code: 204, uri: /start/cid/1, method: POST, req_id: b9f71643-d011-4012-bd20-47db30e63a80, remote_addr: 127.0.0.1:39854, 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(1239) [8820][1] reports Running Main task has work to do, go find it got dsc Stop(2) stop 2 [8830] Got stop action so:false kr:false Jul 22 22:28:39.605 INFO request completed, latency_us: 231, response_code: 204, uri: /stop/cid/2, method: POST, req_id: fd36db40-3fb1-416f-bd06-a16f09d912f0, remote_addr: 127.0.0.1:39854, local_addr: 127.0.0.1:9998 Jul 22 22:28:39.605 INFO request completed, latency_us: 87, response_code: 200, uri: /state/cid/2, method: GET, req_id: c057b97a-3a6f-421e-903c-4e6ff3089731, remote_addr: 127.0.0.1:39854, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 22 22:28:43.608 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3c1f93f8-4c9a-4c31-ad5d-3bd1b862f819, remote_addr: 127.0.0.1:39854, local_addr: 127.0.0.1:9998 Jul 22 22:29:20.952 INFO accepted connection, remote_addr: 127.0.0.1:60201, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jul 22 22:29:20.952 INFO request completed, latency_us: 168, response_code: 204, uri: /start/cid/2, method: POST, req_id: cba47614-f204-44a5-ba4d-de159333f1ea, remote_addr: 127.0.0.1:60201, 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 [8840] Got stop action so:false kr:false Jul 22 22:29:25.367 INFO request completed, latency_us: 276, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 323ec17c-af31-4135-bdb7-c849dca7003a, remote_addr: 127.0.0.1:60201, local_addr: 127.0.0.1:9998 Jul 22 22:29:25.367 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/3, method: GET, req_id: fdd0d703-ce03-447f-aada-7632bb7b70ab, remote_addr: 127.0.0.1:60201, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jul 22 22:29:29.370 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/3, method: GET, req_id: 04d59702-4758-4749-a491-0c59b34c7b2f, remote_addr: 127.0.0.1:60201, local_addr: 127.0.0.1:9998 Jul 22 22:30:06.737 INFO accepted connection, remote_addr: 127.0.0.1:37014, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jul 22 22:30:06.738 INFO request completed, latency_us: 172, response_code: 204, uri: /start/cid/3, method: POST, req_id: 8d043e1f-f614-4607-baee-d2b5beeafe4c, remote_addr: 127.0.0.1:37014, 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 Jul 22 22:30:11.289 INFO[8850] Got stop action so:false kr:false request completed, latency_us: 231, response_code: 204, uri: /stop/cid/4, method: POST, req_id: cc86830a-b28f-4bf8-9c17-75c1f18ebb72, remote_addr: 127.0.0.1:37014, local_addr: 127.0.0.1:9998 Jul 22 22:30:11.290 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/4, method: GET, req_id: ddfa8996-fa84-43cf-b527-6c41e21688ca, remote_addr: 127.0.0.1:37014, local_addr: 127.0.0.1:9998 [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit Jul 22 22:30:15.293 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/4, method: GET, req_id: 2a656ba5-7a74-40b3-ae7d-e16f476208bb, remote_addr: 127.0.0.1:37014, local_addr: 127.0.0.1:9998 Jul 22 22:30:52.682 INFO accepted connection, remote_addr: 127.0.0.1:49405, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(4) start 4 Jul 22 22:30:52.683 INFO request completed, latency_us: 179, response_code: 204, uri: /start/cid/4, method: POST, req_id: e1f14288-608c-4c90-925b-72faa1668985, remote_addr: 127.0.0.1:49405, 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(1242) [8850][4] reports Running Jul 22 22:30:56.727 INFO accepted connection, remote_addr: 127.0.0.1:40242, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Jul 22 22:30:56.728 INFO request completed, latency_us: 135, response_code: 204, uri: /shutdown, method: POST, req_id: c0895c49-16ad-45ca-a895-c7a9a03ea7ae, remote_addr[8820] Disable keep_running :[8820] Got stop action so:false kr:false 127.0.[8810] Disable keep_running 0.1:40242, local_addr: 127.0.0.1:9998[8830] Disable keep_running [8810] Got stop action so:false kr:false [8870] Disable keep_running [8870] Got stop action so:false kr:false [8850] Disable keep_running [8850] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8860] Disable keep_running [8860] Got stop action so:false kr:false [8830] Got stop action so:false kr:false [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] 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