/var/tmp/bins/dsc create --encrypted --cleanup --region-count 6 --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.16998723 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.011790967 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.010734394 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.010653502 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010469548 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010443057 Created 6 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 6 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 ds: 8840 start ds: 8850 start ds: 8860 start access at:127.0.0.1:9998 Starting downstairs at port 8810 Starting downstairs at port 8830 Starting downstairs at port 8860 Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8810][0] initial start wait reports Starting [8830][2] initial start wait reports Starting [8860][5] initial start wait reports Starting [8840][3] initial start wait reports Starting [8820][1] initial start wait reports Starting [8850][4] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1139) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1138) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1142) [8810][0] initial start wait reports Running [8830][2] initial start wait reports Running [8850][4] initial start wait reports Running Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1141) [8820][1] initial start wait reports Running Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1143) [8860][5] initial start wait reports Running Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1140) [8840][3] initial start wait reports Running All downstairs are running Control access at:127.0.0.1:9998 Apr 27 18:25:28.442 INFO listening, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.446 INFO accepted connection, remote_addr: 127.0.0.1:53328, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.448 INFO request completed, latency_us: 500, response_code: 200, uri: /state/cid/0, method: GET, req_id: fbbad5b1-eebd-426a-97d8-2da5a8a47801, remote_addr: 127.0.0.1:53328, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.462 INFO accepted connection, remote_addr: 127.0.0.1:54094, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.463 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/1, method: GET, req_id: 12b74f91-cdc7-4a44-a9f0-79d5a1ebd5e8, remote_addr: 127.0.0.1:54094, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.476 INFO accepted connection, remote_addr: 127.0.0.1:33890, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.476 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/2, method: GET, req_id: c5bc0902-681b-4aa0-8528-6161f876c57b, remote_addr: 127.0.0.1:33890, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.489 INFO accepted connection, remote_addr: 127.0.0.1:58755, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.489 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/3, method: GET, req_id: 627fb6c8-0dc0-45c9-b26f-667948f544a8, remote_addr: 127.0.0.1:58755, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.502 INFO accepted connection, remote_addr: 127.0.0.1:51333, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.502 INFO request completed, latency_us: 54, response_code: 200, uri: /state/cid/4, method: GET, req_id: 3adbf13c-6683-4acb-809c-ed4f0fad6cb3, remote_addr: 127.0.0.1:51333, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.515 INFO accepted connection, remote_addr: 127.0.0.1:49179, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.516 INFO request completed, latency_us: 57, response_code: 200, uri: /state/cid/5, method: GET, req_id: f47cf466-fcde-4d3c-8d52-160c989b9908, remote_addr: 127.0.0.1:49179, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.528 INFO accepted connection, remote_addr: 127.0.0.1:62310, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll Apr 27 18:25:33.528 INFOdisable restart on all: 6 request completed, latency_us: 94, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 821457c0-6a87-4361-8757-45590dd5b05c, remote_addr: 127.0.0.1:62310, local_addr: [8810] Disable keep_running 127.0.0.1:9998[8820] Disable keep_running [8830] Disable keep_running [8850] Disable keep_running [8840] Disable keep_running [8860] Disable keep_running Apr 27 18:25:33.572 INFO accepted connection, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.572 INFO request completed, latency_us: 270, response_code: 200, uri: /regioninfo, method: GET, req_id: 184ee8b1-412f-4085-bb57-261f150e6a12, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.573 INFO request completed, latency_us: 60, response_code: 200, uri: /regioncount, method: GET, req_id: a324fb0e-8ef6-4e62-8a32-d2177190588b, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.574 INFO request completed, latency_us: 95, response_code: 200, uri: /port/cid/0, method: GET, req_id: f98d4d0a-a32a-4f0e-a6e8-701e9a83e1eb, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.574 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/1, method: GET, req_id: cf17d709-e324-4c8a-a554-216c7056e075, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.574 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/2, method: GET, req_id: 5877edb0-ec04-4733-80cf-29408223c7d3, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.577 INFO request completed, latency_us: 75, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8eedcbf9-838d-4c64-8fc2-d9fe5de471a8, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.577 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1dcc6a63-f6c1-489f-8f0c-e1e933ce862e, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:33.578 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: 560026e7-cd43-4920-a2af-a4b56cb57691, remote_addr: 127.0.0.1:41187, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.633 INFO accepted connection, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.634 INFO request completed, latency_us: 155, response_code: 200, uri: /regioninfo, method: GET, req_id: 51cc5e5c-bb66-4447-833a-8fc30a0b2973, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.635 INFO request completed, latency_us: 42, response_code: 200, uri: /regioncount, method: GET, req_id: d85a8f55-cb07-4c28-bc08-b5991a2f359c, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.635 INFO request completed, latency_us: 68, response_code: 200, uri: /port/cid/0, method: GET, req_id: 5e882117-2e75-4713-a764-27cd67b6ecce, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.635 INFO request completed, latency_us: 32, response_code: 200, uri: /port/cid/1, method: GET, req_id: 19cc4504-163e-4dbf-94d8-444de5f2ea70, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.635 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/2, method: GET, req_id: 8711b16e-9af8-48e1-88bb-80410628b520, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.637 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/3, method: GET, req_id: 8dc82624-298b-4de0-b731-fdd98e1772f3, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.637 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/4, method: GET, req_id: 8c526449-a3bc-4386-81a4-79d1e13dc9e5, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:42.637 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/5, method: GET, req_id: a0981da6-8d2e-40de-a699-250723ac5794, remote_addr: 127.0.0.1:40277, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.950 INFO accepted connection, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.950 INFO request completed, latency_us: 189, response_code: 200, uri: /regioninfo, method: GET, req_id: f6cd40a7-5a1a-4ab2-89c6-3f4d7a95d14e, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.951 INFO request completed, latency_us: 117, response_code: 200, uri: /regioncount, method: GET, req_id: 8ae3b10b-aacb-4517-ba38-9d14e13ece7b, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.952 INFO request completed, latency_us: 103, response_code: 200, uri: /port/cid/0, method: GET, req_id: 364b7e87-f148-4862-89d8-39af5c9e576e, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.952 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0cb9b29a-7a2c-4e05-80d1-a36ecb6a2fad, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.952 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/2, method: GET, req_id: 0d3d4e7b-edfd-4d54-9fea-d21dc596562d, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.954 INFO request completed, latency_us: 59, response_code: 200, uri: /port/cid/3, method: GET, req_id: 69ff5e4e-e5dd-47a9-ad2c-ca5c44c13985, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.954 INFO request completed, latency_us: 42, response_code: 200, uri: /port/cid/4, method: GET, req_id: 141c1212-d460-4e23-a835-9c000cf97aef, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:25:51.954 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/5, method: GET, req_id: f2353273-f42b-4565-a080-6f225ec213d3, remote_addr: 127.0.0.1:35253, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.015 INFO accepted connection, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.016 INFO request completed, latency_us: 194, response_code: 200, uri: /regioninfo, method: GET, req_id: 2e414318-0655-4186-b8c3-4ff882f51b20, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.017 INFO request completed, latency_us: 49, response_code: 200, uri: /regioncount, method: GET, req_id: da80eb09-0549-4a70-afc8-d683cb11f869, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.017 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/0, method: GET, req_id: fff6523c-e5f3-477b-828e-011504c9fca8, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.017 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/1, method: GET, req_id: 86b0e9d5-b25f-48db-8d35-b40f5a780a1e, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.017 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/2, method: GET, req_id: c9792afc-ac42-48af-9946-970819310b60, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.019 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/3, method: GET, req_id: 9e7f584e-3b48-438a-b94c-2a4842e672bc, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.020 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/4, method: GET, req_id: f2a1f6cd-cf30-407c-9109-4e1442692823, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:26:17.020 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/5, method: GET, req_id: 968f21b4-a85d-4668-aeef-0d562d610377, remote_addr: 127.0.0.1:45440, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.789 INFO accepted connection, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.790 INFO request completed, latency_us: 194, response_code: 200, uri: /regioninfo, method: GET, req_id: c13fa852-61d2-4cf3-be73-5b2555cdf2d9, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.791 INFO request completed, latency_us: 49, response_code: 200, uri: /regioncount, method: GET, req_id: b91b20c8-b563-4220-8175-962c43511cce, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.791 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/0, method: GET, req_id: 14906265-802b-40b4-b01b-0709a4786c55, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.791 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/1, method: GET, req_id: b620acc5-153b-4da0-86ab-fa5247f881db, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.791 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/2, method: GET, req_id: 45c9f74a-1a2a-47eb-b907-c544dd9877b2, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.793 INFO request completed, latency_us: 47, response_code: 200, uri: /port/cid/3, method: GET, req_id: ddf7fa03-4ba8-4fdc-a2fd-28500604994e, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.793 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/4, method: GET, req_id: 1e41780f-765f-4a9c-ac70-1495b1e79b96, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:28:51.793 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: b225c15f-75d2-4d43-a5a4-4f8c7688536f, remote_addr: 127.0.0.1:55453, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.717 INFO accepted connection, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.718 INFO request completed, latency_us: 148, response_code: 200, uri: /regioninfo, method: GET, req_id: 6fbe5d29-c08c-49bf-9428-d4f25258a488, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.718 INFO request completed, latency_us: 33, response_code: 200, uri: /regioncount, method: GET, req_id: 411067cb-55d1-4e20-8120-462b3a4cbcae, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.718 INFO request completed, latency_us: 53, response_code: 200, uri: /port/cid/0, method: GET, req_id: 80067bf4-8a15-4145-a7ef-07543e266732, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.719 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/1, method: GET, req_id: b80890d7-0bea-466f-a77b-25165ee91f26, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.719 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/2, method: GET, req_id: 40d90a9e-8cb6-4fca-8792-90488c32b9b4, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.720 INFO request completed, latency_us: 50, response_code: 200, uri: /port/cid/3, method: GET, req_id: f4e7a55f-b759-4d5b-bc8f-322f1ac492a5, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.721 INFO request completed, latency_us: 87, response_code: 200, uri: /port/cid/4, method: GET, req_id: f7854e59-45a8-4d03-885a-dbfc45c29034, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:08.721 INFO request completed, latency_us: 65, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6117a316-258c-43ee-bd61-d495067fdc25, remote_addr: 127.0.0.1:65127, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.832 INFO accepted connection, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.833 INFO request completed, latency_us: 161, response_code: 200, uri: /regioninfo, method: GET, req_id: 028ace60-622f-4722-adb0-4f3bae63754b, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.833 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: 2bac415d-ca36-4162-9b86-a085613278ad, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.834 INFO request completed, latency_us: 72, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8a13891b-0e02-4972-bf11-f1c6ce4d5003, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.834 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: cff461e2-a4b5-43b7-a2fc-7be9f1309819, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.834 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/2, method: GET, req_id: 715a162e-1527-42ea-aa29-43168eb0ea8a, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.835 INFO request completed, latency_us: 69, response_code: 200, uri: /port/cid/3, method: GET, req_id: c0d13242-d124-47bc-89c9-ee21c738127f, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.836 INFO request completed, latency_us: 64, response_code: 200, uri: /port/cid/4, method: GET, req_id: d112305f-cf1b-4b03-b308-f8eba1a58072, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:12.836 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/5, method: GET, req_id: 6f8411bf-9809-49e0-a6b0-2508765fa86d, remote_addr: 127.0.0.1:64624, local_addr: 127.0.0.1:9998 Apr 27 18:29:16.934 INFO accepted connection, remote_addr: 127.0.0.1:42197, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Apr 27 18:29:16.934 INFO request completed, latency_us: 148, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 62d78214-192c-4bac-b2b6-fb033a1c8126, remote_addr: 127.0.0.1:42197, local_addr: 127.0.0.1[8820] Disable keep_running :9998[8810] Disable keep_running [8840] Disable keep_running [8850] Disable keep_running [8860] Disable keep_running [8830] Disable keep_running Apr 27 18:29:16.948 INFO accepted connection, remote_addr: 127.0.0.1:60488, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Apr 27 18:29:16.949 INFO request completed, latency_us: 119, response_code: 204, uri: /stop/cid/2, method: POST, req_id: 2c4932ac-53f9-4bdc-afa0-3f812b2792c3, remote_addr: 127.0.0.1:60488, local_addr: 127.0.0.1:9998 [8830] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Apr 27 18:29:16.962 INFO accepted connection, remote_addr: 127.0.0.1:47638, local_addr: 127.0.0.1:9998 Apr 27 18:29:16.963 INFO request completed, latency_us: 96, response_code: 200, uri: /state/cid/2, method: GET, req_id: c911f921-489b-4b22-845b-deb86240a167, remote_addr: 127.0.0.1:47638, local_addr: 127.0.0.1:9998 Apr 27 18:29:16.979 INFO accepted connection, remote_addr: 127.0.0.1:46096, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Apr 27 18:29:16.979 INFO request completed, latency_us: 80, response_code: 204, uri: /start/cid/2, method: POST, req_id: deb396c3-7e24-4c49-80e4-fcb4d7bd2ae6, remote_addr: 127.0.0.1:46096, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.013 INFO accepted connection, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.013 INFO request completed, latency_us: 112, response_code: 200, uri: /regioninfo, method: GET, req_id: def7b690-fa50-4486-8073-711548029f03, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.014 INFO request completed, latency_us: 36, response_code: 200, uri: /regioncount, method: GET, req_id: b3e97e2e-c098-440e-9ae6-f5709dbcaf22, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.014 INFO request completed, latency_us: 51, response_code: 200, uri: /port/cid/0, method: GET, req_id: 40827dbb-9c1c-48fd-9f8f-01d21b03571a, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.014 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: 71f3994c-cbc4-4ba8-9f61-4490623fd0ce, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.015 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/2, method: GET, req_id: 7135bfaa-abc0-4f81-aba2-7f4d9e34ec80, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.016 INFO request completed, latency_us: 50, response_code: 200, uri: /port/cid/3, method: GET, req_id: 95a0ddbf-8caf-4e83-9ee9-17a541a78bc8, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.016 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/4, method: GET, req_id: 840d6d41-d0ed-485c-b3c4-b23278b31277, remote_addr: 127.0.0.1:36099, local_addr: 127.0.0.1:9998 Apr 27 18:29:17.016 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/5, method: GET, req_id: 97654ae8-dfda-4ded-afc4-6e3c87d11a31, remote_addr: 127.0.0.1:36099, 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(1194) [8830][2] reports Running Apr 27 18:29:31.157 INFO accepted connection, remote_addr: 127.0.0.1:43056, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Apr 27 18:29:31.157 INFO request completed, latency_us: 130, response_code:Shut it down 204, uri: /shutdown, method: POST, req_id: 17161ec6-eac1-4e96-b907-fe5c19923d0d, remote_addr: 127.0.0.1:43056, local_addr: 127.0[8820] Disable keep_running .[8810] Disable keep_running 0.1:9998 [8820] Got stop action so:false kr:false [8810] Got stop action so:false kr:false [8830] Disable keep_running [8840] Disable keep_running [8850] Disable keep_running [8850] Got stop action so:false kr:false [8860] Disable keep_running [8860] Got stop action so:false kr:false [8830] Got stop action so:false kr:false [8840] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit /var/tmp/bins/dsc create --encrypted --cleanup --region-count 7 --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.030322079 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.02687753 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.025281904 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.024835544 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.024474166 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024369113 Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.031134197 Created 7 regions /var/tmp/bins/dsc start --region-count 7 --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 start ds: 8850 start ds: 8860 Starting downstairs at port 8810 start ds: 8870 Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8810][0] initial start wait reports Starting Starting downstairs at port 8830 [8820][1] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8830][2] initial start wait reports Starting Starting downstairs at port 8840 Starting downstairs at port 8850 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.txt" [8840][3] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8850.txt" [8850][4] initial start wait reports Starting Starting downstairs at port 8860 Starting downstairs at port 8870 Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" [8860][5] initial start wait reports Starting [8870][6] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1212) Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1214) Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1216) Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1217) Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1211) Control access at:127.0.0.1:9998 Apr 27 18:29:36.369 INFO listening, local_addr: 127.0.0.1:9998 Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1215) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1213) [8870][6] initial start wait reports Running [8830][2] initial start wait reports Running [8820][1] initial start wait reports Running [8810][0] initial start wait reports Running [8860][5] initial start wait reports Running [8840][3] initial start wait reports Running [8850][4] initial start wait reports Running All downstairs are running Apr 27 18:29:41.381 INFO accepted connection, remote_addr: 127.0.0.1:57586, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.382 INFO request completed, latency_us: 315, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3ae9ce82-aaa5-4fee-8064-c9b811f7d5b5, remote_addr: 127.0.0.1:57586, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.397 INFO accepted connection, remote_addr: 127.0.0.1:63155, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.397 INFO request completed, latency_us: 78, response_code: 200, uri: /state/cid/1, method: GET, req_id: 3a3b9d82-9dbb-4e4e-8680-17a745ad5651, remote_addr: 127.0.0.1:63155, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.410 INFO accepted connection, remote_addr: 127.0.0.1:44721, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.411 INFO request completed, latency_us: 70, response_code: 200, uri: /state/cid/2, method: GET, req_id: 30d64125-e0fa-428e-bb75-b380bcb0fd6f, remote_addr: 127.0.0.1:44721, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.424 INFO accepted connection, remote_addr: 127.0.0.1:62595, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.424 INFO request completed, latency_us: 58, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7ecad6d8-6701-46e9-adf3-3a78a7103185, remote_addr: 127.0.0.1:62595, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.437 INFO accepted connection, remote_addr: 127.0.0.1:64668, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.438 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/4, method: GET, req_id: 1c99211c-8d81-432a-9fb3-35b4ffffb372, remote_addr: 127.0.0.1:64668, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.451 INFO accepted connection, remote_addr: 127.0.0.1:46457, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.451 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/5, method: GET, req_id: a374a249-bc71-4e54-be15-56e0b1d50fa4, remote_addr: 127.0.0.1:46457, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.464 INFO accepted connection, remote_addr: 127.0.0.1:57612, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.464 INFO request completed, latency_us: 60, response_code: 200, uri: /state/cid/6, method: GET, req_id: 6aa7cbb7-6eac-4925-a921-aa62f2b583d1, remote_addr: 127.0.0.1:57612, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.477 INFO accepted connection, remote_addr: 127.0.0.1:54917, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.477 INFO request completed, latency_us: 74, response_code: 200, uri: /port/cid/6, method: GET, req_id: 01fbb9aa-be17-4e5f-abf8-847b0fa79a68, remote_addr: 127.0.0.1:54917, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.496 INFO accepted connection, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.497 INFO request completed, latency_us: 102, response_code: 200, uri: /regioninfo, method: GET, req_id: ed11b49f-de59-4b47-817f-d4c065ccd52a, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.497 INFO request completed, latency_us: 33, response_code: 200, uri: /regioncount, method: GET, req_id: 9e0e0803-b91a-4d33-bdcf-28cb0236c331, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.497 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/0, method: GET, req_id: 72094738-e6d9-4d01-af02-7466f02aa1dd, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.498 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/1, method: GET, req_id: c7777fa3-6afb-4bee-9fd7-2ff7b377fcac, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.498 INFO request completed, latency_us: 34, response_code: 200, uri: /port/cid/2, method: GET, req_id: 75f50631-9ab6-479e-b0bb-9558535e1603, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.499 INFO request completed, latency_us: 48, response_code: 200, uri: /port/cid/3, method: GET, req_id: d6564ded-066a-4f3a-8017-7bb2e4571b41, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.499 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/4, method: GET, req_id: 59b9790f-b630-4c2b-8c51-9ddb24e77ae5, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.499 INFO request completed, latency_us: 22, response_code: 200, uri: /port/cid/5, method: GET, req_id: e8a736b9-68b6-40b0-be7b-7971f0db00f4, remote_addr: 127.0.0.1:58795, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.522 INFO accepted connection, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.522 INFO request completed, latency_us: 131, response_code: 200, uri: /regioncount, method: GET, req_id: 232d5c8b-6360-4dea-b6fa-c66fdb3437c7, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Apr 27 18:29:41.920 INFO request completed, latency_us: 241, response_code: 204, uri:[8810] Got stop action so:false kr:false /stop/cid/0, method: POST, req_id: ee0b1d0c-6c19-4d2a-9fa9-d68514f8a1b6, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:29:41.921 INFO request completed, latency_us: 59, response_code: 200, uri: /state/cid/0, method: GET, req_id: ed39b370-94cf-4cec-b9c9-b2b47340192d, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Apr 27 18:29:45.924 INFO request completed, latency_us: 295, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6cb45504-1579-4231-9173-bfb7f8f77a92, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Apr 27 18:29:46.325 INFO request completed, latency_us: 234, response_code: 204, uri: /start/cid/0, method: POST, req_id: 764c111a-eaa5-426d-89a9-d03c575ff5fd, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:29:46.326 INFO request completed, latency_us: 71, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3d35ca5f-1cef-4c5e-a9eb-e6225d8d98c6, remote_addr: 127.0.0.1:39648, 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(1228) [8810][0] reports Running Apr 27 18:29:50.328 INFO request completed, latency_us: 271, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6746ade6-3ba3-4a2b-867a-98e1966fbc94, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Apr 27 18:29:56.723 [8810] Got stop action so:false kr:false INFO request completed, latency_us: 236, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 1207b1aa-cc27-40f9-aab8-bbabd4796ffb, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:29:56.723 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1f1bc79a-dc28-49c8-b0b2-7c5e4c6b4ce8, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Apr 27 18:30:00.726 INFO request completed, latency_us: 302, response_code: 200, uri: /state/cid/0, method: GET, req_id: 84bd0db7-b108-4163-8292-a0cbdfc132a2, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Apr 27 18:30:01.134 INFO request completed, latency_us: 232, response_code: 204, uri: /start/cid/0, method: POST, req_id: 3e764690-5edb-4cb6-b046-be1dcacf79e3, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:01.134 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/0, method: GET, req_id: a31457f6-6a50-41d5-b6e9-badb6eb54a6b, remote_addr: 127.0.0.1:39648, 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(1229) [8810][0] reports Running Apr 27 18:30:05.136 INFO request completed, latency_us: 238, response_code: 200, uri: /state/cid/0, method: GET, req_id: ab53ef5a-9172-4bfc-9698-ef1a9fbc1293, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Apr 27 18:30:10.533 INFO[8810] Got stop action so:false kr:false request completed, latency_us: 225, response_code: 204, uri: /stop/cid/0, method: POST, req_id: c324139e-f3de-402d-bb8e-c4244163c633, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:10.534 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/0, method: GET, req_id: 73def406-ccc7-46fc-a839-5391c5bbc77a, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Apr 27 18:30:14.537 INFO request completed, latency_us: 292, response_code: 200, uri: /state/cid/0, method: GET, req_id: 96bce74e-1e26-4b30-9c6b-413c86bbb265, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Apr 27 18:30:14.949 INFO request completed, latency_us: 225, response_code: 204, uri: /start/cid/0, method: POST, req_id: 25c733e4-e428-448d-9841-7a1a2b5a1df2, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:14.949 INFO request completed, latency_us: 86, response_code: 200, uri: /state/cid/0, method: GET, req_id: aa9a469a-6eab-4d4c-89cf-df5884f53dee, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:18.951 INFO request completed, latency_us: 254, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1d4e0477-0969-48f3-ba25-29783d230bea, remote_addr: 127.0.0.1:39648, 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(1230) [8810][0] reports Running Apr 27 18:30:22.954 INFO request completed, latency_us: 261, response_code: 200, uri: /state/cid/0, method: GET, req_id: 703b2f36-ed78-4110-a484-6a23d12e434f, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Apr 27 18:30:27.354 INFO[8810] Got stop action so:false kr:false request completed, latency_us: 228, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 9323bc51-edc0-452b-9dd0-bc301769541e, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:27.355 INFO request completed, latency_us: 95, response_code: 200, uri: /state/cid/0, method: GET, req_id: 4708b4f9-8cf8-435f-be19-e7154a8f3382, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Apr 27 18:30:31.357 INFO request completed, latency_us: 297, response_code: 200, uri: /state/cid/0, method: GET, req_id: 497d186a-6a4f-47e9-8a12-14d8565eb182, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Apr 27 18:30:31.768 INFO request completed, latency_us: 253, response_code: 204, uri: /start/cid/0, method: POST, req_id: e46ab572-5897-471f-b185-db6dc3a3cdd7, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:31.768 INFO request completed, latency_us: 45, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1905eb99-7a35-4a72-a0a5-3fd4b623fcc6, remote_addr: 127.0.0.1:39648, 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(1231) [8810][0] reports Running Apr 27 18:30:35.770 INFO request completed, latency_us: 266, response_code: 200, uri: /state/cid/0, method: GET, req_id: 6e094db5-8b90-4cc9-a602-83d64290ad86, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Apr 27 18:30:39.167[8810] Got stop action so:false kr:false INFO request completed, latency_us: 237, response_code: 204, uri: /stop/cid/0, method: POST, req_id: c1376295-d41c-4e04-8ac4-dc15abecc88a, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:39.168 INFO request completed, latency_us: 155, response_code: 200, uri: /state/cid/0, method: GET, req_id: ea92d110-c3ab-4fe4-bbb6-36954bbe193a, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Apr 27 18:30:43.171 INFO request completed, latency_us: 288, response_code: 200, uri: /state/cid/0, method: GET, req_id: ac1717fb-7e4a-4d15-951f-0a07cbfc3ca2, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Apr 27 18:30:43.584 INFO request completed, latency_us: 226, response_code: 204, uri: /start/cid/0, method: POST, req_id: 81caf0e5-dd00-4749-a529-20e7b88829b8, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:43.584 INFO request completed, latency_us: 81, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0512442f-bea4-4b64-9249-619bf0f6ff38, remote_addr: 127.0.0.1:39648, 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(1232) [8810][0] reports Running Apr 27 18:30:47.586 INFO request completed, latency_us: 254, response_code: 200, uri: /state/cid/0, method: GET, req_id: 8b05068f-5b6d-4b7c-8e98-499cd121e2be, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Apr 27 18:30:49.985 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: 0c7b1f12-9337-4089-97a2-1847f2ce6d62, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:49.986 INFO request completed, latency_us: 73, response_code: 200, uri: /state/cid/0, method: GET, req_id: 686b49f6-5c8c-4f3b-95a3-f9f37ec16cb8, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Apr 27 18:30:53.988 INFO request completed, latency_us: 307, response_code: 200, uri: /state/cid/0, method: GET, req_id: 706a89c6-d87a-40ca-a102-5ff083dccac1, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Apr 27 18:30:54.397 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/0, method: POST, req_id: ebbdff72-c439-492a-bcd0-4d12de13a758, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:30:54.398 INFO request completed, latency_us: 47, response_code: 200, uri: /state/cid/0, method: GET, req_id: 3a687319-ac99-4265-99b7-825be2f1d602, remote_addr: 127.0.0.1:39648, 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(1233) [8810][0] reports Running Apr 27 18:30:58.400 INFO request completed, latency_us: 284, response_code: 200, uri: /state/cid/0, method: GET, req_id: c9e6e310-ecfa-4e24-99a7-833be19ba9aa, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Apr 27 18:31:25.912 INFO request completed, latency_us: 231, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 140555f1-676a-4375-9dcc-215d00a3bc6e, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:31:25.912 INFO request completed, latency_us: 87, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7711d389-1755-4ec0-9428-1daf72c2b287, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Apr 27 18:31:29.915 INFO request completed, latency_us: 294, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7168dab3-cf9c-4a7c-b5be-bdfb06e22f88, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Apr 27 18:31:30.328 INFO request completed, latency_us: 232, response_code: 204, uri: /start/cid/1, method: POST, req_id: eeff1c06-016a-4ecb-ba8a-0403886d8c43, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:31:30.329 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/1, method: GET, req_id: a759fecf-a713-4947-b050-d640ba9cd020, remote_addr: 127.0.0.1:39648, 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(1234) [8820][1] reports Running Apr 27 18:31:34.331 INFO request completed, latency_us: 269, response_code: 200, uri: /state/cid/1, method: GET, req_id: 91f755a2-ae3a-4819-ad62-db8a7fcde204, remote_addr: 127.0.0.1:39648, 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 Apr 27 18:32:01.946 INFO request completed, latency_us: 227, response_code: 204, uri: /stop/cid/2, method: POST, req_id: ec6859ad-3d2b-442f-a7c9-d1e497b108cc, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:32:01.946 INFO request completed, latency_us: 88, response_code: 200, uri: /state/cid/2, method: GET, req_id: 85529d7d-4d0f-4e02-ad67-05ce20815a5b, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Apr 27 18:32:05.948 INFO request completed, latency_us: 276, response_code: 200, uri: /state/cid/2, method: GET, req_id: 6e9b0644-058a-4690-b15a-1573a854bc85, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Apr 27 18:32:06.363 INFO request completed, latency_us: 224, response_code: 204, uri: /start/cid/2, method: POST, req_id: dceba77a-b587-410b-8b85-29a7a573faa5, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:32:06.363 INFO request completed, latency_us: 46, response_code: 200, uri: /state/cid/2, method: GET, req_id: 27fce12d-d5f1-455c-89f8-7e07bffbc88f, remote_addr: 127.0.0.1:39648, 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(1235) [8830][2] reports Running Apr 27 18:32:10.365 INFO request completed, latency_us: 282, response_code: 200, uri: /state/cid/2, method: GET, req_id: d908c964-9282-4017-8c93-062e3dfccb09, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Apr 27 18:32:38.209 [8840] Got stop action so:false kr:false INFO request completed, latency_us: 225, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 621ad4ca-83d5-4e82-ba75-d02118af2a85, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:32:38.209 INFO request completed, latency_us: 170, response_code: 200, uri: /state/cid/3, method: GET, req_id: e9c5d981-7a02-4cca-ba99-5fffea81ced3, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Apr 27 18:32:42.212 INFO request completed, latency_us: 247, response_code: 200, uri: /state/cid/3, method: GET, req_id: 73d2419c-244c-46e4-ab49-29e418f903d4, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Apr 27 18:32:42.631 INFO request completed, latency_us: 270, response_code: 204, uri: /start/cid/3, method: POST, req_id: b592db8c-220e-4021-b381-94ce6edb2d21, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:32:42.631 INFO request completed, latency_us: 47, response_code: 200, uri: /state/cid/3, method: GET, req_id: ae8a64ed-c35f-4305-83c3-d87c25edd656, remote_addr: 127.0.0.1:39648, 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(1236) [8840][3] reports Running Apr 27 18:32:46.634 INFO request completed, latency_us: 247, response_code: 200, uri: /state/cid/3, method: GET, req_id: 319e1a18-f232-4426-99dc-867c1c46ffed, remote_addr: 127.0.0.1:39648, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.344 INFO accepted connection, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.345 INFO request completed, latency_us: 165, response_code: 200, uri: /regioninfo, method: GET, req_id: 81cba84c-67e1-4cc7-9005-6e7f5cd419fb, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.346 INFO request completed, latency_us: 53, response_code: 200, uri: /regioncount, method: GET, req_id: 8c0928c4-a4f8-4507-8e5f-663486db91db, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.346 INFO request completed, latency_us: 56, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6106b4ac-7ebf-4581-b3d1-221d3a7c5ef8, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.346 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: de2e4f99-d4da-4267-a222-258b1f2a6f7d, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.346 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/2, method: GET, req_id: 8b4c6200-d881-42ec-8ded-0ff3f6836cb0, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.348 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/3, method: GET, req_id: a057210a-c5fc-4982-9136-df4ac395d005, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.348 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/4, method: GET, req_id: 815a8ee2-cb5c-4e98-a1e4-a4c879ebb458, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.348 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1bd887eb-eb05-491b-867f-ee42b0c3d441, remote_addr: 127.0.0.1:55194, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.541 INFO accepted connection, remote_addr: 127.0.0.1:48828, local_addr: 127.0.0.1:9998 Apr 27 18:33:14.542 INFO request completed, latency_us: 138, response_code: 200, uri: /regioncount, method: GET, req_id: 3701e0a2-2a26-460b-aa2b-84f58602a604, remote_addr: 127.0.0.1:48828, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Apr 27 18:33:20.287 INFO [8810] Got stop action so:false kr:false request completed, latency_us: 233, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 5f9590ea-d924-45ed-b2d6-aa0d7471a673, remote_addr: 127.0.0.1:48828, local_addr: 127.0.0.1:9998 Apr 27 18:33:20.288 INFO request completed, latency_us: 166, response_code: 200, uri: /state/cid/0, method: GET, req_id: 439b38a2-806f-4c59-80a1-ed38f40c3993, remote_addr: 127.0.0.1:48828, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Apr 27 18:33:24.290 INFO request completed, latency_us: 258, response_code: 200, uri: /state/cid/0, method: GET, req_id: ce760449-4d05-4d37-a867-e21c855e9fdf, remote_addr: 127.0.0.1:48828, local_addr: 127.0.0.1:9998 Apr 27 18:34:01.877 INFO accepted connection, remote_addr: 127.0.0.1:58338, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Apr 27 18:34:01.877 INFO request completed, latency_us: 175, response_code: 204, uri: /start/cid/0, method: POST, req_id: 8d415298-5dd8-4377-a40d-c5789cb92b20, remote_addr: 127.0.0.1:58338, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Apr 27 18:34:06.282 INFO request completed, latency_us: 243, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 819a6fb4-dc55-4993-b013-41d88f47136d, remote_addr: 127.0.0.1:58338, local_addr: 127.0.0.1:9998 Apr 27 18:34:06.282 INFO request completed, latency_us: 93, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7d7af88e-5fd3-4a3c-9867-4310229614a3, remote_addr: 127.0.0.1:58338, 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(1238) [8810][0] reports Running Apr 27 18:34:10.285 INFO request completed, latency_us: 249, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6406fa53-cbd2-4822-b4f3-2b123a763601, remote_addr: 127.0.0.1:58338, local_addr: 127.0.0.1:9998 Apr 27 18:34:47.835 INFO accepted connection, remote_addr: 127.0.0.1:62308, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Apr 27 18:34:47.835 INFO request completed, latency_us: 199, response_code: 204, uri: /start/cid/1, method: POST, req_id: 3d057dbb-a676-45a4-8d7f-c7b9168d52c9, remote_addr: 127.0.0.1:62308, 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 Apr 27 18:34:52.245 INFO request completed, latency_us: 279, response_code: 204, uri: /stop/cid/2, method: POST, req_id: d13da7f5-e638-4c85-9502-a2ef44b50057, remote_addr: 127.0.0.1:62308, local_addr: 127.0.0.1:9998 Apr 27 18:34:52.246 INFO request completed, latency_us: 73, response_code: 200, uri: /state/cid/2, method: GET, req_id: 1dfcf508-58fc-4699-984b-6f1acd852617, remote_addr: 127.0.0.1:62308, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8820] got start action [8820] I am going to restart Starting downstairs at port 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8820][1] reports Starting Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1239) [8820][1] reports Running Apr 27 18:34:56.249 INFO request completed, latency_us: 243, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9c47bcb4-cfae-47ab-b62b-6eb0e21b2ee7, remote_addr: 127.0.0.1:62308, local_addr: 127.0.0.1:9998 Apr 27 18:35:33.781 INFO accepted connection, remote_addr: 127.0.0.1:45751, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Apr 27 18:35:33.781 INFO request completed, latency_us: 166, response_code: 204, uri: /start/cid/2, method: POST, req_id: 1ed25167-08be-4293-bc4e-b8729c988435, remote_addr: 127.0.0.1:45751, 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(1240) [8830][2] reports Running Main task has work to do, go find it got dsc Stop(3) stop 3 Apr 27 18:35:38.204 INFO request completed[8840] Got stop action so:false kr:false , latency_us: 226, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 736873b6-8167-484c-9fb4-a3a2b60fa9df, remote_addr: 127.0.0.1:45751, local_addr: 127.0.0.1:9998 Apr 27 18:35:38.204 INFO request completed, latency_us: 53, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7e310e04-6ca6-4682-aa1b-067292f76a46, remote_addr: 127.0.0.1:45751, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Apr 27 18:35:42.207 INFO request completed, latency_us: 248, response_code: 200, uri: /state/cid/3, method: GET, req_id: 41d70e3b-85c8-4dfc-99a4-5f1f52c5bc35, remote_addr: 127.0.0.1:45751, local_addr: 127.0.0.1:9998 Apr 27 18:36:19.813 INFO accepted connection, remote_addr: 127.0.0.1:51744, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Apr 27 18:36:19.813 INFO request completed, latency_us: 173, response_code: 204, uri: /start/cid/3, method: POST, req_id: 4c1d9a07-d8d5-4bdd-a120-d74e8bf674dd, remote_addr: 127.0.0.1:51744, 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(1241) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(4) stop 4 Apr 27 18:36:24.376 [8850] Got stop action so:false kr:false INFO request completed, latency_us: 272, response_code: 204, uri: /stop/cid/4, method: POST, req_id: e4712bee-2dfe-4a1f-94ff-d1f683e7d85b, remote_addr: 127.0.0.1:51744, local_addr: 127.0.0.1:9998 Apr 27 18:36:24.377 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/4, method: GET, req_id: f947f87b-4e0b-4524-b2df-cceacd1a43a0, remote_addr: 127.0.0.1:51744, local_addr: 127.0.0.1:9998 [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit Apr 27 18:36:28.379 INFO request completed, latency_us: 238, response_code: 200, uri: /state/cid/4, method: GET, req_id: feafff44-cd00-4bae-8ba9-726cc01b20b3, remote_addr: 127.0.0.1:51744, local_addr: 127.0.0.1:9998 Apr 27 18:37:05.983 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 Start(4) start 4 Apr 27 18:37:05.983 INFO request completed, latency_us: 219, response_code: 204, uri: /start/cid/4, method: POST, req_id: f7e6cf70-5830-4f59-9087-de3c59f04735, remote_addr: 127.0.0.1:61178, local_addr: 127.0.0.1:9998 Apr 27 18:37:10.031 INFO accepted connection, remote_addr: 127.0.0.1:56126, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Apr 27 18:37:10.032 INFO request completed, latency_us: 155, response_code: 204, uri: /shutdown, method: POST, req_id: 3728c205-e691-4b62-a7a7-72552f743106, remote_addrShut it down : 127.0.0.1:56126, local_addr: 127.0.0.1:[8820] Disable keep_running 9998 [8820] Got stop action so:false kr:false [8810] Disable keep_running [8810] Got stop action so:false kr:false [8830] Disable keep_running [8830] Got stop action so:false kr:false [8840] Disable keep_running [8870] Disable keep_running [8840] Got stop action so:false kr:false [8870] Got stop action so:false kr:false [8860] Disable keep_running [8860] Got stop action so:false kr:false [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8820] Exited with: ExitStatus(unix_wait_status(9)) [8810] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit [8810][0] reports Exit [8870] Exited with: ExitStatus(unix_wait_status(9)) [8870][6] reports Exit [8850] got start action [8850] Disable keep_running