[INFO] fetching crate irc-proto 0.15.0...
[INFO] testing irc-proto-0.15.0 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate irc-proto 0.15.0 into /workspace/builds/worker-34/source
[INFO] validating manifest of crates.io crate irc-proto 0.15.0 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate irc-proto 0.15.0
[INFO] finished tweaking crates.io crate irc-proto 0.15.0
[INFO] tweaked toml for crates.io crate irc-proto 0.15.0 written to /workspace/builds/worker-34/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2510d0133d09f15e9e8e95f9155add20c39034635574316d98710f78150d8a79
[INFO] running `Command { std: "docker" "start" "-a" "2510d0133d09f15e9e8e95f9155add20c39034635574316d98710f78150d8a79", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2510d0133d09f15e9e8e95f9155add20c39034635574316d98710f78150d8a79", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2510d0133d09f15e9e8e95f9155add20c39034635574316d98710f78150d8a79", kill_on_drop: false }`
[INFO] [stdout] 2510d0133d09f15e9e8e95f9155add20c39034635574316d98710f78150d8a79
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2715c2384c1875f70e7c24317b5675c9f8da95cc76ab3248b73b97c7200645f2
[INFO] running `Command { std: "docker" "start" "-a" "2715c2384c1875f70e7c24317b5675c9f8da95cc76ab3248b73b97c7200645f2", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.32
[INFO] [stderr]    Compiling encoding_index_tests v0.1.4
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling syn v1.0.81
[INFO] [stderr]    Compiling futures-core v0.3.17
[INFO] [stderr]    Compiling pin-project-lite v0.2.7
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling futures-sink v0.3.17
[INFO] [stderr]    Compiling tokio v1.14.0
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling encoding-index-tradchinese v1.20141219.5
[INFO] [stderr]    Compiling encoding-index-singlebyte v1.20141219.5
[INFO] [stderr]    Compiling encoding-index-japanese v1.20141219.5
[INFO] [stderr]    Compiling encoding-index-simpchinese v1.20141219.5
[INFO] [stderr]    Compiling encoding-index-korean v1.20141219.5
[INFO] [stderr]    Compiling encoding v0.2.33
[INFO] [stderr]    Compiling quote v1.0.10
[INFO] [stderr]    Compiling tokio-util v0.6.9
[INFO] [stderr]    Compiling thiserror-impl v1.0.30
[INFO] [stderr]    Compiling thiserror v1.0.30
[INFO] [stderr]    Compiling irc-proto v0.15.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.71s
[INFO] running `Command { std: "docker" "inspect" "2715c2384c1875f70e7c24317b5675c9f8da95cc76ab3248b73b97c7200645f2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2715c2384c1875f70e7c24317b5675c9f8da95cc76ab3248b73b97c7200645f2", kill_on_drop: false }`
[INFO] [stdout] 2715c2384c1875f70e7c24317b5675c9f8da95cc76ab3248b73b97c7200645f2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5e4c68abd07abcb6b02ee4a6fc3ec292c1fee21bb8faf79ef5df37e68ac7827e
[INFO] running `Command { std: "docker" "start" "-a" "5e4c68abd07abcb6b02ee4a6fc3ec292c1fee21bb8faf79ef5df37e68ac7827e", kill_on_drop: false }`
[INFO] [stderr]    Compiling irc-proto v0.15.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.88s
[INFO] running `Command { std: "docker" "inspect" "5e4c68abd07abcb6b02ee4a6fc3ec292c1fee21bb8faf79ef5df37e68ac7827e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5e4c68abd07abcb6b02ee4a6fc3ec292c1fee21bb8faf79ef5df37e68ac7827e", kill_on_drop: false }`
[INFO] [stdout] 5e4c68abd07abcb6b02ee4a6fc3ec292c1fee21bb8faf79ef5df37e68ac7827e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-34/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 30aac7cb61172f9398abb363e1e66425191f75ee8c665228888877b322f3805a
[INFO] running `Command { std: "docker" "start" "-a" "30aac7cb61172f9398abb363e1e66425191f75ee8c665228888877b322f3805a", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/irc_proto-795e136aeac28ec0)
[INFO] [stdout] 
[INFO] [stdout] running 63 tests
[INFO] [stdout] test caps::test::to_str ... ok
[INFO] [stdout] test colors::test::blank2::test_formatted ... ok
[INFO] [stdout] test colors::test::blank2::test_strip ... ok
[INFO] [stdout] test colors::test::blank3::test_formatted ... ok
[INFO] [stdout] test colors::test::blank3::test_strip ... ok
[INFO] [stdout] test colors::test::blank::test_formatted ... 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_color2::test_formatted ... ok
[INFO] [stdout] test colors::test::fg_color2::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_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_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::thinking::test_formatted ... ok
[INFO] [stdout] test colors::test::test_strip_no_allocation_for_unformatted_text ... 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 message::test::from_and_to_string ... ok
[INFO] [stdout] test message::test::from_string_atypical_endings ... ok
[INFO] [stdout] test message::test::from_string ... ok
[INFO] [stdout] test message::test::new ... ok
[INFO] [stdout] test message::test::to_message ... ok
[INFO] [stdout] test message::test::source_nickname ... ok
[INFO] [stdout] test message::test::to_message_no_prefix_no_args ... ok
[INFO] [stdout] test command::test::user_round_trip ... ok
[INFO] [stdout] test message::test::to_message_tags_escapes ... ok
[INFO] [stdout] test message::test::to_string ... ok
[INFO] [stdout] test message::test::to_message_with_colon_in_arg ... ok
[INFO] [stdout] test mode::test::parse_channel_mode ... ok
[INFO] [stdout] test mode::test::parse_no_mode ... ok
[INFO] [stdout] test message::test::to_string_tags_escapes ... ok
[INFO] [stdout] test prefix::test::parse_danger_cases ... ok
[INFO] [stdout] test prefix::test::parse_dot_and_symbols ... 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. 63 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.16s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests irc-proto
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/prefix.rs - prefix::Prefix::new_from_str (line 20) ... ok
[INFO] [stdout] test src/message.rs - message::Message::source_nickname (line 70) ... ok
[INFO] [stdout] test src/message.rs - message::Message::new (line 34) ... ok
[INFO] [stdout] test src/message.rs - message::Message::to_string (line 119) ... ok
[INFO] [stdout] test src/message.rs - message::Message::response_target (line 94) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.54s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "30aac7cb61172f9398abb363e1e66425191f75ee8c665228888877b322f3805a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "30aac7cb61172f9398abb363e1e66425191f75ee8c665228888877b322f3805a", kill_on_drop: false }`
[INFO] [stdout] 30aac7cb61172f9398abb363e1e66425191f75ee8c665228888877b322f3805a