/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.24770777
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.019424647
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.020970505
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(1192)
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1193)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1194)
[8810][0] initial start wait reports Running
All downstairs are running
Feb 28 06:02:45.953 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Feb 28 06:02:50.997 INFO accepted connection, remote_addr: 127.0.0.1:43404, local_addr: 127.0.0.1:9998
Feb 28 06:02:50.999 INFO request completed, latency_us: 437, response_code: 200, uri: /state/cid/0, method: GET, req_id: 004fca23-8e0e-422c-b8b0-5f20a4d6f17f, remote_addr: 127.0.0.1:43404, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.053 INFO accepted connection, remote_addr: 127.0.0.1:52865, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.054 INFO request completed, latency_us: 130, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7c0310df-fb4d-4514-bdbb-9b0ee6e1c996, remote_addr: 127.0.0.1:52865, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.106 INFO accepted connection, remote_addr: 127.0.0.1:50491, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.106 INFO request completed, latency_us: 121, response_code: 200, uri: /state/cid/2, method: GET, req_id: f168246b-c47f-43f8-a4e8-c89cde023e4b, remote_addr: 127.0.0.1:50491, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.158 INFO accepted connection, remote_addr: 127.0.0.1:52892, 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 28 06:02:51.159 INFO request completed, latency_us: 230, response_code: 204, uri: /disablerestart/all, [8810] Disable keep_running
method[8820] Disable keep_running
: POST, req_id: 46a0f6df-c5df-415b-b28f-f63715c7e222, remote_addr: [8830] Disable keep_running
127.0.0.1:52892, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.240 INFO accepted connection, remote_addr: 127.0.0.1:44076, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.241 INFO request completed, latency_us: 226, response_code: 200, uri: /regioninfo, method: GET, req_id: a613c1bf-f8e7-4a88-9a0a-53fc7fe36790, remote_addr: 127.0.0.1:44076, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.242 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: dd6030b4-ebd0-4026-a174-890eacca4536, remote_addr: 127.0.0.1:44076, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.243 INFO request completed, latency_us: 120, response_code: 200, uri: /port/cid/0, method: GET, req_id: 992437e4-4b09-442c-892f-c1974335c168, remote_addr: 127.0.0.1:44076, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.243 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 7537473f-5c20-4bd3-b010-e0e0b9ac59af, remote_addr: 127.0.0.1:44076, local_addr: 127.0.0.1:9998
Feb 28 06:02:51.244 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/2, method: GET, req_id: dd41c16f-0c68-4857-90db-27fd1c70f4df, remote_addr: 127.0.0.1:44076, local_addr: 127.0.0.1:9998
Feb 28 06:03:00.332 INFO accepted connection, remote_addr: 127.0.0.1:48737, local_addr: 127.0.0.1:9998
Feb 28 06:03:00.333 INFO request completed, latency_us: 145, response_code: 200, uri: /regioninfo, method: GET, req_id: d5914c80-feda-48d5-8aea-23b318603e95, remote_addr: 127.0.0.1:48737, local_addr: 127.0.0.1:9998
Feb 28 06:03:00.334 INFO request completed, latency_us: 85, response_code: 200, uri: /regioncount, method: GET, req_id: 00e31f29-9606-4cd5-9f87-8b4a875d2cef, remote_addr: 127.0.0.1:48737, local_addr: 127.0.0.1:9998
Feb 28 06:03:00.334 INFO request completed, latency_us: 104, response_code: 200, uri: /port/cid/0, method: GET, req_id: 2bdde3c3-218f-440c-b9bc-6f9cbeb558a5, remote_addr: 127.0.0.1:48737, local_addr: 127.0.0.1:9998
Feb 28 06:03:00.335 INFO request completed, latency_us: 105, response_code: 200, uri: /port/cid/1, method: GET, req_id: e1ed71fe-a5e0-4e65-8be4-b43e027fd4c5, remote_addr: 127.0.0.1:48737, local_addr: 127.0.0.1:9998
Feb 28 06:03:00.335 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: fc177816-c8af-4e70-87bd-0d74e77006f5, remote_addr: 127.0.0.1:48737, local_addr: 127.0.0.1:9998
Feb 28 06:03:09.481 INFO accepted connection, remote_addr: 127.0.0.1:56817, local_addr: 127.0.0.1:9998
Feb 28 06:03:09.482 INFO request completed, latency_us: 158, response_code: 200, uri: /regioninfo, method: GET, req_id: 761fd72d-e8c7-4869-81fb-063574017eaf, remote_addr: 127.0.0.1:56817, local_addr: 127.0.0.1:9998
Feb 28 06:03:09.483 INFO request completed, latency_us: 89, response_code: 200, uri: /regioncount, method: GET, req_id: 3ed5ad39-bf61-4c3e-a31c-93660e6dfe6e, remote_addr: 127.0.0.1:56817, local_addr: 127.0.0.1:9998
Feb 28 06:03:09.483 INFO request completed, latency_us: 100, response_code: 200, uri: /port/cid/0, method: GET, req_id: 750335f1-813a-4996-bda9-e66a7cffa68a, remote_addr: 127.0.0.1:56817, local_addr: 127.0.0.1:9998
Feb 28 06:03:09.484 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: ed787412-0da0-43bf-b43d-43b71f2d5f73, remote_addr: 127.0.0.1:56817, local_addr: 127.0.0.1:9998
Feb 28 06:03:09.484 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: f8b0557f-b48d-4c48-be1f-4f63848539ad, remote_addr: 127.0.0.1:56817, local_addr: 127.0.0.1:9998
Feb 28 06:03:27.320 INFO accepted connection, remote_addr: 127.0.0.1:40232, local_addr: 127.0.0.1:9998
Feb 28 06:03:27.321 INFO request completed, latency_us: 156, response_code: 200, uri: /regioninfo, method: GET, req_id: 33b86a00-85f2-4b45-a990-55231011487f, remote_addr: 127.0.0.1:40232, local_addr: 127.0.0.1:9998
Feb 28 06:03:27.322 INFO request completed, latency_us: 83, response_code: 200, uri: /regioncount, method: GET, req_id: 90f104f5-cb6a-46e6-bdf9-bef5ff9ddf92, remote_addr: 127.0.0.1:40232, local_addr: 127.0.0.1:9998
Feb 28 06:03:27.322 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 03509964-8e7b-42f1-8d6f-54b60808ac0e, remote_addr: 127.0.0.1:40232, local_addr: 127.0.0.1:9998
Feb 28 06:03:27.323 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 20e0d904-8f6b-4ffb-b830-dea76a7872b3, remote_addr: 127.0.0.1:40232, local_addr: 127.0.0.1:9998
Feb 28 06:03:27.323 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/2, method: GET, req_id: 4c5c54a1-4e29-424f-a086-0785136ef95b, remote_addr: 127.0.0.1:40232, local_addr: 127.0.0.1:9998
Feb 28 06:03:42.023 INFO accepted connection, remote_addr: 127.0.0.1:59116, local_addr: 127.0.0.1:9998
Feb 28 06:03:42.024 INFO request completed, latency_us: 177, response_code: 200, uri: /regioninfo, method: GET, req_id: 2fc53458-a3ed-45f3-a006-a6abd1a8613f, remote_addr: 127.0.0.1:59116, local_addr: 127.0.0.1:9998
Feb 28 06:03:42.024 INFO request completed, latency_us: 85, response_code: 200, uri: /regioncount, method: GET, req_id: f7a38b3a-4e90-4887-a8f5-a7cc4421800d, remote_addr: 127.0.0.1:59116, local_addr: 127.0.0.1:9998
Feb 28 06:03:42.025 INFO request completed, latency_us: 102, response_code: 200, uri: /port/cid/0, method: GET, req_id: 54519b11-9e94-40be-800d-6c34ad720130, remote_addr: 127.0.0.1:59116, local_addr: 127.0.0.1:9998
Feb 28 06:03:42.026 INFO request completed, latency_us: 99, response_code: 200, uri: /port/cid/1, method: GET, req_id: 5ee1d690-2bc0-4468-9416-49c61d58b692, remote_addr: 127.0.0.1:59116, local_addr: 127.0.0.1:9998
Feb 28 06:03:42.026 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2ebd7f5e-a66f-4d68-98c4-cef13687c59e, remote_addr: 127.0.0.1:59116, local_addr: 127.0.0.1:9998
Feb 28 06:04:44.203 INFO accepted connection, remote_addr: 127.0.0.1:42314, local_addr: 127.0.0.1:9998
Feb 28 06:04:44.203 INFO request completed, latency_us: 148, response_code: 200, uri: /regioninfo, method: GET, req_id: 20b58840-aafb-4042-814f-69b9b27a721f, remote_addr: 127.0.0.1:42314, local_addr: 127.0.0.1:9998
Feb 28 06:04:44.204 INFO request completed, latency_us: 87, response_code: 200, uri: /regioncount, method: GET, req_id: 93ee772f-8bb5-447d-880a-862113faf71b, remote_addr: 127.0.0.1:42314, local_addr: 127.0.0.1:9998
Feb 28 06:04:44.205 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: adf2217a-d5b2-45f0-8a43-edfcf651bc32, remote_addr: 127.0.0.1:42314, local_addr: 127.0.0.1:9998
Feb 28 06:04:44.205 INFO request completed, latency_us: 89, response_code: 200, uri: /port/cid/1, method: GET, req_id: 531e5f97-2cd1-4908-acb6-a0031c249a68, remote_addr: 127.0.0.1:42314, local_addr: 127.0.0.1:9998
Feb 28 06:04:44.206 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: a4c1d931-68b0-4c41-8c44-8c9a62d9cc94, remote_addr: 127.0.0.1:42314, local_addr: 127.0.0.1:9998
Feb 28 06:04:48.297 INFO accepted connection, remote_addr: 127.0.0.1:46165, local_addr: 127.0.0.1:9998
Feb 28 06:04:48.298 INFO request completed, latency_us: 178, response_code: 200, uri: /regioninfo, method: GET, req_id: eb52d212-603b-4200-a58c-f485c8cf74d9, remote_addr: 127.0.0.1:46165, local_addr: 127.0.0.1:9998
Feb 28 06:04:48.298 INFO request completed, latency_us: 96, response_code: 200, uri: /regioncount, method: GET, req_id: 80d577cf-4128-4122-a54d-f03f03897a34, remote_addr: 127.0.0.1:46165, local_addr: 127.0.0.1:9998
Feb 28 06:04:48.299 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3f0047f9-fbd7-4ca0-84f8-49f8bcc3fd5b, remote_addr: 127.0.0.1:46165, local_addr: 127.0.0.1:9998
Feb 28 06:04:48.300 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/1, method: GET, req_id: 61c4f84d-c3e1-4ffa-ab7a-82b56743f469, remote_addr: 127.0.0.1:46165, local_addr: 127.0.0.1:9998
Feb 28 06:04:48.300 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: 13f2cd36-5c1c-43eb-a383-567a9103a725, remote_addr: 127.0.0.1:46165, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.375 INFO accepted connection, remote_addr: 127.0.0.1:55947, 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 28 06:04:52.376 INFO request completed, latency_us: 159, response_code: 204, [8820] Disable keep_running
uri[8810] Disable keep_running
: /disablerestart/all, method: POST, req_id: 225e215c-9cb2-4d01-a563-c1d71c912a85, remote_addr: 127.0.0.1:55947[8830] Disable keep_running
, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.429 INFO accepted connection, remote_addr: 127.0.0.1:39843, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Feb 28 06:04:52.430 INFO request completed, latency_us:[8830] Got stop action so:false kr:false
 193, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 10afe53a-e7b9-4213-8ed9-86a8ef6a7311, remote_addr: 127.0.0.1:39843, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Feb 28 06:04:52.485 INFO accepted connection, remote_addr: 127.0.0.1:56972, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.486 INFO request completed, latency_us: 130, response_code: 200, uri: /state/cid/2, method: GET, req_id: 54992e29-a382-4de1-8572-0933ae81f4e2, remote_addr: 127.0.0.1:56972, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.543 INFO accepted connection, remote_addr: 127.0.0.1:59782, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Feb 28 06:04:52.543 INFO request completed, latency_us: 151, response_code: 204, uri: /start/cid/2, method: POST, req_id: 09fbd3f9-64c1-4793-a5d0-c9a0834f9e6f, remote_addr: 127.0.0.1:59782, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.848 INFO accepted connection, remote_addr: 127.0.0.1:40488, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.848 INFO request completed, latency_us: 147, response_code: 200, uri: /regioninfo, method: GET, req_id: 0399dfa6-ec24-464e-956d-a596f2038d9b, remote_addr: 127.0.0.1:40488, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.849 INFO request completed, latency_us: 109, response_code: 200, uri: /regioncount, method: GET, req_id: de37b145-a42e-4034-85c9-c263d6e17814, remote_addr: 127.0.0.1:40488, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.850 INFO request completed, latency_us: 116, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3c6070ed-75a4-4078-bfe5-b4e2a3c08271, remote_addr: 127.0.0.1:40488, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.851 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/1, method: GET, req_id: 07a3454c-d548-423e-b04c-a171de8ba114, remote_addr: 127.0.0.1:40488, local_addr: 127.0.0.1:9998
Feb 28 06:04:52.851 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: d04b2696-8359-46f9-94d7-29bf673a4a66, remote_addr: 127.0.0.1:40488, 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(1242)
[8830][2] reports Running
Feb 28 06:05:07.019 INFO accepted connection, remote_addr: 127.0.0.1:62643, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Feb 28 06:05:07.020Shut it down
 [8810] Disable keep_running
INFO[8810] Got stop action so:false kr:false
 request completed, latency_us: 199, response_code: 204, uri: /shutdown, method: POST, req_id: 4693deb8-d348-4d48-87bd-9b9966e92bb3, remote_addr: 127.0.0.1:62643, 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))
[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 --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.026186997
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.02387314
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.023309369
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.023667226
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
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"
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8810][0] initial start wait reports Starting
[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/8810 port 8810 PID:Some(1256)
[8810][0] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1257)
[8840][3] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1258)
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1259)
[8820][1] initial start wait reports Running
All downstairs are running
Feb 28 06:05:12.160 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Feb 28 06:05:17.202 INFO accepted connection, remote_addr: 127.0.0.1:62146, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.203 INFO request completed, latency_us: 329, response_code: 200, uri: /state/cid/0, method: GET, req_id: ffda456f-f790-4761-9620-d1df165b598f, remote_addr: 127.0.0.1:62146, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.257 INFO accepted connection, remote_addr: 127.0.0.1:57254, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.258 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/1, method: GET, req_id: c61aa204-b585-477a-8450-62d0a4d2cf4a, remote_addr: 127.0.0.1:57254, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.309 INFO accepted connection, remote_addr: 127.0.0.1:39898, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.310 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9e04d0af-ab3d-4048-aa4c-5eb8c9965373, remote_addr: 127.0.0.1:39898, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.363 INFO accepted connection, remote_addr: 127.0.0.1:36538, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.363 INFO request completed, latency_us: 120, response_code: 200, uri: /state/cid/3, method: GET, req_id: d6b31377-7098-44a1-87d6-bb799ce24e2f, remote_addr: 127.0.0.1:36538, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.417 INFO accepted connection, remote_addr: 127.0.0.1:52904, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.418 INFO request completed, latency_us: 162, response_code: 200, uri: /port/cid/3, method: GET, req_id: f0430865-6432-4a0e-9fa9-4a288126b715, remote_addr: 127.0.0.1:52904, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.476 INFO accepted connection, remote_addr: 127.0.0.1:64087, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.477 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: c11f38ef-1ebc-4168-8eba-c417be951a3e, remote_addr: 127.0.0.1:64087, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.478 INFO request completed, latency_us: 102, response_code: 200, uri: /regioncount, method: GET, req_id: ed462d0a-4969-48bc-8937-83cd13e56417, remote_addr: 127.0.0.1:64087, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.479 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4fb7bd7c-a242-436d-ab7a-f54871163688, remote_addr: 127.0.0.1:64087, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.479 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/1, method: GET, req_id: 566e2389-7b6a-4f8a-bba1-7a7c59871d04, remote_addr: 127.0.0.1:64087, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.480 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/2, method: GET, req_id: 1938c8f0-79c0-4192-9384-2550693a1c5f, remote_addr: 127.0.0.1:64087, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.516 INFO accepted connection, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.516 INFO request completed, latency_us: 100, response_code: 200, uri: /regioncount, method: GET, req_id: 55677084-a46f-4ee2-9e73-167f0b517f00, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Feb 28 06:05:17.540 INFO request completed, latency_us: 270, response_code: 204, uri: [8810] Got stop action so:false kr:false
/stop/cid/0, method: POST, req_id: 1e5c1334-e567-44e9-8510-2267d71af81b, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:17.541 INFO request completed, latency_us: 182, response_code: 200, uri: /state/cid/0, method: GET, req_id: e183072d-32c1-4b8c-9777-1244e8ed5bce, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Feb 28 06:05:21.543 INFO request completed, latency_us: 199, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6b2b2137-bcfa-48b0-9934-e904791d8e9d, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 28 06:05:21.566 INFO request completed, latency_us: 156, response_code: 204, uri: /start/cid/0, method: POST, req_id: 3229085c-b874-4b7e-bb44-fbbe26218d86, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:21.567 INFO request completed, latency_us: 111, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7491f85f-43cc-431e-adb8-ed844c817cae, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:25.569 INFO request completed, latency_us: 202, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5f6df623-3796-4a5f-9efe-7fa0a67ea0c4, remote_addr: 127.0.0.1:60451, 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
Feb 28 06:05:29.572 INFO request completed, latency_us: 317, response_code: 200, uri: /state/cid/0, method: GET, req_id: 893baa36-684e-4ca7-9361-5baa7a47ab56, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Feb 28 06:05:35.598 INFO request completed, latency_us: [8810] Got stop action so:false kr:false
209, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 125a9721-f72c-4c81-a396-d84bb9350c31, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:35.599 INFO request completed, latency_us: 166, response_code: 200, uri: /state/cid/0, method: GET, req_id: a5736a3e-8890-490e-93c7-dfe825bb8a57, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Feb 28 06:05:39.600 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/0, method: GET, req_id: 223cc383-85c0-4955-9b57-e34fa42f0922, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 28 06:05:39.623 INFO request completed, latency_us: 134, response_code: 204, uri: /start/cid/0, method: POST, req_id: dda4c4cb-5723-49db-abc3-de28e39fa6e3, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:39.624 INFO request completed, latency_us: 117, response_code: 200, uri: /state/cid/0, method: GET, req_id: c8b9176d-4378-49f7-9bae-0f0cbf1880a4, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:43.626 INFO request completed, latency_us: 215, response_code: 200, uri: /state/cid/0, method: GET, req_id: 5601fdc1-0018-45fe-97a5-f66cb657111c, remote_addr: 127.0.0.1:60451, 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 28 06:05:47.629 INFO request completed, latency_us: 344, response_code: 200, uri: /state/cid/0, method: GET, req_id: ff285738-4744-41b5-a683-1f3231f8161d, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Feb 28 06:05:52.654 INFO request completed, latency_us: 211[8810] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 3a3fc2f2-f33b-4dfb-9450-2ceefa7c38b1, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:52.655 INFO request completed, latency_us: 151, response_code: 200, uri: /state/cid/0, method: GET, req_id: a1ed955c-ed90-4bc5-b8df-538de900848c, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Feb 28 06:05:56.657 INFO request completed, latency_us: 247, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6b78ec26-0cd8-4307-93e9-018f850bdd40, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 28 06:05:56.680 INFO request completed, latency_us: 145, response_code: 204, uri: /start/cid/0, method: POST, req_id: 594606f8-949d-4e86-84d1-97c7c2a7c76e, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:05:56.680 INFO request completed, latency_us: 101, response_code: 200, uri: /state/cid/0, method: GET, req_id: 993cd697-79d9-49b1-b69a-6eef76458ded, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:06:00.683 INFO request completed, latency_us: 202, response_code: 200, uri: /state/cid/0, method: GET, req_id: af22d633-941d-404e-a922-8d589e9ff660, remote_addr: 127.0.0.1:60451, 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(1269)
[8810][0] reports Running
Feb 28 06:06:04.685 INFO request completed, latency_us: 371, response_code: 200, uri: /state/cid/0, method: GET, req_id: 95972283-e2df-4996-948e-10d808f53bab, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
[8810] Got stop action so:false kr:false
Feb 28 06:06:08.710 INFO request completed, latency_us: 213, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 03c20731-05dd-45f2-9bb4-37a52df8378a, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:06:08.711 INFO request completed, latency_us: 123, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7415f31b-5632-4bbe-a568-e4e2974fb7c2, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Feb 28 06:06:12.714 INFO request completed, latency_us: 207, response_code: 200, uri: /state/cid/0, method: GET, req_id: ca99c2c9-44f2-4430-93ce-fb47ccc56414, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 28 06:06:12.739 INFO request completed, latency_us: 139, response_code: 204, uri: /start/cid/0, method: POST, req_id: 5e8dc754-476f-44d4-b441-e93e27c4d162, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:06:12.739 INFO request completed, latency_us: 91, response_code: 200, uri: /state/cid/0, method: GET, req_id: 100bcb3c-d4d3-43ee-bb17-d62e7b5e0004, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8810] got start action
[8810] I am going to restart
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8810][0] reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1270)
[8810][0] reports Running
Feb 28 06:06:16.742 INFO request completed, latency_us: 298, response_code: 200, uri: /state/cid/0, method: GET, req_id: 173dbd70-6a3c-4563-92b5-13c67ef8d414, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 28 06:06:44.036 INFO request completed, [8820] Got stop action so:false kr:false
latency_us: 228, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 97ad8563-814e-4c6a-9236-ad13b8ccc977, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:06:44.037 INFO request completed, latency_us: 183, response_code: 200, uri: /state/cid/1, method: GET, req_id: a402115a-9550-4714-8efc-27498cd56fbf, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Feb 28 06:06:48.040 INFO request completed, latency_us: 314, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6c3d2a78-ccd6-48a0-a4a2-04cf0b7e9340, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 28 06:06:48.065 INFO request completed, latency_us: 128, response_code: 204, uri: /start/cid/1, method: POST, req_id: b226b9eb-74ff-48c2-8ab8-10d9ca23a1b2, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:06:48.065 INFO request completed, latency_us: 115, response_code: 200, uri: /state/cid/1, method: GET, req_id: eff603f8-48fb-46d3-b9d1-3f79bcb852da, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:06:52.068 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/1, method: GET, req_id: a300cd7f-a467-4458-b8a7-2589c5114389, remote_addr: 127.0.0.1:60451, 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(1271)
[8820][1] reports Running
Feb 28 06:06:56.070 INFO request completed, latency_us: 271, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0f159fa7-4fbd-43f1-8ba0-1183e1028498, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 28 06:06:59.094 INFO request completed, latency_us: 216, response_code: 204, uri[8820] Got stop action so:false kr:false
: /stop/cid/1, method: POST, req_id: cbad3e67-64dc-4ee8-9d6c-0a910384c96d, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:06:59.095 INFO request completed, latency_us: 142, response_code: 200, uri: /state/cid/1, method: GET, req_id: 554acbc5-a875-4837-88d6-ece87bd5c047, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Feb 28 06:07:03.097 INFO request completed, latency_us: 321, response_code: 200, uri: /state/cid/1, method: GET, req_id: 488fed19-4dae-4deb-9ce0-c1fc4bc3dc2d, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 28 06:07:03.123 INFO request completed, latency_us: 156, response_code: 204, uri: /start/cid/1, method: POST, req_id: 53886912-da5a-4d46-b0d0-263d35be1a73, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:07:03.123 INFO request completed, latency_us: 92, response_code: 200, uri: /state/cid/1, method: GET, req_id: 25681300-e977-43cb-8d27-b6b9aaca8072, remote_addr: 127.0.0.1:60451, 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(1272)
[8820][1] reports Running
Feb 28 06:07:07.125 INFO request completed, latency_us: 312, response_code: 200, uri: /state/cid/1, method: GET, req_id: 75263d29-5f16-46a4-95e4-d42f47e75d0b, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
Feb 28 06:07:33.398 INFO request completed, latency_us[8830] Got stop action so:false kr:false
: 208, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 7adc2bb3-7557-43e3-97e0-b2655dffb7a3, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:07:33.399 INFO request completed, latency_us: 177, response_code: 200, uri: /state/cid/2, method: GET, req_id: f500a616-2e43-4740-98b9-78d996d4173c, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Feb 28 06:07:37.401 INFO request completed, latency_us: 264, response_code: 200, uri: /state/cid/2, method: GET, req_id: 0dd4de30-f553-4882-9257-db79837c562d, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Feb 28 06:07:37.428 INFO request completed, latency_us: 153, response_code: 204, uri: /start/cid/2, method: POST, req_id: 3ec21fb8-805e-4500-8136-5ca383852b4d, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:07:37.429 INFO request completed, latency_us: 89, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6585d50f-e030-4b22-a225-b7f4e33e63df, remote_addr: 127.0.0.1:60451, 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(1273)
[8830][2] reports Running
Feb 28 06:07:41.431 INFO request completed, latency_us: 353, response_code: 200, uri: /state/cid/2, method: GET, req_id: e855f394-6da0-4201-8459-3894de8346fb, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
Feb 28 06:08:07.713 INFO request completed, latency_us: 273[8840] Got stop action so:false kr:false
, response_code: 204, uri: /stop/cid/3, method: POST, req_id: ed6f8b8e-3a16-4890-900e-1bd3627a06bb, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:08:07.714 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/3, method: GET, req_id: e2dfbc44-7954-4ab5-a9ee-6b859faa1df8, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Feb 28 06:08:11.717 INFO request completed, latency_us: 340, response_code: 200, uri: /state/cid/3, method: GET, req_id: ba2fbc44-d3d5-4809-811a-8c7a26644eed, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Feb 28 06:08:11.745 INFO request completed, latency_us: 145, response_code: 204, uri: /start/cid/3, method: POST, req_id: 0550874c-4270-40ef-9834-31466aa4cc93, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:08:11.745 INFO request completed, latency_us: 105, response_code: 200, uri: /state/cid/3, method: GET, req_id: e2876596-55f0-43fc-8804-02e1f90a087d, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:08:15.747 INFO request completed, latency_us: 286, response_code: 200, uri: /state/cid/3, method: GET, req_id: 52d371f1-2fa9-4980-9d24-6be5af1c9409, remote_addr: 127.0.0.1:60451, 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(1274)
[8840][3] reports Running
Feb 28 06:08:19.749 INFO request completed, latency_us: 335, response_code: 200, uri: /state/cid/3, method: GET, req_id: 57e047b8-9957-4ed4-849f-98378a55a83b, remote_addr: 127.0.0.1:60451, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.074 INFO accepted connection, remote_addr: 127.0.0.1:62675, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.075 INFO request completed, latency_us: 169, response_code: 200, uri: /regioninfo, method: GET, req_id: 6cd7b69c-f78c-407b-960e-0ece2928fb4e, remote_addr: 127.0.0.1:62675, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.076 INFO request completed, latency_us: 106, response_code: 200, uri: /regioncount, method: GET, req_id: 6643e763-78a3-4602-9bd1-28c4357fba26, remote_addr: 127.0.0.1:62675, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.076 INFO request completed, latency_us: 101, response_code: 200, uri: /port/cid/0, method: GET, req_id: c1fb98f8-2468-4b94-828e-b84fd88f011a, remote_addr: 127.0.0.1:62675, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.077 INFO request completed, latency_us: 90, response_code: 200, uri: /port/cid/1, method: GET, req_id: cf9e5cf7-7d1c-4585-9e12-68f7bdc21b62, remote_addr: 127.0.0.1:62675, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.077 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/2, method: GET, req_id: ca5fe7ae-0fa0-4c5b-97f2-c129c66c6cf1, remote_addr: 127.0.0.1:62675, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.113 INFO accepted connection, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.114 INFO request completed, latency_us: 99, response_code: 200, uri: /regioncount, method: GET, req_id: cb1bc23b-b552-447b-9d80-49bf4bfb3a13, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Feb 28 06:08:46.556 INFO request completed, [8810] Got stop action so:false kr:false
latency_us: 221, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 91820328-6639-421d-86a9-cbea0cd644a7, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Feb 28 06:08:46.557 INFO request completed, latency_us: 124, response_code: 200, uri: /state/cid/0, method: GET, req_id: b92541d7-3893-4241-8846-0b67d0c16318, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Feb 28 06:08:50.559 INFO request completed, latency_us: 256, response_code: 200, uri: /state/cid/0, method: GET, req_id: d275e8b0-264c-4408-bf5e-dff3cb636144, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 28 06:09:15.292 INFO request completed, latency_us: 229, response_code: 204, uri: /start/cid/0, method: POST, req_id: ecf74cb6-d9e3-4e18-b89a-9a4e242a4cf3, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Feb 28 06:09:19.318 INFO request completed, latency_us: [8820] Got stop action so:false kr:false
226, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 13712cbd-4a64-45fd-9987-b65254597c42, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Feb 28 06:09:19.319 INFO request completed, latency_us: 128, response_code: 200, uri: /state/cid/1, method: GET, req_id: 5779485c-92be-43c3-989e-da42875ff4a7, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
[8810] got start action
[8810] I am going to restart
Starting downstairs at port 8810
Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt"
[8810][0] reports Starting
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1276)
[8810][0] reports Running
Feb 28 06:09:23.322 INFO request completed, latency_us: 366, response_code: 200, uri: /state/cid/1, method: GET, req_id: 0407f243-8427-4788-9288-afeea09e333f, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Feb 28 06:09:48.059 INFO request completed, latency_us: 274, response_code: 204, uri: /start/cid/1, method: POST, req_id: c5623758-ac92-4491-8a3c-aee9578c756c, remote_addr: 127.0.0.1:56167, 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(1277)
[8820][1] reports Running
Main task has work to do, go find it
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
Feb 28 06:09:52.087 INFO request completed, latency_us: 312, response_code: 204, uri: /stop/cid/2, method: POST, req_id: ce8a29a4-e8ce-41b6-85c5-1082ee3406dc, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Feb 28 06:09:52.088 INFO request completed, latency_us: 148, response_code: 200, uri: /state/cid/2, method: GET, req_id: 33de84a2-3efb-4f74-a66b-5d5cd585f72b, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Feb 28 06:09:56.090 INFO request completed, latency_us: 219, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4b659b8c-5c26-4e5f-8716-41d695333168, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Feb 28 06:10:20.821 INFO request completed, latency_us: 290, response_code: 204, uri: /start/cid/2, method: POST, req_id: 8f73494a-14ed-420b-99b1-d1f1ec8623e0, remote_addr: 127.0.0.1:56167, 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(1278)
[8830][2] reports Running
Main task has work to do, go find it
got dsc Stop(3)
stop 3
[8840] Got stop action so:false kr:false
Feb 28 06:10:24.855 INFO request completed, latency_us: 314, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 3c47fa0a-0f7d-4a6e-b166-111575649c66, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Feb 28 06:10:24.856 INFO request completed, latency_us: 157, response_code: 200, uri: /state/cid/3, method: GET, req_id: 47ce828c-2e7d-43aa-ad8c-d875e2e0da4f, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Feb 28 06:10:28.859 INFO request completed, latency_us: 588, response_code: 200, uri: /state/cid/3, method: GET, req_id: 1c3fdaf9-61fd-4740-8643-adc7cf93beb2, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Feb 28 06:10:53.588 INFO request completed, latency_us: 238, response_code: 204, uri: /start/cid/3, method: POST, req_id: 98f86547-70a3-4be3-940a-96b68de75863, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Feb 28 06:10:57.625 INFO request completed, latency_us[8810] Got stop action so:false kr:false
: 209, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 74ee1c9f-8db6-4bed-b2e5-ebfe5ebeb5c3, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Feb 28 06:10:57.626 INFO request completed, latency_us: 126, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3b3b3a0d-3180-4cc7-aff3-f826b265a3a0, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8840] got start action
[8840] I am going to restart
Starting downstairs at port 8840
Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt"
[8840][3] reports Starting
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1279)
[8840][3] reports Running
Feb 28 06:11:01.628 INFO request completed, latency_us: 413, response_code: 200, uri: /state/cid/0, method: GET, req_id: e5a72a2a-d45c-4ddc-914c-7a6bc85fadd5, remote_addr: 127.0.0.1:56167, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Feb 28 06:11:26.367 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/0, method: POST, req_id: 7627c804-6ab0-4cd9-88d5-54cb11382f8a, remote_addr: 127.0.0.1:56167, 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(1280)
[8810][0] reports Running
Feb 28 06:11:30.432 INFO accepted connection, remote_addr: 127.0.0.1:61757, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Feb 28 06:11:30.433 INFO request completed, latency_us: 180, response_code: 204, uri: [8810] Disable keep_running
/shutdown[8810] Got stop action so:false kr:false
, [8820] Disable keep_running
method: [8830] Disable keep_running
POST[8830] Got stop action so:false kr:false
, [8820] Got stop action so:false kr:false
req_id[8840] Disable keep_running
:[8840] Got stop action so:false kr:false
 01a96795-4b55-41d7-a551-60844c2cda48, remote_addr: 127.0.0.1:61757, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8820][1] reports Exit