[INFO] fetching crate asciicker-rs 0.0.4...
[INFO] testing asciicker-rs-0.0.4 against 1.60.0 for beta-1.61-1
[INFO] extracting crate asciicker-rs 0.0.4 into /workspace/builds/worker-55/source
[INFO] validating manifest of crates.io crate asciicker-rs 0.0.4 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 crates.io crate asciicker-rs 0.0.4
[INFO] finished tweaking crates.io crate asciicker-rs 0.0.4
[INFO] tweaked toml for crates.io crate asciicker-rs 0.0.4 written to /workspace/builds/worker-55/source/Cargo.toml
[INFO] crate crates.io crate asciicker-rs 0.0.4 already has a lockfile, it will not be regenerated
[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]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded macro_rules_attribute v0.0.2
[INFO] [stderr]   Downloaded crossbeam-queue v0.3.4
[INFO] [stderr]   Downloaded macro_rules_attribute-proc_macro v0.0.2
[INFO] [stderr]   Downloaded tokio v1.16.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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] 7517d4f2fcfabcf022de6c22a7720fc0a0fe396061b25c2cb8331a3a3640aa96
[INFO] running `Command { std: "docker" "start" "-a" "7517d4f2fcfabcf022de6c22a7720fc0a0fe396061b25c2cb8331a3a3640aa96", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7517d4f2fcfabcf022de6c22a7720fc0a0fe396061b25c2cb8331a3a3640aa96", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7517d4f2fcfabcf022de6c22a7720fc0a0fe396061b25c2cb8331a3a3640aa96", kill_on_drop: false }`
[INFO] [stdout] 7517d4f2fcfabcf022de6c22a7720fc0a0fe396061b25c2cb8331a3a3640aa96
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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] 0b8f56d90517ac8d3e4444bb1f6a9a229f90f840d7638778b8a2adf90e644dae
[INFO] running `Command { std: "docker" "start" "-a" "0b8f56d90517ac8d3e4444bb1f6a9a229f90f840d7638778b8a2adf90e644dae", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.36
[INFO] [stderr]    Compiling libc v0.2.117
[INFO] [stderr]    Compiling syn v1.0.86
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling typenum v1.15.0
[INFO] [stderr]    Compiling crossbeam-utils v0.8.7
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling futures-task v0.3.21
[INFO] [stderr]    Compiling ppv-lite86 v0.2.16
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.7
[INFO] [stderr]    Compiling httparse v1.6.0
[INFO] [stderr]    Compiling unicode-bidi v0.3.7
[INFO] [stderr]    Compiling futures-core v0.3.21
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling futures-util v0.3.21
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling cpufeatures v0.2.1
[INFO] [stderr]    Compiling pin-project-lite v0.2.8
[INFO] [stderr]    Compiling crossbeam-queue v0.3.4
[INFO] [stderr]    Compiling futures-sink v0.3.21
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling utf-8 v0.7.6
[INFO] [stderr]    Compiling slab v0.4.5
[INFO] [stderr]    Compiling macro_rules_attribute-proc_macro v0.0.2
[INFO] [stderr]    Compiling tinyvec v1.5.1
[INFO] [stderr]    Compiling memoffset v0.6.5
[INFO] [stderr]    Compiling form_urlencoded v1.0.1
[INFO] [stderr]    Compiling generic-array v0.14.5
[INFO] [stderr]    Compiling macro_rules_attribute v0.0.2
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling crossbeam-channel v0.5.2
[INFO] [stderr]    Compiling http v0.2.6
[INFO] [stderr]    Compiling quote v1.0.15
[INFO] [stderr]    Compiling crossbeam-deque v0.8.1
[INFO] [stderr]    Compiling getrandom v0.2.4
[INFO] [stderr]    Compiling mio v0.7.14
[INFO] [stderr]    Compiling num_cpus v1.13.1
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling crossbeam v0.8.1
[INFO] [stderr]    Compiling idna v0.2.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling sha-1 v0.9.8
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling url v2.2.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.30
[INFO] [stderr]    Compiling futures-macro v0.3.21
[INFO] [stderr]    Compiling tokio-macros v1.7.0
[INFO] [stderr]    Compiling concat-idents v1.1.3
[INFO] [stderr]    Compiling tokio v1.16.1
[INFO] [stderr]    Compiling thiserror v1.0.30
[INFO] [stderr]    Compiling tungstenite v0.16.0
[INFO] [stderr]    Compiling tokio-tungstenite v0.16.1
[INFO] [stderr]    Compiling asciicker-rs v0.0.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.17s
[INFO] running `Command { std: "docker" "inspect" "0b8f56d90517ac8d3e4444bb1f6a9a229f90f840d7638778b8a2adf90e644dae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0b8f56d90517ac8d3e4444bb1f6a9a229f90f840d7638778b8a2adf90e644dae", kill_on_drop: false }`
[INFO] [stdout] 0b8f56d90517ac8d3e4444bb1f6a9a229f90f840d7638778b8a2adf90e644dae
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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] 40dbee994fa56f7b52e3e935171f0612c48f308438afe7870b2117389fe1563b
[INFO] running `Command { std: "docker" "start" "-a" "40dbee994fa56f7b52e3e935171f0612c48f308438afe7870b2117389fe1563b", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling asciicker-rs v0.0.4 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused `Result` that must be used
[INFO] [stdout]   --> examples/y6_echo_bot.rs:25:5
[INFO] [stdout]    |
[INFO] [stdout] 25 |     sender.send(talk_brc.str.into_string().unwrap());
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_must_use)]` on by default
[INFO] [stdout]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 8.67s
[INFO] running `Command { std: "docker" "inspect" "40dbee994fa56f7b52e3e935171f0612c48f308438afe7870b2117389fe1563b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "40dbee994fa56f7b52e3e935171f0612c48f308438afe7870b2117389fe1563b", kill_on_drop: false }`
[INFO] [stdout] 40dbee994fa56f7b52e3e935171f0612c48f308438afe7870b2117389fe1563b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-55/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] dbed7afc6d4de73d9381a69d49315d1605440b1672d4391275b0023ac6e80a03
[INFO] running `Command { std: "docker" "start" "-a" "dbed7afc6d4de73d9381a69d49315d1605440b1672d4391275b0023ac6e80a03", kill_on_drop: false }`
[INFO] [stderr] warning: unused `Result` that must be used
[INFO] [stderr]   --> examples/y6_echo_bot.rs:25:5
[INFO] [stderr]    |
[INFO] [stderr] 25 |     sender.send(talk_brc.str.into_string().unwrap());
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_must_use)]` on by default
[INFO] [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
[INFO] [stderr] 
[INFO] [stderr] warning: `asciicker-rs` (example "y6_echo_bot") generated 1 warning
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.21s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/asciicker_rs-12f6f9dd91f5ced3)
[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] [stderr]    Doc-tests asciicker-rs
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/y6/mod.rs - y6::bot (line 13) ... FAILED
[INFO] [stdout] test src/y6/bot.rs - y6::bot::Bot (line 318) has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "dbed7afc6d4de73d9381a69d49315d1605440b1672d4391275b0023ac6e80a03", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dbed7afc6d4de73d9381a69d49315d1605440b1672d4391275b0023ac6e80a03", kill_on_drop: false }`
[INFO] [stdout] dbed7afc6d4de73d9381a69d49315d1605440b1672d4391275b0023ac6e80a03