/var/tmp/bins/dsc create --cleanup --region-count 3 --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.2379113 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.018731704 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.017585767 Created 3 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 3 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 access at:127.0.0.1:9998 Starting downstairs at port 8820 Starting downstairs at port 8810 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" 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" [8820][1] initial start wait reports Starting [8810][0] initial start wait reports Starting [8830][2] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1186) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1187) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1188) [8820][1] initial start wait reports Running All downstairs are running Nov 19 17:07:59.506 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Nov 19 17:08:04.547 INFO accepted connection, remote_addr: 127.0.0.1:34152, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.549 INFO request completed, latency_us: 426, response_code: 200, uri: /state/cid/0, method: GET, req_id: a1b09a96-d18e-4f48-a633-1950143816ed, remote_addr: 127.0.0.1:34152, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.603 INFO accepted connection, remote_addr: 127.0.0.1:63495, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.604 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/1, method: GET, req_id: 43cb3a0f-1573-4224-98ae-606f76c55877, remote_addr: 127.0.0.1:63495, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.655 INFO accepted connection, remote_addr: 127.0.0.1:47870, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.656 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0bd6903c-6dfe-40fe-a948-543a9bfecd4f, remote_addr: 127.0.0.1:47870, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.707 INFO accepted connection, remote_addr: 127.0.0.1:44823, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Nov 19 17:08:04.707 INFO request completed, latency_us: 143, response_code:[8810] Disable keep_running 204, uri: /disablerestart/all, method: POST, req_id: 848d02bf-e28d-479e-afc7-ecaf0995a2e1[8830] Disable keep_running , [8820] Disable keep_running remote_addr: 127.0.0.1:44823, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.792 INFO accepted connection, remote_addr: 127.0.0.1:39804, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.793 INFO request completed, latency_us: 313, response_code: 200, uri: /regioninfo, method: GET, req_id: d57646c7-5f55-4c61-9b00-babd2b55c3ac, remote_addr: 127.0.0.1:39804, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.794 INFO request completed, latency_us: 98, response_code: 200, uri: /regioncount, method: GET, req_id: ac561df9-93c6-46d8-9c8e-74726f5187ad, remote_addr: 127.0.0.1:39804, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.795 INFO request completed, latency_us: 138, response_code: 200, uri: /port/cid/0, method: GET, req_id: 32899c90-fbe7-4e7c-8314-6069597ffc52, remote_addr: 127.0.0.1:39804, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.796 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: 43f46a4d-6ed3-4135-bfb0-2d0a588fab17, remote_addr: 127.0.0.1:39804, local_addr: 127.0.0.1:9998 Nov 19 17:08:04.796 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: de46872c-a53e-43f5-bf3a-328cc4f7b6bf, remote_addr: 127.0.0.1:39804, local_addr: 127.0.0.1:9998 Nov 19 17:08:13.921 INFO accepted connection, remote_addr: 127.0.0.1:33200, local_addr: 127.0.0.1:9998 Nov 19 17:08:13.922 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: 20a525b6-ae65-41eb-868e-7d900957bfc0, remote_addr: 127.0.0.1:33200, local_addr: 127.0.0.1:9998 Nov 19 17:08:13.923 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: e4741741-504b-42dd-bb04-ae7d1d991fe3, remote_addr: 127.0.0.1:33200, local_addr: 127.0.0.1:9998 Nov 19 17:08:13.923 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/0, method: GET, req_id: 810079f6-27c1-4380-8df3-b22254a62242, remote_addr: 127.0.0.1:33200, local_addr: 127.0.0.1:9998 Nov 19 17:08:13.924 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/1, method: GET, req_id: 41213835-cb76-4f88-a99b-080ca77711e4, remote_addr: 127.0.0.1:33200, local_addr: 127.0.0.1:9998 Nov 19 17:08:13.925 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: b01917c6-2dcf-49b9-9aed-418a8680be89, remote_addr: 127.0.0.1:33200, local_addr: 127.0.0.1:9998 Nov 19 17:08:23.107 INFO accepted connection, remote_addr: 127.0.0.1:41427, local_addr: 127.0.0.1:9998 Nov 19 17:08:23.108 INFO request completed, latency_us: 176, response_code: 200, uri: /regioninfo, method: GET, req_id: 7db3688d-ed93-4371-82f1-3bd6be95d062, remote_addr: 127.0.0.1:41427, local_addr: 127.0.0.1:9998 Nov 19 17:08:23.109 INFO request completed, latency_us: 110, response_code: 200, uri: /regioncount, method: GET, req_id: 1105656d-7720-4e02-92ed-bf6f303a2d58, remote_addr: 127.0.0.1:41427, local_addr: 127.0.0.1:9998 Nov 19 17:08:23.109 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3862749c-eb16-4854-b7f4-961c48bb3596, remote_addr: 127.0.0.1:41427, local_addr: 127.0.0.1:9998 Nov 19 17:08:23.110 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: 503c2c61-d8cc-4418-ac91-13e82c28070c, remote_addr: 127.0.0.1:41427, local_addr: 127.0.0.1:9998 Nov 19 17:08:23.110 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9f18392b-e32b-4edf-842d-9d4ba2791618, remote_addr: 127.0.0.1:41427, local_addr: 127.0.0.1:9998 Nov 19 17:08:40.779 INFO accepted connection, remote_addr: 127.0.0.1:60358, local_addr: 127.0.0.1:9998 Nov 19 17:08:40.780 INFO request completed, latency_us: 181, response_code: 200, uri: /regioninfo, method: GET, req_id: 51c85e94-7469-4a84-8184-f612cbb2308a, remote_addr: 127.0.0.1:60358, local_addr: 127.0.0.1:9998 Nov 19 17:08:40.781 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: 004703c6-37be-48b3-b495-8e4ce4086d93, remote_addr: 127.0.0.1:60358, local_addr: 127.0.0.1:9998 Nov 19 17:08:40.781 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: f8f0cb12-89d5-4679-8080-4eed5ab312ce, remote_addr: 127.0.0.1:60358, local_addr: 127.0.0.1:9998 Nov 19 17:08:40.782 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/1, method: GET, req_id: a291af54-936d-4ca0-8376-bec207f1085f, remote_addr: 127.0.0.1:60358, local_addr: 127.0.0.1:9998 Nov 19 17:08:40.783 INFO request completed, latency_us: 113, response_code: 200, uri: /port/cid/2, method: GET, req_id: ce7c9ead-dd02-4f08-861f-927b620e70e5, remote_addr: 127.0.0.1:60358, local_addr: 127.0.0.1:9998 Nov 19 17:08:55.398 INFO accepted connection, remote_addr: 127.0.0.1:64200, local_addr: 127.0.0.1:9998 Nov 19 17:08:55.399 INFO request completed, latency_us: 196, response_code: 200, uri: /regioninfo, method: GET, req_id: 3250e77f-4f83-400b-815a-b751284b17b1, remote_addr: 127.0.0.1:64200, local_addr: 127.0.0.1:9998 Nov 19 17:08:55.400 INFO request completed, latency_us: 103, response_code: 200, uri: /regioncount, method: GET, req_id: d44708f2-694e-4e21-b1f7-32ca2c9a77e4, remote_addr: 127.0.0.1:64200, local_addr: 127.0.0.1:9998 Nov 19 17:08:55.401 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: bba07b9d-9763-49ea-a377-ec60c8dc4da2, remote_addr: 127.0.0.1:64200, local_addr: 127.0.0.1:9998 Nov 19 17:08:55.401 INFO request completed, latency_us: 123, response_code: 200, uri: /port/cid/1, method: GET, req_id: e69efe91-94c5-461f-b17f-e9b3d00fe431, remote_addr: 127.0.0.1:64200, local_addr: 127.0.0.1:9998 Nov 19 17:08:55.402 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: 6d3e745e-33d7-44d6-8c28-2cbdf47cf933, remote_addr: 127.0.0.1:64200, local_addr: 127.0.0.1:9998 Nov 19 17:09:57.827 INFO accepted connection, remote_addr: 127.0.0.1:40168, local_addr: 127.0.0.1:9998 Nov 19 17:09:57.827 INFO request completed, latency_us: 170, response_code: 200, uri: /regioninfo, method: GET, req_id: 951d77ac-1ce6-40c1-84be-2d24a0841225, remote_addr: 127.0.0.1:40168, local_addr: 127.0.0.1:9998 Nov 19 17:09:57.828 INFO request completed, latency_us: 113, response_code: 200, uri: /regioncount, method: GET, req_id: a9d4348a-28da-4010-a4de-6eb55e3f4e35, remote_addr: 127.0.0.1:40168, local_addr: 127.0.0.1:9998 Nov 19 17:09:57.829 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9f3babdf-3031-4147-b97c-8a94d03bfae8, remote_addr: 127.0.0.1:40168, local_addr: 127.0.0.1:9998 Nov 19 17:09:57.830 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: 75400e72-68d6-4949-bcc3-c3597eb0e8a3, remote_addr: 127.0.0.1:40168, local_addr: 127.0.0.1:9998 Nov 19 17:09:57.830 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 059168b7-68c7-461b-9a30-fa086e55213c, remote_addr: 127.0.0.1:40168, local_addr: 127.0.0.1:9998 Nov 19 17:10:01.960 INFO accepted connection, remote_addr: 127.0.0.1:46932, local_addr: 127.0.0.1:9998 Nov 19 17:10:01.961 INFO request completed, latency_us: 190, response_code: 200, uri: /regioninfo, method: GET, req_id: 73687e10-f966-42cc-ae19-06ebacef3063, remote_addr: 127.0.0.1:46932, local_addr: 127.0.0.1:9998 Nov 19 17:10:01.962 INFO request completed, latency_us: 123, response_code: 200, uri: /regioncount, method: GET, req_id: d9171b13-fa10-4b9c-bc3d-abd7b92a0e0c, remote_addr: 127.0.0.1:46932, local_addr: 127.0.0.1:9998 Nov 19 17:10:01.962 INFO request completed, latency_us: 128, response_code: 200, uri: /port/cid/0, method: GET, req_id: bd8a3bc5-9d71-4db4-b716-ddd8b880a432, remote_addr: 127.0.0.1:46932, local_addr: 127.0.0.1:9998 Nov 19 17:10:01.963 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3a46cdbb-ad35-4ba7-9a03-c9ddb8eabd94, remote_addr: 127.0.0.1:46932, local_addr: 127.0.0.1:9998 Nov 19 17:10:01.964 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3e455429-7f20-45a2-ac35-882696105e55, remote_addr: 127.0.0.1:46932, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.073 INFO accepted connection, remote_addr: 127.0.0.1:43577, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 [8810] Disable keep_running Nov 19 17:10:06.073[8820] Disable keep_running [8830] Disable keep_running INFO request completed, latency_us: 169, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 3cf7fe86-1698-4355-951d-eab7b5bc03c9, remote_addr: 127.0.0.1:43577, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.126 INFO accepted connection, remote_addr: 127.0.0.1:54769, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Nov 19 17:10:06.126 INFO request completed, [8830] Got stop action so:false kr:false latency_us: 151, response_code: 204, uri: /stop/cid/2, method: POST, req_id: e145e94b-9be4-48ef-af0d-6cbebbbb7937, remote_addr: 127.0.0.1:54769, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Nov 19 17:10:06.178 INFO accepted connection, remote_addr: 127.0.0.1:44520, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.179 INFO request completed, latency_us: 140, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3e9adda2-18d1-44af-aabe-ee1c38a66202, remote_addr: 127.0.0.1:44520, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.236 INFO accepted connection, remote_addr: 127.0.0.1:48689, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Nov 19 17:10:06.236 INFO request completed, latency_us: 184, response_code: 204, uri: /start/cid/2, method: POST, req_id: 51c18dc6-0550-4d79-8ddf-cb573d88f738, remote_addr: 127.0.0.1:48689, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.316 INFO accepted connection, remote_addr: 127.0.0.1:51888, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.317 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: f867226a-d7a7-4da3-b171-d358c4870b9f, remote_addr: 127.0.0.1:51888, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.318 INFO request completed, latency_us: 109, response_code: 200, uri: /regioncount, method: GET, req_id: 99d732ca-d571-4636-af7c-2a48e1d3fd3b, remote_addr: 127.0.0.1:51888, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.319 INFO request completed, latency_us: 121, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1a17983a-2e37-43ca-9124-51ccfef45610, remote_addr: 127.0.0.1:51888, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.319 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/1, method: GET, req_id: 1392282c-2353-4a45-a69d-333cea1cc2f7, remote_addr: 127.0.0.1:51888, local_addr: 127.0.0.1:9998 Nov 19 17:10:06.320 INFO request completed, latency_us: 97, response_code: 200, uri: /port/cid/2, method: GET, req_id: 741f9e16-cf5d-468b-87b0-4d2f6334c842, remote_addr: 127.0.0.1:51888, 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(1236) [8830][2] reports Running Nov 19 17:10:20.524 INFO accepted connection, remote_addr: 127.0.0.1:60449, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Nov 19 17:10:20.525 INFO request completed, latency_us: 227, response_code: 204, uri[8810] Disable keep_running : [8810] Got stop action so:false kr:false /shutdown, method: POST, req_id: [8820] Disable keep_running 8fadf0b4-931c-4686-8373-dd1784991867[8820] Got stop action so:false kr:false , [8830] Disable keep_running remote_addr[8830] Got stop action so:false kr:false : 127.0.0.1:60449, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit /var/tmp/bins/dsc create --cleanup --region-count 4 --extent-count 300 --block-size 4096 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Removing existing dsc directory "/tmp/test_up-build/dsc" Removing existing region "/var/tmp/test_up-build" Creating region directory at: /var/tmp/test_up-build Creating dsc directory at: /tmp/test_up-build/dsc Downstairs region 0 created at /var/tmp/test_up-build/8810 in 0.026745768 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.023739303 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.023907872 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.022665497 Created 4 regions /var/tmp/bins/dsc start --region-count 4 --output-dir /tmp/test_up-build/dsc --ds-bin /var/tmp/bins/crucible-downstairs --region-dir /var/tmp/test_up-build Using existing output directory "/tmp/test_up-build/dsc" Update our region info with: Some(RegionExtentInfo { block_size: 4096, blocks_per_extent: 100, extent_count: 100 }) start ds: 8810 start ds: 8820 start ds: 8830 start access at:127.0.0.1:9998 Starting downstairs at port 8810 start ds: 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] initial start wait reports Starting Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] initial start wait reports Starting Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8830][2] initial start wait reports Starting [8840][3] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1250) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1251) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1252) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1253) [8830][2] initial start wait reports Running All downstairs are running Nov 19 17:10:25.666 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Nov 19 17:10:30.708 INFO accepted connection, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.710 INFO request completed, latency_us: 360, response_code: 200, uri: /state/cid/0, method: GET, req_id: a3d71159-909b-478a-9ae2-78dc76dbef0b, remote_addr: 127.0.0.1:40310, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.766 INFO accepted connection, remote_addr: 127.0.0.1:38863, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.766 INFO request completed, latency_us: 125, response_code: 200, uri: /state/cid/1, method: GET, req_id: b8477745-7c84-408e-a385-7ca565d7a6e0, remote_addr: 127.0.0.1:38863, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.820 INFO accepted connection, remote_addr: 127.0.0.1:48933, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.820 INFO request completed, latency_us: 133, response_code: 200, uri: /state/cid/2, method: GET, req_id: c2260541-a0e6-404e-a48b-84ef70b8b8e7, remote_addr: 127.0.0.1:48933, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.873 INFO accepted connection, remote_addr: 127.0.0.1:48081, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.873 INFO request completed, latency_us: 127, response_code: 200, uri: /state/cid/3, method: GET, req_id: 4b2d65de-99d2-4cd9-887e-2d88db8c7a37, remote_addr: 127.0.0.1:48081, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.926 INFO accepted connection, remote_addr: 127.0.0.1:46194, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.927 INFO request completed, latency_us: 152, response_code: 200, uri: /port/cid/3, method: GET, req_id: a415f976-02b8-4e78-80d1-6a9efa491916, remote_addr: 127.0.0.1:46194, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.987 INFO accepted connection, remote_addr: 127.0.0.1:59111, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.988 INFO request completed, latency_us: 188, response_code: 200, uri: /regioninfo, method: GET, req_id: ab48a163-901e-48e1-b65e-982f73e0a143, remote_addr: 127.0.0.1:59111, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.989 INFO request completed, latency_us: 110, response_code: 200, uri: /regioncount, method: GET, req_id: d33b040e-03ce-4205-981f-1d4a25bea69b, remote_addr: 127.0.0.1:59111, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.989 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: f70e0e45-3106-4fd5-b7c2-c2c525b39b5b, remote_addr: 127.0.0.1:59111, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.990 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/1, method: GET, req_id: aea19a8b-6758-4200-9928-3876599f1c7b, remote_addr: 127.0.0.1:59111, local_addr: 127.0.0.1:9998 Nov 19 17:10:30.990 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/2, method: GET, req_id: b4f8cf78-8336-4e7e-8870-540ad55ebb8a, remote_addr: 127.0.0.1:59111, local_addr: 127.0.0.1:9998 Nov 19 17:10:31.060 INFO accepted connection, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:10:31.061 INFO request completed, latency_us: 111, response_code: 200, uri: /regioncount, method: GET, req_id: 0d90cc19-2bbf-4bb1-bb3f-047af302fc86, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Nov 19 17:10:31.085 INFO request completed, latency_us: 213, response_code: 204, uri: /stop/cid/0[8810] Got stop action so:false kr:false , method: POST, req_id: b722d544-b2da-4b93-a4b0-cc64d3779079, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:10:31.086 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2609e819-a2b7-41a9-812c-9ae90be60074, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Nov 19 17:10:35.088 INFO request completed, latency_us: 246, response_code: 200, uri: /state/cid/0, method: GET, req_id: d3afcc5c-b47a-46e2-8a72-f84081f52b05, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Nov 19 17:10:35.110 INFO request completed, latency_us: 167, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0f043b26-87b7-4a18-8712-dbeec6ea5c29, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:10:35.111 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/0, method: GET, req_id: d09b686b-571c-40f4-9bb3-c84b13e30e38, remote_addr: 127.0.0.1:61898, 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(1261) [8810][0] reports Running Nov 19 17:10:39.114 INFO request completed, latency_us: 342, response_code: 200, uri: /state/cid/0, method: GET, req_id: 43dc6a39-1b5a-4dd0-b32e-06f57cead8e4, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Nov 19 17:11:09.406 INFO request completed, latency_us: 304, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 53e51df3-66af-4077-86ef-91a0ef4a8325, remote_addr: 127.[8820] Got stop action so:false kr:false 0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:11:09.407 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1031f8be-b030-439c-a491-3df0f255d774, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Nov 19 17:11:13.409 INFO request completed, latency_us: 265, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0a64e18d-b61f-4566-99fa-aa3941dc23cb, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Nov 19 17:11:13.431 INFO request completed, latency_us: 147, response_code: 204, uri: /start/cid/1, method: POST, req_id: c73dd1b2-694c-4c4a-b2a7-abcc241d8178, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:11:13.431 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/1, method: GET, req_id: b67bb25c-eee3-4b8d-98c0-47fbf8aab4d1, remote_addr: 127.0.0.1:61898, 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(1262) [8820][1] reports Running Nov 19 17:11:17.434 INFO request completed, latency_us: 292, response_code: 200, uri: /state/cid/1, method: GET, req_id: 76eed7b9-9346-4279-b8c1-ae184f9c6840, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Nov 19 17:11:47.725 INFO request completed, latency_us: 218[8830] Got stop action so:false kr:false , response_code: 204, uri: /stop/cid/2, method: POST, req_id: 2e1d0090-0f9e-43f9-8db8-21cb8123b854, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:11:47.726 INFO request completed, latency_us: 140, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6e965a65-1a8f-4658-8e50-78680199b67a, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Nov 19 17:11:51.729 INFO request completed, latency_us: 335, response_code: 200, uri: /state/cid/2, method: GET, req_id: 78fcf8b7-8be7-4fb7-ab10-c191ff593413, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Nov 19 17:11:51.752 INFO request completed, latency_us: 137, response_code: 204, uri: /start/cid/2, method: POST, req_id: edddf60b-5bbf-4635-b93e-bcad9f94418a, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:11:51.753 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/2, method: GET, req_id: cbe66058-21d3-433e-80ba-94b548d45ab0, remote_addr: 127.0.0.1:61898, 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(1263) [8830][2] reports Running Nov 19 17:11:55.756 INFO request completed, latency_us: 458, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5d41387c-b774-4752-b469-f1a666ccb3dc, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Nov 19 17:12:26.041 INFO request completed, latency_us[8840] Got stop action so:false kr:false : 227, response_code: 204, uri: /stop/cid/3, method: POST, req_id: e2b40f99-8f22-4feb-9c3a-d5d65eb980a9, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:12:26.042 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/3, method: GET, req_id: 435538f0-6651-472a-91cf-045f2a0e5f46, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Nov 19 17:12:30.044 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/3, method: GET, req_id: c47011c9-aef7-4eb0-ac4a-7493a8483fe4, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Nov 19 17:12:30.068 INFO request completed, latency_us: 172, response_code: 204, uri: /start/cid/3, method: POST, req_id: cc96bf41-3d1c-4f61-a636-45ae8bc76414, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:12:30.068 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/3, method: GET, req_id: be541ddd-907c-4c72-bffb-5b9087726771, remote_addr: 127.0.0.1:61898, 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(1264) [8840][3] reports Running Nov 19 17:12:34.071 INFO request completed, latency_us: 351, response_code: 200, uri: /state/cid/3, method: GET, req_id: 99f418f9-f44c-447a-a741-d1a522935223, remote_addr: 127.0.0.1:61898, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.406 INFO accepted connection, remote_addr: 127.0.0.1:38481, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.407 INFO request completed, latency_us: 176, response_code: 200, uri: /regioninfo, method: GET, req_id: e57dfe64-e171-4cd3-86bb-52a1db2143fd, remote_addr: 127.0.0.1:38481, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.408 INFO request completed, latency_us: 104, response_code: 200, uri: /regioncount, method: GET, req_id: 645b794b-b3db-412b-a2dc-1a3855a4c50f, remote_addr: 127.0.0.1:38481, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.408 INFO request completed, latency_us: 128, response_code: 200, uri: /port/cid/0, method: GET, req_id: 857c0f86-c57a-4078-b247-ef2fa6a6b745, remote_addr: 127.0.0.1:38481, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.409 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/1, method: GET, req_id: 759cec80-462b-49e1-95c7-85bd729db60c, remote_addr: 127.0.0.1:38481, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.410 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1a855026-1a7b-4f59-bb41-50701b306867, remote_addr: 127.0.0.1:38481, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.478 INFO accepted connection, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.479 INFO request completed, latency_us: 92, response_code: 200, uri: /regioncount, method: GET, req_id: 6489079a-3f72-4f7f-b1ff-e674ad3eecfb, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Nov 19 17:13:04.859 INFO request completed, latency_us: 233, response_code: 204[8810] Got stop action so:false kr:false , uri: /stop/cid/0, method: POST, req_id: b003edd6-2db2-47d5-be08-9b3a13e08aaf, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Nov 19 17:13:04.860 INFO request completed, latency_us: 133, response_code: 200, uri: /state/cid/0, method: GET, req_id: 28cf4806-da76-4f22-8b75-acc8aeacdc26, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Nov 19 17:13:08.862 INFO request completed, latency_us: 236, response_code: 200, uri: /state/cid/0, method: GET, req_id: acc2296b-ad55-4b1b-acbf-f150fa28a197, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Nov 19 17:13:33.651 INFO request completed, latency_us: 228, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8142eb55-9e6c-42d6-906d-bef6a88d7d11, remote_addr: 127.0.0.1:65297, 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(1266) [8810][0] reports Running Main task has work to do, go find it got dsc Stop(1) stop 1 Nov 19 17:13:37.676 INFO [8820] Got stop action so:false kr:false request completed, latency_us: 335, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 0ad1a5ce-7cc0-4b99-a6e5-43bdddc14fa8, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Nov 19 17:13:37.677 INFO request completed, latency_us: 156, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7b19932d-0da8-4127-ac25-c51c57b8dd55, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Nov 19 17:13:41.679 INFO request completed, latency_us: 300, response_code: 200, uri: /state/cid/1, method: GET, req_id: 1b12d399-0a49-4db5-bb69-0c41640db587, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Nov 19 17:14:06.460 INFO request completed, latency_us: 239, response_code: 204, uri: /start/cid/1, method: POST, req_id: 04a4db04-843d-4669-aadb-23be7cc2c9e4, remote_addr: 127.0.0.1:65297, 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(1267) [8820][1] reports Running Main task has work to do, go find it got dsc Stop(2) stop 2 Nov 19 17:14:10.487 [8830] Got stop action so:false kr:false INFO request completed, latency_us: 327, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 33b2d500-8dcc-4595-82c5-3aadb1f007d1, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Nov 19 17:14:10.488 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/2, method: GET, req_id: 86bd9f62-7e99-4a30-867e-862feede2524, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Nov 19 17:14:14.490 INFO request completed, latency_us: 351, response_code: 200, uri: /state/cid/2, method: GET, req_id: 857e39d0-94a2-47ea-8c70-d070bffd435b, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Nov 19 17:14:39.276 INFO request completed, latency_us: 248, response_code: 204, uri: /start/cid/2, method: POST, req_id: 4134c7da-591d-4d7f-b81d-78902fa28aad, remote_addr: 127.0.0.1:65297, 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(1268) [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 Nov 19 17:14:43.303 INFO request completed, latency_us: 309, response_code: 204, uri: /stop/cid/3, method: POST, req_id: f236b9c9-1509-4087-94bb-710bb1816431, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Nov 19 17:14:43.304 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/3, method: GET, req_id: d0d758ac-2058-48f7-b9b0-1d4ae10b049c, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Nov 19 17:14:47.305 INFO request completed, latency_us: 295, response_code: 200, uri: /state/cid/3, method: GET, req_id: be2e8eb0-2875-4c24-a10c-6bf41bdbea25, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Nov 19 17:15:12.087 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/3, method: POST, req_id: 7a838ab4-340b-46a7-a51b-6efa5c1aaa79, remote_addr: 127.0.0.1:65297, 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(1269) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(0) stop 0 [8810] Got stop action so:false kr:false Nov 19 17:15:16.125 INFO request completed, latency_us: 341, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 545b1eb1-b0a5-4a10-81d8-7950bc17992f, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Nov 19 17:15:16.125 INFO request completed, latency_us: 141, response_code: 200, uri: /state/cid/0, method: GET, req_id: c485046e-7138-4c8d-9587-4f377e90c47c, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Nov 19 17:15:20.127 INFO request completed, latency_us: 199, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8be6f5e0-b624-4b5d-b826-4f988900da01, remote_addr: 127.0.0.1:65297, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Nov 19 17:15:44.909 INFO request completed, latency_us: 308, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8ea3dbbf-116b-4b70-8ff8-f81b76750226, remote_addr: 127.0.0.1:65297, 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(1270) [8810][0] reports Running Nov 19 17:15:48.977 INFO accepted connection, remote_addr: 127.0.0.1:58206, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Nov 19 17:15:48.978 INFO request completedShut it down , latency_us: 186, response_code: 204, uri: /shutdown, [8810] Disable keep_running method[8810] Got stop action so:false kr:false : POST, req_id: 572d559b-bd1c-413c-873d-c44e3e9b3184, remote_addr: 127.0.0.1:58206, local_addr: 127.0.0.1:9998 [8820] Disable keep_running [8820] Got stop action so:false kr:false [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] 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