[INFO] fetching crate vigil-reporter 1.2.0... [INFO] testing vigil-reporter-1.2.0 against master#b70888601af92f6cdc0364abab3446e418b91d36 for pr-86479 [INFO] extracting crate vigil-reporter 1.2.0 into /workspace/builds/worker-10/source [INFO] validating manifest of crates.io crate vigil-reporter 1.2.0 on toolchain b70888601af92f6cdc0364abab3446e418b91d36 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate vigil-reporter 1.2.0 [INFO] finished tweaking crates.io crate vigil-reporter 1.2.0 [INFO] tweaked toml for crates.io crate vigil-reporter 1.2.0 written to /workspace/builds/worker-10/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] c410efd1ff8c1d008131a79cc80f03ea308075a198ba81e6f9ad466cb1a8c737 [INFO] running `Command { std: "docker" "start" "-a" "c410efd1ff8c1d008131a79cc80f03ea308075a198ba81e6f9ad466cb1a8c737", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "c410efd1ff8c1d008131a79cc80f03ea308075a198ba81e6f9ad466cb1a8c737", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c410efd1ff8c1d008131a79cc80f03ea308075a198ba81e6f9ad466cb1a8c737", kill_on_drop: false }` [INFO] [stdout] c410efd1ff8c1d008131a79cc80f03ea308075a198ba81e6f9ad466cb1a8c737 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 68711f957aebfebd2391a17f1e84b0b658e1806e17f0d38117e8ef90e933a476 [INFO] running `Command { std: "docker" "start" "-a" "68711f957aebfebd2391a17f1e84b0b658e1806e17f0d38117e8ef90e933a476", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling cc v1.0.69 [INFO] [stderr] Compiling proc-macro2 v1.0.28 [INFO] [stderr] Compiling futures-core v0.3.16 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling memchr v2.4.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling syn v1.0.74 [INFO] [stderr] Compiling pkg-config v0.3.19 [INFO] [stderr] Compiling bytes v0.5.6 [INFO] [stderr] Compiling slab v0.4.3 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling itoa v0.4.7 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling futures-task v0.3.16 [INFO] [stderr] Compiling bitflags v1.2.1 [INFO] [stderr] Compiling pin-project-lite v0.1.12 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling bytes v1.0.1 [INFO] [stderr] Compiling matches v0.1.8 [INFO] [stderr] Compiling openssl v0.10.35 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling serde v1.0.127 [INFO] [stderr] Compiling futures-io v0.3.16 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling httparse v1.4.1 [INFO] [stderr] Compiling once_cell v1.8.0 [INFO] [stderr] Compiling native-tls v0.2.7 [INFO] [stderr] Compiling crc32fast v1.2.1 [INFO] [stderr] Compiling futures-sink v0.3.16 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling openssl-probe v0.1.4 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling try-lock v0.2.3 [INFO] [stderr] Compiling httpdate v0.3.2 [INFO] [stderr] Compiling encoding_rs v0.8.28 [INFO] [stderr] Compiling serde_json v1.0.66 [INFO] [stderr] Compiling tower-service v0.3.1 [INFO] [stderr] Compiling serde_derive v1.0.127 [INFO] [stderr] Compiling mime v0.3.16 [INFO] [stderr] Compiling ipnet v2.3.1 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling unicase v2.6.0 [INFO] [stderr] Compiling unicode-bidi v0.3.5 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling tinyvec v1.3.1 [INFO] [stderr] Compiling tracing-core v0.1.18 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling net2 v0.2.37 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling socket2 v0.3.19 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling http v0.2.4 [INFO] [stderr] Compiling want v0.3.0 [INFO] [stderr] Compiling openssl-src v111.15.0+1.1.1k [INFO] [stderr] Compiling tracing v0.1.26 [INFO] [stderr] Compiling mio v0.6.23 [INFO] [stderr] Compiling futures-channel v0.3.16 [INFO] [stderr] Compiling mime_guess v2.0.3 [INFO] [stderr] Compiling futures-util v0.3.16 [INFO] [stderr] Compiling indexmap v1.7.0 [INFO] [stderr] Compiling miniz_oxide v0.4.4 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling openssl-sys v0.9.65 [INFO] [stderr] Compiling sys-info v0.7.0 [INFO] [stderr] Compiling tokio v0.2.25 [INFO] [stderr] Compiling http-body v0.3.1 [INFO] [stderr] Compiling flate2 v1.0.20 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling async-compression v0.3.8 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling serde_urlencoded v0.7.0 [INFO] [stderr] Compiling tokio-util v0.3.1 [INFO] [stderr] Compiling pin-project-internal v1.0.8 [INFO] [stderr] Compiling pin-project v1.0.8 [INFO] [stderr] Compiling tracing-futures v0.2.5 [INFO] [stderr] Compiling h2 v0.2.7 [INFO] [stderr] Compiling hyper v0.13.10 [INFO] [stderr] Compiling tokio-tls v0.3.1 [INFO] [stderr] Compiling hyper-tls v0.4.3 [INFO] [stderr] Compiling reqwest v0.10.10 [INFO] [stderr] Compiling vigil-reporter v1.2.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 59.53s [INFO] running `Command { std: "docker" "inspect" "68711f957aebfebd2391a17f1e84b0b658e1806e17f0d38117e8ef90e933a476", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "68711f957aebfebd2391a17f1e84b0b658e1806e17f0d38117e8ef90e933a476", kill_on_drop: false }` [INFO] [stdout] 68711f957aebfebd2391a17f1e84b0b658e1806e17f0d38117e8ef90e933a476 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 581e83cee862aa75b234c706084346dd18ec057c1aae315742178dfc11609155 [INFO] running `Command { std: "docker" "start" "-a" "581e83cee862aa75b234c706084346dd18ec057c1aae315742178dfc11609155", kill_on_drop: false }` [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling env_logger v0.5.13 [INFO] [stderr] Compiling vigil-reporter v1.2.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 11.89s [INFO] running `Command { std: "docker" "inspect" "581e83cee862aa75b234c706084346dd18ec057c1aae315742178dfc11609155", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "581e83cee862aa75b234c706084346dd18ec057c1aae315742178dfc11609155", kill_on_drop: false }` [INFO] [stdout] 581e83cee862aa75b234c706084346dd18ec057c1aae315742178dfc11609155 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+b70888601af92f6cdc0364abab3446e418b91d36" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 6a927c6a73f831bc2bef4d21b8fca8516ac6bdeadaaced6337d62cd7053c0316 [INFO] running `Command { std: "docker" "start" "-a" "6a927c6a73f831bc2bef4d21b8fca8516ac6bdeadaaced6337d62cd7053c0316", kill_on_drop: false }` [INFO] [stdout] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.10s [INFO] [stdout] running 0 tests [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/vigil_reporter-e017f1fe21fc771e) [INFO] [stdout] [INFO] [stderr] Running tests/report.rs (/opt/rustwide/target/debug/deps/report-ad151a80c4df6081) [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stderr] DEBUG 2021-08-04T03:42:25Z: vigil_reporter: Vigil Reporter: Will run using URL: http://status.example.com.local [INFO] [stdout] test initialize_valid ... ok [INFO] [stderr] TRACE 2021-08-04T03:42:25Z: reqwest::blocking::wait: (ThreadId(6)) park without timeout [INFO] [stderr] TRACE 2021-08-04T03:42:25Z: mio::poll: registering with poller [INFO] [stderr] TRACE 2021-08-04T03:42:25Z: reqwest::blocking::client: (ThreadId(7)) start runtime::block_on [INFO] [stderr] DEBUG 2021-08-04T03:42:25Z: vigil_reporter: Vigil Reporter: Now running [INFO] [stdout] test initialize_invalid_node_id - should panic ... ok [INFO] [stdout] test initialize_invalid_replica_id - should panic ... ok [INFO] [stdout] test initialize_invalid_probe_id - should panic ... ok [INFO] [stderr] DEBUG 2021-08-04T03:42:35Z: vigil_reporter: Vigil Reporter: Will dispatch request [INFO] [stderr] DEBUG 2021-08-04T03:42:35Z: 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: 3.4990625, ram: 0.076651216 } } [INFO] [stderr] TRACE 2021-08-04T03:42:35Z: reqwest::blocking::wait: wait at most 10s [INFO] [stderr] TRACE 2021-08-04T03:42:35Z: reqwest::blocking::wait: (ThreadId(8)) park timeout 9.999973439s [INFO] [stderr] TRACE 2021-08-04T03:42:35Z: hyper::client::pool: checkout waiting for idle connection: ("http", status.example.com.local) [INFO] [stderr] DEBUG 2021-08-04T03:42:35Z: reqwest::connect: starting new connection: http://status.example.com.local/ [INFO] [stderr] TRACE 2021-08-04T03:42:35Z: hyper::client::connect::http: Http::connect; scheme=Some("http"), host=Some("status.example.com.local"), port=None [INFO] [stderr] DEBUG 2021-08-04T03:42:35Z: hyper::client::connect::dns: resolving host="status.example.com.local" [INFO] [stderr] TRACE 2021-08-04T03:42:35Z: hyper::client::pool: checkout dropped for ("http", status.example.com.local) [INFO] [stderr] ERROR 2021-08-04T03:42:35Z: vigil_reporter: Vigil Reporter: Failed dispatching request: error sending request for url (http://status.example.com.local/reporter/relay/socket-client/): error trying to connect: dns error: failed to lookup address information: Temporary failure in name resolution [INFO] [stderr] WARN 2021-08-04T03:42:35Z: vigil_reporter: Vigil Reporter: Last report failed, trying again sooner than usual [INFO] [stdout] test run_and_end_valid ... ok [INFO] [stderr] Doc-tests vigil_reporter [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 15.02s [INFO] [stdout] [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; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "6a927c6a73f831bc2bef4d21b8fca8516ac6bdeadaaced6337d62cd7053c0316", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6a927c6a73f831bc2bef4d21b8fca8516ac6bdeadaaced6337d62cd7053c0316", kill_on_drop: false }` [INFO] [stdout] 6a927c6a73f831bc2bef4d21b8fca8516ac6bdeadaaced6337d62cd7053c0316