/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.18429114 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.012576293 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.011001568 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.010366052 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010407507 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.01080754 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 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 8840 Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8820][1] initial start wait reports Starting [8840][3] initial start wait reports Starting [8830][2] initial start wait reports Starting [8850][4] initial start wait reports Starting [8810][0] initial start wait reports Starting [8860][5] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1141) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1144) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1143) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1145) Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1142) Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1146) [8810][0] initial start wait reports Running [8830][2] initial start wait reports Running [8840][3] initial start wait reports Running [8850][4] initial start wait reports Running [8820][1] initial start wait reports Running [8860][5] initial start wait reports Running All downstairs are running Jul 20 22:56:08.772 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jul 20 22:56:13.780 INFO accepted connection, remote_addr: 127.0.0.1:59968, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.781 INFO request completed, latency_us: 564, response_code: 200, uri: /state/cid/0, method: GET, req_id: 675dd675-bd96-45fe-80a2-963428cc24ab, remote_addr: 127.0.0.1:59968, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.795 INFO accepted connection, remote_addr: 127.0.0.1:59003, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.795 INFO request completed, latency_us: 58, response_code: 200, uri: /state/cid/1, method: GET, req_id: 15e523d2-bb6b-40b6-927e-f726f2bd3ca3, remote_addr: 127.0.0.1:59003, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.809 INFO accepted connection, remote_addr: 127.0.0.1:58013, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.809 INFO request completed, latency_us: 51, response_code: 200, uri: /state/cid/2, method: GET, req_id: c395e96c-1ca0-4c11-bc93-0b3fb5895e43, remote_addr: 127.0.0.1:58013, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.822 INFO accepted connection, remote_addr: 127.0.0.1:47901, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.822 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/3, method: GET, req_id: fa40e67b-782a-4b95-9320-0644a02ae069, remote_addr: 127.0.0.1:47901, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.835 INFO accepted connection, remote_addr: 127.0.0.1:42409, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.835 INFO request completed, latency_us: 71, response_code: 200, uri: /state/cid/4, method: GET, req_id: 89023ec0-0855-4322-984f-19acf0004d14, remote_addr: 127.0.0.1:42409, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.848 INFO accepted connection, remote_addr: 127.0.0.1:34568, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.848 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/5, method: GET, req_id: 17e2652f-6aa8-407f-ad7d-824232ccb081, remote_addr: 127.0.0.1:34568, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.860 INFO accepted connection, remote_addr: 127.0.0.1:44202, 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 20 22:56:13.861 INFO request completed, latency_us: 98, response_code: 204, uri: /disablerestart/all, method: POST, req_id: eb32a64a-1b54-488c-8fa2-d226ad9c0c3d, remote_addr: 127.0.0[8810] Disable keep_running .[8820] Disable keep_running 1[8830] Disable keep_running :[8840] Disable keep_running 44202, local_addr: [8860] Disable keep_running 127[8850] Disable keep_running .0.0.1:9998 Jul 20 22:56:13.904 INFO accepted connection, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.905 INFO request completed, latency_us: 234, response_code: 200, uri: /regioninfo, method: GET, req_id: 0b9502d4-5ab4-4dd3-9742-38f58fb19c75, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.906 INFO request completed, latency_us: 33, response_code: 200, uri: /regioncount, method: GET, req_id: 2e95df71-be35-4cc1-b14b-ad1f15a83254, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.906 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9f6932d8-410a-4d81-9898-73b7f29e98ce, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.907 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/1, method: GET, req_id: 18a27eb5-8ed8-4fc7-bbc9-041b3d681da5, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.907 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: fb39c09d-9b3a-436c-98cd-db29468e64df, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.910 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/3, method: GET, req_id: 270b731f-368a-4fe0-b5fe-3a7144640088, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.910 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2f1a3008-9c9d-4785-a528-5be00a21406c, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:13.910 INFO request completed, latency_us: 21, response_code: 200, uri: /port/cid/5, method: GET, req_id: f91c3734-edc8-4d02-941f-847e3fafd251, remote_addr: 127.0.0.1:34858, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.967 INFO accepted connection, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.967 INFO request completed, latency_us: 180, response_code: 200, uri: /regioninfo, method: GET, req_id: 7148db03-e643-4492-947d-15b916ca2a29, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.968 INFO request completed, latency_us: 71, response_code: 200, uri: /regioncount, method: GET, req_id: c7400cd4-f24e-4a13-b2c1-693eb75937c1, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.969 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 25af691a-b5f5-4a35-99ab-df08df230031, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.969 INFO request completed, latency_us: 72, response_code: 200, uri: /port/cid/1, method: GET, req_id: 56f03a23-2db8-4c23-abdc-1ca9124d3a3a, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.969 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/2, method: GET, req_id: 42a634b4-3869-427f-a91b-8b8f78d58db9, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.971 INFO request completed, latency_us: 66, response_code: 200, uri: /port/cid/3, method: GET, req_id: b764272f-a894-4e67-842c-adee63e1eb6d, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.971 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/4, method: GET, req_id: 97eb7bc4-55d8-47f5-be73-b28c942128f6, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:22.972 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5d02e692-6387-4953-a64f-0cbd3a10d77d, remote_addr: 127.0.0.1:54431, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.283 INFO accepted connection, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.284 INFO request completed, latency_us: 201, response_code: 200, uri: /regioninfo, method: GET, req_id: 92e6a303-d833-4aba-8a32-8dec10b3afee, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.285 INFO request completed, latency_us: 77, response_code: 200, uri: /regioncount, method: GET, req_id: 0c2e07a8-008a-4b56-b77f-2fe4fe678d57, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.285 INFO request completed, latency_us: 80, response_code: 200, uri: /port/cid/0, method: GET, req_id: 91da4422-6cd1-4c5e-ac7b-4516eeb20eef, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.285 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/1, method: GET, req_id: 976082ff-64d1-4189-a32d-998036254b18, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.286 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/2, method: GET, req_id: 591a2ea4-796f-4d76-bde2-a1f203a719dc, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.287 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/3, method: GET, req_id: 58682f04-8e03-44bb-9430-4cef3a32b77a, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.288 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/4, method: GET, req_id: 9a144dc1-8712-4a2a-ad60-98fdf1d9e611, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:32.288 INFO request completed, latency_us: 45, response_code: 200, uri: /port/cid/5, method: GET, req_id: 69b7e895-96be-4c30-a548-31b66d42f16a, remote_addr: 127.0.0.1:65499, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.977 INFO accepted connection, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.978 INFO request completed, latency_us: 198, response_code: 200, uri: /regioninfo, method: GET, req_id: d6dd7561-090d-4b71-8e15-27011964147b, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.979 INFO request completed, latency_us: 59, response_code: 200, uri: /regioncount, method: GET, req_id: b4bf0829-ae8b-4733-8bbe-8a9adc210f4f, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.979 INFO request completed, latency_us: 74, response_code: 200, uri: /port/cid/0, method: GET, req_id: c206d453-e509-4450-8e97-219321c5ce0b, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.979 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/1, method: GET, req_id: 599c0a11-a10e-4368-b86e-4b9f797d6ca8, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.979 INFO request completed, latency_us: 46, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2ed86f3b-3640-4fa7-a8aa-4710f3b0bbf7, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.981 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/3, method: GET, req_id: 0076ba52-1175-4d66-8e23-38e416e4672f, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.982 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/4, method: GET, req_id: 188dbef9-ed19-4081-8341-a047184df52a, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:56:56.982 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/5, method: GET, req_id: b4a19e0c-d958-4b6f-954e-d5312d1b09c4, remote_addr: 127.0.0.1:43965, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.200 INFO accepted connection, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.200 INFO request completed, latency_us: 196, response_code: 200, uri: /regioninfo, method: GET, req_id: 552f903e-f9d4-4eb8-9422-bf55fc9b4d54, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.201 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: 7a5cc4d2-a21a-4324-beb3-fc1f863559bb, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.202 INFO request completed, latency_us: 78, response_code: 200, uri: /port/cid/0, method: GET, req_id: e42aa398-74f7-4b25-a922-83dcf073e755, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.202 INFO request completed, latency_us: 49, response_code: 200, uri: /port/cid/1, method: GET, req_id: f7316641-fe99-4476-b918-8fe41f9ba97f, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.202 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/2, method: GET, req_id: 397d234f-2b29-4b4b-9c1b-3d2ca1157c97, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.203 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8f30ea3e-9893-4907-857b-ea814aef675b, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.204 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/4, method: GET, req_id: bee400ca-74c6-488e-a83f-ceccb8be355c, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:30.204 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/5, method: GET, req_id: f17f5a30-0626-495b-92d9-3f29b37a8942, remote_addr: 127.0.0.1:57222, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.774 INFO accepted connection, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.775 INFO request completed, latency_us: 156, response_code: 200, uri: /regioninfo, method: GET, req_id: ca25e68c-fa24-4e49-afee-45ccabcc75f7, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.776 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: e0df2f3d-76cf-4bf8-a634-f590fa786f52, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.776 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/0, method: GET, req_id: ea87d39a-dd5e-4007-9a3c-e42188c080c9, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.776 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/1, method: GET, req_id: c990839b-3bbe-45ef-8a8d-0c56dac29425, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.776 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: fa03f6df-b06d-4a6b-8d04-03062bcf3fb6, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.778 INFO request completed, latency_us: 76, response_code: 200, uri: /port/cid/3, method: GET, req_id: 95583013-b6bb-498f-9db4-7c8c73fef8cc, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.778 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/4, method: GET, req_id: f63d4896-5e4b-4262-9681-8f2caf3e3515, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:51.778 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/5, method: GET, req_id: c230e0f1-656c-416f-b974-23e0fd59e810, remote_addr: 127.0.0.1:34408, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.887 INFO accepted connection, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.888 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: fa2e6222-e6cc-4d23-9ea9-ddf915a591cd, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.888 INFO request completed, latency_us: 45, response_code: 200, uri: /regioncount, method: GET, req_id: b82da0fa-92b8-4fd5-8858-55d188c231d9, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.889 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/0, method: GET, req_id: be98245c-e491-4cc7-b1fd-0bad60bdf4a9, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.889 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: 632e9149-bbb7-4a33-ab1d-7df41dab1466, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.889 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9431f6a7-2c3f-4abc-84a7-41b24966f49d, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.891 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/3, method: GET, req_id: 769441ae-5c16-453b-8c96-5348a520dced, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.891 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/4, method: GET, req_id: 279e8a54-e909-45f8-8623-41e03e3b3a7e, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:55.891 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/5, method: GET, req_id: 7bb5ea79-98bd-4fea-a8f8-9b6233515ac8, remote_addr: 127.0.0.1:53682, local_addr: 127.0.0.1:9998 Jul 20 22:59:59.989 INFO accepted connection, remote_addr: 127.0.0.1:49708, 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 20 22:59:59.990 INFO request completed, latency_us: 129, response_code: 204, uri: /disablerestart/all, method: POST, req_id: ff81878c-0593-4c6b-bb5d-cd77ed1e9fef, remote_addr: 127.0.0[8820] Disable keep_running .[8810] Disable keep_running 1[8840] Disable keep_running :[8830] Disable keep_running 49708, local_addr: 127.0.0.1:9998 [8860] Disable keep_running [8850] Disable keep_running Jul 20 23:00:00.004 INFO accepted connection, remote_addr: 127.0.0.1:39896, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) Jul 20 23:00:00.004 INFO request completed, latency_us: 91, response_code: stop 2 204, uri: /stop/cid/2, method: POST, req_id: d63ff659-c813-496a-9781-be47f05b9bb8, remote_addr: 127.0.0.1:39896, local_addr:[8830] Got stop action so:false kr:false 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 20 23:00:00.017 INFO accepted connection, remote_addr: 127.0.0.1:37619, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.018 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/2, method: GET, req_id: e4773c37-e4a6-4d85-bd48-db11099220eb, remote_addr: 127.0.0.1:37619, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.034 INFO accepted connection, remote_addr: 127.0.0.1:48817, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jul 20 23:00:00.034 INFO request completed, latency_us: 77, response_code: 204, uri: /start/cid/2, method: POST, req_id: c4a6e9c4-0219-4947-b322-7b100fe10ba9, remote_addr: 127.0.0.1:48817, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.067 INFO accepted connection, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.067 INFO request completed, latency_us: 105, response_code: 200, uri: /regioninfo, method: GET, req_id: 0d8312ed-6e4f-4b04-a62a-46d6be456337, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.068 INFO request completed, latency_us: 61, response_code: 200, uri: /regioncount, method: GET, req_id: b796bec4-bf51-4a9f-8362-029884b205fa, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.068 INFO request completed, latency_us: 77, response_code: 200, uri: /port/cid/0, method: GET, req_id: 811c8dd5-90d8-4b37-ab44-f221cef4de90, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.069 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/1, method: GET, req_id: abcb0ef2-1699-4e98-a026-1a5312e370e7, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.069 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7a16022d-9ecd-4dbe-8bbb-739cb97ed7f2, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.070 INFO request completed, latency_us: 72, response_code: 200, uri: /port/cid/3, method: GET, req_id: 3ae54f46-d8d4-4e6c-a1dd-ebd1c5bb4641, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.071 INFO request completed, latency_us: 59, response_code: 200, uri: /port/cid/4, method: GET, req_id: da19cb00-8390-4ce3-907a-52428e9710ca, remote_addr: 127.0.0.1:39612, local_addr: 127.0.0.1:9998 Jul 20 23:00:00.071 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/5, method: GET, req_id: f7e9dc39-09b7-458f-859a-5c16dba5f9b7, remote_addr: 127.0.0.1:39612, 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(1197) [8830][2] reports Running Jul 20 23:00:14.209 INFO accepted connection, remote_addr: 127.0.0.1:49190, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Jul 20 23:00:14.210 INFO request completed, latency_us: 134, response_code: 204, uri: /shutdown, method: POST, req_id: d284dfa2-4371-4110-953c-a1e7e82edac4, remote_addr: 127.0[8810] Disable keep_running .0.[8810] Got stop action so:false kr:false 1:49190[8830] Disable keep_running , local_addr: 127.0.0.1:9998 [8830] Got stop action so:false kr:false [8820] Disable keep_running [8840] Disable keep_running [8860] Disable keep_running [8840] Got stop action so:false kr:false [8860] Got stop action so:false kr:false [8850] Disable keep_running [8820] Got stop action so:false kr:false [8850] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8860] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8810][0] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] 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.03141153 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.027706116 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.027316092 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.026363742 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.025152624 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024815744 Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.035778087 Created 7 regions /var/tmp/bins/dsc start --region-count 7 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Using existing output directory "/tmp/test_up-build/dsc" Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 400 }) start ds: 8810 start access at:127.0.0.1:9998 start ds: 8820 start ds: 8830 start ds: 8840 start ds: 8850 start ds: 8860 start ds: 8870 Starting downstairs at port 8810 Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-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" [8830][2] initial start wait reports Starting Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] initial start wait reports Starting Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" Starting downstairs at port 8860 Starting downstairs at port 8870 [8850][4] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8870][6] initial start wait reports Starting [8860][5] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1214) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1218) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1220) [8870][6] initial start wait reports Running [8840][3] initial start wait reports Running [8830][2] initial start wait reports Running Control access at:127.0.0.1:9998 Jul 20 23:00:19.434 INFO listening, local_addr: 127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1215) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1219) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1216) [8850][4] initial start wait reports Running Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1217) [8860][5] initial start wait reports Running All downstairs are running Jul 20 23:00:24.446 INFO accepted connection, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.447 INFO request completed, latency_us: 398, response_code: 200, uri: /state/cid/0, method: GET, req_id: 846b1fab-7943-4d11-92ad-12190b264add, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.462 INFO accepted connection, remote_addr: 127.0.0.1:42297, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.462 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4fcd78d7-7e7d-477f-b3f0-1c1ff4058e00, remote_addr: 127.0.0.1:42297, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.476 INFO accepted connection, remote_addr: 127.0.0.1:48894, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.476 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9d8dbc5b-cd60-4722-af94-74c6b1badb41, remote_addr: 127.0.0.1:48894, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.490 INFO accepted connection, remote_addr: 127.0.0.1:43541, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.490 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/3, method: GET, req_id: 0dff9ff4-61ce-40ce-a45e-ec74c8f7a48f, remote_addr: 127.0.0.1:43541, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.503 INFO accepted connection, remote_addr: 127.0.0.1:39939, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.504 INFO request completed, latency_us: 68, response_code: 200, uri: /state/cid/4, method: GET, req_id: 7df0a3c9-74d2-48e1-bea9-97db524d743e, remote_addr: 127.0.0.1:39939, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.517 INFO accepted connection, remote_addr: 127.0.0.1:57795, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.517 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/5, method: GET, req_id: 63e15814-e537-4f7a-9594-b34e0b1a038a, remote_addr: 127.0.0.1:57795, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.530 INFO accepted connection, remote_addr: 127.0.0.1:38746, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.531 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/6, method: GET, req_id: 1f3a9c0b-9087-4fa0-9782-e29e51a835a2, remote_addr: 127.0.0.1:38746, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.544 INFO accepted connection, remote_addr: 127.0.0.1:51474, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.544 INFO request completed, latency_us: 85, response_code: 200, uri: /port/cid/6, method: GET, req_id: aa8d823e-690f-4a10-b26d-56dbb1cabf94, remote_addr: 127.0.0.1:51474, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.563 INFO accepted connection, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.563 INFO request completed, latency_us: 99, response_code: 200, uri: /regioninfo, method: GET, req_id: bdcacac8-bd9b-4d7e-9f85-df84608d8e50, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.564 INFO request completed, latency_us: 63, response_code: 200, uri: /regioncount, method: GET, req_id: 9ef18445-e39a-4c2c-94e2-8daf7f8b30bf, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.564 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4f3d193a-1778-4ae5-b642-7cc97b18f346, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.565 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/1, method: GET, req_id: 72d43027-e6c5-483a-9227-b1e0d614667f, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.565 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/2, method: GET, req_id: 97e14318-21fd-4405-beec-b0f4a2fe67de, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.566 INFO request completed, latency_us: 64, response_code: 200, uri: /port/cid/3, method: GET, req_id: 187167e9-eb9b-4390-b534-00ba026474d4, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.567 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/4, method: GET, req_id: 4c2d5b96-16b0-4459-a9ec-560120fb3623, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.567 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/5, method: GET, req_id: f7b7224d-4be3-4620-a1de-f336007b8986, remote_addr: 127.0.0.1:54312, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.589 INFO accepted connection, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.590 INFO request completed, latency_us: 130, response_code: 200, uri: /regioncount, method: GET, req_id: fb61e57d-3224-44cd-916b-7a0696969178, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 20 23:00:24.984[8810] Got stop action so:false kr:false INFO request completed, latency_us: 248, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 30f822a3-0bd2-424c-a649-f9ff02e8d5fd, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:00:24.984 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/0, method: GET, req_id: 34d53e77-2edb-4523-8b2d-cd475e9b1774, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 20 23:00:28.986 INFO request completed, latency_us: 315, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2e84770a-9d47-42bc-b749-7ad14e73d95e, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 20 23:00:29.385 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/0, method: POST, req_id: 65389a1c-8d15-4e5e-998d-e14858694f8c, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:00:29.385 INFO request completed, latency_us: 48, response_code: 200, uri: /state/cid/0, method: GET, req_id: 03d69d26-3c30-410e-be18-d7a407a89cc7, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:00:33.388 INFO request completed, latency_us: 301, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6b965d81-acb1-4d5a-a422-d49cbb2241a5, remote_addr: 127.0.0.1:39266, 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 20 23:00:37.391 INFO request completed, latency_us: 280, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6fc5cd72-fe9b-4a5d-93a0-7b608e3f81ee, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 20 23:00:43.784 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: 565e54e2-fdd8-4c50-9c42-294d2c900686, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:00:43.784 INFO request completed, latency_us: 69, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3ba5a9aa-6988-4f30-973c-5fc225f2e064, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 20 23:00:47.786 INFO request completed, latency_us: 295, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5154456a-da79-4648-be12-087375d11022, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 20 23:00:48.189 INFO request completed, latency_us: 249, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0d7aa616-4186-477e-87ea-b39b75fb8749, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:00:48.189 INFO request completed, latency_us: 81, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5a952bcd-6c5c-4d23-91af-8fa8261b3d4d, remote_addr: 127.0.0.1:39266, 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 20 23:00:52.191 INFO request completed, latency_us: 294, response_code: 200, uri: /state/cid/0, method: GET, req_id: ccc9faa6-7020-4506-bb66-a47ca64a982d, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 20 23:00:57.582 [8810] Got stop action so:false kr:false INFO request completed, latency_us: 223, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 47c08eab-631f-4d5d-89d0-eb277f029a0a, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:00:57.583 INFO request completed, latency_us: 88, response_code: 200, uri: /state/cid/0, method: GET, req_id: a2db7df4-7241-476a-a98a-6470901faf44, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 20 23:01:01.586 INFO request completed, latency_us: 286, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1f8a8c59-9849-456b-b2d2-8a2317c9bddc, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 20 23:01:01.993 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: 7b8fc5ea-f943-4106-99d6-f262905a73c6, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:01:01.993 INFO request completed, latency_us: 50, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3dd69776-140a-40ef-8547-0f0257ad2165, remote_addr: 127.0.0.1:39266, 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 20 23:01:05.995 INFO request completed, latency_us: 275, response_code: 200, uri: /state/cid/0, method: GET, req_id: 603d2b22-e938-4589-a536-2421f4f68e3f, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 20 23:01:10.389 INFO request completed, latency_us: 224, response_code: 204, uri: /stop/cid/0, method: [8810] Got stop action so:false kr:false POST, req_id: ecbc5444-dbe5-475d-927d-d9d53e8f097d, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:01:10.390 INFO request completed, latency_us: 89, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3b871c74-3507-4d3b-b01f-c833fc3355ea, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 20 23:01:14.392 INFO request completed, latency_us: 296, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9c5807b3-fd3f-4bf5-8f66-2ee194234589, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 20 23:01:14.800 INFO request completed, latency_us: 233, response_code: 204, uri: /start/cid/0, method: POST, req_id: 56054aec-6834-4a77-af50-03c1b266e6e2, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:01:14.800 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6fe7821f-a195-4fdd-94f4-506f9ca7be49, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:01:18.803 INFO request completed, latency_us: 259, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7cbff4f1-b945-46c6-b8dc-2bd0a2d28977, remote_addr: 127.0.0.1:39266, 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(1234) [8810][0] reports Running Jul 20 23:01:22.806 INFO request completed, latency_us: 269, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9bdda853-f2e3-4eef-be27-7e5a90cf915a, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 20 23:01:26.200[8810] Got stop action so:false kr:false INFO request completed, latency_us: 229, response_code: 204, uri: /stop/cid/0, method: POST, req_id: d34ae1ae-3696-4a74-bd76-9ec160acf8e4, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 20 23:01:26.209 INFO request completed, latency_us: 185, response_code: 200, uri: /state/cid/0, method: GET, req_id: 068fcf57-b54a-410a-886e-a76be7c3ca66, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 20 23:01:26.613 INFO request completed, latency_us: 263, response_code: 204, uri: /start/cid/0, method: POST, req_id: c10c15c5-6919-4e2a-a824-7464fe0427ec, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:01:26.614 INFO request completed, latency_us: 204, response_code: 200, uri: /state/cid/0, method: GET, req_id: bdb8e9b5-d2dc-403a-b4d9-adbf6312b08e, remote_addr: 127.0.0.1:39266, 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(1235) [8810][0] reports Running Jul 20 23:01:30.616 INFO request completed, latency_us: 295, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0730e18f-d3a3-4544-bbf1-1b3d8126040b, remote_addr: 127.0.0.1:39266, 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 20 23:01:33.009 INFO request completed, latency_us: 224, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 15c58563-bd68-48ab-8ea6-db09aa4153ee, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:01:33.010 INFO request completed, latency_us: 54, response_code: 200, uri: /state/cid/0, method: GET, req_id: bd962452-310e-4820-a19d-3808d78abbb8, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 20 23:01:37.012 INFO request completed, latency_us: 297, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6365fe44-e96d-45ff-8347-88d8cd6fd802, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 20 23:01:37.420 INFO request completed, latency_us: 274, response_code: 204, uri: /start/cid/0, method: POST, req_id: c4927a38-a2e7-44f8-a2b3-3d34e4bbdea5, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:01:37.420 INFO request completed, latency_us: 72, response_code: 200, uri: /state/cid/0, method: GET, req_id: 302ee385-7b1b-4a3c-8c08-44e10fd3885a, remote_addr: 127.0.0.1:39266, 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(1236) [8810][0] reports Running Jul 20 23:01:41.422 INFO request completed, latency_us: 278, response_code: 200, uri: /state/cid/0, method: GET, req_id: f3e8458e-55a5-47f5-943c-dc7d80eabc3c, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Jul 20 23:02:08.917 [8820] Got stop action so:false kr:false INFO request completed, latency_us: 226, response_code: 204, uri: /stop/cid/1, method: POST, req_id: f282e019-396f-46a0-abcc-585a1310443c, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:02:08.918 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/1, method: GET, req_id: ddec0d1f-2c2c-40c9-8b6f-7563ab318515, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jul 20 23:02:12.920 INFO request completed, latency_us: 296, response_code: 200, uri: /state/cid/1, method: GET, req_id: 04c249ee-45a0-4629-9fd2-d31a2d29f757, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jul 20 23:02:13.327 INFO request completed, latency_us: 236, response_code: 204, uri: /start/cid/1, method: POST, req_id: 813bf10c-d5a4-4b97-a81b-7afd8030fd26, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:02:13.327 INFO request completed, latency_us: 50, response_code: 200, uri: /state/cid/1, method: GET, req_id: d6a32676-a712-4d48-b9a6-ac108e163fdf, remote_addr: 127.0.0.1:39266, 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(1237) [8820][1] reports Running Jul 20 23:02:17.329 INFO request completed, latency_us: 253, response_code: 200, uri: /state/cid/1, method: GET, req_id: e9dc0568-0388-4c16-8115-139866c403f6, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jul 20 23:02:44.937 INFO request completed, [8830] Got stop action so:false kr:false latency_us: 224, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 41acc91d-98b5-4333-a498-0eb923934f16, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:02:44.938 INFO request completed, latency_us: 87, response_code: 200, uri: /state/cid/2, method: GET, req_id: e7259a0b-0eb2-4603-b753-14f31795c5e2, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 20 23:02:48.940 INFO request completed, latency_us: 244, response_code: 200, uri: /state/cid/2, method: GET, req_id: 282a36b2-8e80-4d1b-802b-d81ba85730ed, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jul 20 23:02:49.348 INFO request completed, latency_us: 222, response_code: 204, uri: /start/cid/2, method: POST, req_id: 5c082a08-defc-457b-a436-1af5be5a5524, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:02:49.348 INFO request completed, latency_us: 71, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1772c64c-ade5-460b-8f62-2a9b955022b4, remote_addr: 127.0.0.1:39266, 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(1238) [8830][2] reports Running Jul 20 23:02:53.350 INFO request completed, latency_us: 275, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4bbc0bb8-b881-47f9-8d46-41f5ff70feac, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Jul 20 23:03:21.175 INFO request completed, latency_us:[8840] Got stop action so:false kr:false 223, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 9e604db1-e0e0-4464-a8a3-b5a9ba508c2a, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:03:21.175 INFO request completed, latency_us: 90, response_code: 200, uri: /state/cid/3, method: GET, req_id: 0e39f790-174f-4774-ad9a-fe280b2518eb, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jul 20 23:03:25.177 INFO request completed, latency_us: 287, response_code: 200, uri: /state/cid/3, method: GET, req_id: 47c67df0-886c-45eb-a40c-8c5e7b06021e, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jul 20 23:03:25.590 INFO request completed, latency_us: 251, response_code: 204, uri: /start/cid/3, method: POST, req_id: 9a83a6de-7b83-426d-9c6b-13ecc0e9edff, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:03:25.590 INFO request completed, latency_us: 54, response_code: 200, uri: /state/cid/3, method: GET, req_id: c6434927-d6e4-448a-98b0-1fb6294e8e21, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:03:29.592 INFO request completed, latency_us: 285, response_code: 200, uri: /state/cid/3, method: GET, req_id: 37664276-2718-42e5-8796-4144a7402110, remote_addr: 127.0.0.1:39266, 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(1239) [8840][3] reports Running Jul 20 23:03:33.594 INFO request completed, latency_us: 283, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2edea02b-8ca5-4778-8180-df8e6fd55929, remote_addr: 127.0.0.1:39266, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.304 INFO accepted connection, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.304 INFO request completed, latency_us: 161, response_code: 200, uri: /regioninfo, method: GET, req_id: c9144764-f5b7-4fe3-affe-ccd9796657eb, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.305 INFO request completed, latency_us: 64, response_code: 200, uri: /regioncount, method: GET, req_id: 04af6177-d6d7-45cf-a1fb-ebdb3447d8cc, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.306 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/0, method: GET, req_id: f9c4ce84-9b8e-4aea-b102-7290ea686f5c, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.306 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/1, method: GET, req_id: 06acd74e-728a-4082-9d40-be8613740c41, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.306 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/2, method: GET, req_id: 96fd60c7-bdc9-4de1-b9f8-a9816abfbfb9, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.307 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/3, method: GET, req_id: 993c0070-257e-4b4a-8daa-6d2af7b300b5, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.308 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: 23925022-6f24-4f71-b689-d5b6d7887ba5, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.308 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: e592363a-9566-4214-bf5e-4a77404b4657, remote_addr: 127.0.0.1:58816, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.443 INFO accepted connection, remote_addr: 127.0.0.1:64379, local_addr: 127.0.0.1:9998 Jul 20 23:04:01.443 INFO request completed, latency_us: 131, response_code: 200, uri: /regioncount, method: GET, req_id: 98e8f654-9a2f-469a-9d50-01e88e2ff0f6, remote_addr: 127.0.0.1:64379, 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 20 23:04:07.198 INFO request completed, latency_us: 239, response_code: 204, uri: /stop/cid/0, method: POST, req_id: b107c394-5153-4124-a122-3a8089866765, remote_addr: 127.0.0.1:64379, local_addr: 127.0.0.1:9998 Jul 20 23:04:07.199 INFO request completed, latency_us: 138, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2422a1b4-2746-4d6a-87df-eed01a33415a, remote_addr: 127.0.0.1:64379, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 20 23:04:11.202 INFO request completed, latency_us: 241, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0ec7d5b0-6812-4ad7-959a-d2091349eed9, remote_addr: 127.0.0.1:64379, local_addr: 127.0.0.1:9998 Jul 20 23:04:48.600 INFO accepted connection, remote_addr: 127.0.0.1:45524, local_addr: 127.0.0.1:9998 Main task has work to do, go find it Jul 20 23:04:48.600 INFO request completedgot dsc Start(0) , latency_us: 177, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8c38c54b-66db-4d12-9267-6b2c73287b53, remote_addr: 127.start 0 0.0.1:45524, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Jul 20 23:04:53.002 INFO request completed[8820] Got stop action so:false kr:false , latency_us: 220, response_code: 204, uri: /stop/cid/1, method: POST, req_id: a9ac4b21-84be-4186-b1ff-f0c1d75cc096, remote_addr: 127.0.0.1:45524, local_addr: 127.0.0.1:9998 Jul 20 23:04:53.002 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/1, method: GET, req_id: 10c86cfa-2061-457e-ac0c-cd66d86246d1, remote_addr: 127.0.0.1:45524, 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(1241) [8810][0] reports Running Jul 20 23:04:57.005 INFO request completed, latency_us: 237, response_code: 200, uri: /state/cid/1, method: GET, req_id: 124f72ca-4b60-4e75-b1c7-80b7f98a7d10, remote_addr: 127.0.0.1:45524, local_addr: 127.0.0.1:9998 Jul 20 23:05:34.419 INFO accepted connection, remote_addr: 127.0.0.1:56115, local_addr: 127.0.0.1:9998 Main task has work to do, go find it Jul 20 23:05:34.419 INFO request completed, latency_us: got dsc Start(1) 172, response_code: 204, uri: /start/cid/1, method: POST, req_id: 7a15fda0-34b0-485e-8093-fdd6760e1eab, remote_addr: 127.0.0.1:56115start 1 , 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(1242) [8820][1] reports Running Main task has work to do, go find it got dsc Stop(2) stop 2 Jul 20 23:05:38.824[8830] Got stop action so:false kr:false INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/2, method: POST, req_id: fd836112-0b50-487c-b995-195f24398306, remote_addr: 127.0.0.1:56115, local_addr: 127.0.0.1:9998 Jul 20 23:05:38.825 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/2, method: GET, req_id: 2bfbd0e8-9a05-4277-8b2b-5e8c5da29296, remote_addr: 127.0.0.1:56115, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 20 23:05:42.827 INFO request completed, latency_us: 228, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1cf7bad7-d959-4627-b833-eaea3bf4131e, remote_addr: 127.0.0.1:56115, local_addr: 127.0.0.1:9998 Jul 20 23:06:20.237 INFO accepted connection, remote_addr: 127.0.0.1:50095, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) Jul 20 23:06:20.238start 2 INFO request completed, latency_us: 162, response_code: 204, uri: /start/cid/2, method: POST, req_id: 096a302c-07bb-4997-ae88-d58493fa6d6b, remote_addr: 127.0.0.1:50095, 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(1243) [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 20 23:06:24.660 INFO request completed, latency_us: 223, response_code: 204, uri: /stop/cid/3, method: POST, req_id: d27dfa10-52f4-43c9-97c0-905bf02ff7c8, remote_addr: 127.0.0.1:50095, local_addr: 127.0.0.1:9998 Jul 20 23:06:24.660 INFO request completed, latency_us: 53, response_code: 200, uri: /state/cid/3, method: GET, req_id: 526ae7a6-9cad-456b-b47e-2bcc9745f650, remote_addr: 127.0.0.1:50095, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jul 20 23:06:28.663 INFO request completed, latency_us: 240, response_code: 200, uri: /state/cid/3, method: GET, req_id: 2c585c3b-7073-4257-812d-4f67fc1d6ccb, remote_addr: 127.0.0.1:50095, local_addr: 127.0.0.1:9998 Jul 20 23:07:06.089 INFO accepted connection, remote_addr: 127.0.0.1:61225, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) Jul 20 23:07:06.090 start 3 INFO request completed, latency_us: 181, response_code: 204, uri: /start/cid/3, method: POST, req_id: 1c63f471-235f-42b1-97f0-a5309b73c6c2, remote_addr: 127.0.0.1:61225, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(4) stop 4 Jul 20 23:07:10.665[8850] Got stop action so:false kr:false INFO request completed, latency_us: 224, response_code: 204, uri: /stop/cid/4, method: POST, req_id: 65768050-f892-4e5f-9604-83483fe03254, remote_addr: 127.0.0.1:61225, local_addr: 127.0.0.1:9998 Jul 20 23:07:10.666 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/4, method: GET, req_id: 3a3f8336-c7c4-4ef5-96d6-cb7f89fe5401, remote_addr: 127.0.0.1:61225, local_addr: 127.0.0.1:9998 [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [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(1244) [8840][3] reports Running Jul 20 23:07:14.668 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/4, method: GET, req_id: 50bbb634-78e0-42aa-bab5-5fc7671a8851, remote_addr: 127.0.0.1:61225, local_addr: 127.0.0.1:9998 Jul 20 23:07:52.094 INFO accepted connection, remote_addr: 127.0.0.1:62584, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(4) start 4 Jul 20 23:07:52.095 INFO request completed, latency_us: 172, response_code: 204, uri: /start/cid/4, method: POST, req_id: cd7de128-10c1-4c8c-85cc-aa5b94a28e9c, remote_addr: 127.0.0.1:62584, local_addr: 127.0.0.1:9998 Jul 20 23:07:56.147 INFO accepted connection, remote_addr: 127.0.0.1:62138, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Jul 20 23:07:56.148 Shut it down INFO request completed, latency_us: 131, response_code: 204, uri: /shutdown, method: POST, req_id: 3a24c002-3b2e-4ed2-9b28-e274cf858b79, remote_addr:[8810] Disable keep_running [8820] Disable keep_running 127.0.0.1:[8820] Got stop action so:false kr:false 62138[8830] Disable keep_running , [8840] Disable keep_running local_addr: 127[8840] Got stop action so:false kr:false .0.0.1:9998 [8870] Disable keep_running [8870] Got stop action so:false kr:false [8830] Got stop action so:false kr:false [8810] Got stop action so:false kr:false [8860] Disable keep_running [8860] Got stop action so:false kr:false [8840] Exited with: ExitStatus(unix_wait_status(9)) [8830] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8810] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8810][0] reports Exit [8870] Exited with: ExitStatus(unix_wait_status(9)) [8870][6] reports Exit [8850] got start action [8850] Disable keep_running [8850] Got stop action so:false kr:false