[INFO] fetching crate vigil-reporter 1.1.1... [INFO] extracting crate vigil-reporter 1.1.1 into work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/vigil-reporter/1.1.1 [INFO] extracting crate vigil-reporter 1.1.1 into work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/vigil-reporter/1.1.1 [INFO] validating manifest of vigil-reporter-1.1.1 on toolchain master#c8865d8e195813ade6b84434ac9f8850e7112d1a [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] validating manifest of vigil-reporter-1.1.1 on toolchain try#e212b7d492c96d3837691ba29d32d5f468933fb8 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started frobbing vigil-reporter-1.1.1 [INFO] finished frobbing vigil-reporter-1.1.1 [INFO] frobbed toml for vigil-reporter-1.1.1 written to work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/vigil-reporter/1.1.1/Cargo.toml [INFO] started frobbing vigil-reporter-1.1.1 [INFO] finished frobbing vigil-reporter-1.1.1 [INFO] frobbed toml for vigil-reporter-1.1.1 written to work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/vigil-reporter/1.1.1/Cargo.toml [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] testing vigil-reporter-1.1.1 against master#c8865d8e195813ade6b84434ac9f8850e7112d1a for pr-61629 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-1/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/vigil-reporter/1.1.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=forbid" "-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" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "build" "--frozen"` [INFO] [stdout] 98d28851367da602de06c505a619da92cf646e9fa63dcada96d4bcdd7d9317d5 [INFO] running `"docker" "start" "-a" "98d28851367da602de06c505a619da92cf646e9fa63dcada96d4bcdd7d9317d5"` [INFO] [stderr] Compiling sys-info v0.5.7 [INFO] [stderr] Compiling uuid v0.6.5 [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 vigil-reporter v1.1.1 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 22.98s [INFO] running `"docker" "inspect" "98d28851367da602de06c505a619da92cf646e9fa63dcada96d4bcdd7d9317d5"` [INFO] running `"docker" "rm" "-f" "98d28851367da602de06c505a619da92cf646e9fa63dcada96d4bcdd7d9317d5"` [INFO] [stdout] 98d28851367da602de06c505a619da92cf646e9fa63dcada96d4bcdd7d9317d5 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-1/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/vigil-reporter/1.1.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=forbid" "-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" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen" "--no-run"` [INFO] [stdout] a39999d3f1e7cf1298504001771ec81cdbd567a680f978cbd4efaa877f18fc93 [INFO] running `"docker" "start" "-a" "a39999d3f1e7cf1298504001771ec81cdbd567a680f978cbd4efaa877f18fc93"` [INFO] [stderr] Compiling vigil-reporter v1.1.1 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 5.69s [INFO] running `"docker" "inspect" "a39999d3f1e7cf1298504001771ec81cdbd567a680f978cbd4efaa877f18fc93"` [INFO] running `"docker" "rm" "-f" "a39999d3f1e7cf1298504001771ec81cdbd567a680f978cbd4efaa877f18fc93"` [INFO] [stdout] a39999d3f1e7cf1298504001771ec81cdbd567a680f978cbd4efaa877f18fc93 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-1/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/vigil-reporter/1.1.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=forbid" "-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" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen"` [INFO] [stdout] 35f0ab3b4d5b15c69e82eaeeec69b6e6e72f664827cccfe69baaa73db23f3fc8 [INFO] running `"docker" "start" "-a" "35f0ab3b4d5b15c69e82eaeeec69b6e6e72f664827cccfe69baaa73db23f3fc8"` [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.07s [INFO] [stderr] Running /opt/crater/target/debug/deps/vigil_reporter-f925cdd1d4bf7924 [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] [stderr] Running /opt/crater/target/debug/deps/report-320f403578dd10cb [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test initialize_valid ... ok [INFO] [stderr] DEBUG 2019-06-11T06:25:53Z: vigil_reporter: Vigil Reporter: Will run using URL: http://status.example.com.local [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: tokio_threadpool::builder: build; num-workers=8 [INFO] [stderr] TRACE 2019-06-11T06:25:53Z: mio::poll: registering with poller [INFO] [stderr] DEBUG 2019-06-11T06:25:53Z: tokio_reactor::background: starting background reactor [INFO] [stderr] DEBUG 2019-06-11T06:25:53Z: tokio_core::reactor: consuming notification queue [INFO] [stderr] DEBUG 2019-06-11T06:25:53Z: tokio_core::reactor: loop poll - 61.373µs [INFO] [stderr] DEBUG 2019-06-11T06:25:53Z: tokio_core::reactor: loop time - Instant { tv_sec: 509481, tv_nsec: 612370786 } [INFO] [stderr] DEBUG 2019-06-11T06:25:53Z: tokio_core::reactor: loop process, 37.196µs [INFO] [stderr] DEBUG 2019-06-11T06:25:53Z: vigil_reporter: Vigil Reporter: Now running [INFO] [stdout] test initialize_invalid_replica_id ... ok [INFO] [stdout] test initialize_invalid_probe_id ... ok [INFO] [stdout] test initialize_invalid_node_id ... ok [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: vigil_reporter: Vigil Reporter: Will dispatch request [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: vigil_reporter: Vigil Reporter: Will send request to URL: http://status.example.com.local/reporter/relay/socket-client/ with payload: ReportPayload { replica: "192.168.1.10", interval: 30, load: ReportPayloadLoad { cpu: 2.805, ram: 0.19277656 } } [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: tokio_core::reactor: loop poll - 10.001690431s [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: tokio_core::reactor: loop time - Instant { tv_sec: 509491, tv_nsec: 614116416 } [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: tokio_core::reactor: loop process, 68.579µs [INFO] [stderr] TRACE 2019-06-11T06:26:03Z: hyper::client::pool: park; waiting for idle connection: "http://status.example.com.local" [INFO] [stderr] TRACE 2019-06-11T06:26:03Z: hyper::client::connect: Http::connect("http://status.example.com.local/reporter/relay/socket-client/") [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: hyper::client::dns: resolving host="status.example.com.local", port=80 [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: tokio_core::reactor: loop poll - 1.160122ms [INFO] [stderr] ERROR 2019-06-11T06:26:03Z: vigil_reporter: Vigil Reporter: Failed dispatching request: http://status.example.com.local/reporter/relay/socket-client/: failed to lookup address information: Temporary failure in name resolution [INFO] [stderr] WARN 2019-06-11T06:26:03Z: vigil_reporter: Vigil Reporter: Last report failed, trying again sooner than usual [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: tokio_core::reactor: loop time - Instant { tv_sec: 509491, tv_nsec: 615687870 } [INFO] [stderr] DEBUG 2019-06-11T06:26:03Z: tokio_core::reactor: loop process, 118.054µs [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 vigil_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" "35f0ab3b4d5b15c69e82eaeeec69b6e6e72f664827cccfe69baaa73db23f3fc8"` [INFO] running `"docker" "rm" "-f" "35f0ab3b4d5b15c69e82eaeeec69b6e6e72f664827cccfe69baaa73db23f3fc8"` [INFO] [stdout] 35f0ab3b4d5b15c69e82eaeeec69b6e6e72f664827cccfe69baaa73db23f3fc8