[INFO] cloning repository https://github.com/Niki4tap/asciicker-rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Niki4tap/asciicker-rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FNiki4tap%2Fasciicker-rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FNiki4tap%2Fasciicker-rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] f49df192597ced84bccd51f8c57d890d375aa755
[INFO] testing Niki4tap/asciicker-rs against beta-2022-04-10 for beta-1.61-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FNiki4tap%2Fasciicker-rs" "/workspace/builds/worker-16/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-16/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Niki4tap/asciicker-rs on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Niki4tap/asciicker-rs
[INFO] finished tweaking git repo https://github.com/Niki4tap/asciicker-rs
[INFO] tweaked toml for git repo https://github.com/Niki4tap/asciicker-rs written to /workspace/builds/worker-16/source/Cargo.toml
[INFO] crate git repo https://github.com/Niki4tap/asciicker-rs already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ee144e183af62d8ddfab61561526eadf456b110fec782e23eacd951b78a3f9d7
[INFO] running `Command { std: "docker" "start" "-a" "ee144e183af62d8ddfab61561526eadf456b110fec782e23eacd951b78a3f9d7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ee144e183af62d8ddfab61561526eadf456b110fec782e23eacd951b78a3f9d7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ee144e183af62d8ddfab61561526eadf456b110fec782e23eacd951b78a3f9d7", kill_on_drop: false }`
[INFO] [stdout] ee144e183af62d8ddfab61561526eadf456b110fec782e23eacd951b78a3f9d7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 22ce0b43b81a8fe6ca3b99f9733fce6b23296816cca488cb7b628d6c9e5521c0
[INFO] running `Command { std: "docker" "start" "-a" "22ce0b43b81a8fe6ca3b99f9733fce6b23296816cca488cb7b628d6c9e5521c0", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.36
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling syn v1.0.86
[INFO] [stderr]    Compiling libc v0.2.117
[INFO] [stderr]    Compiling typenum v1.15.0
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling crossbeam-utils v0.8.7
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling tinyvec_macros v0.1.0
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling unicode-bidi v0.3.7
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.16
[INFO] [stderr]    Compiling futures-core v0.3.21
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.7
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling httparse v1.6.0
[INFO] [stderr]    Compiling futures-task v0.3.21
[INFO] [stderr]    Compiling percent-encoding v2.1.0
[INFO] [stderr]    Compiling itoa v1.0.1
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling futures-util v0.3.21
[INFO] [stderr]    Compiling cpufeatures v0.2.1
[INFO] [stderr]    Compiling crossbeam-queue v0.3.4
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling pin-project-lite v0.2.8
[INFO] [stderr]    Compiling utf-8 v0.7.6
[INFO] [stderr]    Compiling futures-sink v0.3.21
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling slab v0.4.5
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling macro_rules_attribute-proc_macro v0.0.2
[INFO] [stderr]    Compiling tinyvec v1.5.1
[INFO] [stderr]    Compiling form_urlencoded v1.0.1
[INFO] [stderr]    Compiling http v0.2.6
[INFO] [stderr]    Compiling generic-array v0.14.5
[INFO] [stderr]    Compiling memoffset v0.6.5
[INFO] [stderr]    Compiling macro_rules_attribute v0.0.2
[INFO] [stderr]    Compiling crossbeam-channel v0.5.2
[INFO] [stderr]    Compiling quote v1.0.15
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[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-deque v0.8.1
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling idna v0.2.3
[INFO] [stderr]    Compiling sha-1 v0.9.8
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling crossbeam v0.8.1
[INFO] [stderr]    Compiling url v2.2.2
[INFO] [stderr]    Compiling rand v0.8.5
[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 2m 08s
[INFO] running `Command { std: "docker" "inspect" "22ce0b43b81a8fe6ca3b99f9733fce6b23296816cca488cb7b628d6c9e5521c0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "22ce0b43b81a8fe6ca3b99f9733fce6b23296816cca488cb7b628d6c9e5521c0", kill_on_drop: false }`
[INFO] [stdout] 22ce0b43b81a8fe6ca3b99f9733fce6b23296816cca488cb7b628d6c9e5521c0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 50e588e0a904e4424b4046883554cb4a5a088664716fdd74fe9a006aa5cc0cfe
[INFO] running `Command { std: "docker" "start" "-a" "50e588e0a904e4424b4046883554cb4a5a088664716fdd74fe9a006aa5cc0cfe", 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 52.77s
[INFO] [stderr]   Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/asciicker_rs-d94c8b2a8059b3cb)
[INFO] running `Command { std: "docker" "inspect" "50e588e0a904e4424b4046883554cb4a5a088664716fdd74fe9a006aa5cc0cfe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "50e588e0a904e4424b4046883554cb4a5a088664716fdd74fe9a006aa5cc0cfe", kill_on_drop: false }`
[INFO] [stdout] 50e588e0a904e4424b4046883554cb4a5a088664716fdd74fe9a006aa5cc0cfe
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3b7559e073f49ae50afb501d9b499faeff9cebeb676f7895b10c8a6f654ddc7c
[INFO] running `Command { std: "docker" "start" "-a" "3b7559e073f49ae50afb501d9b499faeff9cebeb676f7895b10c8a6f654ddc7c", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[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 9.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/asciicker_rs-d94c8b2a8059b3cb)
[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" "3b7559e073f49ae50afb501d9b499faeff9cebeb676f7895b10c8a6f654ddc7c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3b7559e073f49ae50afb501d9b499faeff9cebeb676f7895b10c8a6f654ddc7c", kill_on_drop: false }`
[INFO] [stdout] 3b7559e073f49ae50afb501d9b499faeff9cebeb676f7895b10c8a6f654ddc7c