/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.17012218
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.011796565
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.010775536
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-8810.txt"
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/8820 port 8820 PID:Some(1139)
Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1138)
[8820][1] initial start wait reports Running
[8830][2] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1140)
[8810][0] initial start wait reports Running
All downstairs are running
Sep 24 22:10:17.798 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Sep 24 22:10:22.810 INFO accepted connection, remote_addr: 127.0.0.1:62616, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.811 INFO request completed, latency_us: 443, response_code: 200, uri: /state/cid/0, method: GET, req_id: db277d50-0dd0-4533-806f-acb730aa8253, remote_addr: 127.0.0.1:62616, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.825 INFO accepted connection, remote_addr: 127.0.0.1:65195, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.825 INFO request completed, latency_us: 58, response_code: 200, uri: /state/cid/1, method: GET, req_id: abef9b63-d2a4-4d97-aa97-f740d3ac5170, remote_addr: 127.0.0.1:65195, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.838 INFO accepted connection, remote_addr: 127.0.0.1:51937, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.838 INFO request completed, latency_us: 72, response_code: 200, uri: /state/cid/2, method: GET, req_id: bfcd8e76-9a12-424e-bae6-4297500ae951, remote_addr: 127.0.0.1:51937, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.850 INFO accepted connection, remote_addr: 127.0.0.1:51796, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 3
Sep 24 22:10:22.851 INFO request completed, latency_us: 85, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 1ed1e137-0dab-441b-bb62-64303a84a4fb, remote_addr: 127.0.0[8810] Disable keep_running
.1:51796, local_addr: 127.0.[8820] Disable keep_running
0[8830] Disable keep_running
.1:9998
Sep 24 22:10:22.920 INFO accepted connection, remote_addr: 127.0.0.1:41638, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.921 INFO request completed, latency_us: 234, response_code: 200, uri: /regioninfo, method: GET, req_id: afad1116-b698-42be-a3be-da442933af22, remote_addr: 127.0.0.1:41638, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.923 INFO request completed, latency_us: 75, response_code: 200, uri: /regioncount, method: GET, req_id: eb63b953-d3fc-432f-8ddb-609740155e9f, remote_addr: 127.0.0.1:41638, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.923 INFO request completed, latency_us: 106, response_code: 200, uri: /port/cid/0, method: GET, req_id: b67cdb07-e712-43c0-bd4a-8e541bca437d, remote_addr: 127.0.0.1:41638, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.924 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/1, method: GET, req_id: e8f47eae-f1a5-4eb9-8a98-225028472f34, remote_addr: 127.0.0.1:41638, local_addr: 127.0.0.1:9998
Sep 24 22:10:22.924 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/2, method: GET, req_id: 3f36cdb0-97cf-4431-85e4-6aaf50152f84, remote_addr: 127.0.0.1:41638, local_addr: 127.0.0.1:9998
Sep 24 22:10:31.975 INFO accepted connection, remote_addr: 127.0.0.1:56143, local_addr: 127.0.0.1:9998
Sep 24 22:10:31.976 INFO request completed, latency_us: 145, response_code: 200, uri: /regioninfo, method: GET, req_id: 5ebb3108-cefd-43be-9a94-ece247b0d1f2, remote_addr: 127.0.0.1:56143, local_addr: 127.0.0.1:9998
Sep 24 22:10:31.976 INFO request completed, latency_us: 45, response_code: 200, uri: /regioncount, method: GET, req_id: d8edb91d-63f9-432b-b757-3405e3ad8137, remote_addr: 127.0.0.1:56143, local_addr: 127.0.0.1:9998
Sep 24 22:10:31.977 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/0, method: GET, req_id: b996eff1-4c29-4def-94af-376f244b61c2, remote_addr: 127.0.0.1:56143, local_addr: 127.0.0.1:9998
Sep 24 22:10:31.977 INFO request completed, latency_us: 43, response_code: 200, uri: /port/cid/1, method: GET, req_id: 8e8f035a-edf4-4d63-b0c0-fc566de0ab1c, remote_addr: 127.0.0.1:56143, local_addr: 127.0.0.1:9998
Sep 24 22:10:31.977 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: 10e0c0f6-b40e-4d16-afda-dba0642c86cd, remote_addr: 127.0.0.1:56143, local_addr: 127.0.0.1:9998
Sep 24 22:10:41.148 INFO accepted connection, remote_addr: 127.0.0.1:54499, local_addr: 127.0.0.1:9998
Sep 24 22:10:41.149 INFO request completed, latency_us: 143, response_code: 200, uri: /regioninfo, method: GET, req_id: a26381ff-635d-4c6e-bdeb-ef361758e39b, remote_addr: 127.0.0.1:54499, local_addr: 127.0.0.1:9998
Sep 24 22:10:41.150 INFO request completed, latency_us: 39, response_code: 200, uri: /regioncount, method: GET, req_id: 8c1a6612-f285-4ff4-9a80-09abb6d8ff8a, remote_addr: 127.0.0.1:54499, local_addr: 127.0.0.1:9998
Sep 24 22:10:41.150 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4270212a-1fcc-4721-8e67-f5ef12f851eb, remote_addr: 127.0.0.1:54499, local_addr: 127.0.0.1:9998
Sep 24 22:10:41.150 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: bb8f8321-9893-48c7-bce0-1cf1157f21b0, remote_addr: 127.0.0.1:54499, local_addr: 127.0.0.1:9998
Sep 24 22:10:41.150 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 05876314-585d-4953-b7f7-2bebf7dfbd3a, remote_addr: 127.0.0.1:54499, local_addr: 127.0.0.1:9998
Sep 24 22:11:18.612 INFO accepted connection, remote_addr: 127.0.0.1:55386, local_addr: 127.0.0.1:9998
Sep 24 22:11:18.613 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: 7ea6ab25-8edc-4e50-af07-dab2601c4491, remote_addr: 127.0.0.1:55386, local_addr: 127.0.0.1:9998
Sep 24 22:11:18.613 INFO request completed, latency_us: 51, response_code: 200, uri: /regioncount, method: GET, req_id: 26f19950-777f-4435-b138-a0a46bc3bd1e, remote_addr: 127.0.0.1:55386, local_addr: 127.0.0.1:9998
Sep 24 22:11:18.614 INFO request completed, latency_us: 80, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8a24ea00-1616-4250-a1be-ae75d289d332, remote_addr: 127.0.0.1:55386, local_addr: 127.0.0.1:9998
Sep 24 22:11:18.614 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: 41fc62f4-be63-4e7d-b9dc-f2d195c96bb5, remote_addr: 127.0.0.1:55386, local_addr: 127.0.0.1:9998
Sep 24 22:11:18.614 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: d2a22158-3720-4070-8302-c4d4d5b3fb89, remote_addr: 127.0.0.1:55386, local_addr: 127.0.0.1:9998
Sep 24 22:11:49.767 INFO accepted connection, remote_addr: 127.0.0.1:37399, local_addr: 127.0.0.1:9998
Sep 24 22:11:49.767 INFO request completed, latency_us: 147, response_code: 200, uri: /regioninfo, method: GET, req_id: 4109c141-7320-4b18-aa67-167b56228b7b, remote_addr: 127.0.0.1:37399, local_addr: 127.0.0.1:9998
Sep 24 22:11:49.768 INFO request completed, latency_us: 42, response_code: 200, uri: /regioncount, method: GET, req_id: f98ec2ee-eac9-47d7-a31f-7d43f071ebda, remote_addr: 127.0.0.1:37399, local_addr: 127.0.0.1:9998
Sep 24 22:11:49.768 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: 91f080c9-8479-43ac-8638-93030a14eccd, remote_addr: 127.0.0.1:37399, local_addr: 127.0.0.1:9998
Sep 24 22:11:49.768 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/1, method: GET, req_id: 4149bee0-04e1-4408-b2f7-f030ad1fcc22, remote_addr: 127.0.0.1:37399, local_addr: 127.0.0.1:9998
Sep 24 22:11:49.768 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: 9c80a87f-b098-474e-b81c-29e4821d43e2, remote_addr: 127.0.0.1:37399, local_addr: 127.0.0.1:9998
Sep 24 22:12:11.481 INFO accepted connection, remote_addr: 127.0.0.1:43507, local_addr: 127.0.0.1:9998
Sep 24 22:12:11.482 INFO request completed, latency_us: 152, response_code: 200, uri: /regioninfo, method: GET, req_id: 3c390354-be7b-43fc-bcbb-a5425bccd0d0, remote_addr: 127.0.0.1:43507, local_addr: 127.0.0.1:9998
Sep 24 22:12:11.482 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: b713aa7a-4e8b-46d9-8971-fa23dc68890a, remote_addr: 127.0.0.1:43507, local_addr: 127.0.0.1:9998
Sep 24 22:12:11.483 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3ac5a669-2c07-4321-a631-855d456babe2, remote_addr: 127.0.0.1:43507, local_addr: 127.0.0.1:9998
Sep 24 22:12:11.483 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0e9b8b92-ab06-4171-83b2-4dd896afe8ba, remote_addr: 127.0.0.1:43507, local_addr: 127.0.0.1:9998
Sep 24 22:12:11.483 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/2, method: GET, req_id: 992b7c25-89b4-41cf-a37b-01fa759cb93b, remote_addr: 127.0.0.1:43507, local_addr: 127.0.0.1:9998
Sep 24 22:12:15.568 INFO accepted connection, remote_addr: 127.0.0.1:33509, local_addr: 127.0.0.1:9998
Sep 24 22:12:15.568 INFO request completed, latency_us: 159, response_code: 200, uri: /regioninfo, method: GET, req_id: 20c783f8-b1c8-4201-90b4-06ab668bdbd8, remote_addr: 127.0.0.1:33509, local_addr: 127.0.0.1:9998
Sep 24 22:12:15.569 INFO request completed, latency_us: 38, response_code: 200, uri: /regioncount, method: GET, req_id: d7f7c7b2-83c2-43c6-afbf-049d0c1722fb, remote_addr: 127.0.0.1:33509, local_addr: 127.0.0.1:9998
Sep 24 22:12:15.569 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/0, method: GET, req_id: 3a8e7ea6-2c29-49cb-a951-6a9836b535b7, remote_addr: 127.0.0.1:33509, local_addr: 127.0.0.1:9998
Sep 24 22:12:15.570 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/1, method: GET, req_id: a9b5f77e-6a04-41de-abef-a387114c7d45, remote_addr: 127.0.0.1:33509, local_addr: 127.0.0.1:9998
Sep 24 22:12:15.570 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/2, method: GET, req_id: a7bbaa1a-7460-40ec-9ed3-b81fc1abd386, remote_addr: 127.0.0.1:33509, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.642 INFO accepted connection, remote_addr: 127.0.0.1:39898, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc DisableRestartAll
disable restart on all: 3
Sep 24 22:12:19.642 INFO request completed, latency_us: 130, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 50397549-d25b-4aa5-a466-84a83d798b4e, remote_addr: 127.0.0.1:39898, local_addr: 127.0[8810] Disable keep_running
.0.[8820] Disable keep_running
1[8830] Disable keep_running
:9998
Sep 24 22:12:19.655 INFO accepted connection, remote_addr: 127.0.0.1:41261, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
Sep 24 22:12:19.656 stop 2
INFO request completed, latency_us: 101, response_code: 204, uri: /stop/cid/2, method: POST, req_id: [8830] Got stop action so:false kr:false
77e4f003-4100-41ef-86f0-024266b7d7a0, remote_addr: 127.0.0.1:41261, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Sep 24 22:12:19.669 INFO accepted connection, remote_addr: 127.0.0.1:46223, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.669 INFO request completed, latency_us: 78, response_code: 200, uri: /state/cid/2, method: GET, req_id: 958fcdcd-e5bc-4f87-aebf-f99b180b90d2, remote_addr: 127.0.0.1:46223, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.684 INFO accepted connection, remote_addr: 127.0.0.1:53644, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Sep 24 22:12:19.685 INFO request completed, latency_us: 72, response_code: 204, uri: /start/cid/2, method: POST, req_id: a7c05881-ead0-4e40-8c13-00fb0342d623, remote_addr: 127.0.0.1:53644, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.955 INFO accepted connection, remote_addr: 127.0.0.1:42453, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.955 INFO request completed, latency_us: 153, response_code: 200, uri: /regioninfo, method: GET, req_id: c3e7795c-bd8f-4826-bc86-4fb8c3c9fc97, remote_addr: 127.0.0.1:42453, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.956 INFO request completed, latency_us: 70, response_code: 200, uri: /regioncount, method: GET, req_id: 35925e4b-a1bd-4f8e-9896-b8879179d7af, remote_addr: 127.0.0.1:42453, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.957 INFO request completed, latency_us: 71, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5c54b150-5927-45eb-9f89-df4dcc491d8c, remote_addr: 127.0.0.1:42453, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.957 INFO request completed, latency_us: 37, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0871bccc-1d50-4852-86ea-adba5141aba0, remote_addr: 127.0.0.1:42453, local_addr: 127.0.0.1:9998
Sep 24 22:12:19.957 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/2, method: GET, req_id: 189a8caa-caab-465a-a742-402e433fec6b, remote_addr: 127.0.0.1:42453, 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(1188)
[8830][2] reports Running
Sep 24 22:12:34.072 INFO accepted connection, remote_addr: 127.0.0.1:42005, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Sep 24 22:12:34.073 INFO request completed, latency_us: 123, response_code: 204, uri: /shutdown, method: POST, req_id: 6c6b0788-7da5-4caa-bcb9-d57431e4be8a, remote_addr:[8810] Disable keep_running
 127.0.0.1:42005[8810] Got stop action so:false kr:false
, local_addr:[8820] Disable keep_running
 [8830] Disable keep_running
127.0[8830] Got stop action so:false kr:false
.0.1:9998
[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 --encrypted --cleanup --region-count 4 --extent-count 400 --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.029347692
Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.027314791
Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.026987614
Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.026023239
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: 400 })
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-8810.txt"
Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt"
[8810][0] initial start wait reports Starting
[8820][1] initial start wait reports Starting
Starting downstairs at port 8830
Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt"
[8830][2] initial start wait reports Starting
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/8830 port 8830 PID:Some(1204)
Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1202)
Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1205)
[8830][2] initial start wait reports Running
[8840][3] initial start wait reports Running
[8820][1] initial start wait reports Running
Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1203)
[8810][0] initial start wait reports Running
All downstairs are running
Sep 24 22:12:39.202 INFO listening, local_addr: 127.0.0.1:9998
Control access at:127.0.0.1:9998
Sep 24 22:12:44.214 INFO accepted connection, remote_addr: 127.0.0.1:44638, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.215 INFO request completed, latency_us: 287, response_code: 200, uri: /state/cid/0, method: GET, req_id: cc12eb15-8496-4a0d-94b0-1d8712a89c84, remote_addr: 127.0.0.1:44638, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.229 INFO accepted connection, remote_addr: 127.0.0.1:64212, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.229 INFO request completed, latency_us: 76, response_code: 200, uri: /state/cid/1, method: GET, req_id: e5c8c954-1eb6-48de-a1fe-e99fe7e4a5a3, remote_addr: 127.0.0.1:64212, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.242 INFO accepted connection, remote_addr: 127.0.0.1:36936, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.242 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/2, method: GET, req_id: 49a34296-493b-492c-902f-4e069e24e396, remote_addr: 127.0.0.1:36936, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.255 INFO accepted connection, remote_addr: 127.0.0.1:61239, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.256 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/3, method: GET, req_id: 215df3b1-f472-4625-bcde-66e8bf5c1eca, remote_addr: 127.0.0.1:61239, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.269 INFO accepted connection, remote_addr: 127.0.0.1:50876, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.269 INFO request completed, latency_us: 78, response_code: 200, uri: /port/cid/3, method: GET, req_id: d3d19ac4-fba4-4178-b4a8-1bb172a228e1, remote_addr: 127.0.0.1:50876, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.289 INFO accepted connection, remote_addr: 127.0.0.1:50206, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.289 INFO request completed, latency_us: 112, response_code: 200, uri: /regioninfo, method: GET, req_id: 17070c5a-7b96-4efd-b7bf-89c1ec8b2ce7, remote_addr: 127.0.0.1:50206, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.290 INFO request completed, latency_us: 50, response_code: 200, uri: /regioncount, method: GET, req_id: 26b68973-e670-4aca-9894-a3375c723b9c, remote_addr: 127.0.0.1:50206, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.290 INFO request completed, latency_us: 79, response_code: 200, uri: /port/cid/0, method: GET, req_id: aa5e14c4-c1dd-4352-a674-b1064f8394a5, remote_addr: 127.0.0.1:50206, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.291 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/1, method: GET, req_id: 90d144bf-d6d5-4617-a95d-89cfa8324a00, remote_addr: 127.0.0.1:50206, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.291 INFO request completed, latency_us: 62, response_code: 200, uri: /port/cid/2, method: GET, req_id: b5961984-3157-4239-8003-da414216b5e6, remote_addr: 127.0.0.1:50206, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.303 INFO accepted connection, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.303 INFO request completed, latency_us: 56, response_code: 200, uri: /regioncount, method: GET, req_id: e55d14ec-041e-4bfe-9ba7-9b86ff0e5492, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 24 22:12:44.500 INFO request completed, latency_us[8810] Got stop action so:false kr:false
: 234, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 4f9fe431-4cd6-4dd1-a575-7900a6b081c0, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:12:44.501 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0bcb54c7-2b5c-4a99-9443-82e50532eb5a, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:12:48.503 INFO request completed, latency_us: 236, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1206737e-4183-4582-8598-1c776ad14843, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:12:48.705 INFO request completed, latency_us: 216, response_code: 204, uri: /start/cid/0, method: POST, req_id: a654d257-acf7-4103-9c68-d7ca2251d7e3, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:12:48.705 INFO request completed, latency_us: 50, response_code: 200, uri: /state/cid/0, method: GET, req_id: 18fd2eec-7134-4d76-96f7-7c36924b1f36, remote_addr: 127.0.0.1:50447, 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(1213)
[8810][0] reports Running
Sep 24 22:12:52.708 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/0, method: GET, req_id: 071143cc-7c09-4846-9de8-441e4acf6572, remote_addr: 127.0.0.1:50447, 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
Sep 24 22:12:58.905 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 73d5c872-6a9b-45fb-bb08-5d2855811942, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:12:58.906 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/0, method: GET, req_id: bfd924fa-0997-4be5-9db8-8dc6475040a8, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:13:02.908 INFO request completed, latency_us: 207, response_code: 200, uri: /state/cid/0, method: GET, req_id: a9a485d9-71eb-4bbc-a28d-2cef9fa6f9ec, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:13:03.115 INFO request completed, latency_us: 227, response_code: 204, uri: /start/cid/0, method: POST, req_id: 07337dd4-f66e-42ef-821f-0f6f6cd9215c, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:03.115 INFO request completed, latency_us: 84, response_code: 200, uri: /state/cid/0, method: GET, req_id: e3e4f621-a585-4ed6-adea-205469d4f826, remote_addr: 127.0.0.1:50447, 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(1214)
[8810][0] reports Running
Sep 24 22:13:07.117 INFO request completed, latency_us: 193, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6278d0bd-5ad4-4499-be06-46c489813709, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 24 22:13:12.316 INFO request completed, latency_us[8810] Got stop action so:false kr:false
: 214, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 72bb85d0-e831-4672-afb6-ae5a3d94625e, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:12.317 INFO request completed, latency_us: 53, response_code: 200, uri: /state/cid/0, method: GET, req_id: b19ba418-3c89-4045-8564-077109e00245, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:13:16.319 INFO request completed, latency_us: 224, response_code: 200, uri: /state/cid/0, method: GET, req_id: 77047b9e-50cd-4476-b589-72d872a80c58, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:13:16.529 INFO request completed, latency_us: 178, response_code: 204, uri: /start/cid/0, method: POST, req_id: 9cfed83f-e17b-4a57-a5a8-1a7159e63a4c, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:16.530 INFO request completed, latency_us: 77, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0501de0d-99e2-4b0f-8a96-860b7d772635, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:20.532 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/0, method: GET, req_id: 996c629e-0e66-44fe-a962-c04783636ed9, remote_addr: 127.0.0.1:50447, 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(1215)
[8810][0] reports Running
Sep 24 22:13:24.534 INFO request completed, latency_us: 144, response_code: 200, uri: /state/cid/0, method: GET, req_id: f30ebdf1-1f3a-4cbc-b324-b41de4bdd766, remote_addr: 127.0.0.1:50447, 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
Sep 24 22:13:28.730 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/0, method: POST, req_id: f83a7e93-35bc-48df-9e08-6b8d5b7650a2, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:28.731 INFO request completed, latency_us: 113, response_code: 200, uri: /state/cid/0, method: GET, req_id: da8605d4-9838-455d-9d7e-32a09ea507b9, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:13:32.732 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/0, method: GET, req_id: 33f756ac-a86f-4b15-a4b0-156e8328c9da, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:13:32.943 INFO request completed, latency_us: 148, response_code: 204, uri: /start/cid/0, method: POST, req_id: 5d1849ea-d4fa-458b-a17c-b95c9e6d81ac, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:32.943 INFO request completed, latency_us: 80, response_code: 200, uri: /state/cid/0, method: GET, req_id: 40b96b03-a6b7-4a89-9f22-c31083953717, remote_addr: 127.0.0.1:50447, 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(1216)
[8810][0] reports Running
Sep 24 22:13:36.945 INFO request completed, latency_us: 206, response_code: 200, uri: /state/cid/0, method: GET, req_id: eed3aaf5-42a8-4227-9719-286af71f42cd, remote_addr: 127.0.0.1:50447, 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
Sep 24 22:13:40.143 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/0, method: POST, req_id: a6faa32c-9752-4f0b-9079-f2ef87e4b24f, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:40.144 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/0, method: GET, req_id: d0be6a0d-99d8-4db9-a7db-44f373378b6e, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:13:44.146 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/0, method: GET, req_id: d4d7e829-5f49-4aa3-a5c5-7315d68ac73f, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:13:44.357 INFO request completed, latency_us: 145, response_code: 204, uri: /start/cid/0, method: POST, req_id: 97f97e56-7f99-4890-99c1-723ea652695e, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:44.357 INFO request completed, latency_us: 126, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1e376507-fb44-4289-82ca-acd653b9444f, remote_addr: 127.0.0.1:50447, 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(1217)
[8810][0] reports Running
Sep 24 22:13:48.359 INFO request completed, latency_us: 183, response_code: 200, uri: /state/cid/0, method: GET, req_id: f18ca811-1824-48f2-9f9d-c6060006a006, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 24 22:13:50.557 INFO request completed[8810] Got stop action so:false kr:false
, latency_us: 225, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 979ade89-13e3-41e9-b6c4-f253ed5388f8, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:50.558 INFO request completed, latency_us: 128, response_code: 200, uri: /state/cid/0, method: GET, req_id: 74d0ac51-a9a8-48e5-9fd2-72e941804cdc, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:13:54.560 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/0, method: GET, req_id: 99e79855-6dcf-4cee-a87c-857cc2ea64b0, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:13:54.779 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/0, method: POST, req_id: 40a4ee61-9d7b-4d3e-aa1b-62acf3616a2f, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:13:54.779 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6367f114-a5f8-4d68-b86f-06313edbdd25, remote_addr: 127.0.0.1:50447, 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(1218)
[8810][0] reports Running
Sep 24 22:13:58.781 INFO request completed, latency_us: 197, response_code: 200, uri: /state/cid/0, method: GET, req_id: 816215ca-4788-4924-9929-929cfa21742d, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Sep 24 22:14:25.059[8820] Got stop action so:false kr:false
 INFO request completed, latency_us: 209, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 6c2519f3-2e81-4b70-b006-86521558d655, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:14:25.060 INFO request completed, latency_us: 88, response_code: 200, uri: /state/cid/1, method: GET, req_id: b643e157-5f28-40d6-9b80-b4d8b39c1225, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit
Sep 24 22:14:29.062 INFO request completed, latency_us: 196, response_code: 200, uri: /state/cid/1, method: GET, req_id: 92b534f8-4905-4660-9dbf-45c517ccdf7a, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
start 1
Sep 24 22:14:29.274 INFO request completed, latency_us: 146, response_code: 204, uri: /start/cid/1, method: POST, req_id: 5ece7a84-c7a3-45ea-b9c0-c4aa63968595, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:14:29.274 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/1, method: GET, req_id: ea6c5fbd-cbe3-4672-9180-9a4f2c3a4846, remote_addr: 127.0.0.1:50447, 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(1219)
[8820][1] reports Running
Sep 24 22:14:33.276 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/1, method: GET, req_id: debe45d2-541b-477c-98b3-5036fe390d98, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(2)
stop 2
[8830] Got stop action so:false kr:false
Sep 24 22:14:59.603 INFO request completed, latency_us: 206, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 94129fd9-53c1-4f88-832d-d4c84935ed1d, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:14:59.603 INFO request completed, latency_us: 53, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6f820644-1fb6-4df9-9cb8-d38b97b27552, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Sep 24 22:15:03.605 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/2, method: GET, req_id: ea53503c-ee74-4cc8-8f89-0a0e5e66cab8, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Sep 24 22:15:03.815 INFO request completed, latency_us: 179, response_code: 204, uri: /start/cid/2, method: POST, req_id: 57222400-ff96-4919-bd16-4dd21bba1211, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:15:03.816 INFO request completed, latency_us: 75, response_code: 200, uri: /state/cid/2, method: GET, req_id: 677903ae-5863-4339-a92b-a42855ddb9a8, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:15:07.819 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/2, method: GET, req_id: 14d01432-c791-46a3-aee3-268fedd936a0, remote_addr: 127.0.0.1:50447, 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(1220)
[8830][2] reports Running
Sep 24 22:15:11.822 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/2, method: GET, req_id: 4a52cb65-79a0-49c8-9dc1-5e25580c516b, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(3)
stop 3
[8840] Got stop action so:false kr:false
Sep 24 22:15:38.262 INFO request completed, latency_us: 208, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 7dfe94c0-d480-4cad-bad7-149a6d104d2e, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:15:38.262 INFO request completed, latency_us: 86, response_code: 200, uri: /state/cid/3, method: GET, req_id: a596ce28-bbd6-4c50-b007-cbc3309d7c05, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Sep 24 22:15:42.264 INFO request completed, latency_us: 212, response_code: 200, uri: /state/cid/3, method: GET, req_id: 5ee5a4fb-ca9d-472e-b101-1f220ecb9f64, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Sep 24 22:15:42.474 INFO request completed, latency_us: 160, response_code: 204, uri: /start/cid/3, method: POST, req_id: 13172b6f-2eaf-493e-9b6b-d775ac7b4e7d, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:15:42.474 INFO request completed, latency_us: 86, response_code: 200, uri: /state/cid/3, method: GET, req_id: 1e67fb65-5eca-44e6-bb55-f3e78d683b89, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:15:46.476 INFO request completed, latency_us: 196, response_code: 200, uri: /state/cid/3, method: GET, req_id: 28b1996d-89f8-435a-b6ca-4b4440bad2ea, remote_addr: 127.0.0.1:50447, 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(1221)
[8840][3] reports Running
Sep 24 22:15:50.478 INFO request completed, latency_us: 177, response_code: 200, uri: /state/cid/3, method: GET, req_id: f81bbee2-e7cd-469a-ba29-6c484c3bd5a8, remote_addr: 127.0.0.1:50447, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.883 INFO accepted connection, remote_addr: 127.0.0.1:35074, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.884 INFO request completed, latency_us: 148, response_code: 200, uri: /regioninfo, method: GET, req_id: a934f8b2-bd8f-4563-9be9-75ec643a316a, remote_addr: 127.0.0.1:35074, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.884 INFO request completed, latency_us: 71, response_code: 200, uri: /regioncount, method: GET, req_id: fb7afbdc-f3ff-42e2-92de-63ef1cde7c53, remote_addr: 127.0.0.1:35074, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.885 INFO request completed, latency_us: 92, response_code: 200, uri: /port/cid/0, method: GET, req_id: 0c9cdd37-e372-4bb4-824d-c24ef60b20cf, remote_addr: 127.0.0.1:35074, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.885 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/1, method: GET, req_id: 34ca1366-1406-4e34-9127-9375aaf6fdf9, remote_addr: 127.0.0.1:35074, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.885 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5f9a8c5b-b5c2-448f-8c39-253b9b5423aa, remote_addr: 127.0.0.1:35074, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.896 INFO accepted connection, remote_addr: 127.0.0.1:57406, local_addr: 127.0.0.1:9998
Sep 24 22:16:16.897 INFO request completed, latency_us: 60, response_code: 200, uri: /regioncount, method: GET, req_id: 1ce1e3e8-a0c2-4afd-ac02-ef4153885826, remote_addr: 127.0.0.1:57406, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(0)
stop 0
Sep 24 22:16:19.920 INFO [8810] Got stop action so:false kr:false
request completed, latency_us: 220, response_code: 204, uri: /stop/cid/0, method: POST, req_id: ca31be2a-96e1-480b-b64d-9f9db450628e, remote_addr: 127.0.0.1:57406, local_addr: 127.0.0.1:9998
Sep 24 22:16:19.921 INFO request completed, latency_us: 152, response_code: 200, uri: /state/cid/0, method: GET, req_id: f6928a8c-e9b7-4433-a6d4-5916762d968e, remote_addr: 127.0.0.1:57406, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:16:23.923 INFO request completed, latency_us: 220, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3a370d67-ca99-41ee-91bc-81e485c70851, remote_addr: 127.0.0.1:57406, local_addr: 127.0.0.1:9998
Sep 24 22:16:54.892 INFO accepted connection, remote_addr: 127.0.0.1:46956, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:16:54.892 INFO request completed, latency_us: 170, response_code: 204, uri: /start/cid/0, method: POST, req_id: 2d4180d4-630c-498f-86dd-922c6eacdbb1, remote_addr: 127.0.0.1:46956, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Stop(1)
stop 1
Sep 24 22:16:59.099[8820] Got stop action so:false kr:false
 INFO request completed, latency_us: 215, response_code: 204, uri: /stop/cid/1, method: POST, req_id: da603063-458d-43eb-86b1-afb58522c79d, remote_addr: 127.0.0.1:46956, local_addr: 127.0.0.1:9998
Sep 24 22:16:59.100 INFO request completed, latency_us: 81, response_code: 200, uri: /state/cid/1, method: GET, req_id: 184c2625-3c48-4113-bc40-8a7e45c8260e, remote_addr: 127.0.0.1:46956, 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(1223)
[8810][0] reports Running
Sep 24 22:17:03.102 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/1, method: GET, req_id: 4e05cc42-f5b9-45dc-9d82-4a88ce9fca53, remote_addr: 127.0.0.1:46956, local_addr: 127.0.0.1:9998
Sep 24 22:17:34.084 INFO accepted connection, remote_addr: 127.0.0.1:58932, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(1)
Sep 24 22:17:34.084 INFOstart 1
 request completed, latency_us: 175, response_code: 204, uri: /start/cid/1, method: POST, req_id: 9368e07d-6c5d-4a99-9fff-0b1a2456f4ec, remote_addr: 127.0.0.1:58932, 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(1224)
[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
Sep 24 22:17:38.294 INFO request completed, latency_us: 210, response_code: 204, uri: /stop/cid/2, method: POST, req_id: d96b1a43-3714-48c7-b438-340655511396, remote_addr: 127.0.0.1:58932, local_addr: 127.0.0.1:9998
Sep 24 22:17:38.294 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/2, method: GET, req_id: b2ba1037-b1b4-4d92-a0fd-1ea142a7e45a, remote_addr: 127.0.0.1:58932, local_addr: 127.0.0.1:9998
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
Sep 24 22:17:42.297 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/2, method: GET, req_id: 07891a74-39eb-43d4-9090-c3869f802054, remote_addr: 127.0.0.1:58932, local_addr: 127.0.0.1:9998
Sep 24 22:18:13.292 INFO accepted connection, remote_addr: 127.0.0.1:51769, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(2)
start 2
Sep 24 22:18:13.292 INFO request completed, latency_us: 164, response_code: 204, uri: /start/cid/2, method: POST, req_id: 465d6072-44ab-4c81-8949-170ca4444281, remote_addr: 127.0.0.1:51769, 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(1225)
[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
Sep 24 22:18:17.511 INFO request completed, latency_us: 201, response_code: 204, uri: /stop/cid/3, method: POST, req_id: e7aa8b22-ee9b-4971-b111-3ab5cd4a33a0, remote_addr: 127.0.0.1:51769, local_addr: 127.0.0.1:9998
Sep 24 22:18:17.512 INFO request completed, latency_us: 127, response_code: 200, uri: /state/cid/3, method: GET, req_id: 65277098-9be6-46ca-97c8-e1f99d098d8e, remote_addr: 127.0.0.1:51769, local_addr: 127.0.0.1:9998
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
Sep 24 22:18:21.514 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/3, method: GET, req_id: 0535b151-3eff-4e01-a431-5d11bcd6fc09, remote_addr: 127.0.0.1:51769, local_addr: 127.0.0.1:9998
Sep 24 22:18:52.486 INFO accepted connection, remote_addr: 127.0.0.1:44952, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(3)
start 3
Sep 24 22:18:52.486 INFO request completed, latency_us: 163, response_code: 204, uri: /start/cid/3, method: POST, req_id: ee4bc18f-b574-46c9-98de-5a8337f152e0, remote_addr: 127.0.0.1:44952, 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
Sep 24 22:18:56.773 INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 19654df3-c700-4a51-bd69-cd847fed1cf7, remote_addr: 127.0.0.1:44952, local_addr: 127.0.0.1:9998
Sep 24 22:18:56.773 INFO request completed, latency_us: 82, response_code: 200, uri: /state/cid/0, method: GET, req_id: 762b24a3-6e05-49dd-8a6a-eb6e75588c96, remote_addr: 127.0.0.1:44952, local_addr: 127.0.0.1:9998
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
Sep 24 22:19:00.775 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/0, method: GET, req_id: 94869b6f-8ecf-4b69-abb4-d5fc1bd1c7ff, remote_addr: 127.0.0.1:44952, 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(1226)
[8840][3] reports Running
Sep 24 22:19:31.756 INFO accepted connection, remote_addr: 127.0.0.1:65364, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Start(0)
start 0
Sep 24 22:19:31.756 INFO request completed, latency_us: 163, response_code: 204, uri: /start/cid/0, method: POST, req_id: aa951cd6-6504-46e9-92c2-1515b20319b7, remote_addr: 127.0.0.1:65364, 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(1227)
[8810][0] reports Running
Sep 24 22:19:35.795 INFO accepted connection, remote_addr: 127.0.0.1:61178, local_addr: 127.0.0.1:9998
Main task has work to do, go find it
got dsc Shutdown
Shutdown
Shut it down
Sep 24 22:19:35.796 INFO request completed, latency_us: 124, response_code: 204, uri: /shutdown, method: POST, req_id: f9fc18e6-9f55-420f-b5b1-c63ff370badd, remote_addr: 127.0.0.1:61178, [8810] Disable keep_running
local_addr[8820] Disable keep_running
:[8820] Got stop action so:false kr:false
 127.[8810] Got stop action so:false kr:false
0[8830] Disable keep_running
.[8830] Got stop action so:false kr:false
0.1:9998
[8840] Disable keep_running
[8840] Got stop action so:false kr:false
[8810] Exited with: ExitStatus(unix_wait_status(9))
[8810][0] reports Exit
[8840] Exited with: ExitStatus(unix_wait_status(9))
[8840][3] reports Exit
[8830] Exited with: ExitStatus(unix_wait_status(9))
[8830][2] reports Exit
[8820] Exited with: ExitStatus(unix_wait_status(9))
[8820][1] reports Exit