[INFO] fetching crate grep-printer 0.3.1...
[INFO] testing grep-printer-0.3.1 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-1
[INFO] extracting crate grep-printer 0.3.1 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate grep-printer 0.3.1
[INFO] finished tweaking crates.io crate grep-printer 0.3.1
[INFO] tweaked toml for crates.io crate grep-printer 0.3.1 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate grep-printer 0.3.1 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] crate crates.io crate grep-printer 0.3.1 already has a lockfile, it will not be regenerated
[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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 398352e73d0ae732b1a02f3a859a52ee8405d08016e5bc46c26cfc8d481bd03f
[INFO] running `Command { std: "docker" "start" "-a" "398352e73d0ae732b1a02f3a859a52ee8405d08016e5bc46c26cfc8d481bd03f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "398352e73d0ae732b1a02f3a859a52ee8405d08016e5bc46c26cfc8d481bd03f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "398352e73d0ae732b1a02f3a859a52ee8405d08016e5bc46c26cfc8d481bd03f", kill_on_drop: false }`
[INFO] [stdout] 398352e73d0ae732b1a02f3a859a52ee8405d08016e5bc46c26cfc8d481bd03f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] dbe5292f9297f4cba60d6351b3b6f43f5e4be062ed885160bf3a6e74fdd5ad84
[INFO] running `Command { std: "docker" "start" "-a" "dbe5292f9297f4cba60d6351b3b6f43f5e4be062ed885160bf3a6e74fdd5ad84", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling grep-matcher v0.1.8
[INFO] [stderr]    Compiling encoding_rs_io v0.1.7
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling memmap2 v0.9.9
[INFO] [stderr]    Compiling grep-searcher v0.1.16
[INFO] [stderr]    Compiling grep-printer v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.02s
[INFO] running `Command { std: "docker" "inspect" "dbe5292f9297f4cba60d6351b3b6f43f5e4be062ed885160bf3a6e74fdd5ad84", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dbe5292f9297f4cba60d6351b3b6f43f5e4be062ed885160bf3a6e74fdd5ad84", kill_on_drop: false }`
[INFO] [stdout] dbe5292f9297f4cba60d6351b3b6f43f5e4be062ed885160bf3a6e74fdd5ad84
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 0350b0bbe4f183f4e43a065d2e40b16c39f96104460829cfe6c9c9a6525a59ba
[INFO] running `Command { std: "docker" "start" "-a" "0350b0bbe4f183f4e43a065d2e40b16c39f96104460829cfe6c9c9a6525a59ba", kill_on_drop: false }`
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling grep-searcher v0.1.16
[INFO] [stderr]    Compiling grep-regex v0.1.14
[INFO] [stderr]    Compiling grep-printer v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 11.13s
[INFO] running `Command { std: "docker" "inspect" "0350b0bbe4f183f4e43a065d2e40b16c39f96104460829cfe6c9c9a6525a59ba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0350b0bbe4f183f4e43a065d2e40b16c39f96104460829cfe6c9c9a6525a59ba", kill_on_drop: false }`
[INFO] [stdout] 0350b0bbe4f183f4e43a065d2e40b16c39f96104460829cfe6c9c9a6525a59ba
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 693c90ec1ab293bebeafc28b8a619341a1c2e9397fb5e873a2340f2415176a7d
[INFO] running `Command { std: "docker" "start" "-a" "693c90ec1ab293bebeafc28b8a619341a1c2e9397fb5e873a2340f2415176a7d", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/grep_printer-8e4b38b7c65d98f4)
[INFO] [stdout] 
[INFO] [stdout] running 109 tests
[INFO] [stdout] test hyperlink::tests::parse_valid ... ok
[INFO] [stdout] test json::tests::always_begin_end_no_match ... ok
[INFO] [stdout] test json::tests::max_matches ... ok
[INFO] [stdout] test hyperlink::tests::alias_names_are_reasonable ... ok
[INFO] [stdout] test hyperlink::tests::build_empty_format ... ok
[INFO] [stdout] test hyperlink::tests::build_format ... ok
[INFO] [stdout] test hyperlink::tests::parse_invalid ... ok
[INFO] [stdout] test hyperlink::tests::parse_format ... ok
[INFO] [stdout] test json::tests::binary_detection ... ok
[INFO] [stdout] test json::tests::max_matches_after_context ... ok
[INFO] [stdout] test hyperlink::tests::aliases_are_valid_formats ... ok
[INFO] [stdout] test hyperlink::tests::aliases_are_sorted ... ok
[INFO] [stdout] test hyperlink::tests::handle_alias ... ok
[INFO] [stdout] test jsont::tests::base64_basic ... ok
[INFO] [stdout] test standard::tests::byte_offset ... ok
[INFO] [stdout] test standard::tests::context_break ... ok
[INFO] [stdout] test standard::tests::column_number ... ok
[INFO] [stdout] test standard::tests::context_break_multiple_heading ... ok
[INFO] [stdout] test standard::tests::invert_context ... ok
[INFO] [stdout] test standard::tests::invert ... ok
[INFO] [stdout] test standard::tests::context_break_multiple_no_heading ... ok
[INFO] [stdout] test standard::tests::column_number_multi_line ... ok
[INFO] [stdout] test standard::tests::heading_multiple ... ok
[INFO] [stdout] test json::tests::no_match ... ok
[INFO] [stdout] test standard::tests::invert_context_only_matching ... ok
[INFO] [stdout] test standard::tests::invert_multi_line ... ok
[INFO] [stdout] test json::tests::missing_crlf ... ok
[INFO] [stdout] test standard::tests::invert_context_only_matching_multi_line ... ok
[INFO] [stdout] test standard::tests::heading ... ok
[INFO] [stdout] test standard::tests::invert_context_multi_line ... ok
[INFO] [stdout] test standard::tests::byte_offset_multi_line ... ok
[INFO] [stdout] test standard::tests::max_columns ... ok
[INFO] [stdout] test standard::tests::max_matches_context ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_one_match ... ok
[INFO] [stdout] test standard::tests::line_number ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_no_match ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count ... ok
[INFO] [stdout] test standard::tests::max_columns_preview ... ok
[INFO] [stdout] test standard::tests::max_matches_context_invert ... ok
[INFO] [stdout] test standard::tests::max_matches ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line1 ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line3 ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_two_matches ... ok
[INFO] [stdout] test standard::tests::line_number_multi_line ... ok
[INFO] [stdout] test standard::tests::no_heading ... ok
[INFO] [stdout] test standard::tests::no_heading_multiple ... ok
[INFO] [stdout] test standard::tests::path_terminator ... ok
[INFO] [stdout] test standard::tests::max_columns_multi_line ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview ... ok
[INFO] [stdout] test standard::tests::only_matching ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line4 ... ok
[INFO] [stdout] test standard::tests::path ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_multi_line1 ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line1_only_first_line ... ok
[INFO] [stdout] test standard::tests::regression_search_empty_with_crlf ... ok
[INFO] [stdout] test standard::tests::only_matching_multi_line1 ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview_multi_line1 ... ok
[INFO] [stdout] test standard::tests::per_match ... ok
[INFO] [stdout] test standard::tests::regression_after_context_with_match ... ok
[INFO] [stdout] test standard::tests::regression_crlf_preserve ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line1 ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns_preview2 ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line2_only_first_line ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line2 ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line_diff_line_term ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_multi_line2 ... ok
[INFO] [stdout] test standard::tests::reports_match ... ok
[INFO] [stdout] test standard::tests::reports_stats_multiple ... ok
[INFO] [stdout] test standard::tests::separator_field ... ok
[INFO] [stdout] test standard::tests::only_matching_multi_line2 ... ok
[INFO] [stdout] test standard::tests::separator_path ... ok
[INFO] [stdout] test standard::tests::reports_stats ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview_multi_line2 ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line2 ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line_combine_lines ... ok
[INFO] [stdout] test standard::tests::trim_ascii ... ok
[INFO] [stdout] test standard::tests::trim_ascii_multi_line ... ok
[INFO] [stdout] test standard::tests::reports_binary ... ok
[INFO] [stdout] test standard::tests::max_columns_multi_line_preview ... ok
[INFO] [stdout] test summary::tests::count_max_matches ... ok
[INFO] [stdout] test summary::tests::count_matches ... ok
[INFO] [stdout] test summary::tests::count_no_path ... ok
[INFO] [stdout] test summary::tests::count_no_path_even_with_path ... ok
[INFO] [stdout] test standard::tests::trim_ascii_with_line_term ... ok
[INFO] [stdout] test summary::tests::count_path_field_separator ... ok
[INFO] [stdout] test summary::tests::count_path ... ok
[INFO] [stdout] test summary::tests::path_with_match_error ... ok
[INFO] [stdout] test summary::tests::path_with_match_found ... ok
[INFO] [stdout] test summary::tests::count_path_with_zero ... ok
[INFO] [stdout] test summary::tests::count_path_without_zero ... ok
[INFO] [stdout] test summary::tests::count_path_terminator ... ok
[INFO] [stdout] test summary::tests::count_path_separator ... ok
[INFO] [stdout] test summary::tests::path_without_match_error ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line3 ... ok
[INFO] [stdout] test summary::tests::path_with_match_not_found ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line3_only_first_line ... ok
[INFO] [stdout] test summary::tests::quiet ... ok
[INFO] [stdout] test summary::tests::path_without_match_found ... ok
[INFO] [stdout] test util::tests::custom_decimal_format ... ok
[INFO] [stdout] test summary::tests::path_without_match_not_found ... ok
[INFO] [stdout] test summary::tests::quiet_with_stats ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns ... ok
[INFO] [stdout] test standard::tests::replacement_only_matching ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns_preview1 ... ok
[INFO] [stdout] test standard::tests::replacement ... ok
[INFO] [stdout] test standard::tests::replacement_per_match ... ok
[INFO] [stdout] test standard::tests::replacement_passthru ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 109 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.45s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests grep_printer
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/color.rs - color::UserColorSpec (line 136) ... ok
[INFO] [stdout] test src/hyperlink/mod.rs - hyperlink::HyperlinkFormat (line 62) ... ok
[INFO] [stdout] test src/lib.rs - (line 26) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.30s; merged doctests compilation took 1.27s
[INFO] running `Command { std: "docker" "inspect" "693c90ec1ab293bebeafc28b8a619341a1c2e9397fb5e873a2340f2415176a7d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "693c90ec1ab293bebeafc28b8a619341a1c2e9397fb5e873a2340f2415176a7d", kill_on_drop: false }`
[INFO] [stdout] 693c90ec1ab293bebeafc28b8a619341a1c2e9397fb5e873a2340f2415176a7d