/var/tmp/bins/dsc create --encrypted --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.17507967 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.021405311 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.01855439 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 8810 Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" [8810][0] initial start wait reports Starting [8830][2] initial start wait reports Starting [8820][1] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1193) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1194) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1195) [8830][2] initial start wait reports Running All downstairs are running Feb 25 17:18:44.472 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Feb 25 17:18:49.511 INFO accepted connection, remote_addr: 127.0.0.1:35778, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.513 INFO request completed, latency_us: 429, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0675f4db-3900-4008-beab-f99ad5ee1526, remote_addr: 127.0.0.1:35778, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.567 INFO accepted connection, remote_addr: 127.0.0.1:56216, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.567 INFO request completed, latency_us: 116, response_code: 200, uri: /state/cid/1, method: GET, req_id: ba2a3bb6-584a-4280-92b7-af77f63fc47a, remote_addr: 127.0.0.1:56216, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.620 INFO accepted connection, remote_addr: 127.0.0.1:49887, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.620 INFO request completed, latency_us: 104, response_code: 200, uri: /state/cid/2, method: GET, req_id: 347c2258-d838-47cb-804a-0e63740d0126, remote_addr: 127.0.0.1:49887, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.672 INFO accepted connection, remote_addr: 127.0.0.1:60169, 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 [8820] Disable keep_running Feb 25 17:18:49.672 INFO request completed, latency_us: 192, response_code: 204, uri[8830] Disable keep_running : /disablerestart/all, method: POST, req_id: 46cb84f1-bf57-464f-bc06-3a5960625032, remote_addr: 127.0.0.1:60169, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.796 INFO accepted connection, remote_addr: 127.0.0.1:56019, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.798 INFO request completed, latency_us: 277, response_code: 200, uri: /regioninfo, method: GET, req_id: cbca9236-2b1e-451c-8b70-a868778a5ae4, remote_addr: 127.0.0.1:56019, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.800 INFO request completed, latency_us: 91, response_code: 200, uri: /regioncount, method: GET, req_id: 6137bdd0-2eb7-4174-b34e-c762f8a30558, remote_addr: 127.0.0.1:56019, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.801 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/0, method: GET, req_id: bd0524e3-7fdd-43a3-b915-c10283ead76c, remote_addr: 127.0.0.1:56019, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.802 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 88cb517e-c193-4886-a4a9-1129b2af4314, remote_addr: 127.0.0.1:56019, local_addr: 127.0.0.1:9998 Feb 25 17:18:49.802 INFO request completed, latency_us: 84, response_code: 200, uri: /port/cid/2, method: GET, req_id: 360b59d0-ddea-493f-b332-15311833a97b, remote_addr: 127.0.0.1:56019, local_addr: 127.0.0.1:9998 Feb 25 17:18:58.903 INFO accepted connection, remote_addr: 127.0.0.1:63015, local_addr: 127.0.0.1:9998 Feb 25 17:18:58.904 INFO request completed, latency_us: 152, response_code: 200, uri: /regioninfo, method: GET, req_id: ec7050a5-f161-47b3-b669-d5e18032e618, remote_addr: 127.0.0.1:63015, local_addr: 127.0.0.1:9998 Feb 25 17:18:58.905 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: aae94307-5f8d-449c-864e-9f7178b2c3f6, remote_addr: 127.0.0.1:63015, local_addr: 127.0.0.1:9998 Feb 25 17:18:58.906 INFO request completed, latency_us: 121, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0edd6378-926c-4789-8aab-6986328c9c1a, remote_addr: 127.0.0.1:63015, local_addr: 127.0.0.1:9998 Feb 25 17:18:58.906 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/1, method: GET, req_id: d27527cf-86c0-4ed7-b2bd-e8ee2cca7e93, remote_addr: 127.0.0.1:63015, local_addr: 127.0.0.1:9998 Feb 25 17:18:58.907 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/2, method: GET, req_id: 629bcfb5-c3de-4c82-a5b7-90b3cde707de, remote_addr: 127.0.0.1:63015, local_addr: 127.0.0.1:9998 Feb 25 17:19:08.248 INFO accepted connection, remote_addr: 127.0.0.1:61412, local_addr: 127.0.0.1:9998 Feb 25 17:19:08.248 INFO request completed, latency_us: 186, response_code: 200, uri: /regioninfo, method: GET, req_id: 600debe6-cc73-4214-8d65-c3e864a8bd89, remote_addr: 127.0.0.1:61412, local_addr: 127.0.0.1:9998 Feb 25 17:19:08.249 INFO request completed, latency_us: 98, response_code: 200, uri: /regioncount, method: GET, req_id: 0016258d-c087-43db-9837-7f3733805793, remote_addr: 127.0.0.1:61412, local_addr: 127.0.0.1:9998 Feb 25 17:19:08.250 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 03062a81-b7b7-4efe-976a-df8b0a25040d, remote_addr: 127.0.0.1:61412, local_addr: 127.0.0.1:9998 Feb 25 17:19:08.251 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0673220e-b512-4011-a8ec-4e84e14a463b, remote_addr: 127.0.0.1:61412, local_addr: 127.0.0.1:9998 Feb 25 17:19:08.251 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 90e7e50a-dc94-4de8-a53a-91140e3414e3, remote_addr: 127.0.0.1:61412, local_addr: 127.0.0.1:9998 Feb 25 17:20:06.113 INFO accepted connection, remote_addr: 127.0.0.1:35518, local_addr: 127.0.0.1:9998 Feb 25 17:20:06.114 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: 2972f94b-3427-495c-b026-e9359909a999, remote_addr: 127.0.0.1:35518, local_addr: 127.0.0.1:9998 Feb 25 17:20:06.115 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: 2e194c93-a7fa-42a3-aadc-e35f899b4e2b, remote_addr: 127.0.0.1:35518, local_addr: 127.0.0.1:9998 Feb 25 17:20:06.115 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: b9b71607-e884-4df1-889d-bf8af0ad1684, remote_addr: 127.0.0.1:35518, local_addr: 127.0.0.1:9998 Feb 25 17:20:06.116 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 11991f57-dea2-4b70-afd6-a0e51c8ab2da, remote_addr: 127.0.0.1:35518, local_addr: 127.0.0.1:9998 Feb 25 17:20:06.116 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/2, method: GET, req_id: 111010e6-479b-4c62-abf0-60680a753aaf, remote_addr: 127.0.0.1:35518, local_addr: 127.0.0.1:9998 Feb 25 17:20:52.270 INFO accepted connection, remote_addr: 127.0.0.1:63957, local_addr: 127.0.0.1:9998 Feb 25 17:20:52.271 INFO request completed, latency_us: 153, response_code: 200, uri: /regioninfo, method: GET, req_id: e64cd13d-ba70-4a4e-9845-b6feb8ea9a10, remote_addr: 127.0.0.1:63957, local_addr: 127.0.0.1:9998 Feb 25 17:20:52.272 INFO request completed, latency_us: 126, response_code: 200, uri: /regioncount, method: GET, req_id: 791df49c-aa58-4ed6-b700-fb2ddba34435, remote_addr: 127.0.0.1:63957, local_addr: 127.0.0.1:9998 Feb 25 17:20:52.272 INFO request completed, latency_us: 121, response_code: 200, uri: /port/cid/0, method: GET, req_id: cc1a2d5a-4f11-47c9-862f-ff8f3def8bd6, remote_addr: 127.0.0.1:63957, local_addr: 127.0.0.1:9998 Feb 25 17:20:52.273 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/1, method: GET, req_id: 34d18fea-488a-4e1d-9d12-c8bbe06e42f5, remote_addr: 127.0.0.1:63957, local_addr: 127.0.0.1:9998 Feb 25 17:20:52.273 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2becea0f-5350-4e49-9ecc-e885e12cc1ca, remote_addr: 127.0.0.1:63957, local_addr: 127.0.0.1:9998 Feb 25 17:22:04.856 INFO accepted connection, remote_addr: 127.0.0.1:48712, local_addr: 127.0.0.1:9998 Feb 25 17:22:04.856 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: d700dba7-d1bc-4a92-ad87-6f79b2bb8a84, remote_addr: 127.0.0.1:48712, local_addr: 127.0.0.1:9998 Feb 25 17:22:04.857 INFO request completed, latency_us: 120, response_code: 200, uri: /regioncount, method: GET, req_id: a8cebb58-1d30-4553-b78f-08f7f54ffab5, remote_addr: 127.0.0.1:48712, local_addr: 127.0.0.1:9998 Feb 25 17:22:04.858 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5a5719a4-39de-479d-8ba3-c8c212b27233, remote_addr: 127.0.0.1:48712, local_addr: 127.0.0.1:9998 Feb 25 17:22:04.858 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 598f90e6-a35e-4eaa-8a78-632bae6460f7, remote_addr: 127.0.0.1:48712, local_addr: 127.0.0.1:9998 Feb 25 17:22:04.859 INFO request completed, latency_us: 96, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2a57ea09-8a17-4e6f-9583-b4c816d88596, remote_addr: 127.0.0.1:48712, local_addr: 127.0.0.1:9998 Feb 25 17:22:09.021 INFO accepted connection, remote_addr: 127.0.0.1:38570, local_addr: 127.0.0.1:9998 Feb 25 17:22:09.022 INFO request completed, latency_us: 190, response_code: 200, uri: /regioninfo, method: GET, req_id: 787ad737-4664-49e4-a283-a8888fb185c3, remote_addr: 127.0.0.1:38570, local_addr: 127.0.0.1:9998 Feb 25 17:22:09.023 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 0e245b32-df31-4480-80a7-6c0d681fac67, remote_addr: 127.0.0.1:38570, local_addr: 127.0.0.1:9998 Feb 25 17:22:09.024 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 9ee11731-54bc-4037-a11b-942403b1fc09, remote_addr: 127.0.0.1:38570, local_addr: 127.0.0.1:9998 Feb 25 17:22:09.024 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/1, method: GET, req_id: c1854863-3cbb-448c-bedd-96ff7ce8f2a6, remote_addr: 127.0.0.1:38570, local_addr: 127.0.0.1:9998 Feb 25 17:22:09.025 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7ff3780b-7acf-4e97-bb73-57044cca9124, remote_addr: 127.0.0.1:38570, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.168 INFO accepted connection, remote_addr: 127.0.0.1:51271, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Feb 25 17:22:13.169 INFO request completed, latency_us: 147, response_code: 204, uri: [8810] Disable keep_running /disablerestart/all, method: POST[8830] Disable keep_running , req_id: 54a254df-bf3a-4b30-9d80-2a64847944ae, remote_addr: 127.0.0.1:51271, local_addr: 127.0[8820] Disable keep_running .0.1:9998 Feb 25 17:22:13.223 INFO accepted connection, remote_addr: 127.0.0.1:54978, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Feb 25 17:22:13.223 INFO request completed, latency_us: 148, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 70545ee5-b3da-4ecf-8cc3-591e5b698803, remote_addr: 127.0.0.1:54978, local_addr: 127.0.0.1:9998 [8830] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Feb 25 17:22:13.278 INFO accepted connection, remote_addr: 127.0.0.1:64868, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.279 INFO request completed, latency_us: 136, response_code: 200, uri: /state/cid/2, method: GET, req_id: e1933832-9e15-46f5-8df1-17903c8f896a, remote_addr: 127.0.0.1:64868, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.336 INFO accepted connection, remote_addr: 127.0.0.1:42336, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Feb 25 17:22:13.337 INFO request completed, latency_us: 147, response_code: 204, uri: /start/cid/2, method: POST, req_id: b3a5a407-b102-4a4f-a97e-60058168f49e, remote_addr: 127.0.0.1:42336, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.646 INFO accepted connection, remote_addr: 127.0.0.1:39734, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.647 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: 6bd0df6e-66f3-4dc7-b8d2-6ba59ace9740, remote_addr: 127.0.0.1:39734, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.648 INFO request completed, latency_us: 141, response_code: 200, uri: /regioncount, method: GET, req_id: c4ab76a3-cbba-4a76-a815-7e0e88293d13, remote_addr: 127.0.0.1:39734, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.649 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: ba80f914-362a-41fd-8f77-933411f18db9, remote_addr: 127.0.0.1:39734, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.649 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: c6479d5b-fc8b-48ea-90bb-866e7bfbf474, remote_addr: 127.0.0.1:39734, local_addr: 127.0.0.1:9998 Feb 25 17:22:13.650 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: a8e0386e-a686-4d63-bd05-1b7d2ce06891, remote_addr: 127.0.0.1:39734, 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 Feb 25 17:22:27.858 INFO accepted connection, remote_addr: 127.0.0.1:35843, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Shut it down Feb 25 17:22:27.859 INFO request completed, latency_us: 223, response_code: 204, uri: /shutdown, method: POST, req_id: [8810] Disable keep_running 1dff1aaf-af32-4ecc-8b4d-89e0e2c0fbdf[8820] Disable keep_running , [8810] Got stop action so:false kr:false remote_addr: 127.0.0.1:35843, local_addr: 127.0[8820] Got stop action so:false kr:false .0.1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [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 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.028045708 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.025910372 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.025114425 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.024758833 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 ds: 8840 start access at:127.0.0.1:9998 Starting downstairs at port 8810 Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8810][0] initial start wait reports Starting Starting downstairs at port 8840 [8820][1] initial start wait reports Starting [8830][2] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1257) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1258) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1259) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1260) [8820][1] initial start wait reports Running All downstairs are running Feb 25 17:22:33.010 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Feb 25 17:22:38.050 INFO accepted connection, remote_addr: 127.0.0.1:41571, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.051 INFO request completed, latency_us: 292, response_code: 200, uri: /state/cid/0, method: GET, req_id: 34528cb5-955d-44bb-bae6-c4f81e9f6dc2, remote_addr: 127.0.0.1:41571, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.106 INFO accepted connection, remote_addr: 127.0.0.1:54729, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.107 INFO request completed, latency_us: 146, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3eafc5d7-91ec-462c-8276-f4da14b9cb17, remote_addr: 127.0.0.1:54729, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.159 INFO accepted connection, remote_addr: 127.0.0.1:61101, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.160 INFO request completed, latency_us: 108, response_code: 200, uri: /state/cid/2, method: GET, req_id: 063d2c08-508a-4535-b370-e8bab0f068bd, remote_addr: 127.0.0.1:61101, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.218 INFO accepted connection, remote_addr: 127.0.0.1:44640, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.219 INFO request completed, latency_us: 163, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5cdb5cca-d3e2-4680-8c00-e60884a7a22c, remote_addr: 127.0.0.1:44640, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.277 INFO accepted connection, remote_addr: 127.0.0.1:57038, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.277 INFO request completed, latency_us: 161, response_code: 200, uri: /port/cid/3, method: GET, req_id: b4c4ae95-808d-44e4-91c4-6b0a7608b459, remote_addr: 127.0.0.1:57038, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.339 INFO accepted connection, remote_addr: 127.0.0.1:57117, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.340 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: e76a6073-dd06-4c7c-93d8-e75bdb76f79d, remote_addr: 127.0.0.1:57117, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.341 INFO request completed, latency_us: 98, response_code: 200, uri: /regioncount, method: GET, req_id: f783f716-cd32-428a-b912-590e3ee498b3, remote_addr: 127.0.0.1:57117, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.341 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 49f4bf0b-8188-433f-83d6-277042f9ca05, remote_addr: 127.0.0.1:57117, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.342 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: 99a4d468-7a73-4deb-b5e0-9e191751da7d, remote_addr: 127.0.0.1:57117, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.342 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 490706e4-0d5f-4669-98fc-6e6d8c96882d, remote_addr: 127.0.0.1:57117, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.380 INFO accepted connection, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.380 INFO request completed, latency_us: 104, response_code: 200, uri: /regioncount, method: GET, req_id: 8ac112a2-0b8b-403a-9bfd-65344d4ea68e, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Feb 25 17:22:38.473 INFO request completed, latency_us: 200, response_code: 204[8810] Got stop action so:false kr:false , uri: /stop/cid/0, method: POST, req_id: 2dbe7e0f-e7fc-4faf-b144-9bab9a2f99c0, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:22:38.474 INFO request completed, latency_us: 188, response_code: 200, uri: /state/cid/0, method: GET, req_id: 948b7462-9d8e-4015-9edf-f98b90251faa, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Feb 25 17:22:42.476 INFO request completed, latency_us: 253, response_code: 200, uri: /state/cid/0, method: GET, req_id: f927eae5-d6df-4f15-b4f6-97643cb28801, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Feb 25 17:22:42.566 INFO request completed, latency_us: 149, response_code: 204, uri: /start/cid/0, method: POST, req_id: 5105de28-ebb4-4009-9c02-bb6cf9f44644, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:22:42.566 INFO request completed, latency_us: 94, response_code: 200, uri: /state/cid/0, method: GET, req_id: b464e79e-646b-426e-815d-f20ac5833272, remote_addr: 127.0.0.1:43993, 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(1268) [8810][0] reports Running Feb 25 17:22:46.569 INFO request completed, latency_us: 342, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8f34eb02-ed20-469e-9fa3-164bbd20c903, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 Feb 25 17:23:17.004 INFO request completed, latency_us: 207, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 76e56b0b-ef7c-4dcd-a508-1860eb94431d, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 [8820] Got stop action so:false kr:false Feb 25 17:23:17.005 INFO request completed, latency_us: 159, response_code: 200, uri: /state/cid/1, method: GET, req_id: e171ecf3-0168-4519-aaee-0d0006bc37b6, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Feb 25 17:23:21.007 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/1, method: GET, req_id: 15fa16ba-0bf3-4587-9452-430eedfbf9bd, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Feb 25 17:23:21.093 INFO request completed, latency_us: 142, response_code: 204, uri: /start/cid/1, method: POST, req_id: 3f1e5b46-683f-4927-8a04-06f74ea2a90b, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:23:21.094 INFO request completed, latency_us: 119, response_code: 200, uri: /state/cid/1, method: GET, req_id: 43f8688a-5bc0-4c04-8439-2fcdbb0f5b94, remote_addr: 127.0.0.1:43993, 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(1269) [8820][1] reports Running Feb 25 17:23:25.097 INFO request completed, latency_us: 341, response_code: 200, uri: /state/cid/1, method: GET, req_id: 9a8c8be1-4b91-4e6a-81f5-807671b1d137, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 [8830] Got stop action so:false kr:false Feb 25 17:23:55.628 INFO request completed, latency_us: 202, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 701119af-8bc3-4a30-b98e-dac3e82e20ab, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:23:55.629 INFO request completed, latency_us: 137, response_code: 200, uri: /state/cid/2, method: GET, req_id: 744bacdc-82a7-4c0d-a166-544d74985ce8, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Feb 25 17:23:59.633 INFO request completed, latency_us: 325, response_code: 200, uri: /state/cid/2, method: GET, req_id: ee930561-d8a5-4fa7-9fbc-fa4505e6afa9, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Feb 25 17:23:59.721 INFO request completed, latency_us: 138, response_code: 204, uri: /start/cid/2, method: POST, req_id: 610ae4ae-b95d-41e0-bd38-00b6a3d61da0, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:23:59.721 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/2, method: GET, req_id: 405806e4-ffd2-4b88-aff5-82753e4f96c8, remote_addr: 127.0.0.1:43993, 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(1270) [8830][2] reports Running Feb 25 17:24:03.724 INFO request completed, latency_us: 389, response_code: 200, uri: /state/cid/2, method: GET, req_id: d1eb074d-c2a1-48f4-9298-0315dcaf48a5, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Feb 25 17:24:34.347 INFO request completed, latency_us: 214[8840] Got stop action so:false kr:false , response_code: 204, uri: /stop/cid/3, method: POST, req_id: f6b93812-6196-4792-9f13-774be6872c67, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:24:34.348 INFO request completed, latency_us: 112, response_code: 200, uri: /state/cid/3, method: GET, req_id: 40ae38d7-7586-44e9-8a45-b3ab80c7d40d, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Feb 25 17:24:38.350 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/3, method: GET, req_id: a5209a42-e137-41b5-9058-16d1a7215c78, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Feb 25 17:24:38.440 INFO request completed, latency_us: 183, response_code: 204, uri: /start/cid/3, method: POST, req_id: b56e4df7-7e39-44d0-98f1-ad981cb315d2, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:24:38.440 INFO request completed, latency_us: 94, response_code: 200, uri: /state/cid/3, method: GET, req_id: 11db40e0-ffcf-443c-8b81-3ca8908a0f03, remote_addr: 127.0.0.1:43993, 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(1271) [8840][3] reports Running Feb 25 17:24:42.443 INFO request completed, latency_us: 328, response_code: 200, uri: /state/cid/3, method: GET, req_id: df68cc05-a1f6-4436-80b1-258170641fd6, remote_addr: 127.0.0.1:43993, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.126 INFO accepted connection, remote_addr: 127.0.0.1:49431, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.127 INFO request completed, latency_us: 149, response_code: 200, uri: /regioninfo, method: GET, req_id: 0f6add7b-5428-4e3f-ac26-8e9f2c4b846e, remote_addr: 127.0.0.1:49431, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.127 INFO request completed, latency_us: 83, response_code: 200, uri: /regioncount, method: GET, req_id: 4ca99dd7-e369-4c82-b401-d5b4f437151b, remote_addr: 127.0.0.1:49431, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.128 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: cd2c81ec-6026-43f8-870b-301308781296, remote_addr: 127.0.0.1:49431, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.129 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: 78a626ed-4fef-4748-b726-ea65b0701865, remote_addr: 127.0.0.1:49431, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.129 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: cfc7ba5a-ff0a-460e-b095-884de73f8eb5, remote_addr: 127.0.0.1:49431, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.166 INFO accepted connection, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Feb 25 17:25:13.167 INFO request completed, latency_us: 130, response_code: 200, uri: /regioncount, method: GET, req_id: 36fec3c4-f5e3-48d5-a148-0ac393e1edcd, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Feb 25 17:25:15.153 INFO request completed, latency_us[8810] Got stop action so:false kr:false : 222, response_code: 204, uri: /stop/cid/0, method: POST, req_id: b74750a6-a53d-44e9-924a-97052a238bf6, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Feb 25 17:25:15.154 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/0, method: GET, req_id: bbb2ddab-4fff-4320-9a05-e3708ebe5fbf, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Feb 25 17:25:19.156 INFO request completed, latency_us: 347, response_code: 200, uri: /state/cid/0, method: GET, req_id: 016ec19e-7076-4660-b795-d3407df91025, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Feb 25 17:25:48.030 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/0, method: POST, req_id: 4851a812-abed-4faa-a8f2-02230b335997, remote_addr: 127.0.0.1:58283, 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(1273) [8810][0] reports Running Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Feb 25 17:25:52.129 INFO request completed, latency_us: 305, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 653b70a3-d89f-456d-a62f-9e3698b6ca9e, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Feb 25 17:25:52.130 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/1, method: GET, req_id: ce73f96d-15be-4325-abc1-1b19619db12f, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Feb 25 17:25:56.132 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7ced362b-5afe-4f00-8a73-f1bcf2c04935, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Feb 25 17:26:24.984 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/1, method: POST, req_id: cdc3f7c0-3281-4d82-b089-4389258562dd, remote_addr: 127.0.0.1:58283, 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(1274) [8820][1] reports Running Main task has work to do, go find it got dsc Stop(2) stop 2 Feb 25 17:26:29.082[8830] Got stop action so:false kr:false INFO request completed, latency_us: 318, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 9665f1c2-5ecb-4fda-ab6a-0f587fac90f2, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Feb 25 17:26:29.083 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3d12531d-05ec-4772-a7ce-d2709de667ea, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Feb 25 17:26:33.086 INFO request completed, latency_us: 283, response_code: 200, uri: /state/cid/2, method: GET, req_id: 7f63b35c-ef00-4c26-a013-8741292b7a68, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Feb 25 17:27:01.946 INFO request completed, latency_us: 241, response_code: 204, uri: /start/cid/2, method: POST, req_id: 6f2dc71b-744b-42b0-aca3-4af6018c1595, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Feb 25 17:27:06.047 INFO request completed, latency_us: 214, response_code: 204[8840] Got stop action so:false kr:false , uri: /stop/cid/3, method: POST, req_id: 98db8d2d-2f86-4ee5-a148-cce114f8b59b, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Feb 25 17:27:06.048 INFO request completed, latency_us: 156, response_code: 200, uri: /state/cid/3, method: GET, req_id: bb888e36-ab62-428b-a7b4-5877f856c54b, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Feb 25 17:27:10.051 INFO request completed, latency_us: 272, response_code: 200, uri: /state/cid/3, method: GET, req_id: 79cce4c9-38c2-4e6c-9e18-f455210e8b78, remote_addr: 127.0.0.1:58283, 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(1275) [8830][2] reports Running Main task has work to do, go find it got dsc Start(3) start 3 Feb 25 17:27:38.920 INFO request completed, latency_us: 353, response_code: 204, uri: /start/cid/3, method: POST, req_id: 26aa65a3-af71-4742-98d1-4ccd210bee0c, remote_addr: 127.0.0.1:58283, 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(1276) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(0) stop 0 Feb 25 17:27:43.047 INFO request completed, latency_us: 345, response_code: 204[8810] Got stop action so:false kr:false , uri: /stop/cid/0, method: POST, req_id: d96f47eb-43b6-48f8-ab1b-0a7f71657897, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Feb 25 17:27:43.048 INFO request completed, latency_us: 139, response_code: 200, uri: /state/cid/0, method: GET, req_id: c3770979-87f6-4916-8e0e-4c21af84dd35, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Feb 25 17:27:47.050 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7e639b6d-2e77-4111-925c-367964581a15, remote_addr: 127.0.0.1:58283, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Feb 25 17:28:15.883 INFO request completed, latency_us: 274, response_code: 204, uri: /start/cid/0, method: POST, req_id: ad3735c4-fe38-4bfd-8440-44a981b13f91, remote_addr: 127.0.0.1:58283, 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(1277) [8810][0] reports Running Feb 25 17:28:19.952 INFO accepted connection, remote_addr: 127.0.0.1:56986, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Feb 25 17:28:19.953 INFO request completed, latency_us: 186, response_code: 204, uri: /shutdown, method: POST, req_id: fab0ee56-9632-4859-ba59-2b88bdb7ae1e, remote_addr:[8810] Disable keep_running Shut it down 127[8820] Disable keep_running .0.0.1[8820] Got stop action so:false kr:false :[8810] Got stop action so:false kr:false 56986[8830] Disable keep_running , [8830] Got stop action so:false kr:false local_addr: 127.0.0.1:9998 [8840] Disable keep_running [8840] Got stop action so:false kr:false [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8840] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8840][3] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit