[INFO] crate crisp-status-reporter 1.2.1 is already in cache [INFO] extracting crate crisp-status-reporter 1.2.1 into work/ex/beta-1.38-1/sources/1.37.0/reg/crisp-status-reporter/1.2.1 [INFO] extracting crate crisp-status-reporter 1.2.1 into work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/crisp-status-reporter/1.2.1 [INFO] validating manifest of crisp-status-reporter-1.2.1 on toolchain 1.37.0 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] validating manifest of crisp-status-reporter-1.2.1 on toolchain beta-2019-08-13 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started frobbing crisp-status-reporter-1.2.1 [INFO] finished frobbing crisp-status-reporter-1.2.1 [INFO] frobbed toml for crisp-status-reporter-1.2.1 written to work/ex/beta-1.38-1/sources/1.37.0/reg/crisp-status-reporter/1.2.1/Cargo.toml [INFO] started frobbing crisp-status-reporter-1.2.1 [INFO] finished frobbing crisp-status-reporter-1.2.1 [INFO] frobbed toml for crisp-status-reporter-1.2.1 written to work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/crisp-status-reporter/1.2.1/Cargo.toml [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] testing crisp-status-reporter-1.2.1 against beta-2019-08-13 for beta-1.38-1 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-2/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/crisp-status-reporter/1.2.1:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "build" "--frozen"` [INFO] [stdout] 4e05ce487b194b0accce9a9c645fc5e971f3ecdba45fa61edbfd9ac8ea67f720 [INFO] running `"docker" "start" "-a" "4e05ce487b194b0accce9a9c645fc5e971f3ecdba45fa61edbfd9ac8ea67f720"` [INFO] [stderr] Compiling sys-info v0.5.7 [INFO] [stderr] Compiling hyper v0.11.27 [INFO] [stderr] Compiling hyper-tls v0.1.4 [INFO] [stderr] Compiling reqwest v0.8.8 [INFO] [stderr] Compiling crisp-status-reporter v1.2.1 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 15.59s [INFO] running `"docker" "inspect" "4e05ce487b194b0accce9a9c645fc5e971f3ecdba45fa61edbfd9ac8ea67f720"` [INFO] running `"docker" "rm" "-f" "4e05ce487b194b0accce9a9c645fc5e971f3ecdba45fa61edbfd9ac8ea67f720"` [INFO] [stdout] 4e05ce487b194b0accce9a9c645fc5e971f3ecdba45fa61edbfd9ac8ea67f720 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-2/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/crisp-status-reporter/1.2.1:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "test" "--frozen" "--no-run"` [INFO] [stdout] fd928056c380ad01c586c8e560483953a6b235444a30efbeee70eddeba7d725a [INFO] running `"docker" "start" "-a" "fd928056c380ad01c586c8e560483953a6b235444a30efbeee70eddeba7d725a"` [INFO] [stderr] Compiling crisp-status-reporter v1.2.1 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 5.29s [INFO] running `"docker" "inspect" "fd928056c380ad01c586c8e560483953a6b235444a30efbeee70eddeba7d725a"` [INFO] running `"docker" "rm" "-f" "fd928056c380ad01c586c8e560483953a6b235444a30efbeee70eddeba7d725a"` [INFO] [stdout] fd928056c380ad01c586c8e560483953a6b235444a30efbeee70eddeba7d725a [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-2/beta-2019-08-13:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/crisp-status-reporter/1.2.1:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+beta-2019-08-13" "test" "--frozen"` [INFO] [stdout] 87f3c5fbaf1e73db7cab70bfe2aa71760c68fd596bd6bd11978b8410b4ac3b25 [INFO] running `"docker" "start" "-a" "87f3c5fbaf1e73db7cab70bfe2aa71760c68fd596bd6bd11978b8410b4ac3b25"` [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] Running /opt/crater/target/debug/deps/crisp_status_reporter-234a6134f71e4266 [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Running /opt/crater/target/debug/deps/report-5dcb8e2642a753ae [INFO] [stdout] running 5 tests [INFO] [stderr] DEBUG 2019-08-24T10:40:29Z: crisp_status_reporter: Crisp Status Reporter: Will run using URL: https://report.crisp.watch/v1 [INFO] [stdout] test initialize_valid ... ok [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: tokio_threadpool::builder: build; num-workers=8 [INFO] [stderr] TRACE 2019-08-24T10:40:29Z: mio::poll: registering with poller [INFO] [stderr] DEBUG 2019-08-24T10:40:29Z: tokio_reactor::background: starting background reactor [INFO] [stderr] DEBUG 2019-08-24T10:40:29Z: tokio_core::reactor: consuming notification queue [INFO] [stderr] DEBUG 2019-08-24T10:40:29Z: tokio_core::reactor: loop poll - 75.553µs [INFO] [stderr] DEBUG 2019-08-24T10:40:29Z: tokio_core::reactor: loop time - Instant { tv_sec: 3938508, tv_nsec: 414756853 } [INFO] [stderr] DEBUG 2019-08-24T10:40:29Z: tokio_core::reactor: loop process, 48.761µs [INFO] [stderr] DEBUG 2019-08-24T10:40:29Z: crisp_status_reporter: Crisp Status Reporter: Now running [INFO] [stdout] test initialize_invalid_node_id ... ok [INFO] [stdout] test initialize_invalid_replica_id ... ok [INFO] [stdout] test initialize_invalid_service_id ... ok [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: crisp_status_reporter: Crisp Status Reporter: Will dispatch request [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: crisp_status_reporter: Crisp Status Reporter: Will send request to URL: https://report.crisp.watch/v1/report/d657b4c1-dd07-4f94-ac7a-d4c3b4b219c1/5eca824b-4134-4126-982d-2c2338ecf3ab/ with payload: ReportPayload { replica_id: "192.168.1.10", interval: 30, load: ReportPayloadLoad { cpu: 5.43625, ram: 0.31045508 } } [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop poll - 10.001504734s [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop time - Instant { tv_sec: 3938518, tv_nsec: 416335597 } [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop process, 54.612µs [INFO] [stderr] TRACE 2019-08-24T10:40:39Z: hyper::client::pool: park; waiting for idle connection: "https://report.crisp.watch" [INFO] [stderr] TRACE 2019-08-24T10:40:39Z: hyper::client::connect: Http::connect("https://report.crisp.watch/v1/report/d657b4c1-dd07-4f94-ac7a-d4c3b4b219c1/5eca824b-4134-4126-982d-2c2338ecf3ab/") [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop poll - 231.571µs [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop time - Instant { tv_sec: 3938518, tv_nsec: 416891073 } [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop process, 37.155µs [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: hyper::client::dns: resolving host="report.crisp.watch", port=443 [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop poll - 6.375577ms [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop time - Instant { tv_sec: 3938518, tv_nsec: 423326264 } [INFO] [stderr] DEBUG 2019-08-24T10:40:39Z: tokio_core::reactor: loop process, 75.833µs [INFO] [stderr] ERROR 2019-08-24T10:40:39Z: crisp_status_reporter: Crisp Status Reporter: Failed dispatching request: https://report.crisp.watch/v1/report/d657b4c1-dd07-4f94-ac7a-d4c3b4b219c1/5eca824b-4134-4126-982d-2c2338ecf3ab/: failed to lookup address information: Temporary failure in name resolution [INFO] [stderr] WARN 2019-08-24T10:40:39Z: crisp_status_reporter: Crisp Status Reporter: Last report failed, trying again sooner than usual [INFO] [stdout] test run_and_end_valid ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Doc-tests crisp_status_reporter [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] running `"docker" "inspect" "87f3c5fbaf1e73db7cab70bfe2aa71760c68fd596bd6bd11978b8410b4ac3b25"` [INFO] running `"docker" "rm" "-f" "87f3c5fbaf1e73db7cab70bfe2aa71760c68fd596bd6bd11978b8410b4ac3b25"` [INFO] [stdout] 87f3c5fbaf1e73db7cab70bfe2aa71760c68fd596bd6bd11978b8410b4ac3b25