[INFO] cloning repository https://github.com/harporoeder/tokio-nsq [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/harporoeder/tokio-nsq" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fharporoeder%2Ftokio-nsq", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fharporoeder%2Ftokio-nsq'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 1613556e61fe4a6b22291ae2f947cc7d5b5bfef5 [INFO] testing harporoeder/tokio-nsq against 1.60.0 for beta-1.61-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fharporoeder%2Ftokio-nsq" "/workspace/builds/worker-21/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-21/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/harporoeder/tokio-nsq on toolchain 1.60.0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/harporoeder/tokio-nsq [INFO] finished tweaking git repo https://github.com/harporoeder/tokio-nsq [INFO] tweaked toml for git repo https://github.com/harporoeder/tokio-nsq written to /workspace/builds/worker-21/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded backoff v0.2.1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 15aedfe55d74f982af81b8a97d08201ecfb0ef9b0b060bde16a4cd5e1cba84be [INFO] running `Command { std: "docker" "start" "-a" "15aedfe55d74f982af81b8a97d08201ecfb0ef9b0b060bde16a4cd5e1cba84be", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "15aedfe55d74f982af81b8a97d08201ecfb0ef9b0b060bde16a4cd5e1cba84be", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "15aedfe55d74f982af81b8a97d08201ecfb0ef9b0b060bde16a4cd5e1cba84be", kill_on_drop: false }` [INFO] [stdout] 15aedfe55d74f982af81b8a97d08201ecfb0ef9b0b060bde16a4cd5e1cba84be [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 20102ab760a47acdaf9042527db5c7e3a43bb42c1350763fa39bfb7262a6ede4 [INFO] running `Command { std: "docker" "start" "-a" "20102ab760a47acdaf9042527db5c7e3a43bb42c1350763fa39bfb7262a6ede4", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.37 [INFO] [stderr] Compiling libc v0.2.123 [INFO] [stderr] Compiling syn v1.0.91 [INFO] [stderr] Compiling log v0.4.16 [INFO] [stderr] Compiling serde_derive v1.0.136 [INFO] [stderr] Compiling pin-project-lite v0.2.8 [INFO] [stderr] Compiling once_cell v1.10.0 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling futures-core v0.3.21 [INFO] [stderr] Compiling parking_lot_core v0.9.2 [INFO] [stderr] Compiling cc v1.0.73 [INFO] [stderr] Compiling smallvec v1.8.0 [INFO] [stderr] Compiling bytes v1.1.0 [INFO] [stderr] Compiling matches v0.1.9 [INFO] [stderr] Compiling futures-task v0.3.21 [INFO] [stderr] Compiling futures-channel v0.3.21 [INFO] [stderr] Compiling unicode-bidi v0.3.7 [INFO] [stderr] Compiling futures-sink v0.3.21 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling untrusted v0.7.1 [INFO] [stderr] Compiling futures-util v0.3.21 [INFO] [stderr] Compiling itoa v1.0.1 [INFO] [stderr] Compiling slab v0.4.6 [INFO] [stderr] Compiling crc32fast v1.3.2 [INFO] [stderr] Compiling futures-io v0.3.21 [INFO] [stderr] Compiling httparse v1.7.0 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling anyhow v1.0.56 [INFO] [stderr] Compiling snap v1.0.5 [INFO] [stderr] Compiling httpdate v1.0.2 [INFO] [stderr] Compiling ryu v1.0.9 [INFO] [stderr] Compiling tower-service v0.3.1 [INFO] [stderr] Compiling lock_api v0.4.7 [INFO] [stderr] Compiling tinyvec v1.5.1 [INFO] [stderr] Compiling tracing-core v0.1.26 [INFO] [stderr] Compiling miniz_oxide v0.5.1 [INFO] [stderr] Compiling regex v1.5.5 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling http v0.2.6 [INFO] [stderr] Compiling tracing v0.1.34 [INFO] [stderr] Compiling want v0.3.0 [INFO] [stderr] Compiling quote v1.0.18 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling mio v0.8.2 [INFO] [stderr] Compiling socket2 v0.4.4 [INFO] [stderr] Compiling num_cpus v1.13.1 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling flate2 v1.0.23 [INFO] [stderr] Compiling gethostname v0.2.3 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling parking_lot v0.12.0 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling http-body v0.4.4 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling backoff v0.2.1 [INFO] [stderr] Compiling webpki v0.21.4 [INFO] [stderr] Compiling sct v0.6.1 [INFO] [stderr] Compiling rustls v0.19.1 [INFO] [stderr] Compiling tokio-macros v1.7.0 [INFO] [stderr] Compiling futures-macro v0.3.21 [INFO] [stderr] Compiling thiserror-impl v1.0.30 [INFO] [stderr] Compiling tokio v1.17.0 [INFO] [stderr] Compiling thiserror v1.0.30 [INFO] [stderr] Compiling futures-executor v0.3.21 [INFO] [stderr] Compiling futures v0.3.21 [INFO] [stderr] Compiling async-compression v0.3.12 [INFO] [stderr] Compiling hyper v0.14.18 [INFO] [stderr] Compiling tokio-rustls v0.22.0 [INFO] [stderr] Compiling tokio-io-timeout v1.2.0 [INFO] [stderr] Compiling toml v0.5.9 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling cargo-lock v4.0.1 [INFO] [stderr] Compiling built v0.4.4 [INFO] [stderr] Compiling tokio-nsq v0.13.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 16.92s [INFO] running `Command { std: "docker" "inspect" "20102ab760a47acdaf9042527db5c7e3a43bb42c1350763fa39bfb7262a6ede4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "20102ab760a47acdaf9042527db5c7e3a43bb42c1350763fa39bfb7262a6ede4", kill_on_drop: false }` [INFO] [stdout] 20102ab760a47acdaf9042527db5c7e3a43bb42c1350763fa39bfb7262a6ede4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] eb1d723e0e61042e374ed8e39f5c2c9c44d4b7261446af7e4daae455a0fdf4f8 [INFO] running `Command { std: "docker" "start" "-a" "eb1d723e0e61042e374ed8e39f5c2c9c44d4b7261446af7e4daae455a0fdf4f8", kill_on_drop: false }` [INFO] [stderr] Compiling termcolor v1.1.3 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling env_logger v0.7.1 [INFO] [stderr] Compiling tokio-nsq v0.13.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 5.44s [INFO] running `Command { std: "docker" "inspect" "eb1d723e0e61042e374ed8e39f5c2c9c44d4b7261446af7e4daae455a0fdf4f8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "eb1d723e0e61042e374ed8e39f5c2c9c44d4b7261446af7e4daae455a0fdf4f8", kill_on_drop: false }` [INFO] [stdout] eb1d723e0e61042e374ed8e39f5c2c9c44d4b7261446af7e4daae455a0fdf4f8 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-21/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=warn" "-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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 925dc41ce8b9e28196134007208dad7cb3a475c99ef5b647618411eb2197e8b7 [INFO] running `Command { std: "docker" "start" "-a" "925dc41ce8b9e28196134007208dad7cb3a475c99ef5b647618411eb2197e8b7", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 56.69s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/tokio_nsq-01e177ef7d78ad97) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test snappy::test::test_snappy_identity_small ... ok [INFO] [stdout] test snappy::test::test_snappy_identity_large ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s [INFO] [stdout] [INFO] [stderr] Running tests/test_live.rs (/opt/rustwide/target/debug/deps/test_live-24ec78a6d604b60a) [INFO] [stdout] [INFO] [stdout] running 10 tests [INFO] [stdout] test direct_connection_auth has been running for over 60 seconds [INFO] [stdout] test direct_connection_basic has been running for over 60 seconds [INFO] [stdout] test direct_connection_deflate has been running for over 60 seconds [INFO] [stdout] test direct_connection_encryption has been running for over 60 seconds [INFO] [stdout] test direct_connection_encryption_and_deflate has been running for over 60 seconds [INFO] [stdout] test direct_connection_encryption_and_snappy has been running for over 60 seconds [INFO] [stdout] test direct_connection_inflight_10 has been running for over 60 seconds [INFO] [stdout] test direct_connection_snappy has been running for over 60 seconds [INFO] [stdout] test direct_connection_snappy_large has been running for over 60 seconds [INFO] [stdout] test lookup_consume_basic has been running for over 60 seconds [ERROR] error running command: no output for 300 seconds [INFO] running `Command { std: "docker" "inspect" "925dc41ce8b9e28196134007208dad7cb3a475c99ef5b647618411eb2197e8b7", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "925dc41ce8b9e28196134007208dad7cb3a475c99ef5b647618411eb2197e8b7", kill_on_drop: false }` [INFO] [stdout] 925dc41ce8b9e28196134007208dad7cb3a475c99ef5b647618411eb2197e8b7