/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.24314627
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.022086984
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.020439668
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 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"
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/8820 port 8820 PID:Some(1180)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1181)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1182)
[8830][2] initial start wait reports Running
All downstairs are running
Nov 01 16:50:53.539 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Nov 01 16:50:58.579 INFO accepted connection, remote_addr: 127.0.0.1:62128, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.581 INFO request completed, latency_us: 516, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8e9f6cbc-0b15-4919-a4cc-228f74ea77c4, remote_addr: 127.0.0.1:62128, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.635 INFO accepted connection, remote_addr: 127.0.0.1:58700, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.636 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/1, method: GET, req_id: 36ec8349-be2c-48a0-9166-7d3783d10635, remote_addr: 127.0.0.1:58700, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.688 INFO accepted connection, remote_addr: 127.0.0.1:64824, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.688 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/2, method: GET, req_id: a02ca97e-297e-4537-9918-d5717eebc90d, remote_addr: 127.0.0.1:64824, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.741 INFO accepted connection, remote_addr: 127.0.0.1:32978, 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 01 16:50:58.742 INFO [8810] Disable keep_running
request completed[8820] Disable keep_running
, [8830] Disable keep_running
latency_us: 155, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 7753892b-b803-40bc-86ba-bd7680735b42, remote_addr: 127.0.0.1:32978, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.858 INFO accepted connection, remote_addr: 127.0.0.1:63361, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.860 INFO request completed, latency_us: 312, response_code: 200, uri: /regioninfo, method: GET, req_id: b1a14fc4-1123-4550-a8e9-9332db4fa9d0, remote_addr: 127.0.0.1:63361, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.862 INFO request completed, latency_us: 107, response_code: 200, uri: /regioncount, method: GET, req_id: 7b797383-7df6-45cc-a309-d88d307f26e3, remote_addr: 127.0.0.1:63361, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.863 INFO request completed, latency_us: 114, response_code: 200, uri: /port/cid/0, method: GET, req_id: fb0c246b-59b6-4efb-8f32-769eec72eaf6, remote_addr: 127.0.0.1:63361, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.863 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/1, method: GET, req_id: b2c2bc78-2a89-4041-9efa-6d31ed94377e, remote_addr: 127.0.0.1:63361, local_addr: 127.0.0.1:9998
Nov 01 16:50:58.864 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/2, method: GET, req_id: 01d09619-b0c6-4f8b-b0d2-8546c6cf0f4e, remote_addr: 127.0.0.1:63361, local_addr: 127.0.0.1:9998
Nov 01 16:51:07.992 INFO accepted connection, remote_addr: 127.0.0.1:61663, local_addr: 127.0.0.1:9998
Nov 01 16:51:07.993 INFO request completed, latency_us: 167, response_code: 200, uri: /regioninfo, method: GET, req_id: 9b86f82b-5c0a-478e-8f37-3a4858cd4e31, remote_addr: 127.0.0.1:61663, local_addr: 127.0.0.1:9998
Nov 01 16:51:07.994 INFO request completed, latency_us: 90, response_code: 200, uri: /regioncount, method: GET, req_id: 96014eeb-6afb-4f85-ba1a-6236b6781253, remote_addr: 127.0.0.1:61663, local_addr: 127.0.0.1:9998
Nov 01 16:51:07.994 INFO request completed, latency_us: 125, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2f61eea1-8575-44f3-a5eb-3ff59a879fff, remote_addr: 127.0.0.1:61663, local_addr: 127.0.0.1:9998
Nov 01 16:51:07.995 INFO request completed, latency_us: 127, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0218e251-5d2f-42d5-b649-6a16ff7ed80f, remote_addr: 127.0.0.1:61663, local_addr: 127.0.0.1:9998
Nov 01 16:51:07.995 INFO request completed, latency_us: 112, response_code: 200, uri: /port/cid/2, method: GET, req_id: 96d5c356-a183-4c12-951b-999dbf98bda1, remote_addr: 127.0.0.1:61663, local_addr: 127.0.0.1:9998
Nov 01 16:51:17.232 INFO accepted connection, remote_addr: 127.0.0.1:61457, local_addr: 127.0.0.1:9998
Nov 01 16:51:17.233 INFO request completed, latency_us: 170, response_code: 200, uri: /regioninfo, method: GET, req_id: 87c13980-ed41-4b54-9627-0475a9960229, remote_addr: 127.0.0.1:61457, local_addr: 127.0.0.1:9998
Nov 01 16:51:17.234 INFO request completed, latency_us: 120, response_code: 200, uri: /regioncount, method: GET, req_id: 38aab115-3f32-4720-88e1-81922883652e, remote_addr: 127.0.0.1:61457, local_addr: 127.0.0.1:9998
Nov 01 16:51:17.234 INFO request completed, latency_us: 111, response_code: 200, uri: /port/cid/0, method: GET, req_id: e5c6c623-f8d2-4928-b2c5-89faa17801c6, remote_addr: 127.0.0.1:61457, local_addr: 127.0.0.1:9998
Nov 01 16:51:17.235 INFO request completed, latency_us: 93, response_code: 200, uri: /port/cid/1, method: GET, req_id: a6c17def-1c18-4d0f-b40f-0905cca4817a, remote_addr: 127.0.0.1:61457, local_addr: 127.0.0.1:9998
Nov 01 16:51:17.236 INFO request completed, latency_us: 128, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4fe9ba59-68fa-4311-9897-08201939ca4d, remote_addr: 127.0.0.1:61457, local_addr: 127.0.0.1:9998
Nov 01 16:51:35.190 INFO accepted connection, remote_addr: 127.0.0.1:53028, local_addr: 127.0.0.1:9998
Nov 01 16:51:35.190 INFO request completed, latency_us: 170, response_code: 200, uri: /regioninfo, method: GET, req_id: 5745b34e-cf95-40a7-aae7-4210100cfe65, remote_addr: 127.0.0.1:53028, local_addr: 127.0.0.1:9998
Nov 01 16:51:35.191 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: 51106d72-7e11-476e-9065-e70ab8d654fd, remote_addr: 127.0.0.1:53028, local_addr: 127.0.0.1:9998
Nov 01 16:51:35.192 INFO request completed, latency_us: 131, response_code: 200, uri: /port/cid/0, method: GET, req_id: 1f0904ce-23db-433a-adf9-2a4338a6305c, remote_addr: 127.0.0.1:53028, local_addr: 127.0.0.1:9998
Nov 01 16:51:35.193 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/1, method: GET, req_id: 6cc00344-5f49-4b41-a273-60cb4e7f0ef9, remote_addr: 127.0.0.1:53028, local_addr: 127.0.0.1:9998
Nov 01 16:51:35.193 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/2, method: GET, req_id: 89a2ac80-c0e5-4464-a763-0392dccadd5b, remote_addr: 127.0.0.1:53028, local_addr: 127.0.0.1:9998
Nov 01 16:51:53.614 INFO accepted connection, remote_addr: 127.0.0.1:47156, local_addr: 127.0.0.1:9998
Nov 01 16:51:53.615 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: 62901178-56ae-49fa-afb5-1a3270a0f1c1, remote_addr: 127.0.0.1:47156, local_addr: 127.0.0.1:9998
Nov 01 16:51:53.616 INFO request completed, latency_us: 86, response_code: 200, uri: /regioncount, method: GET, req_id: 7c6944e1-f8a3-427c-933b-a4ad24f8ef7b, remote_addr: 127.0.0.1:47156, local_addr: 127.0.0.1:9998
Nov 01 16:51:53.617 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4c455699-0ddb-4b5c-80e7-98ad62e562b9, remote_addr: 127.0.0.1:47156, local_addr: 127.0.0.1:9998
Nov 01 16:51:53.617 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/1, method: GET, req_id: ceab7c59-b93b-4684-a677-dd362922e620, remote_addr: 127.0.0.1:47156, local_addr: 127.0.0.1:9998
Nov 01 16:51:53.618 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/2, method: GET, req_id: f8e92fea-26da-4a2d-afaf-a855ab305217, remote_addr: 127.0.0.1:47156, local_addr: 127.0.0.1:9998
Nov 01 16:52:56.498 INFO accepted connection, remote_addr: 127.0.0.1:34769, local_addr: 127.0.0.1:9998
Nov 01 16:52:56.498 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: d19c64fd-3e72-4055-b725-3098958415db, remote_addr: 127.0.0.1:34769, local_addr: 127.0.0.1:9998
Nov 01 16:52:56.499 INFO request completed, latency_us: 121, response_code: 200, uri: /regioncount, method: GET, req_id: 19ac66da-1340-4156-8c38-b66d8c67bfda, remote_addr: 127.0.0.1:34769, local_addr: 127.0.0.1:9998
Nov 01 16:52:56.500 INFO request completed, latency_us: 130, response_code: 200, uri: /port/cid/0, method: GET, req_id: 29179905-f0c4-4970-9dce-521f6335f8b9, remote_addr: 127.0.0.1:34769, local_addr: 127.0.0.1:9998
Nov 01 16:52:56.501 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: db9684a0-f056-4c9f-8c8c-3b19d942ffb8, remote_addr: 127.0.0.1:34769, local_addr: 127.0.0.1:9998
Nov 01 16:52:56.501 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 67264535-7b6c-4977-ab9f-c744673d3497, remote_addr: 127.0.0.1:34769, local_addr: 127.0.0.1:9998
Nov 01 16:53:00.635 INFO accepted connection, remote_addr: 127.0.0.1:62561, local_addr: 127.0.0.1:9998
Nov 01 16:53:00.636 INFO request completed, latency_us: 201, response_code: 200, uri: /regioninfo, method: GET, req_id: a083541d-a5da-47a0-9eeb-06e48b9f2b7e, remote_addr: 127.0.0.1:62561, local_addr: 127.0.0.1:9998
Nov 01 16:53:00.637 INFO request completed, latency_us: 108, response_code: 200, uri: /regioncount, method: GET, req_id: 95946947-e486-42a4-890a-f1d3622615fd, remote_addr: 127.0.0.1:62561, local_addr: 127.0.0.1:9998
Nov 01 16:53:00.637 INFO request completed, latency_us: 137, response_code: 200, uri: /port/cid/0, method: GET, req_id: 19176787-8526-4d24-86e2-e66f7d785cd6, remote_addr: 127.0.0.1:62561, local_addr: 127.0.0.1:9998
Nov 01 16:53:00.638 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: c2b0829d-42e1-4641-8286-9a6c0af2dafb, remote_addr: 127.0.0.1:62561, local_addr: 127.0.0.1:9998
Nov 01 16:53:00.638 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 81f9d8f3-1cc6-4e87-8b87-3e538aba6318, remote_addr: 127.0.0.1:62561, local_addr: 127.0.0.1:9998
Nov 01 16:53:04.753 INFO accepted connection, remote_addr: 127.0.0.1:53506, 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 01 16:53:04.754 INFO [8820] Disable keep_running
request completed[8810] Disable keep_running
, latency_us: 173[8830] Disable keep_running
, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 3263b17e-0e4b-45a3-9159-a83a05d35a0d, remote_addr: 127.0.0.1:53506, local_addr: 127.0.0.1:9998
Nov 01 16:53:04.806 INFO accepted connection, remote_addr: 127.0.0.1:46132, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 01 16:53:04.807 INFO [8830] Got stop action so:false kr:false
request completed, latency_us: 175, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 6486dde8-a866-4690-a1d9-9b67ce697dee, remote_addr: 127.0.0.1:46132, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 01 16:53:04.862 INFO accepted connection, remote_addr: 127.0.0.1:57791, local_addr: 127.0.0.1:9998
Nov 01 16:53:04.863 INFO request completed, latency_us: 175, response_code: 200, uri: /state/cid/2, method: GET, req_id: 5dd9c1b7-7082-4aff-b17c-8095ef7b9aa6, remote_addr: 127.0.0.1:57791, local_addr: 127.0.0.1:9998
Nov 01 16:53:04.921 INFO accepted connection, remote_addr: 127.0.0.1:45606, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 01 16:53:04.922 INFO request completed, latency_us: 145, response_code: 204, uri: /start/cid/2, method: POST, req_id: 3a798e05-b730-470e-92ae-38165f1775e0, remote_addr: 127.0.0.1:45606, local_addr: 127.0.0.1:9998
Nov 01 16:53:05.004 INFO accepted connection, remote_addr: 127.0.0.1:44250, local_addr: 127.0.0.1:9998
Nov 01 16:53:05.004 INFO request completed, latency_us: 171, response_code: 200, uri: /regioninfo, method: GET, req_id: 7c75e5b4-1801-4745-a33d-98022d862705, remote_addr: 127.0.0.1:44250, local_addr: 127.0.0.1:9998
Nov 01 16:53:05.005 INFO request completed, latency_us: 102, response_code: 200, uri: /regioncount, method: GET, req_id: 3b10fc45-4c5b-401f-a871-0466381257a2, remote_addr: 127.0.0.1:44250, local_addr: 127.0.0.1:9998
Nov 01 16:53:05.006 INFO request completed, latency_us: 122, response_code: 200, uri: /port/cid/0, method: GET, req_id: 25c412d6-b1c7-4d7e-9602-e05b50cccd7d, remote_addr: 127.0.0.1:44250, local_addr: 127.0.0.1:9998
Nov 01 16:53:05.007 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: 76374a0b-f83c-49e4-ba24-3d802e916d73, remote_addr: 127.0.0.1:44250, local_addr: 127.0.0.1:9998
Nov 01 16:53:05.007 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3d7d1d84-3609-4975-a49d-9ac16a9bee7c, remote_addr: 127.0.0.1:44250, 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(1230)
[8830][2] reports Running
Nov 01 16:53:19.235 INFO accepted connection, remote_addr: 127.0.0.1:58420, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Nov 01 16:53:19.236 INFO request completed, latency_us: 204, response_code: 204, uri: /shutdown[8810] Disable keep_running
, [8810] Got stop action so:false kr:false
method: POST, req_id: ea6496bc-891f-4bfb-a485-75a55f6e1ae6, remote_addr: 127.0.0.1:58420, local_addr: 127.0.0.1:9998
[8830] Disable keep_running
[8830] Got stop action so:false kr:false
[8820] Disable keep_running
[8820] Got stop action so:false kr:false
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8810][0] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] 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.12689774
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.110337354
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.10392685
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.14193138
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 access at:127.0.0.1:9998
start ds: 8820
start ds: 8830
start ds: 8840
Starting downstairs at port 8810
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"
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8810][0] initial start wait reports Starting
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8820][1] initial start wait reports Starting
[8830][2] initial start wait reports Starting
[8840][3] initial start wait reports Starting
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1244)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1245)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1246)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1247)
[8830][2] initial start wait reports Running
All downstairs are running
Nov 01 16:53:24.763 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Nov 01 16:53:29.802 INFO accepted connection, remote_addr: 127.0.0.1:47444, local_addr: 127.0.0.1:9998
Nov 01 16:53:29.804 INFO request completed, latency_us: 337, response_code: 200, uri: /state/cid/0, method: GET, req_id: bfce3c62-b68e-45ac-8373-a3994f6ba233, remote_addr: 127.0.0.1:47444, local_addr: 127.0.0.1:9998
Nov 01 16:53:29.859 INFO accepted connection, remote_addr: 127.0.0.1:42898, local_addr: 127.0.0.1:9998
Nov 01 16:53:29.859 INFO request completed, latency_us: 131, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4428c70d-b11f-4eac-b3b0-8d7c35a72b61, remote_addr: 127.0.0.1:42898, local_addr: 127.0.0.1:9998
Nov 01 16:53:29.914 INFO accepted connection, remote_addr: 127.0.0.1:35083, local_addr: 127.0.0.1:9998
Nov 01 16:53:29.914 INFO request completed, latency_us: 182, response_code: 200, uri: /state/cid/2, method: GET, req_id: d9062b35-f876-442e-a427-9850be905d60, remote_addr: 127.0.0.1:35083, local_addr: 127.0.0.1:9998
Nov 01 16:53:29.972 INFO accepted connection, remote_addr: 127.0.0.1:49040, local_addr: 127.0.0.1:9998
Nov 01 16:53:29.973 INFO request completed, latency_us: 171, response_code: 200, uri: /state/cid/3, method: GET, req_id: fb17d8e3-662c-48ae-b233-098a8340a13d, remote_addr: 127.0.0.1:49040, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.031 INFO accepted connection, remote_addr: 127.0.0.1:45057, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.032 INFO request completed, latency_us: 191, response_code: 200, uri: /port/cid/3, method: GET, req_id: ca9a9f60-9a38-4c77-8acd-62c07f9cce0e, remote_addr: 127.0.0.1:45057, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.096 INFO accepted connection, remote_addr: 127.0.0.1:40616, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.096 INFO request completed, latency_us: 202, response_code: 200, uri: /regioninfo, method: GET, req_id: 3cc44da7-cf71-4321-8897-5e4efb77396c, remote_addr: 127.0.0.1:40616, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.097 INFO request completed, latency_us: 123, response_code: 200, uri: /regioncount, method: GET, req_id: 160d0bb5-c1c4-4777-a2bb-67ecc7df6da1, remote_addr: 127.0.0.1:40616, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.098 INFO request completed, latency_us: 124, response_code: 200, uri: /port/cid/0, method: GET, req_id: 46dbc987-5cc2-40f7-ac7c-a74dd62a1ceb, remote_addr: 127.0.0.1:40616, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.099 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/1, method: GET, req_id: ba0e679b-de3b-461d-b8a4-293da45c37d8, remote_addr: 127.0.0.1:40616, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.099 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9b47f40d-f070-400f-a79a-7dccb74df156, remote_addr: 127.0.0.1:40616, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.170 INFO accepted connection, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.170 INFO request completed, latency_us: 167, response_code: 200, uri: /regioncount, method: GET, req_id: 0bc9d8bc-4507-4e4e-9775-e472b80498eb, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 01 16:53:30.201 INFO request completed, latency_us: 244, response_code: 204, uri: /stop/cid/0, [8810] Got stop action so:false kr:false
method: POST, req_id: 2e1efc4c-430c-4bfd-a867-2560ce96938f, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:53:30.201 INFO request completed, latency_us: 133, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6692bd60-e496-418f-90ad-ee213f7707f9, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 01 16:53:34.204 INFO request completed, latency_us: 202, response_code: 200, uri: /state/cid/0, method: GET, req_id: 791a6423-df30-4348-af3e-21b39952b5bc, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 01 16:53:34.229 INFO request completed, latency_us: 177, response_code: 204, uri: /start/cid/0, method: POST, req_id: c4bf32b7-c641-4cf1-b39d-f209637d9e23, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:53:34.230 INFO request completed, latency_us: 151, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2b146b78-5f93-45fc-8290-ad04a4ecd09b, remote_addr: 127.0.0.1:60590, 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(1255)
[8810][0] reports Running
Nov 01 16:53:38.232 INFO request completed, latency_us: 312, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1878bc3d-d3ea-44de-93e2-2343f4a256f2, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Nov 01 16:54:08.522 [8820] Got stop action so:false kr:false
INFO request completed, latency_us: 244, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 9fa180c3-e20a-4721-8dbe-73f5a45ddfaa, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:54:08.523 INFO request completed, latency_us: 187, response_code: 200, uri: /state/cid/1, method: GET, req_id: e55c8a89-5a84-455e-9ccb-5d9195c9ad9f, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 01 16:54:12.525 INFO request completed, latency_us: 221, response_code: 200, uri: /state/cid/1, method: GET, req_id: fd45a820-ef7f-4105-b122-e59c5c7a31f5, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 01 16:54:12.550 INFO request completed, latency_us: 166, response_code: 204, uri: /start/cid/1, method: POST, req_id: 6095443d-3e1c-4a84-b2db-44ace36f633d, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:54:12.550 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/1, method: GET, req_id: 66ef53cc-219f-401a-b6a6-871c2d738bc1, remote_addr: 127.0.0.1:60590, 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(1256)
[8820][1] reports Running
Nov 01 16:54:16.552 INFO request completed, latency_us: 334, response_code: 200, uri: /state/cid/1, method: GET, req_id: 936eaaa6-94b1-4742-8276-9cbb8b13a83c, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 01 16:54:42.851 INFO request completed, latency_us: 212, response_code: 204, uri: /stop/cid/2, method:[8830] Got stop action so:false kr:false
 POST, req_id: 0e777371-65a4-40a2-8aef-148981c2db52, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:54:42.852 INFO request completed, latency_us: 240, response_code: 200, uri: /state/cid/2, method: GET, req_id: 81825dd7-2fe1-4a05-89d6-ee3eff63b73e, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Nov 01 16:54:46.854 INFO request completed, latency_us: 295, response_code: 200, uri: /state/cid/2, method: GET, req_id: cf66d688-777e-4ea4-aaa7-cb2817ab003a, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 01 16:54:46.880 INFO request completed, latency_us: 165, response_code: 204, uri: /start/cid/2, method: POST, req_id: cd46d54b-26e0-47f7-b4ea-f7d27c6c31d2, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:54:46.880 INFO request completed, latency_us: 107, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6af5d876-3c40-4f95-b6f1-2532a8e5fa0d, remote_addr: 127.0.0.1:60590, 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(1257)
[8830][2] reports Running
Nov 01 16:54:50.883 INFO request completed, latency_us: 306, response_code: 200, uri: /state/cid/2, method: GET, req_id: 949a0e4a-67e8-4d31-b3a2-78778fdeac52, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Nov 01 16:55:21.177 INFO request completed, latency_us: 239, response_code: 204, [8840] Got stop action so:false kr:false
uri: /stop/cid/3, method: POST, req_id: 14801d0f-cd34-4c4c-a09f-75a95a00dd14, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:55:21.178 INFO request completed, latency_us: 143, response_code: 200, uri: /state/cid/3, method: GET, req_id: fc175607-9b75-4e9c-9ee1-e2fb4d4c89fb, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Nov 01 16:55:25.180 INFO request completed, latency_us: 271, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5cd08397-4bed-4245-ad4b-76409c9a29a9, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Nov 01 16:55:25.206 INFO request completed, latency_us: 148, response_code: 204, uri: /start/cid/3, method: POST, req_id: 63c1d8da-b748-4eb2-9788-8354912d3166, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:55:25.207 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/3, method: GET, req_id: e27161b6-1a9f-4f86-a8a3-f74f5d0bc76a, remote_addr: 127.0.0.1:60590, 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(1262)
[8840][3] reports Running
Nov 01 16:55:29.210 INFO request completed, latency_us: 300, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5d7cac2f-d654-464e-84eb-85fe23ef6d02, remote_addr: 127.0.0.1:60590, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.543 INFO accepted connection, remote_addr: 127.0.0.1:41771, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.544 INFO request completed, latency_us: 161, response_code: 200, uri: /regioninfo, method: GET, req_id: dc14e19d-0656-4b2b-b458-e6ca660d4024, remote_addr: 127.0.0.1:41771, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.545 INFO request completed, latency_us: 111, response_code: 200, uri: /regioncount, method: GET, req_id: 97ab2f36-ebbb-4afe-a768-35f19659a20f, remote_addr: 127.0.0.1:41771, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.546 INFO request completed, latency_us: 129, response_code: 200, uri: /port/cid/0, method: GET, req_id: 909315b5-ef57-4124-894f-314b1eaeab67, remote_addr: 127.0.0.1:41771, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.546 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3df117d7-5e99-4cc5-98fa-310fa0aac803, remote_addr: 127.0.0.1:41771, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.547 INFO request completed, latency_us: 94, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1cd9d940-6cb7-41b2-b69a-0d803f7e6e35, remote_addr: 127.0.0.1:41771, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.616 INFO accepted connection, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Nov 01 16:55:55.617 INFO request completed, latency_us: 125, response_code: 200, uri: /regioncount, method: GET, req_id: bbbd227a-db76-4cbd-bc25-234ad0e2e132, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Nov 01 16:55:56.022 INFO request completed, latency_us: 312, response_code: 204[8810] Got stop action so:false kr:false
, uri: /stop/cid/0, method: POST, req_id: 8b46b9e8-be69-4192-b208-594bea493858, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Nov 01 16:55:56.023 INFO request completed, latency_us: 166, response_code: 200, uri: /state/cid/0, method: GET, req_id: d4abad36-3be0-4332-aa19-aa763519d442, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 01 16:56:00.026 INFO request completed, latency_us: 256, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3bed8006-fe91-4d15-a404-17b56d088bad, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 01 16:56:24.799 INFO request completed, latency_us: 236, response_code: 204, uri: /start/cid/0, method: POST, req_id: 1c488d59-b0fa-4f50-9642-94b889d43069, remote_addr: 127.0.0.1:53601, 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(1264)
[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
Nov 01 16:56:28.827 INFO request completed, latency_us: 336, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 60a21806-f576-4822-94e7-14ecdf010ead, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Nov 01 16:56:28.828 INFO request completed, latency_us: 133, response_code: 200, uri: /state/cid/1, method: GET, req_id: e78c82d5-419a-469d-bf28-6dc0ab7d96c5, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Nov 01 16:56:32.831 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/1, method: GET, req_id: fa6bb446-3bb6-4fcc-9b91-c0e6c79b2209, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Nov 01 16:56:57.615 INFO request completed, latency_us: 267, response_code: 204, uri: /start/cid/1, method: POST, req_id: 5b256916-37a0-4096-a5e7-8f2a46a692cf, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Nov 01 16:57:01.645 INFO request completed, latency_us: 218, response_code[8830] Got stop action so:false kr:false
: 204, uri: /stop/cid/2, method: POST, req_id: 3a1a217b-7b09-4018-bd7b-5fbde353f660, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Nov 01 16:57:01.646 INFO request completed, latency_us: 126, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0ec039de-c23c-417b-9e6d-2b07fe18334c, remote_addr: 127.0.0.1:53601, 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(1265)
[8820][1] reports Running
Nov 01 16:57:05.648 INFO request completed, latency_us: 362, response_code: 200, uri: /state/cid/2, method: GET, req_id: ac5cadcd-5d3d-45c3-8399-50a82554aa47, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Nov 01 16:57:30.433 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/2, method: POST, req_id: 587cf9a4-d0f8-4b7a-ad21-afc317c77074, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Nov 01 16:57:30.464 INFO request completed, latency_us: 157, response_code: 204, uri: /stop/cid/3, method: POST, req_id: e0eb9644-ec45-4f55-b62f-72f287d7016c, remote_addr: 127.0.0.1[8840] Got stop action so:false kr:false
:53601, local_addr: 127.0.0.1:9998
Nov 01 16:57:30.464 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/3, method: GET, req_id: 4373b1ac-6a83-44e4-b003-c23278cd48bc, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Nov 01 16:57:34.467 INFO request completed, latency_us: 300, response_code: 200, uri: /state/cid/3, method: GET, req_id: f5cb548a-78f8-46c7-8f6f-21b83c3591e2, remote_addr: 127.0.0.1:53601, 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(1266)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Start(3)
start 3
Nov 01 16:57:59.252 INFO request completed, latency_us: 367, response_code: 204, uri: /start/cid/3, method: POST, req_id: 4e48814e-580e-4bf2-aa02-af93b01d93f0, remote_addr: 127.0.0.1:53601, 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(1267)
[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 01 16:58:03.292 INFO request completed, latency_us: 330, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 6be9a789-52eb-4028-a7b2-b222fa3c21e3, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Nov 01 16:58:03.293 INFO request completed, latency_us: 133, response_code: 200, uri: /state/cid/0, method: GET, req_id: b97a9177-2537-497f-84e5-491485c1a624, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Nov 01 16:58:07.295 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/0, method: GET, req_id: 25de5c0a-36e9-4581-ab8e-6d1677120391, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Nov 01 16:58:32.073 INFO request completed, latency_us: 235, response_code: 204, uri: /start/cid/0, method: POST, req_id: 7ae64458-5ba2-47a4-9ebd-eeb0cbb2a6d7, remote_addr: 127.0.0.1:53601, local_addr: 127.0.0.1:9998
Nov 01 16:58:32.139 INFO accepted connection, remote_addr: 127.0.0.1:53135, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Nov 01 16:58:32.140 INFO request completed, latency_us: 162, response_code: 204, uri: /shutdown, method: POST, [8820] Disable keep_running
req_id[8830] Disable keep_running
:[8840] Disable keep_running
 8bbd1af9-09b4-42b1-977e-558db0a5d88f, remote_addr: [8840] Got stop action so:false kr:false
127.0.0.1:53135, local_addr: 127.0.0.1:9998
[8820] Got stop action so:false kr:false
[8830] Got stop action so:false kr:false
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830][2] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit