/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.18464398 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.012607556 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.011254602 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.010650488 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.010768458 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.010541287 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 8820 Make output file at "/tmp/test_up-build/dsc/downstairs-8810.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" Starting downstairs at port 8840 Make output file at "/tmp/test_up-build/dsc/downstairs-8840.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 [8820][1] initial start wait reports Starting [8840][3] initial start wait reports Starting [8850][4] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1141) Starting downstairs at port 8860 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1145) Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1144) Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1142) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1146) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1143) [8830][2] initial start wait reports Running [8860][5] initial start wait reports Starting [8860][5] initial start wait reports Running [8810][0] initial start wait reports Running [8820][1] initial start wait reports Running [8840][3] initial start wait reports Running [8850][4] initial start wait reports Running All downstairs are running Jul 28 18:53:09.272 INFO listening, local_addr: 127.0.0.1:9998 Control access at:127.0.0.1:9998 Jul 28 18:53:14.274 INFO accepted connection, remote_addr: 127.0.0.1:63444, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.275 INFO request completed, latency_us: 404, response_code: 200, uri: /state/cid/0, method: GET, req_id: f222594d-d3f8-4cf5-acf8-9086ab1e3ed0, remote_addr: 127.0.0.1:63444, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.289 INFO accepted connection, remote_addr: 127.0.0.1:56706, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.289 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/1, method: GET, req_id: d07afc74-12de-4857-b2cf-8c41bdc4126b, remote_addr: 127.0.0.1:56706, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.302 INFO accepted connection, remote_addr: 127.0.0.1:47984, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.302 INFO request completed, latency_us: 66, response_code: 200, uri: /state/cid/2, method: GET, req_id: d8813724-ccc5-4d07-89e6-72e7f9e9c4b6, remote_addr: 127.0.0.1:47984, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.315 INFO accepted connection, remote_addr: 127.0.0.1:61244, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.316 INFO request completed, latency_us: 73, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7238a6b6-e216-49b1-a76f-9a81ede02b9b, remote_addr: 127.0.0.1:61244, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.329 INFO accepted connection, remote_addr: 127.0.0.1:42732, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.329 INFO request completed, latency_us: 67, response_code: 200, uri: /state/cid/4, method: GET, req_id: bc2faa2d-112a-4c41-a4d7-06e4510d9b03, remote_addr: 127.0.0.1:42732, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.342 INFO accepted connection, remote_addr: 127.0.0.1:48681, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.342 INFO request completed, latency_us: 65, response_code: 200, uri: /state/cid/5, method: GET, req_id: ee441ad9-2feb-496b-9327-3c41eb5d67ca, remote_addr: 127.0.0.1:48681, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.355 INFO accepted connection, remote_addr: 127.0.0.1:36985, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Jul 28 18:53:14.355 INFO request completed, latency_us: 84, response_code: 204, uri: /disablerestart/all, method: POST, req_id: [8810] Disable keep_running 0b1e0da6-e81c-4997-8879-82701dfba7dd, remote_addr: 127.0.0.1:[8830] Disable keep_running 36985[8840] Disable keep_running , local_addr: 127[8820] Disable keep_running .[8850] Disable keep_running 0[8860] Disable keep_running .0.1:9998 Jul 28 18:53:14.419 INFO accepted connection, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.420 INFO request completed, latency_us: 242, response_code: 200, uri: /regioninfo, method: GET, req_id: d41dc16d-12d1-4afe-b47b-088d306b502b, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.421 INFO request completed, latency_us: 62, response_code: 200, uri: /regioncount, method: GET, req_id: 31d89212-5dac-46a6-a491-e90b07a41ed6, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.422 INFO request completed, latency_us: 98, response_code: 200, uri: /port/cid/0, method: GET, req_id: c99a6969-fb5a-48e4-8d9e-dac272e863a1, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.422 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/1, method: GET, req_id: 8c958b8d-4c53-4fbb-94c9-62c05768aff6, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.422 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/2, method: GET, req_id: 0ba46491-58e5-4fb2-b9f0-35867db6c87a, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.428 INFO request completed, latency_us: 55, response_code: 200, uri: /port/cid/3, method: GET, req_id: 178bce62-4c6d-499f-877f-1b4d29d13f12, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.428 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/4, method: GET, req_id: 99e53479-3154-4a28-9c41-271100c249c0, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:14.428 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/5, method: GET, req_id: bf696c5e-c6ef-43bf-892c-16725cd3b518, remote_addr: 127.0.0.1:60329, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.485 INFO accepted connection, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.486 INFO request completed, latency_us: 147, response_code: 200, uri: /regioninfo, method: GET, req_id: ca059cce-ca57-441b-bef6-25a4eb961b70, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.486 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: 47f1f05e-da84-4d8b-a0a8-fb2cd81a6c3a, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.487 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: 6fb542f5-5adc-4443-bf84-300812742de0, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.487 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/1, method: GET, req_id: 23883cf2-1a0d-4fb6-a680-58fed0faa9fc, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.487 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/2, method: GET, req_id: 52a440da-7d16-4c40-b6c5-215cfcb4e45c, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.489 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/3, method: GET, req_id: f4f85923-9086-41a9-9b7d-9c2f675420b8, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.489 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/4, method: GET, req_id: af949ccc-51f1-4e58-9594-42c4434b4719, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:23.489 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/5, method: GET, req_id: 59c60a58-31b8-4971-b7ba-b04048646c08, remote_addr: 127.0.0.1:61131, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.799 INFO accepted connection, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.800 INFO request completed, latency_us: 149, response_code: 200, uri: /regioninfo, method: GET, req_id: 9effc451-2fe0-4250-a9d6-8a49da198388, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.800 INFO request completed, latency_us: 47, response_code: 200, uri: /regioncount, method: GET, req_id: f479124b-63f6-4267-98b9-03907f8e4a99, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.801 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: 8f48ed6e-5339-4c50-8177-bfded268e0be, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.801 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: b2021197-4666-42f5-b953-31d48b4600fd, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.801 INFO request completed, latency_us: 36, response_code: 200, uri: /port/cid/2, method: GET, req_id: d3e49f5c-0cef-46d3-8704-cffad52df0dd, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.802 INFO request completed, latency_us: 44, response_code: 200, uri: /port/cid/3, method: GET, req_id: e77a639b-a4de-4d45-b7a4-dc0574e59ff6, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.803 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/4, method: GET, req_id: 0b438a43-c05f-411a-8981-8f1fc42bc7dc, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:32.803 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: e8f9b159-eb72-47f8-b140-ad20fde8ae28, remote_addr: 127.0.0.1:44836, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.691 INFO accepted connection, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.691 INFO request completed, latency_us: 149, response_code: 200, uri: /regioninfo, method: GET, req_id: f38c9b82-54a4-4cf1-b64d-3598e27304f9, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.692 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: f8b9b30d-6a41-496c-9a9d-612406971c5a, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.692 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/0, method: GET, req_id: 4e38b1cc-ee27-4a71-8f18-38f9440c1d72, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.693 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3fb39db3-8706-4c9a-92d8-11e63ccd10ea, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.693 INFO request completed, latency_us: 33, response_code: 200, uri: /port/cid/2, method: GET, req_id: a26f8b30-ae9b-41bc-919e-55075818160a, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.694 INFO request completed, latency_us: 44, response_code: 200, uri: /port/cid/3, method: GET, req_id: 89e28f55-c88d-4d2f-82e4-000a6ebdb2b1, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.694 INFO request completed, latency_us: 30, response_code: 200, uri: /port/cid/4, method: GET, req_id: 228f2c38-832c-49ef-aa42-c0ef9d58c963, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:53:57.694 INFO request completed, latency_us: 28, response_code: 200, uri: /port/cid/5, method: GET, req_id: 5721e587-18c0-4657-a6f0-8c7f03a6fd44, remote_addr: 127.0.0.1:47853, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.657 INFO accepted connection, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.657 INFO request completed, latency_us: 151, response_code: 200, uri: /regioninfo, method: GET, req_id: ff909194-f310-4d55-ac21-a6ec016fb5b2, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.658 INFO request completed, latency_us: 37, response_code: 200, uri: /regioncount, method: GET, req_id: dd0b42f4-204e-4fd8-a263-34b15c51274d, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.658 INFO request completed, latency_us: 60, response_code: 200, uri: /port/cid/0, method: GET, req_id: d1099823-899b-46ef-afa3-1f057ba9cbe4, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.659 INFO request completed, latency_us: 35, response_code: 200, uri: /port/cid/1, method: GET, req_id: 365c86af-ca16-4d10-8110-dda7b0eb50a6, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.659 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/2, method: GET, req_id: 0ede3375-89bf-4083-8538-2fc30b2b3ccf, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.660 INFO request completed, latency_us: 66, response_code: 200, uri: /port/cid/3, method: GET, req_id: 5f5fcc88-cd75-4242-9b1b-91d564996fb2, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.661 INFO request completed, latency_us: 63, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2291b59b-6353-4966-b292-abd300dc45fa, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:32.661 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/5, method: GET, req_id: d6225f9a-3e2e-4b15-9c9c-81532411f5fd, remote_addr: 127.0.0.1:38373, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.574 INFO accepted connection, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.574 INFO request completed, latency_us: 152, response_code: 200, uri: /regioninfo, method: GET, req_id: 84844435-7b33-4949-8fc6-99c4d17537b5, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.575 INFO request completed, latency_us: 39, response_code: 200, uri: /regioncount, method: GET, req_id: dbd71e62-b349-4c6f-9c5e-871b940d6c9e, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.575 INFO request completed, latency_us: 54, response_code: 200, uri: /port/cid/0, method: GET, req_id: 749cfce7-f78a-4ce6-b1d4-1934d5e069e0, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.576 INFO request completed, latency_us: 29, response_code: 200, uri: /port/cid/1, method: GET, req_id: e84a8ee5-6404-4ebc-9783-e2592cf8d1d1, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.576 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/2, method: GET, req_id: 39b31cd8-275c-49b8-9b5e-e1f623921615, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.577 INFO request completed, latency_us: 47, response_code: 200, uri: /port/cid/3, method: GET, req_id: 6b2808f2-c2d8-4233-a4cf-8443bfae9d44, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.577 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: dc01b64c-acea-4599-9234-e767935cccd8, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:54.578 INFO request completed, latency_us: 25, response_code: 200, uri: /port/cid/5, method: GET, req_id: a7c6f3ae-3122-47fb-84a7-a00123e7dbaa, remote_addr: 127.0.0.1:56886, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.686 INFO accepted connection, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.687 INFO request completed, latency_us: 144, response_code: 200, uri: /regioninfo, method: GET, req_id: e49976f9-0e5a-4d21-b610-1d99b475733f, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.688 INFO request completed, latency_us: 42, response_code: 200, uri: /regioncount, method: GET, req_id: 6e9ddb28-0c48-438e-865c-4396ce9f97bb, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.688 INFO request completed, latency_us: 60, response_code: 200, uri: /port/cid/0, method: GET, req_id: b3922ff3-5841-488a-b244-87bfb82fda42, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.688 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/1, method: GET, req_id: 0f21f18f-b59b-426a-b205-eb12857fe8a5, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.688 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/2, method: GET, req_id: dc65278a-ec6f-41b9-8525-55bdd879216a, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.690 INFO request completed, latency_us: 40, response_code: 200, uri: /port/cid/3, method: GET, req_id: a87da81d-fb77-400c-8786-a9aaef1b4423, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.690 INFO request completed, latency_us: 26, response_code: 200, uri: /port/cid/4, method: GET, req_id: 6c2b771b-f477-4845-a04e-faaba8919295, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:56:58.690 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: 1c9810c9-9f11-4217-a150-512b10a7545a, remote_addr: 127.0.0.1:63288, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.787 INFO accepted connection, remote_addr: 127.0.0.1:61214, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc DisableRestartAll disable restart on all: 6 Jul 28 18:57:02.787 INFO request completed, latency_us: 134, response_code: 204, uri: /disablerestart/all, method: POST, req_id: 88d62eb2-6deb-4f20-9334-aef378d6a96d, remote_addr: 127.0.0.1:61214, local_addr: 127.0.0.1:9998 [8820] Disable keep_running [8810] Disable keep_running [8840] Disable keep_running [8850] Disable keep_running [8860] Disable keep_running [8830] Disable keep_running Jul 28 18:57:02.800 INFO accepted connection, remote_addr: 127.0.0.1:50790, local_addr: 127.0.0.1:9998 Main task has work to do, go find it Jul 28 18:57:02.801 INFO request completed, latency_us: got dsc Stop(2) 84, response_code: 204, stop 2 uri: /stop/cid/2, method: POST, req_id: 883081e7-dd2e-47cd-ba0a-c5362298454c, remote_addr: 127.0.[8830] Got stop action so:false kr:false 0.1:50790, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 28 18:57:02.814 INFO accepted connection, remote_addr: 127.0.0.1:65164, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.815 INFO request completed, latency_us: 100, response_code: 200, uri: /state/cid/2, method: GET, req_id: d60b20a0-4247-4d55-bb36-89b04a1ff00f, remote_addr: 127.0.0.1:65164, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.830 INFO accepted connection, remote_addr: 127.0.0.1:51531, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) Jul 28 18:57:02.831 INFOstart 2 request completed, latency_us: 78, response_code: 204, uri: /start/cid/2, method: POST, req_id: 3a1e7aa8-89b5-45e9-8ee8-619f7947460f, remote_addr: 127.0.0.1:51531, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.863 INFO accepted connection, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.864 INFO request completed, latency_us: 99, response_code: 200, uri: /regioninfo, method: GET, req_id: 9e7756fb-2a64-4914-943d-93b0c7657ad9, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.864 INFO request completed, latency_us: 60, response_code: 200, uri: /regioncount, method: GET, req_id: 63d8f405-1205-4dc1-bdb8-95c6bc78da66, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.865 INFO request completed, latency_us: 88, response_code: 200, uri: /port/cid/0, method: GET, req_id: ef6d4b58-b0c5-4601-a0bd-31f69819fd40, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.865 INFO request completed, latency_us: 61, response_code: 200, uri: /port/cid/1, method: GET, req_id: ddfedb82-4329-41d1-8720-f1914ae8d36c, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.865 INFO request completed, latency_us: 59, response_code: 200, uri: /port/cid/2, method: GET, req_id: f8f1527f-2b86-45c4-b6ab-8ed3da82d9ae, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.867 INFO request completed, latency_us: 72, response_code: 200, uri: /port/cid/3, method: GET, req_id: c9c7a708-7b4d-4a77-b8ac-71dce394da0f, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.867 INFO request completed, latency_us: 58, response_code: 200, uri: /port/cid/4, method: GET, req_id: 2c68e848-2d63-4ca7-9bff-f84636a64454, remote_addr: 127.0.0.1:50218, local_addr: 127.0.0.1:9998 Jul 28 18:57:02.867 INFO request completed, latency_us: 57, response_code: 200, uri: /port/cid/5, method: GET, req_id: b4c48803-76cb-4275-afc0-be740fa0291e, remote_addr: 127.0.0.1:50218, 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(1197) [8830][2] reports Running Jul 28 18:57:17.004 INFO accepted connection, remote_addr: 127.0.0.1:38933, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Jul 28 18:57:17.004 INFO request completedShut it down , latency_us: 135, response_code: 204, uri: /shutdown, method: POST, req_id: 9e738db4-2481-4c88-82b1-fb73486819cc, remote_addr: 127.0.0.[8810] Disable keep_running 1[8810] Got stop action so:false kr:false :38933[8830] Disable keep_running , [8830] Got stop action so:false kr:false local_addr[8840] Disable keep_running :[8840] Got stop action so:false kr:false 127.0.0.1:9998 [8860] Disable keep_running [8820] Disable keep_running [8860] Got stop action so:false kr:false [8820] Got stop action so:false kr:false [8850] Disable keep_running [8850] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8840] Exited with: ExitStatus(unix_wait_status(9)) [8810] Exited with: ExitStatus(unix_wait_status(9)) [8820] Exited with: ExitStatus(unix_wait_status(9)) [8850] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit [8820][1] reports Exit [8810][0] reports Exit [8850][4] 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.029580658 Downstairs region 1 created at /var/tmp/test_up-build/8820 in 0.028101947 Downstairs region 2 created at /var/tmp/test_up-build/8830 in 0.027352737 Downstairs region 3 created at /var/tmp/test_up-build/8840 in 0.026161669 Downstairs region 4 created at /var/tmp/test_up-build/8850 in 0.025318973 Downstairs region 5 created at /var/tmp/test_up-build/8860 in 0.024908744 Downstairs region 6 created at /var/tmp/test_up-build/8870 in 0.033971492 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 Starting downstairs at port 8830 Make output file at "/tmp/test_up-build/dsc/downstairs-8820.txt" [8810][0] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8830.txt" [8820][1] initial start wait reports Starting 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-8840.txt" [8830][2] initial start wait reports Starting Starting downstairs at port 8850 [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 Make output file at "/tmp/test_up-build/dsc/downstairs-8860.txt" Starting downstairs at port 8870 [8860][5] initial start wait reports Starting Make output file at "/tmp/test_up-build/dsc/downstairs-8870.txt" [8870][6] initial start wait reports Starting Downstairs /var/tmp/test_up-build/8830 port 8830 PID:Some(1220) Downstairs /var/tmp/test_up-build/8810 port 8810 PID:Some(1218) Downstairs /var/tmp/test_up-build/8820 port 8820 PID:Some(1219) Downstairs /var/tmp/test_up-build/8850 port 8850 PID:Some(1214) Downstairs /var/tmp/test_up-build/8840 port 8840 PID:Some(1217) Downstairs /var/tmp/test_up-build/8860 port 8860 PID:Some(1216) [8830][2] initial start wait reports Running [8810][0] initial start wait reports Running [8820][1] initial start wait reports Running [8850][4] initial start wait reports Running [8840][3] initial start wait reports Running [8860][5] initial start wait reports Running Downstairs /var/tmp/test_up-build/8870 port 8870 PID:Some(1215) Control access at:127.0.0.1:9998 Jul 28 18:57:22.223 INFO listening, local_addr: 127.0.0.1:9998 [8870][6] initial start wait reports Running All downstairs are running Jul 28 18:57:27.235 INFO accepted connection, remote_addr: 127.0.0.1:65162, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.236 INFO request completed, latency_us: 291, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0758cd14-7f0e-46d9-a3ba-ea093cf809db, remote_addr: 127.0.0.1:65162, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.250 INFO accepted connection, remote_addr: 127.0.0.1:36040, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.250 INFO request completed, latency_us: 78, response_code: 200, uri: /state/cid/1, method: GET, req_id: 502f1820-583c-4b48-85df-bf8003cd0252, remote_addr: 127.0.0.1:36040, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.264 INFO accepted connection, remote_addr: 127.0.0.1:51289, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.264 INFO request completed, latency_us: 64, response_code: 200, uri: /state/cid/2, method: GET, req_id: ddf2057e-1027-430b-b37b-fcd6bace330b, remote_addr: 127.0.0.1:51289, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.277 INFO accepted connection, remote_addr: 127.0.0.1:61217, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.277 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/3, method: GET, req_id: 54ed8a28-70dd-4ac2-9288-82722a5a286b, remote_addr: 127.0.0.1:61217, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.290 INFO accepted connection, remote_addr: 127.0.0.1:41718, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.291 INFO request completed, latency_us: 74, response_code: 200, uri: /state/cid/4, method: GET, req_id: f3286b37-90b4-439b-a709-0650de9cdd17, remote_addr: 127.0.0.1:41718, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.303 INFO accepted connection, remote_addr: 127.0.0.1:45592, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.304 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/5, method: GET, req_id: 61ee9a1e-c63b-458e-834a-10685cec6647, remote_addr: 127.0.0.1:45592, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.316 INFO accepted connection, remote_addr: 127.0.0.1:47889, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.317 INFO request completed, latency_us: 61, response_code: 200, uri: /state/cid/6, method: GET, req_id: 59f6daeb-4683-4875-a9df-cc8e93d6d34e, remote_addr: 127.0.0.1:47889, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.329 INFO accepted connection, remote_addr: 127.0.0.1:43278, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.330 INFO request completed, latency_us: 91, response_code: 200, uri: /port/cid/6, method: GET, req_id: e37437f5-61d6-46a7-b3a8-8201b697445f, remote_addr: 127.0.0.1:43278, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.348 INFO accepted connection, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.349 INFO request completed, latency_us: 92, response_code: 200, uri: /regioninfo, method: GET, req_id: 80313c2b-6b9f-45ff-818f-f8ce4f81a525, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.349 INFO request completed, latency_us: 61, response_code: 200, uri: /regioncount, method: GET, req_id: d8a1cce8-395e-43ab-bf98-19892ce81021, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.350 INFO request completed, latency_us: 73, response_code: 200, uri: /port/cid/0, method: GET, req_id: ad56e01b-f4d6-4198-bced-52c9177bb1bc, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.350 INFO request completed, latency_us: 31, response_code: 200, uri: /port/cid/1, method: GET, req_id: 3763b085-1189-4de5-80d2-ee4404dc47a1, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.350 INFO request completed, latency_us: 38, response_code: 200, uri: /port/cid/2, method: GET, req_id: 2edd41e0-32ee-429b-999f-4126f14f5a3f, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.351 INFO request completed, latency_us: 49, response_code: 200, uri: /port/cid/3, method: GET, req_id: 7e1ab884-9389-477a-9984-72ce166d0819, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.352 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: cc287337-a5f1-4d0b-b7c7-3e0531553a0c, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.352 INFO request completed, latency_us: 23, response_code: 200, uri: /port/cid/5, method: GET, req_id: 968c56fc-b5d9-4098-b8e2-acc99f536021, remote_addr: 127.0.0.1:34598, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.374 INFO accepted connection, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.374 INFO request completed, latency_us: 132, response_code: 200, uri: /regioncount, method: GET, req_id: f881a925-49b7-4f9a-b765-1803d0255ca3, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 28 18:57:27.770 INFO request completed, [8810] Got stop action so:false kr:false latency_us: 235, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 2f957158-239c-48c6-b366-e5bb96cb136d, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:57:27.771 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/0, method: GET, req_id: d0b428e2-c477-4396-9081-de76ac61211f, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 28 18:57:31.774 INFO request completed, latency_us: 252, response_code: 200, uri: /state/cid/0, method: GET, req_id: ddcbaa41-8b3c-445b-86b9-af9371e26b8f, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 28 18:57:32.178 INFO request completed, latency_us: 224, response_code: 204, uri: /start/cid/0, method: POST, req_id: ffab2f53-4ad2-4b6a-a08a-e91aee2c06cf, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:57:32.179 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/0, method: GET, req_id: 41179831-01f3-4913-91d8-c33595e79007, remote_addr: 127.0.0.1:57719, 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 Jul 28 18:57:36.180 INFO request completed, latency_us: 231, response_code: 200, uri: /state/cid/0, method: GET, req_id: c9b6f23e-90c0-4cd3-afda-290f48fd14e0, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 28 18:57:42.577 [8810] Got stop action so:false kr:false INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 23b8a7f3-fb1a-4fdd-a539-96af84303903, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:57:42.578 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/0, method: GET, req_id: 9e78fca1-6e42-45f6-81a0-a0835e6593d9, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 28 18:57:46.580 INFO request completed, latency_us: 208, response_code: 200, uri: /state/cid/0, method: GET, req_id: d703e5d7-ec7a-4171-a1d0-25b36055ea92, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 28 18:57:46.986 INFO request completed, latency_us: 217, response_code: 204, uri: /start/cid/0, method: POST, req_id: c26ddea3-f7e2-42c3-8a4e-a400275bb93f, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:57:46.986 INFO request completed, latency_us: 52, response_code: 200, uri: /state/cid/0, method: GET, req_id: 2511901f-336e-480e-a983-f7a2fc787ad9, remote_addr: 127.0.0.1:57719, 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 Jul 28 18:57:50.988 INFO request completed, latency_us: 210, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7620c9a7-0610-469b-9be0-1cc64bbfea99, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 28 18:57:56.385[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: 74919b7f-1735-492a-b4e9-6de0f4d1aac6, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:57:56.386 INFO request completed, latency_us: 159, response_code: 200, uri: /state/cid/0, method: GET, req_id: 165a4305-3b7d-42ad-9ba1-9edd80e06c27, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 28 18:58:00.387 INFO request completed, latency_us: 198, response_code: 200, uri: /state/cid/0, method: GET, req_id: d22ea10d-9274-4a5f-9176-877f711c47f1, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 28 18:58:00.802 INFO request completed, latency_us: 233, response_code: 204, uri: /start/cid/0, method: POST, req_id: 3382b189-67b5-4c68-a757-5722e7be2f1a, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:58:00.802 INFO request completed, latency_us: 122, response_code: 200, uri: /state/cid/0, method: GET, req_id: 47f53142-d97b-4d30-9fa9-48a5bb46b352, remote_addr: 127.0.0.1:57719, 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 Jul 28 18:58:04.805 INFO request completed, latency_us: 188, response_code: 200, uri: /state/cid/0, method: GET, req_id: 0c3dcb0a-326d-4aa6-9167-7afe2b507e11, remote_addr: 127.0.0.1:57719, 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 Jul 28 18:58:09.200 INFO request completed, latency_us: 228, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 20ad5030-9b7b-4679-ac67-27d613397bf5, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:58:09.201 INFO request completed, latency_us: 158, response_code: 200, uri: /state/cid/0, method: GET, req_id: 050197dd-379d-4cb6-a465-1f89469ba8da, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 28 18:58:13.202 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/0, method: GET, req_id: 1ddc19a1-9aae-4f3b-9ba4-69769d27692f, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 28 18:58:13.614 INFO request completed, latency_us: 218, response_code: 204, uri: /start/cid/0, method: POST, req_id: 20bccd26-7891-4473-8e0c-8073070fa92a, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:58:13.614 INFO request completed, latency_us: 47, response_code: 200, uri: /state/cid/0, method: GET, req_id: da9284c3-379d-4a74-b1df-29bbbded1770, remote_addr: 127.0.0.1:57719, 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(1234) [8810][0] reports Running Jul 28 18:58:17.616 INFO request completed, latency_us: 187, response_code: 200, uri: /state/cid/0, method: GET, req_id: 403e677f-fcd6-4c7f-8d3c-2f0425563683, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(0) stop 0 Jul 28 18:58:21.011 INFO[8810] Got stop action so:false kr:false request completed, latency_us: 224, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 7c4097f4-287e-4bc4-9af9-e4ea307a278c, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:58:21.011 INFO request completed, latency_us: 135, response_code: 200, uri: /state/cid/0, method: GET, req_id: 24655aa5-fffc-46a5-81b9-f0c77c8f7d0f, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 28 18:58:25.013 INFO request completed, latency_us: 234, response_code: 200, uri: /state/cid/0, method: GET, req_id: d86dc514-2eeb-4f64-bc39-b1b8c0650c7e, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 28 18:58:25.422 INFO request completed, latency_us: 218, response_code: 204, uri: /start/cid/0, method: POST, req_id: c4bdf8db-3d0c-487f-afb3-2605d9598fd0, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:58:25.423 INFO request completed, latency_us: 49, response_code: 200, uri: /state/cid/0, method: GET, req_id: 563758f1-c967-451a-a769-c466600886d7, remote_addr: 127.0.0.1:57719, 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(1235) [8810][0] reports Running Jul 28 18:58:29.425 INFO request completed, latency_us: 189, response_code: 200, uri: /state/cid/0, method: GET, req_id: cf8198df-fdb2-4df1-acf6-4fcdf30f37b7, remote_addr: 127.0.0.1:57719, 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 Jul 28 18:58:31.823 INFO request completed, latency_us: 403, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 3c8cc028-2a35-412f-be98-6d2f5e3f84bc, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:58:31.824 INFO request completed, latency_us: 99, response_code: 200, uri: /state/cid/0, method: GET, req_id: 7b015ce0-d7c2-4394-8ab2-f0eb0ee34758, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 28 18:58:35.826 INFO request completed, latency_us: 207, response_code: 200, uri: /state/cid/0, method: GET, req_id: 724e091f-a626-44b7-829b-3202643d7eb1, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 28 18:58:36.236 INFO request completed, latency_us: 223, response_code: 204, uri: /start/cid/0, method: POST, req_id: c668b3df-95a3-41ad-81a8-87df65d2f1b4, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:58:36.237 INFO request completed, latency_us: 90, response_code: 200, uri: /state/cid/0, method: GET, req_id: 29459f85-47b2-4283-9308-ee230f299321, remote_addr: 127.0.0.1:57719, 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(1236) [8810][0] reports Running Jul 28 18:58:40.238 INFO request completed, latency_us: 182, response_code: 200, uri: /state/cid/0, method: GET, req_id: cbc61e07-4869-40c9-8119-dd8111316ffd, remote_addr: 127.0.0.1:57719, 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 Jul 28 18:59:07.748 INFO request completed, latency_us: 226, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 6818394c-5da8-4160-8ef5-107a860e8196, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:59:07.748 INFO request completed, latency_us: 69, response_code: 200, uri: /state/cid/1, method: GET, req_id: 7ad0d640-6775-4f55-984e-e3c669860834, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jul 28 18:59:11.750 INFO request completed, latency_us: 205, response_code: 200, uri: /state/cid/1, method: GET, req_id: eb5fbf4b-547c-4669-8584-08af868a929c, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jul 28 18:59:12.162 INFO request completed, latency_us: 210, response_code: 204, uri: /start/cid/1, method: POST, req_id: 773ae9c6-0095-4912-aead-99fdf795d833, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:59:12.162 INFO request completed, latency_us: 62, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6cb6ca1a-6dc3-4e91-8db8-7ebd48358ec0, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:59:16.163 INFO request completed, latency_us: 188, response_code: 200, uri: /state/cid/1, method: GET, req_id: 01d9f1cd-d1ec-46fc-b7a0-9f1833b722b6, remote_addr: 127.0.0.1:57719, 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(1237) [8820][1] reports Running Jul 28 18:59:20.165 INFO request completed, latency_us: 184, response_code: 200, uri: /state/cid/1, method: GET, req_id: a32e0c74-4904-4711-8c5c-a8b986d544e1, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(2) stop 2 Jul 28 18:59:47.789[8830] Got stop action so:false kr:false INFO request completed, latency_us: 220, response_code: 204, uri: /stop/cid/2, method: POST, req_id: d4b9d4b0-e0ee-4d46-a95b-8b06182aa4ca, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:59:47.789 INFO request completed, latency_us: 83, response_code: 200, uri: /state/cid/2, method: GET, req_id: 848f1ca8-8fd4-4bdf-a9fb-2cdcb755cb3f, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 28 18:59:51.791 INFO request completed, latency_us: 204, response_code: 200, uri: /state/cid/2, method: GET, req_id: c6461f05-2004-4c09-a2a3-e44f5e830af2, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) start 2 Jul 28 18:59:52.205 INFO request completed, latency_us: 216, response_code: 204, uri: /start/cid/2, method: POST, req_id: 8f18320e-fa75-4b81-829b-721d907b8d3e, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 18:59:52.205 INFO request completed, latency_us: 86, response_code: 200, uri: /state/cid/2, method: GET, req_id: b6b03766-3f15-4f54-aeca-eeb5a9bd88a7, remote_addr: 127.0.0.1:57719, 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(1238) [8830][2] reports Running Jul 28 18:59:56.206 INFO request completed, latency_us: 209, response_code: 200, uri: /state/cid/2, method: GET, req_id: 9a509929-d10e-4386-a042-4965e2f36405, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Stop(3) stop 3 Jul 28 19:00:24.068[8840] Got stop action so:false kr:false INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 8fcbf079-4ea6-4985-8a68-86e4a9947cfd, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 19:00:24.068 INFO request completed, latency_us: 85, response_code: 200, uri: /state/cid/3, method: GET, req_id: f44eacc3-090d-4c52-b9de-4f874b4ba86f, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jul 28 19:00:28.069 INFO request completed, latency_us: 203, response_code: 200, uri: /state/cid/3, method: GET, req_id: 11a7cbe9-7f6a-4994-9534-10e41fba7555, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jul 28 19:00:28.485 INFO request completed, latency_us: 234, response_code: 204, uri: /start/cid/3, method: POST, req_id: 13b1d334-de72-413d-8708-b88d000e2052, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 19:00:28.486 INFO request completed, latency_us: 48, response_code: 200, uri: /state/cid/3, method: GET, req_id: 27c1145c-7309-41a5-91ed-fffa47705c03, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 19:00:32.488 INFO request completed, latency_us: 217, response_code: 200, uri: /state/cid/3, method: GET, req_id: 8515768e-5a26-4a75-9223-edad2b508590, remote_addr: 127.0.0.1:57719, 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(1239) [8840][3] reports Running Jul 28 19:00:36.489 INFO request completed, latency_us: 216, response_code: 200, uri: /state/cid/3, method: GET, req_id: 67f20633-6c76-4814-910a-213591be5a41, remote_addr: 127.0.0.1:57719, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.212 INFO accepted connection, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.212 INFO request completed, latency_us: 142, response_code: 200, uri: /regioninfo, method: GET, req_id: 3f314e7e-c9b7-4262-8a35-b4a8928ac346, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.213 INFO request completed, latency_us: 63, response_code: 200, uri: /regioncount, method: GET, req_id: 7934e067-0e38-4d03-906d-382d106b7a2e, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.213 INFO request completed, latency_us: 59, response_code: 200, uri: /port/cid/0, method: GET, req_id: d1a962f8-26d0-41fd-ac1b-c5797dd1bd6a, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.213 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/1, method: GET, req_id: 9b82b76b-2080-4dd4-b3b7-84e43708492f, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.213 INFO request completed, latency_us: 53, response_code: 200, uri: /port/cid/2, method: GET, req_id: 59a5d9df-a109-4e1e-9639-b75440ab49ec, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.215 INFO request completed, latency_us: 41, response_code: 200, uri: /port/cid/3, method: GET, req_id: d93ed947-9510-4187-8694-870bec50bd9a, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.215 INFO request completed, latency_us: 27, response_code: 200, uri: /port/cid/4, method: GET, req_id: 290459b7-8cf2-43f1-bd6a-05cc0a9c3e23, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.215 INFO request completed, latency_us: 24, response_code: 200, uri: /port/cid/5, method: GET, req_id: d4498434-8977-4d6f-8de1-5f99e375eb68, remote_addr: 127.0.0.1:36136, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.352 INFO accepted connection, remote_addr: 127.0.0.1:37729, local_addr: 127.0.0.1:9998 Jul 28 19:01:04.353 INFO request completed, latency_us: 138, response_code: 200, uri: /regioncount, method: GET, req_id: 1bbef8e9-e396-48a2-9573-e780d77a20cd, remote_addr: 127.0.0.1:37729, 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 Jul 28 19:01:10.109 INFO request completed, latency_us: 225, response_code: 204, uri: /stop/cid/0, method: POST, req_id: 5db97c71-3c2a-4ee8-ac29-27c03e7113d4, remote_addr: 127.0.0.1:37729, local_addr: 127.0.0.1:9998 Jul 28 19:01:10.109 INFO request completed, latency_us: 97, response_code: 200, uri: /state/cid/0, method: GET, req_id: c39d75b5-1e60-4cf6-886a-63e1a1a4898d, remote_addr: 127.0.0.1:37729, local_addr: 127.0.0.1:9998 [8810] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit Jul 28 19:01:14.111 INFO request completed, latency_us: 205, response_code: 200, uri: /state/cid/0, method: GET, req_id: 869aaf29-aa2d-4596-b5e1-badfc7541eb0, remote_addr: 127.0.0.1:37729, local_addr: 127.0.0.1:9998 Jul 28 19:01:51.653 INFO accepted connection, remote_addr: 127.0.0.1:38062, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(0) start 0 Jul 28 19:01:51.653 INFO request completed, latency_us: 179, response_code: 204, uri: /start/cid/0, method: POST, req_id: eaf03b28-6aa9-4cdd-9252-acd31c58b3ce, remote_addr: 127.0.0.1:38062, 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(1241) [8810][0] reports Running Main task has work to do, go find it got dsc Stop(1) stop 1 [8820] Got stop action so:false kr:false Jul 28 19:01:56.056 INFO request completed, latency_us: 254, response_code: 204, uri: /stop/cid/1, method: POST, req_id: 6464fadc-21be-4703-a120-64c83a4231e8, remote_addr: 127.0.0.1:38062, local_addr: 127.0.0.1:9998 Jul 28 19:01:56.056 INFO request completed, latency_us: 98, response_code: 200, uri: /state/cid/1, method: GET, req_id: 6dedddf6-5099-4097-84b6-e641c58a04fb, remote_addr: 127.0.0.1:38062, local_addr: 127.0.0.1:9998 [8820] Exited with: ExitStatus(unix_wait_status(9)) [8820][1] reports Exit Jul 28 19:02:00.058 INFO request completed, latency_us: 213, response_code: 200, uri: /state/cid/1, method: GET, req_id: 8a8cbba4-e152-4b46-ba9b-873b3fd945c2, remote_addr: 127.0.0.1:38062, local_addr: 127.0.0.1:9998 Jul 28 19:02:37.612 INFO accepted connection, remote_addr: 127.0.0.1:41624, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(1) start 1 Jul 28 19:02:37.613 INFO request completed, latency_us: 176, response_code: 204, uri: /start/cid/1, method: POST, req_id: ecca3b28-822e-4a49-9ae9-61cb70a1d90d, remote_addr: 127.0.0.1:41624, 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(1242) [8820][1] reports Running Main task has work to do, go find it got dsc Stop(2) stop 2 Jul 28 19:02:42.020 INFO [8830] Got stop action so:false kr:false request completed, latency_us: 218, response_code: 204, uri: /stop/cid/2, method: POST, req_id: da110496-bcc0-4490-9f18-c9721b62af62, remote_addr: 127.0.0.1:41624, local_addr: 127.0.0.1:9998 Jul 28 19:02:42.021 INFO request completed, latency_us: 53, response_code: 200, uri: /state/cid/2, method: GET, req_id: 796cd97b-45b9-4eac-b1e3-8274c7633a98, remote_addr: 127.0.0.1:41624, local_addr: 127.0.0.1:9998 [8830] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit Jul 28 19:02:46.023 INFO request completed, latency_us: 224, response_code: 200, uri: /state/cid/2, method: GET, req_id: a724f2e8-9116-474d-b5e4-89edc6ac50f0, remote_addr: 127.0.0.1:41624, local_addr: 127.0.0.1:9998 Jul 28 19:03:23.596 INFO accepted connection, remote_addr: 127.0.0.1:54637, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(2) Jul 28 19:03:23.596 INFO start 2 request completed, latency_us: 167, response_code: 204, uri: /start/cid/2, method: POST, req_id: 6d93cbcd-69c6-4813-b82d-e7b67174476f, remote_addr: 127.0.0.1:54637, 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(1243) [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 Jul 28 19:03:28.023 INFO request completed, latency_us: 225, response_code: 204, uri: /stop/cid/3, method: POST, req_id: 0f614beb-89e2-4512-88a9-9000bedea2e0, remote_addr: 127.0.0.1:54637, local_addr: 127.0.0.1:9998 Jul 28 19:03:28.023 INFO request completed, latency_us: 63, response_code: 200, uri: /state/cid/3, method: GET, req_id: 7e206d1f-ddbf-450a-8b53-d64ac4d4381a, remote_addr: 127.0.0.1:54637, local_addr: 127.0.0.1:9998 [8840] Exited with: ExitStatus(unix_wait_status(9)) [8840][3] reports Exit Jul 28 19:03:32.026 INFO request completed, latency_us: 214, response_code: 200, uri: /state/cid/3, method: GET, req_id: aadf1039-0214-4334-a23c-f3541aa50e2a, remote_addr: 127.0.0.1:54637, local_addr: 127.0.0.1:9998 Jul 28 19:04:09.578 INFO accepted connection, remote_addr: 127.0.0.1:40714, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(3) start 3 Jul 28 19:04:09.579 INFO request completed, latency_us: 167, response_code: 204, uri: /start/cid/3, method: POST, req_id: 04e84ff4-b68d-416a-bae7-0e69a1418093, remote_addr: 127.0.0.1:40714, 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(1244) [8840][3] reports Running Main task has work to do, go find it got dsc Stop(4) stop 4 [8850] Got stop action so:false kr:false Jul 28 19:04:14.146 INFO request completed, latency_us: 216, response_code: 204, uri: /stop/cid/4, method: POST, req_id: fa756917-1d60-462d-92d5-b6d65c0940ff, remote_addr: 127.0.0.1:40714, local_addr: 127.0.0.1:9998 Jul 28 19:04:14.146 INFO request completed, latency_us: 75, response_code: 200, uri: /state/cid/4, method: GET, req_id: 8b4d3f6a-28bd-4b0d-8663-c47e211a193d, remote_addr: 127.0.0.1:40714, local_addr: 127.0.0.1:9998 [8850] Exited with: ExitStatus(unix_wait_status(9)) [8850][4] reports Exit Jul 28 19:04:18.149 INFO request completed, latency_us: 211, response_code: 200, uri: /state/cid/4, method: GET, req_id: d58c5a96-7a59-491b-8796-fd71c2321821, remote_addr: 127.0.0.1:40714, local_addr: 127.0.0.1:9998 Jul 28 19:04:55.680 INFO accepted connection, remote_addr: 127.0.0.1:35346, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Start(4) start 4 Jul 28 19:04:55.680 INFO request completed, latency_us: 167, response_code: 204, uri: /start/cid/4, method: POST, req_id: 57a42208-7c0a-42af-bb80-67a31d92ad84, remote_addr: 127.0.0.1:35346, local_addr: 127.0.0.1:9998 Jul 28 19:04:59.724 INFO accepted connection, remote_addr: 127.0.0.1:65263, local_addr: 127.0.0.1:9998 Main task has work to do, go find it got dsc Shutdown Shutdown Jul 28 19:04:59.724 INFO request completed, latency_us: 143, response_code: 204, uri: /shutdown, method: POSTShut it down , req_id: a511b8a6-7798-47c9-8f74-c746837ce644, remote_addr: 127.0.0.1:65263, local_addr: 127.0.[8820] Disable keep_running 0[8820] Got stop action so:false kr:false .[8810] Disable keep_running 1:9998 [8830] Disable keep_running [8830] Got stop action so:false kr:false [8810] Got stop action so:false kr:false [8840] Disable keep_running [8860] Disable keep_running [8840] Got stop action so:false kr:false [8860] Got stop action so:false kr:false [8870] Disable keep_running [8870] Got stop action so:false kr:false [8830] Exited with: ExitStatus(unix_wait_status(9)) [8840] Exited with: ExitStatus(unix_wait_status(9)) [8830][2] reports Exit [8840][3] reports Exit [8810] Exited with: ExitStatus(unix_wait_status(9)) [8820] Exited with: ExitStatus(unix_wait_status(9)) [8810][0] reports Exit [8820][1] reports Exit [8860] Exited with: ExitStatus(unix_wait_status(9)) [8860][5] reports Exit [8870] Exited with: ExitStatus(unix_wait_status(9)) [8870][6] reports Exit