[INFO] fetching crate vigil-reporter 1.2.0... [INFO] testing vigil-reporter-1.2.0 against try#ddc023471205c186b40f4bf8ffb598008dbf4885 for pr-87041-1 [INFO] extracting crate vigil-reporter 1.2.0 into /workspace/builds/worker-60/source [INFO] validating manifest of crates.io crate vigil-reporter 1.2.0 on toolchain ddc023471205c186b40f4bf8ffb598008dbf4885 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "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-60/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "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" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "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-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] de0cddb0119e783a8f3d9930550301d31cae0596e6409c387b21608ae86ddfd4 [INFO] running `Command { std: "docker" "start" "-a" "de0cddb0119e783a8f3d9930550301d31cae0596e6409c387b21608ae86ddfd4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "de0cddb0119e783a8f3d9930550301d31cae0596e6409c387b21608ae86ddfd4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "de0cddb0119e783a8f3d9930550301d31cae0596e6409c387b21608ae86ddfd4", kill_on_drop: false }` [INFO] [stdout] de0cddb0119e783a8f3d9930550301d31cae0596e6409c387b21608ae86ddfd4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9343e870b8f00a6da9f43605aee2b7faf035070b3659c520b06068bf41d5223b [INFO] running `Command { std: "docker" "start" "-a" "9343e870b8f00a6da9f43605aee2b7faf035070b3659c520b06068bf41d5223b", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling libc v0.2.112 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling cc v1.0.72 [INFO] [stderr] Compiling proc-macro2 v1.0.34 [INFO] [stderr] Compiling futures-core v0.3.17 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling pkg-config v0.3.24 [INFO] [stderr] Compiling syn v1.0.82 [INFO] [stderr] Compiling slab v0.4.5 [INFO] [stderr] Compiling bytes v0.5.6 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling pin-project-lite v0.1.12 [INFO] [stderr] Compiling futures-task v0.3.17 [INFO] [stderr] Compiling itoa v0.4.8 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling foreign-types-shared v0.1.1 [INFO] [stderr] Compiling openssl v0.10.38 [INFO] [stderr] Compiling serde v1.0.131 [INFO] [stderr] Compiling once_cell v1.9.0 [INFO] [stderr] Compiling crc32fast v1.3.0 [INFO] [stderr] Compiling matches v0.1.9 [INFO] [stderr] Compiling futures-io v0.3.17 [INFO] [stderr] Compiling httparse v1.5.1 [INFO] [stderr] Compiling hashbrown v0.11.2 [INFO] [stderr] Compiling futures-channel v0.3.17 [INFO] [stderr] Compiling futures-sink v0.3.17 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling native-tls v0.2.8 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling try-lock v0.2.3 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling openssl-probe v0.1.4 [INFO] [stderr] Compiling percent-encoding v2.1.0 [INFO] [stderr] Compiling httpdate v0.3.2 [INFO] [stderr] Compiling encoding_rs v0.8.30 [INFO] [stderr] Compiling serde_json v1.0.73 [INFO] [stderr] Compiling ryu v1.0.9 [INFO] [stderr] Compiling unicode-bidi v0.3.7 [INFO] [stderr] Compiling tower-service v0.3.1 [INFO] [stderr] Compiling itoa v1.0.1 [INFO] [stderr] Compiling mime v0.3.16 [INFO] [stderr] Compiling serde_derive v1.0.131 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling ipnet v2.3.1 [INFO] [stderr] Compiling tracing-core v0.1.21 [INFO] [stderr] Compiling foreign-types v0.3.2 [INFO] [stderr] Compiling tinyvec v1.5.1 [INFO] [stderr] Compiling indexmap v1.7.0 [INFO] [stderr] Compiling futures-util v0.3.17 [INFO] [stderr] Compiling miniz_oxide v0.4.4 [INFO] [stderr] Compiling unicase v2.6.0 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling openssl-src v111.17.0+1.1.1m [INFO] [stderr] Compiling http v0.2.5 [INFO] [stderr] Compiling tracing v0.1.29 [INFO] [stderr] Compiling want v0.3.0 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling net2 v0.2.37 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling socket2 v0.3.19 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling mime_guess v2.0.3 [INFO] [stderr] Compiling sys-info v0.7.0 [INFO] [stderr] Compiling mio v0.6.23 [INFO] [stderr] Compiling flate2 v1.0.22 [INFO] [stderr] Compiling http-body v0.3.1 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling serde_urlencoded v0.7.0 [INFO] [stderr] Compiling openssl-sys v0.9.72 [INFO] [stderr] Compiling async-compression v0.3.8 [INFO] [stderr] Compiling tokio v0.2.25 [INFO] [stderr] Compiling url v2.2.2 [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 49.53s [INFO] running `Command { std: "docker" "inspect" "9343e870b8f00a6da9f43605aee2b7faf035070b3659c520b06068bf41d5223b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9343e870b8f00a6da9f43605aee2b7faf035070b3659c520b06068bf41d5223b", kill_on_drop: false }` [INFO] [stdout] 9343e870b8f00a6da9f43605aee2b7faf035070b3659c520b06068bf41d5223b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 14ae30c4ffe18bf3b644f66974b433170e1abe59ef6113865d1b8c9e3d348575 [INFO] running `Command { std: "docker" "start" "-a" "14ae30c4ffe18bf3b644f66974b433170e1abe59ef6113865d1b8c9e3d348575", kill_on_drop: false }` [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling quick-error v1.2.3 [INFO] [stderr] Compiling termcolor v1.1.2 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling humantime v1.3.0 [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 15.53s [INFO] running `Command { std: "docker" "inspect" "14ae30c4ffe18bf3b644f66974b433170e1abe59ef6113865d1b8c9e3d348575", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "14ae30c4ffe18bf3b644f66974b433170e1abe59ef6113865d1b8c9e3d348575", kill_on_drop: false }` [INFO] [stdout] 14ae30c4ffe18bf3b644f66974b433170e1abe59ef6113865d1b8c9e3d348575 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-60/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:a429bb59b7a3b4e7270a4b4c243bb115fc561d8f62ec34ef63a0a36cabf65dfd" "/opt/rustwide/cargo-home/bin/cargo" "+ddc023471205c186b40f4bf8ffb598008dbf4885" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] cd822ed827cf042549214aa859daf318094f9cfac742248816b58a18de99431f [INFO] running `Command { std: "docker" "start" "-a" "cd822ed827cf042549214aa859daf318094f9cfac742248816b58a18de99431f", 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] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.36s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/vigil_reporter-062385b97d953305) [INFO] [stdout] [INFO] [stderr] Running tests/report.rs (/opt/rustwide/target/debug/deps/report-fe9ae9d6eb13d2f4) [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] [stderr] DEBUG 2021-12-16T15:48:54Z: vigil_reporter: Vigil Reporter: Will run using URL: http://status.example.com.local [INFO] [stdout] [INFO] [stderr] TRACE 2021-12-16T15:48:54Z: reqwest::blocking::wait: (ThreadId(6)) park without timeout [INFO] [stdout] running 5 tests [INFO] [stderr] TRACE 2021-12-16T15:48:54Z: mio::poll: registering with poller [INFO] [stdout] test initialize_valid ... ok [INFO] [stderr] TRACE 2021-12-16T15:48:54Z: reqwest::blocking::client: (ThreadId(7)) start runtime::block_on [INFO] [stderr] DEBUG 2021-12-16T15:48:54Z: vigil_reporter: Vigil Reporter: Now running [INFO] [stdout] test initialize_invalid_probe_id - should panic ... ok [INFO] [stdout] test initialize_invalid_replica_id - should panic ... ok [INFO] [stdout] test initialize_invalid_node_id - should panic ... ok [INFO] [stderr] DEBUG 2021-12-16T15:49:04Z: vigil_reporter: Vigil Reporter: Will dispatch request [INFO] [stderr] DEBUG 2021-12-16T15:49:04Z: 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.3740625, ram: 0.13672179 } } [INFO] [stderr] TRACE 2021-12-16T15:49:04Z: reqwest::blocking::wait: wait at most 10s [INFO] [stderr] TRACE 2021-12-16T15:49:04Z: reqwest::blocking::wait: (ThreadId(8)) park timeout 9.99996138s [INFO] [stderr] TRACE 2021-12-16T15:49:04Z: hyper::client::pool: checkout waiting for idle connection: ("http", status.example.com.local) [INFO] [stderr] DEBUG 2021-12-16T15:49:04Z: reqwest::connect: starting new connection: http://status.example.com.local/ [INFO] [stderr] TRACE 2021-12-16T15:49:04Z: hyper::client::connect::http: Http::connect; scheme=Some("http"), host=Some("status.example.com.local"), port=None [INFO] [stderr] DEBUG 2021-12-16T15:49:04Z: hyper::client::connect::dns: resolving host="status.example.com.local" [INFO] [stderr] TRACE 2021-12-16T15:49:04Z: hyper::client::pool: checkout dropped for ("http", status.example.com.local) [INFO] [stderr] ERROR 2021-12-16T15:49:04Z: 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-12-16T15:49:04Z: vigil_reporter: Vigil 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; finished in 15.02s [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; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "cd822ed827cf042549214aa859daf318094f9cfac742248816b58a18de99431f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "cd822ed827cf042549214aa859daf318094f9cfac742248816b58a18de99431f", kill_on_drop: false }` [INFO] [stdout] cd822ed827cf042549214aa859daf318094f9cfac742248816b58a18de99431f