[INFO] fetching crate irc-proto 1.1.0...
[INFO] testing irc-proto-1.1.0 against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_getrandom_patch_0
[INFO] extracting crate irc-proto 1.1.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate irc-proto 1.1.0
[INFO] finished tweaking crates.io crate irc-proto 1.1.0
[INFO] tweaked toml for crates.io crate irc-proto 1.1.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate irc-proto 1.1.0 on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "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" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 38 packages to latest compatible versions
[INFO] [stderr]       Adding thiserror v1.0.69 (available: v2.0.12)
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "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-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d1a087431eba94aeae6caf6469153b8e5e11488ebe82a1bd438bf157b0fe9a81
[INFO] running `Command { std: "docker" "start" "-a" "d1a087431eba94aeae6caf6469153b8e5e11488ebe82a1bd438bf157b0fe9a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d1a087431eba94aeae6caf6469153b8e5e11488ebe82a1bd438bf157b0fe9a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d1a087431eba94aeae6caf6469153b8e5e11488ebe82a1bd438bf157b0fe9a81", kill_on_drop: false }`
[INFO] [stdout] d1a087431eba94aeae6caf6469153b8e5e11488ebe82a1bd438bf157b0fe9a81
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 984460f954d86939cc4a4cc19e0ff98f762359c028585769cea13a233fbcae3b
[INFO] running `Command { std: "docker" "start" "-a" "984460f954d86939cc4a4cc19e0ff98f762359c028585769cea13a233fbcae3b", kill_on_drop: false }`
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling tokio v1.45.1
[INFO] [stderr]    Compiling syn v2.0.104
[INFO] [stderr]    Compiling tokio-util v0.7.15
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling irc-proto v1.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused variable: `label`
[INFO] [stdout]   --> src/line.rs:23:16
[INFO] [stdout]    |
[INFO] [stdout] 23 |     pub fn new(label: &str) -> error::Result<LineCodec> {
[INFO] [stdout]    |                ^^^^^ help: if this is intentional, prefix it with an underscore: `_label`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 5.29s
[INFO] running `Command { std: "docker" "inspect" "984460f954d86939cc4a4cc19e0ff98f762359c028585769cea13a233fbcae3b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "984460f954d86939cc4a4cc19e0ff98f762359c028585769cea13a233fbcae3b", kill_on_drop: false }`
[INFO] [stdout] 984460f954d86939cc4a4cc19e0ff98f762359c028585769cea13a233fbcae3b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 37040592ae7dcb72878c6668cbb208d7fc8fbc86ee4e73d9fb0f9674e2782192
[INFO] running `Command { std: "docker" "start" "-a" "37040592ae7dcb72878c6668cbb208d7fc8fbc86ee4e73d9fb0f9674e2782192", kill_on_drop: false }`
[INFO] [stderr]    Compiling irc-proto v1.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused variable: `label`
[INFO] [stdout]   --> src/line.rs:23:16
[INFO] [stdout]    |
[INFO] [stdout] 23 |     pub fn new(label: &str) -> error::Result<LineCodec> {
[INFO] [stdout]    |                ^^^^^ help: if this is intentional, prefix it with an underscore: `_label`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `label`
[INFO] [stdout]   --> src/line.rs:23:16
[INFO] [stdout]    |
[INFO] [stdout] 23 |     pub fn new(label: &str) -> error::Result<LineCodec> {
[INFO] [stdout]    |                ^^^^^ help: if this is intentional, prefix it with an underscore: `_label`
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.49s
[INFO] running `Command { std: "docker" "inspect" "37040592ae7dcb72878c6668cbb208d7fc8fbc86ee4e73d9fb0f9674e2782192", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "37040592ae7dcb72878c6668cbb208d7fc8fbc86ee4e73d9fb0f9674e2782192", kill_on_drop: false }`
[INFO] [stdout] 37040592ae7dcb72878c6668cbb208d7fc8fbc86ee4e73d9fb0f9674e2782192
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/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:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] dcef6c8fa1cc694db8673fe73bf0cd31fe44a3d21264860bb02be6ca6b91bd1e
[INFO] running `Command { std: "docker" "start" "-a" "dcef6c8fa1cc694db8673fe73bf0cd31fe44a3d21264860bb02be6ca6b91bd1e", kill_on_drop: false }`
[INFO] [stderr] warning: unused variable: `label`
[INFO] [stderr]   --> src/line.rs:23:16
[INFO] [stderr]    |
[INFO] [stderr] 23 |     pub fn new(label: &str) -> error::Result<LineCodec> {
[INFO] [stderr]    |                ^^^^^ help: if this is intentional, prefix it with an underscore: `_label`
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_variables)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `irc-proto` (lib) generated 1 warning
[INFO] [stderr] warning: `irc-proto` (lib test) generated 1 warning (1 duplicate)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/irc_proto-5fc2d66c49e44f90)
[INFO] [stdout] 
[INFO] [stdout] running 74 tests
[INFO] [stdout] test caps::test::to_str ... ok
[INFO] [stdout] test colors::test::blank3::test_strip ... ok
[INFO] [stdout] test colors::test::blank2::test_formatted ... ok
[INFO] [stdout] test colors::test::blank::test_formatted ... ok
[INFO] [stdout] test colors::test::blank3::test_formatted ... ok
[INFO] [stdout] test colors::test::blank2::test_strip ... ok
[INFO] [stdout] test colors::test::blank::test_strip ... ok
[INFO] [stdout] test colors::test::bold::test_formatted ... ok
[INFO] [stdout] test colors::test::bold::test_strip ... ok
[INFO] [stdout] test colors::test::bold_from_string::test_formatted ... ok
[INFO] [stdout] test colors::test::bold_from_string::test_strip ... ok
[INFO] [stdout] test colors::test::bold_hangul::test_formatted ... ok
[INFO] [stdout] test colors::test::bold_hangul::test_strip ... ok
[INFO] [stdout] test colors::test::fg_bg_11::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_bg_11::test_strip ... ok
[INFO] [stdout] test colors::test::fg_bg_12::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_bg_12::test_strip ... ok
[INFO] [stdout] test colors::test::fg_bg_21::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_bg_21::test_strip ... ok
[INFO] [stdout] test colors::test::fg_bg_22::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_bg_22::test_strip ... ok
[INFO] [stdout] test colors::test::fg_bold::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_bold::test_strip ... ok
[INFO] [stdout] test colors::test::fg_color2::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_color2::test_strip ... ok
[INFO] [stdout] test colors::test::fg_color3::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_color3::test_strip ... ok
[INFO] [stdout] test colors::test::fg_color4::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_color4::test_strip ... ok
[INFO] [stdout] test colors::test::fg_color5::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_color5::test_strip ... ok
[INFO] [stdout] test colors::test::fg_color::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_color::test_strip ... ok
[INFO] [stdout] test colors::test::string_with_digit_after_2digit_color::test_formatted ... ok
[INFO] [stdout] test colors::test::string_with_digit_after_2digit_color::test_strip ... ok
[INFO] [stdout] test colors::test::string_with_digit_after_color::test_formatted ... ok
[INFO] [stdout] test colors::test::string_with_digit_after_color::test_strip ... ok
[INFO] [stdout] test colors::test::string_with_multiple_2digit_colors::test_formatted ... ok
[INFO] [stdout] test colors::test::string_with_multiple_2digit_colors::test_strip ... ok
[INFO] [stdout] test colors::test::string_with_multiple_colors::test_formatted ... ok
[INFO] [stdout] test colors::test::string_with_multiple_colors::test_strip ... ok
[INFO] [stdout] test colors::test::test_strip_no_allocation_for_unformatted_text ... ok
[INFO] [stdout] test colors::test::thinking::test_formatted ... ok
[INFO] [stdout] test colors::test::thinking::test_strip ... ok
[INFO] [stdout] test colors::test::unformatted::test_formatted ... ok
[INFO] [stdout] test colors::test::unformatted::test_strip ... ok
[INFO] [stdout] test command::test::format_response ... ok
[INFO] [stdout] test command::test::parse_user_message ... ok
[INFO] [stdout] test command::test::user_round_trip ... ok
[INFO] [stdout] test message::test::from_and_to_string ... ok
[INFO] [stdout] test message::test::from_string ... ok
[INFO] [stdout] test message::test::from_string_atypical_endings ... ok
[INFO] [stdout] test message::test::new ... ok
[INFO] [stdout] test message::test::source_nickname ... ok
[INFO] [stdout] test message::test::to_message ... ok
[INFO] [stdout] test message::test::to_message_no_prefix_no_args ... ok
[INFO] [stdout] test message::test::to_message_tags_escapes ... ok
[INFO] [stdout] test message::test::to_message_with_colon_in_arg ... ok
[INFO] [stdout] test message::test::to_message_with_colon_in_suffix ... ok
[INFO] [stdout] test message::test::to_string ... ok
[INFO] [stdout] test message::test::to_string_with_colon_in_suffix ... ok
[INFO] [stdout] test message::test::to_string_tags_escapes ... ok
[INFO] [stdout] test mode::test::parse_channel_mode ... ok
[INFO] [stdout] test mode::test::parse_no_mode ... ok
[INFO] [stdout] test mode::test::parse_no_plus ... ok
[INFO] [stdout] test prefix::test::parse_dot_and_symbols ... ok
[INFO] [stdout] test prefix::test::parse_danger_cases ... ok
[INFO] [stdout] test prefix::test::parse_host ... ok
[INFO] [stdout] test prefix::test::parse_nick_user ... ok
[INFO] [stdout] test prefix::test::parse_nick_user_host ... ok
[INFO] [stdout] test prefix::test::parse_word ... ok
[INFO] [stdout] test prefix::test::print ... ok
[INFO] [stdout] test response::test::is_error ... ok
[INFO] [stdout] test message::test::to_message_invalid_format - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 74 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "dcef6c8fa1cc694db8673fe73bf0cd31fe44a3d21264860bb02be6ca6b91bd1e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dcef6c8fa1cc694db8673fe73bf0cd31fe44a3d21264860bb02be6ca6b91bd1e", kill_on_drop: false }`
[INFO] [stdout] dcef6c8fa1cc694db8673fe73bf0cd31fe44a3d21264860bb02be6ca6b91bd1e