[INFO] fetching crate traq-ws-bot 0.1.2... [INFO] testing traq-ws-bot-0.1.2 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2 [INFO] extracting crate traq-ws-bot 0.1.2 into /workspace/builds/worker-1-tc2/source [INFO] started tweaking crates.io crate traq-ws-bot 0.1.2 [INFO] finished tweaking crates.io crate traq-ws-bot 0.1.2 [INFO] tweaked toml for crates.io crate traq-ws-bot 0.1.2 written to /workspace/builds/worker-1-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate traq-ws-bot 0.1.2 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 194 packages to latest compatible versions [INFO] [stderr] Adding generic-array v0.14.7 (available: v0.14.9) [INFO] [stderr] Adding http v0.2.12 (available: v1.4.0) [INFO] [stderr] Adding reqwest v0.11.27 (available: v0.13.2) [INFO] [stderr] Adding tokio-tungstenite v0.17.2 (available: v0.29.0) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] f89fbdc5f2e8ed4cb632438f52728e8045f19bee04c8a65a59569a8259c40348 [INFO] running `Command { std: "docker" "start" "-a" "f89fbdc5f2e8ed4cb632438f52728e8045f19bee04c8a65a59569a8259c40348", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "f89fbdc5f2e8ed4cb632438f52728e8045f19bee04c8a65a59569a8259c40348", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f89fbdc5f2e8ed4cb632438f52728e8045f19bee04c8a65a59569a8259c40348", kill_on_drop: false }` [INFO] [stdout] f89fbdc5f2e8ed4cb632438f52728e8045f19bee04c8a65a59569a8259c40348 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] b4dd4940d9d0042ee043df164dd81712ee2f8aba7ce069fd0e18a3df5732a362 [INFO] running `Command { std: "docker" "start" "-a" "b4dd4940d9d0042ee043df164dd81712ee2f8aba7ce069fd0e18a3df5732a362", kill_on_drop: false }` [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling sct v0.7.1 [INFO] [stderr] Compiling futures-util v0.3.32 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling rustls v0.21.12 [INFO] [stderr] Compiling untrusted v0.7.1 [INFO] [stderr] Compiling rustls v0.20.9 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling webpki v0.22.4 [INFO] [stderr] Compiling rustls-webpki v0.101.7 [INFO] [stderr] Compiling url v2.5.8 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling sha-1 v0.10.1 [INFO] [stderr] Compiling utf-8 v0.7.6 [INFO] [stderr] Compiling base64 v0.13.1 [INFO] [stderr] Compiling tokio v1.52.1 [INFO] [stderr] Compiling rustls-native-certs v0.6.3 [INFO] [stderr] Compiling webpki-roots v0.25.4 [INFO] [stderr] Compiling iana-time-zone v0.1.65 [INFO] [stderr] Compiling chrono v0.4.44 [INFO] [stderr] Compiling futures-executor v0.3.32 [INFO] [stderr] Compiling futures v0.3.32 [INFO] [stderr] Compiling tungstenite v0.17.3 [INFO] [stderr] Compiling tokio-util v0.7.18 [INFO] [stderr] Compiling tokio-rustls v0.24.1 [INFO] [stderr] Compiling tokio-rustls v0.23.4 [INFO] [stderr] Compiling tokio-tungstenite v0.17.2 [INFO] [stderr] Compiling h2 v0.3.27 [INFO] [stderr] Compiling hyper v0.14.32 [INFO] [stderr] Compiling hyper-rustls v0.24.2 [INFO] [stderr] Compiling reqwest v0.11.27 [INFO] [stderr] Compiling traq-ws-bot v0.1.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 39.98s [INFO] running `Command { std: "docker" "inspect" "b4dd4940d9d0042ee043df164dd81712ee2f8aba7ce069fd0e18a3df5732a362", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b4dd4940d9d0042ee043df164dd81712ee2f8aba7ce069fd0e18a3df5732a362", kill_on_drop: false }` [INFO] [stdout] b4dd4940d9d0042ee043df164dd81712ee2f8aba7ce069fd0e18a3df5732a362 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 3bbbee8943d4d9e80976c11e6602d25dcf456c0bd73abc1a4bd3033705a2fd85 [INFO] running `Command { std: "docker" "start" "-a" "3bbbee8943d4d9e80976c11e6602d25dcf456c0bd73abc1a4bd3033705a2fd85", kill_on_drop: false }` [INFO] [stderr] Compiling traq-ws-bot v0.1.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.65s [INFO] running `Command { std: "docker" "inspect" "3bbbee8943d4d9e80976c11e6602d25dcf456c0bd73abc1a4bd3033705a2fd85", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3bbbee8943d4d9e80976c11e6602d25dcf456c0bd73abc1a4bd3033705a2fd85", kill_on_drop: false }` [INFO] [stdout] 3bbbee8943d4d9e80976c11e6602d25dcf456c0bd73abc1a4bd3033705a2fd85 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8a1e2c18245f9b5873bebc34be83b8fa6bdfacdc3d3daafd691a57773dc2f7f6 [INFO] running `Command { std: "docker" "start" "-a" "8a1e2c18245f9b5873bebc34be83b8fa6bdfacdc3d3daafd691a57773dc2f7f6", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.28s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/traq_ws_bot-bf40cac358be2090) [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 traq_ws_bot [INFO] [stdout] [INFO] [stdout] running 42 tests [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_channel_topic_changed (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::build (line 350) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_channel_created_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_channel_created (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_bot_message_stamps_updated (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::insert_resource (line 525) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_bot_message_stamps_updated_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_direct_message_created (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_direct_message_deleted (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_direct_message_deleted_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_channel_topic_changed_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_direct_message_updated (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_direct_message_created_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_direct_message_updated_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_joined_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_event (line 423) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_left (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_error_with_resource (line 503) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_joined (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_event (line 435) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_error (line 483) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_message_created (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_message_created_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_message_updated (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_message_deleted (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_left_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_message_deleted_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_message_updated_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_ping (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_ping_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_tag_added (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_stamp_created_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_tag_added_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_stamp_created (line 464) ... ok [INFO] [stdout] test src/utils.rs - utils::RateLimiter::acquire (line 73) ... FAILED [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_tag_removed (line 464) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_user_created (line 464) ... ok [INFO] [stdout] test src/utils.rs - utils::RateLimiter (line 45) ... FAILED [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_user_created_with_resource (line 465) ... ok [INFO] [stdout] test src/utils.rs - utils::RateLimiter::try_acquire (line 97) ... FAILED [INFO] [stdout] test src/bot/mod.rs - bot::TraqBotBuilder::on_tag_removed_with_resource (line 465) ... ok [INFO] [stdout] test src/bot/mod.rs - bot::TraqBot::start (line 117) has been running for over 60 seconds [ERROR] error running command: no output for 300 seconds [INFO] running `Command { std: "docker" "inspect" "8a1e2c18245f9b5873bebc34be83b8fa6bdfacdc3d3daafd691a57773dc2f7f6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8a1e2c18245f9b5873bebc34be83b8fa6bdfacdc3d3daafd691a57773dc2f7f6", kill_on_drop: false }` [INFO] [stdout] 8a1e2c18245f9b5873bebc34be83b8fa6bdfacdc3d3daafd691a57773dc2f7f6