/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.20899168 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.019758692 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.019186744 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 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Starting downstairs at port 8820 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-8830.txt" [8810][0] initial start wait reports Starting [8820][1] initial start wait reports Starting [8830][2] initial start wait reports Starting 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/8830 port 8830 PID:Some(1188) [8830][2] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1189) [8820][1] initial start wait reports Running All downstairs are running Jan 28 21:54:24.524 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jan 28 21:54:29.565 INFO accepted connection, remote_addr: 127.0.0.1:54009, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.567 INFO request completed, latency_us: 465, response_code: 200, uri: /state/cid/0, method: GET, req_id: f15a780c-aae6-4ec4-afe3-db2f15cb2db1, remote_addr: 127.0.0.1:54009, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.623 INFO accepted connection, remote_addr: 127.0.0.1:61845, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.623 INFO request completed, latency_us: 169, response_code: 200, uri: /state/cid/1, method: GET, req_id: 21bba8ed-efd9-49a0-ae4c-e7cd0861a57b, remote_addr: 127.0.0.1:61845, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.679 INFO accepted connection, remote_addr: 127.0.0.1:33121, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.680 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/2, method: GET, req_id: 28165d75-6e0e-4d67-a82c-ebdd79dfb573, remote_addr: 127.0.0.1:33121, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.734 INFO accepted connection, remote_addr: 127.0.0.1:63403, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Jan 28 21:54:29.735 INFO request completed, latency_us: 174, response_code: 204, uri: /disablerestart/all, method: POST, req_id: [8810] Disable keep_running 1de76cdc-c55e-4e1b-bfa1-4dda3cdfdb91, remote_addr: 127.0[8820] Disable keep_running .0.1:63403, local_addr:[8830] Disable keep_running 127.0.0.1:9998 Jan 28 21:54:29.854 INFO accepted connection, remote_addr: 127.0.0.1:62769, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.856 INFO request completed, latency_us: 345, response_code: 200, uri: /regioninfo, method: GET, req_id: eb583464-7d95-4d75-b20b-c545feaeb196, remote_addr: 127.0.0.1:62769, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.857 INFO request completed, latency_us: 100, response_code: 200, uri: /regioncount, method: GET, req_id: fa0ca10e-b9a2-487a-adf1-ba6162589e01, remote_addr: 127.0.0.1:62769, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.859 INFO request completed, latency_us: 133, response_code: 200, uri: /port/cid/0, method: GET, req_id: 915e9d6e-6d69-427a-8c25-b9a1b3d2b730, remote_addr: 127.0.0.1:62769, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.860 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: a8b85738-c090-4a4a-8861-ac9be42e7f98, remote_addr: 127.0.0.1:62769, local_addr: 127.0.0.1:9998 Jan 28 21:54:29.860 INFO request completed, latency_us: 86, response_code: 200, uri: /port/cid/2, method: GET, req_id: 19f702a0-9aae-4088-ab45-3f6b3c62b716, remote_addr: 127.0.0.1:62769, local_addr: 127.0.0.1:9998 Jan 28 21:54:38.962 INFO accepted connection, remote_addr: 127.0.0.1:36069, local_addr: 127.0.0.1:9998 Jan 28 21:54:38.963 INFO request completed, latency_us: 173, response_code: 200, uri: /regioninfo, method: GET, req_id: 7a5ebeda-522d-4463-b365-442d00482a0f, remote_addr: 127.0.0.1:36069, local_addr: 127.0.0.1:9998 Jan 28 21:54:38.964 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 97068f79-49df-4e95-a986-e9ab946fe71a, remote_addr: 127.0.0.1:36069, local_addr: 127.0.0.1:9998 Jan 28 21:54:38.964 INFO request completed, latency_us: 143, response_code: 200, uri: /port/cid/0, method: GET, req_id: 82e21c63-7b51-436b-b2b9-b6fb7995bb5d, remote_addr: 127.0.0.1:36069, local_addr: 127.0.0.1:9998 Jan 28 21:54:38.965 INFO request completed, latency_us: 131, response_code: 200, uri: /port/cid/1, method: GET, req_id: c6ef7861-5de5-46e1-971b-5c85892c45d4, remote_addr: 127.0.0.1:36069, local_addr: 127.0.0.1:9998 Jan 28 21:54:38.965 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: b1d5b987-e932-4c1e-9e61-7d459acb5661, remote_addr: 127.0.0.1:36069, local_addr: 127.0.0.1:9998 Jan 28 21:54:48.305 INFO accepted connection, remote_addr: 127.0.0.1:49222, local_addr: 127.0.0.1:9998 Jan 28 21:54:48.305 INFO request completed, latency_us: 183, response_code: 200, uri: /regioninfo, method: GET, req_id: 33229c07-ca30-4f03-aca9-0179f9ea1b81, remote_addr: 127.0.0.1:49222, local_addr: 127.0.0.1:9998 Jan 28 21:54:48.306 INFO request completed, latency_us: 95, response_code: 200, uri: /regioncount, method: GET, req_id: 306206d0-0c36-4d95-bf4b-ee63edec2e26, remote_addr: 127.0.0.1:49222, local_addr: 127.0.0.1:9998 Jan 28 21:54:48.307 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3bbb798d-281d-481d-9615-abf4abb16eb6, remote_addr: 127.0.0.1:49222, local_addr: 127.0.0.1:9998 Jan 28 21:54:48.307 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: deb50531-b561-48cf-ac2f-2f347b34b6fc, remote_addr: 127.0.0.1:49222, local_addr: 127.0.0.1:9998 Jan 28 21:54:48.308 INFO request completed, latency_us: 108, response_code: 200, uri: /port/cid/2, method: GET, req_id: da97bb86-6fbf-4f6a-8e9b-6a43374c968c, remote_addr: 127.0.0.1:49222, local_addr: 127.0.0.1:9998 Jan 28 21:55:46.180 INFO accepted connection, remote_addr: 127.0.0.1:39872, local_addr: 127.0.0.1:9998 Jan 28 21:55:46.180 INFO request completed, latency_us: 170, response_code: 200, uri: /regioninfo, method: GET, req_id: eb86ce3b-ac1a-40c7-9de4-300b69f94da8, remote_addr: 127.0.0.1:39872, local_addr: 127.0.0.1:9998 Jan 28 21:55:46.181 INFO request completed, latency_us: 95, response_code: 200, uri: /regioncount, method: GET, req_id: 0540432b-bfe8-4ddf-bbce-f93d3bcc1a06, remote_addr: 127.0.0.1:39872, local_addr: 127.0.0.1:9998 Jan 28 21:55:46.182 INFO request completed, latency_us: 135, response_code: 200, uri: /port/cid/0, method: GET, req_id: e3977a53-ad04-473f-a8e6-eabde89e77f8, remote_addr: 127.0.0.1:39872, local_addr: 127.0.0.1:9998 Jan 28 21:55:46.183 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/1, method: GET, req_id: fabe1b33-e43a-4014-9911-4be7f415b1e2, remote_addr: 127.0.0.1:39872, local_addr: 127.0.0.1:9998 Jan 28 21:55:46.183 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: eb68948e-593e-49cc-88dc-0d94461d2469, remote_addr: 127.0.0.1:39872, local_addr: 127.0.0.1:9998 Jan 28 21:56:32.370 INFO accepted connection, remote_addr: 127.0.0.1:42302, local_addr: 127.0.0.1:9998 Jan 28 21:56:32.371 INFO request completed, latency_us: 164, response_code: 200, uri: /regioninfo, method: GET, req_id: bec9da19-32cb-4826-a08a-576108ac34b6, remote_addr: 127.0.0.1:42302, local_addr: 127.0.0.1:9998 Jan 28 21:56:32.372 INFO request completed, latency_us: 88, response_code: 200, uri: /regioncount, method: GET, req_id: 56ad4966-96ae-42fe-ae33-6b6a007f6cc4, remote_addr: 127.0.0.1:42302, local_addr: 127.0.0.1:9998 Jan 28 21:56:32.372 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 96f26a2f-aa12-46e9-b134-7118854c7598, remote_addr: 127.0.0.1:42302, local_addr: 127.0.0.1:9998 Jan 28 21:56:32.373 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/1, method: GET, req_id: 135b160e-0db1-4818-9819-0e52c2d864c1, remote_addr: 127.0.0.1:42302, local_addr: 127.0.0.1:9998 Jan 28 21:56:32.374 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5700a9c1-08b4-45bf-93f8-780fd91bbce0, remote_addr: 127.0.0.1:42302, local_addr: 127.0.0.1:9998 Jan 28 21:57:44.885 INFO accepted connection, remote_addr: 127.0.0.1:59188, local_addr: 127.0.0.1:9998 Jan 28 21:57:44.886 INFO request completed, latency_us: 176, response_code: 200, uri: /regioninfo, method: GET, req_id: e1c1d123-1b48-47d9-b89b-ca9d1a0a3f66, remote_addr: 127.0.0.1:59188, local_addr: 127.0.0.1:9998 Jan 28 21:57:44.887 INFO request completed, latency_us: 110, response_code: 200, uri: /regioncount, method: GET, req_id: 92b28f99-1ac4-4c9e-beb4-4d415280819f, remote_addr: 127.0.0.1:59188, local_addr: 127.0.0.1:9998 Jan 28 21:57:44.888 INFO request completed, latency_us: 109, response_code: 200, uri: /port/cid/0, method: GET, req_id: f8521be6-2da8-42b6-b3d5-f3d2bec23be4, remote_addr: 127.0.0.1:59188, local_addr: 127.0.0.1:9998 Jan 28 21:57:44.888 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/1, method: GET, req_id: d7566843-709d-49c1-a423-accfb4d2f157, remote_addr: 127.0.0.1:59188, local_addr: 127.0.0.1:9998 Jan 28 21:57:44.891 INFO request completed, latency_us: 2176, response_code: 200, uri: /port/cid/2, method: GET, req_id: b47a5a68-d93c-471f-860c-275d2f2ea1c5, remote_addr: 127.0.0.1:59188, local_addr: 127.0.0.1:9998 Jan 28 21:57:49.052 INFO accepted connection, remote_addr: 127.0.0.1:47808, local_addr: 127.0.0.1:9998 Jan 28 21:57:49.053 INFO request completed, latency_us: 157, response_code: 200, uri: /regioninfo, method: GET, req_id: ed9140f5-bfb7-482d-b179-77414308d96c, remote_addr: 127.0.0.1:47808, local_addr: 127.0.0.1:9998 Jan 28 21:57:49.054 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: a8cd93b8-809f-401f-99aa-1bd431f183b0, remote_addr: 127.0.0.1:47808, local_addr: 127.0.0.1:9998 Jan 28 21:57:49.055 INFO request completed, latency_us: 140, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5ada5cf8-5cc1-4753-8299-9a3a14d3bbc1, remote_addr: 127.0.0.1:47808, local_addr: 127.0.0.1:9998 Jan 28 21:57:49.055 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/1, method: GET, req_id: f1091420-0a93-40be-b170-cd03bf138664, remote_addr: 127.0.0.1:47808, local_addr: 127.0.0.1:9998 Jan 28 21:57:49.056 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5f9e9ef7-c7fe-45ef-8901-0ec096b89d7a, remote_addr: 127.0.0.1:47808, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.209 INFO accepted connection, remote_addr: 127.0.0.1:47345, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 3 Jan 28 21:57:53.209 INFO request completed, latency_us: 163, response_code: 204, uri: /disablerestart/all, method: [8820] Disable keep_running POST[8810] Disable keep_running , [8830] Disable keep_running req_id: 73588d03-e342-41a4-946e-da5d32067052, remote_addr: 127.0.0.1:47345, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.263 INFO accepted connection, remote_addr: 127.0.0.1:51402, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jan 28 21:57:53.264 INFO request completed, latency_us: 169[8830] Got stop action so:false kr:false , response_code: 204, uri: /stop/cid/2, method: POST, req_id: a2106d63-6357-4243-9e5a-faf904d18e3b, remote_addr: 127.0.0.1:51402, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jan 28 21:57:53.317 INFO accepted connection, remote_addr: 127.0.0.1:56057, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.318 INFO request completed, latency_us: 160, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4dfc86da-87e2-458f-992c-0e4ff3901f8b, remote_addr: 127.0.0.1:56057, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.375 INFO accepted connection, remote_addr: 127.0.0.1:36767, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 28 21:57:53.376 INFO request completed, latency_us: 174, response_code: 204, uri: /start/cid/2, method: POST, req_id: 60101dc6-9ad7-4bae-8190-b16607a5dbcc, remote_addr: 127.0.0.1:36767, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.689 INFO accepted connection, remote_addr: 127.0.0.1:53288, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.689 INFO request completed, latency_us: 174, response_code: 200, uri: /regioninfo, method: GET, req_id: 25048858-57bb-4a0e-8ff1-fb041932aa47, remote_addr: 127.0.0.1:53288, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.690 INFO request completed, latency_us: 105, response_code: 200, uri: /regioncount, method: GET, req_id: 5b50c88b-c4b8-410a-8e8c-3feb8b60f56f, remote_addr: 127.0.0.1:53288, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.691 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/0, method: GET, req_id: 57a60788-b608-4720-bd18-2ab9f5deab5b, remote_addr: 127.0.0.1:53288, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.692 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 27a35086-5f81-4db1-8d50-28f3a4a55294, remote_addr: 127.0.0.1:53288, local_addr: 127.0.0.1:9998 Jan 28 21:57:53.692 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: 48b34c09-78e1-4ddc-90e2-48936b9e5609, remote_addr: 127.0.0.1:53288, 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(1237) [8830][2] reports Running Jan 28 21:58:07.898 INFO accepted connection, remote_addr: 127.0.0.1:57644, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Jan 28 21:58:07.899Shut it down INFO request completed, latency_us: 226, response_code: 204, uri[8810] Disable keep_running :[8810] Got stop action so:false kr:false [8820] Disable keep_running /shutdown[8820] Got stop action so:false kr:false , method: [8830] Disable keep_running POST[8830] Got stop action so:false kr:false , req_id: c5ee69e8-d550-4ea1-84a7-169e15971c88, remote_addr: 127.0.0.1:57644, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8820] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8820][1] reports Exit /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.02749912 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.025532847 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.024785873 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.025403451 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" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8810][0] initial start wait reports Starting Starting downstairs at port 8830 [8820][1] initial start wait reports Starting [8830][2] initial start wait reports Starting 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" [8840][3] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1251) [8810][0] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1252) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1253) [8840][3] initial start wait reports Running Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1254) [8830][2] initial start wait reports Running All downstairs are running Jan 28 21:58:13.049 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jan 28 21:58:18.089 INFO accepted connection, remote_addr: 127.0.0.1:38614, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.090 INFO request completed, latency_us: 308, response_code: 200, uri: /state/cid/0, method: GET, req_id: 901dbf7b-139a-49f1-8a1e-630f735c84ab, remote_addr: 127.0.0.1:38614, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.146 INFO accepted connection, remote_addr: 127.0.0.1:56558, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.147 INFO request completed, latency_us: 157, response_code: 200, uri: /state/cid/1, method: GET, req_id: 9990af20-f63a-4d75-9f93-3d0746c16a2f, remote_addr: 127.0.0.1:56558, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.203 INFO accepted connection, remote_addr: 127.0.0.1:52166, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.203 INFO request completed, latency_us: 168, response_code: 200, uri: /state/cid/2, method: GET, req_id: 30668ff4-ab75-4033-82f0-ed98cc0c5dfd, remote_addr: 127.0.0.1:52166, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.258 INFO accepted connection, remote_addr: 127.0.0.1:40370, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.259 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/3, method: GET, req_id: 3b8019f8-fa8c-4f86-a81d-cbd3abd68687, remote_addr: 127.0.0.1:40370, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.316 INFO accepted connection, remote_addr: 127.0.0.1:40588, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.317 INFO request completed, latency_us: 175, response_code: 200, uri: /port/cid/3, method: GET, req_id: 26d1f118-0c97-4135-9925-8929348bbfb9, remote_addr: 127.0.0.1:40588, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.380 INFO accepted connection, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.381 INFO request completed, latency_us: 210, response_code: 200, uri: /regioninfo, method: GET, req_id: c96bde40-59ff-4ad9-8403-a29f06f04103, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.382 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: 911911a6-5829-4f2c-939a-35f8a8d3df48, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.383 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: a9228fe8-bddd-40a4-a449-545d6bee5f41, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.383 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6feb04be-adc4-4569-b5a3-5464f622ec97, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.384 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: ca742e76-a175-423a-a43e-5cad8c2a6ebf, remote_addr: 127.0.0.1:59974, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.421 INFO accepted connection, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.422 INFO request completed, latency_us: 130, response_code: 200, uri: /regioncount, method: GET, req_id: cd7ecb0b-5e79-4f3a-80c9-46ce98e25f9e, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jan 28 21:58:18.512 INFO request completed, latency_us: 255, response_code: 204, uri: /stop/cid/0, method[8810] Got stop action so:false kr:false : POST, req_id: 52d84379-2696-4593-a15c-60f448d9cb70, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 21:58:18.512 INFO request completed, latency_us: 145, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1a326ee1-1a5e-4976-a4f0-4564eb4bd09c, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 28 21:58:22.515 INFO request completed, latency_us: 258, response_code: 200, uri: /state/cid/0, method: GET, req_id: 15072cec-5e81-40da-978a-7dd9d235c355, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 28 21:58:22.607 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/0, method: POST, req_id: a79a519b-51a6-4afa-ad8f-f73b168a1d59, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 21:58:22.607 INFO request completed, latency_us: 103, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3414242e-c94f-4301-b0c2-5a98e4047c4e, remote_addr: 127.0.0.1:59162, 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(1262) [8810][0] reports Running Jan 28 21:58:26.610 INFO request completed, latency_us: 337, response_code: 200, uri: /state/cid/0, method: GET, req_id: ef947e12-cb29-4c49-b58d-116b3e4f2a8f, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) Jan 28 21:58:57.045stop 1 INFO request completed, latency_us: 230, response_code: 204, uri: /stop/cid/1, method: POST, req_id: ed2ca4f6-44b6-4145-8c45-1681d393cda7, remote_addr: 127.0.0.1:59162, local_addr: 127.[8820] Got stop action so:false kr:false 0.0.1:9998 Jan 28 21:58:57.046 INFO request completed, latency_us: 165, response_code: 200, uri: /state/cid/1, method: GET, req_id: e3653c48-f7cc-4b7d-8e6c-fe407d06e52c, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jan 28 21:59:01.049 INFO request completed, latency_us: 218, response_code: 200, uri: /state/cid/1, method: GET, req_id: edda9450-5c3e-4333-98f6-2f201e42ac2c, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jan 28 21:59:01.136 INFO request completed, latency_us: 181, response_code: 204, uri: /start/cid/1, method: POST, req_id: 1537722d-0e7b-4532-b1b4-292aec809ed8, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 21:59:01.136 INFO request completed, latency_us: 148, response_code: 200, uri: /state/cid/1, method: GET, req_id: fb0df195-122a-48b2-b90e-e22265bfbda1, remote_addr: 127.0.0.1:59162, 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(1263) [8820][1] reports Running Jan 28 21:59:05.140 INFO request completed, latency_us: 495, response_code: 200, uri: /state/cid/1, method: GET, req_id: 69646446-88c0-45c6-9476-70ec76faad2b, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jan 28 21:59:35.660 [8830] Got stop action so:false kr:false INFO request completed, latency_us: 205, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 3a209b03-d9c4-495d-bf66-5b2de71b83c3, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 21:59:35.661 INFO request completed, latency_us: 154, response_code: 200, uri: /state/cid/2, method: GET, req_id: 233da6ed-5d11-46d4-a7f1-6fe42e7c93f5, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jan 28 21:59:39.663 INFO request completed, latency_us: 227, response_code: 200, uri: /state/cid/2, method: GET, req_id: 58a2530a-4703-4d20-a6db-ba60231a1187, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 28 21:59:39.751 INFO request completed, latency_us: 215, response_code: 204, uri: /start/cid/2, method: POST, req_id: 2601b54d-c7af-4693-a7ad-ec8a0d571fd7, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 21:59:39.752 INFO request completed, latency_us: 130, response_code: 200, uri: /state/cid/2, method: GET, req_id: de37c9e2-5201-4a3a-b438-c90bbde6b6eb, remote_addr: 127.0.0.1:59162, 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(1264) [8830][2] reports Running Jan 28 21:59:43.754 INFO request completed, latency_us: 373, response_code: 200, uri: /state/cid/2, method: GET, req_id: c6bfd098-a361-4196-87db-e80ed9f55eda, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Jan 28 22:00:14.366 INFO request completed, latency_us: 236[8840] Got stop action so:false kr:false , response_code: 204, uri: /stop/cid/3, method: POST, req_id: 58d0c7fe-19fa-475b-a8a3-145640aefe7b, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 22:00:14.366 INFO request completed, latency_us: 161, response_code: 200, uri: /state/cid/3, method: GET, req_id: c72c90a5-f47e-43a0-bad3-1af12fb6cf8a, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jan 28 22:00:18.369 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7f608de0-05c2-486d-88e8-a4f8d7feacb2, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jan 28 22:00:18.458 INFO request completed, latency_us: 259, response_code: 204, uri: /start/cid/3, method: POST, req_id: f5ecb803-3483-4b34-b30f-907b74f2b039, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 22:00:18.458 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5a8d08e8-401f-47ae-aa6c-16e160250d04, remote_addr: 127.0.0.1:59162, 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(1265) [8840][3] reports Running Jan 28 22:00:22.461 INFO request completed, latency_us: 374, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8fbc0523-e264-4d5c-8f9a-19a4aece5933, remote_addr: 127.0.0.1:59162, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.138 INFO accepted connection, remote_addr: 127.0.0.1:57761, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.139 INFO request completed, latency_us: 172, response_code: 200, uri: /regioninfo, method: GET, req_id: dd5d2a4b-9190-4d12-8e3b-f2c452e0a57f, remote_addr: 127.0.0.1:57761, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.140 INFO request completed, latency_us: 94, response_code: 200, uri: /regioncount, method: GET, req_id: 452d2e2e-f49a-4d85-a3ad-6fe220fd38cb, remote_addr: 127.0.0.1:57761, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.141 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/0, method: GET, req_id: 10a8849e-f086-4de8-b9aa-dee8ae31813c, remote_addr: 127.0.0.1:57761, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.141 INFO request completed, latency_us: 110, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3ebcfd2b-fcab-47e8-8174-0835ce965fa0, remote_addr: 127.0.0.1:57761, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.142 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/2, method: GET, req_id: 98b87c1d-7029-4b03-a40b-a0908b5429b8, remote_addr: 127.0.0.1:57761, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.179 INFO accepted connection, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Jan 28 22:00:53.179 INFO request completed, latency_us: 108, response_code: 200, uri: /regioncount, method: GET, req_id: 6a251c54-a44f-41b0-9c71-40aecb5731ee, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jan 28 22:00:55.152 INFO request completed, latency_us: 219, response_code[8810] Got stop action so:false kr:false : 204, uri: /stop/cid/0, method: POST, req_id: 5336cdcf-b7b0-4d9e-afb4-633fa0ac2b50, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Jan 28 22:00:55.152 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/0, method: GET, req_id: 61f21556-702b-4112-a965-651871ed58f3, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 28 22:00:59.154 INFO request completed, latency_us: 226, response_code: 200, uri: /state/cid/0, method: GET, req_id: a552c350-1d63-4d93-bb1b-f715418d90ff, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 28 22:01:28.014 INFO request completed, latency_us: 235, response_code: 204, uri: /start/cid/0, method: POST, req_id: 465e711a-b840-4c10-a2a9-44b92565cd72, remote_addr: 127.0.0.1:55227, 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(1267) [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 Jan 28 22:01:32.109 INFO request completed, latency_us: 325, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 287528cd-16dd-4cb2-984a-b003a0404412, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Jan 28 22:01:32.110 INFO request completed, latency_us: 136, response_code: 200, uri: /state/cid/1, method: GET, req_id: d2883e56-657a-4433-bf19-83e46638fa73, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jan 28 22:01:36.113 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/1, method: GET, req_id: c9fd9e24-614e-4e1c-b5a2-bb16c5756cf6, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jan 28 22:02:04.992 INFO request completed, latency_us: 209, response_code: 204, uri: /start/cid/1, method: POST, req_id: d39527d6-807e-4552-ade2-5974cb6e0c3d, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jan 28 22:02:09.087 INFO request completed, latency_us: [8830] Got stop action so:false kr:false 210, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 5527bd4f-8ec6-4d41-8701-8a31e5fe4046, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Jan 28 22:02:09.088 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/2, method: GET, req_id: 029a1293-cf24-48a0-bbd0-0f160d2321e1, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] got start action [8820] I am going to restart Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1268) [8820][1] reports Running Jan 28 22:02:13.091 INFO request completed, latency_us: 333, response_code: 200, uri: /state/cid/2, method: GET, req_id: 3c1e4058-35da-40ca-b14f-5a4520bc6a28, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jan 28 22:02:41.959 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/2, method: POST, req_id: 7d688957-2221-4d69-a9c9-388eb1325308, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Jan 28 22:02:46.065 INFO request completed, latency_us: 210, response_code: 204, uri: /stop/cid/3, method: POST, req_id: a6fe3469-8c6a-4085-aaad-2c35a1ae1cfd, remote_addr: 127.0.0.1:55227, local_addr: 127[8840] Got stop action so:false kr:false .0.0.1:9998 Jan 28 22:02:46.066 INFO request completed, latency_us: 109, response_code: 200, uri: /state/cid/3, method: GET, req_id: f1969a11-ec5d-4dec-a125-94512e250e61, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830] got start action [8830] I am going to restart Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1269) [8830][2] reports Running Jan 28 22:02:50.068 INFO request completed, latency_us: 334, response_code: 200, uri: /state/cid/3, method: GET, req_id: c879c261-cd46-442d-ab45-2d3c5ea57ea1, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jan 28 22:03:18.937 INFO request completed, latency_us: 240, response_code: 204, uri: /start/cid/3, method: POST, req_id: 49630728-cabb-4082-8f96-6cdf57d561dc, remote_addr: 127.0.0.1:55227, 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(1270) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(0) stop 0 Jan 28 22:03:23.057 [8810] Got stop action so:false kr:false INFO request completed, latency_us: 337, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 1372c4c9-bc79-4914-bc48-acb9ac7bdf61, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Jan 28 22:03:23.058 INFO request completed, latency_us: 154, response_code: 200, uri: /state/cid/0, method: GET, req_id: ceca09dd-0495-46ca-9bbb-6c5a63b25f5a, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jan 28 22:03:27.060 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6aadf8c3-4e8f-443d-9dca-4c2dfd9d9e81, remote_addr: 127.0.0.1:55227, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jan 28 22:03:55.886 INFO request completed, latency_us: 236, response_code: 204, uri: /start/cid/0, method: POST, req_id: 0a89b123-fb39-40f6-b223-bc533be4bda2, remote_addr: 127.0.0.1:55227, 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(1271) [8810][0] reports Running Jan 28 22:03:59.956 INFO accepted connection, remote_addr: 127.0.0.1:52661, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Jan 28 22:03:59.957Shut it down INFO request completed, latency_us: 206, response_code: 204, uri: /shutdown, method: POST, req_id: 6e75d96e-2c80-409b-822c-c78eec65096b, remote_addr[8810] Disable keep_running : 127.0.0.1:52661, local_addr: 127.0.[8810] Got stop action so:false kr:false 0.1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Disable keep_running [8840] Got stop action so:false kr:false [8820] Disable keep_running [8820] 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 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8830] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8830][2] reports Exit