[INFO] fetching crate grep-printer 0.3.1...
[INFO] testing grep-printer-0.3.1 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate grep-printer 0.3.1 into /workspace/builds/worker-4-tc1/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-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate grep-printer 0.3.1 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded syn v2.0.107
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 7626bbf4f8ff982086591e116cf369d33bbfdb87d8f739ab83491808cf3583a7
[INFO] running `Command { std: "docker" "start" "-a" "7626bbf4f8ff982086591e116cf369d33bbfdb87d8f739ab83491808cf3583a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7626bbf4f8ff982086591e116cf369d33bbfdb87d8f739ab83491808cf3583a7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7626bbf4f8ff982086591e116cf369d33bbfdb87d8f739ab83491808cf3583a7", kill_on_drop: false }`
[INFO] [stdout] 7626bbf4f8ff982086591e116cf369d33bbfdb87d8f739ab83491808cf3583a7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c22d7c53add18ab09b9664aa0e08c3ad70ec4a6d86b6c31264d85ca3e0b65782
[INFO] running `Command { std: "docker" "start" "-a" "c22d7c53add18ab09b9664aa0e08c3ad70ec4a6d86b6c31264d85ca3e0b65782", kill_on_drop: false }`
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling libc v0.2.177
[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 memmap2 v0.9.9
[INFO] [stderr]    Compiling bstr v1.12.0
[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.29s
[INFO] running `Command { std: "docker" "inspect" "c22d7c53add18ab09b9664aa0e08c3ad70ec4a6d86b6c31264d85ca3e0b65782", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c22d7c53add18ab09b9664aa0e08c3ad70ec4a6d86b6c31264d85ca3e0b65782", kill_on_drop: false }`
[INFO] [stdout] c22d7c53add18ab09b9664aa0e08c3ad70ec4a6d86b6c31264d85ca3e0b65782
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8c2095460971bb2f09288fbb85e92d6d24419b1025956efc18d2f753cfa5186f
[INFO] running `Command { std: "docker" "start" "-a" "8c2095460971bb2f09288fbb85e92d6d24419b1025956efc18d2f753cfa5186f", 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 9.09s
[INFO] running `Command { std: "docker" "inspect" "8c2095460971bb2f09288fbb85e92d6d24419b1025956efc18d2f753cfa5186f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8c2095460971bb2f09288fbb85e92d6d24419b1025956efc18d2f753cfa5186f", kill_on_drop: false }`
[INFO] [stdout] 8c2095460971bb2f09288fbb85e92d6d24419b1025956efc18d2f753cfa5186f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 049f1841eb2ce4c577652a690260a389e25318db9d83c8fd5b3420fcd1626436
[INFO] running `Command { std: "docker" "start" "-a" "049f1841eb2ce4c577652a690260a389e25318db9d83c8fd5b3420fcd1626436", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[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::alias_names_are_reasonable ... ok
[INFO] [stdout] test hyperlink::tests::aliases_are_sorted ... ok
[INFO] [stdout] test hyperlink::tests::build_format ... ok
[INFO] [stdout] test hyperlink::tests::aliases_are_valid_formats ... ok
[INFO] [stdout] test hyperlink::tests::parse_valid ... ok
[INFO] [stdout] test hyperlink::tests::handle_alias ... ok
[INFO] [stdout] test hyperlink::tests::parse_invalid ... ok
[INFO] [stdout] test json::tests::always_begin_end_no_match ... ok
[INFO] [stdout] test json::tests::max_matches ... ok
[INFO] [stdout] test json::tests::max_matches_after_context ... ok
[INFO] [stdout] test json::tests::no_match ... ok
[INFO] [stdout] test standard::tests::byte_offset ... ok
[INFO] [stdout] test json::tests::binary_detection ... ok
[INFO] [stdout] test jsont::tests::base64_basic ... ok
[INFO] [stdout] test standard::tests::heading_multiple ... ok
[INFO] [stdout] test standard::tests::context_break ... ok
[INFO] [stdout] test json::tests::missing_crlf ... ok
[INFO] [stdout] test standard::tests::heading ... ok
[INFO] [stdout] test standard::tests::column_number ... ok
[INFO] [stdout] test standard::tests::context_break_multiple_heading ... ok
[INFO] [stdout] test standard::tests::context_break_multiple_no_heading ... ok
[INFO] [stdout] test hyperlink::tests::build_empty_format ... ok
[INFO] [stdout] test standard::tests::invert_context ... ok
[INFO] [stdout] test standard::tests::invert ... ok
[INFO] [stdout] test standard::tests::invert_multi_line ... ok
[INFO] [stdout] test standard::tests::invert_context_only_matching_multi_line ... ok
[INFO] [stdout] test standard::tests::line_number ... ok
[INFO] [stdout] test standard::tests::max_columns ... ok
[INFO] [stdout] test hyperlink::tests::parse_format ... ok
[INFO] [stdout] test standard::tests::byte_offset_multi_line ... ok
[INFO] [stdout] test standard::tests::invert_context_only_matching ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line1 ... ok
[INFO] [stdout] test standard::tests::column_number_multi_line ... ok
[INFO] [stdout] test standard::tests::max_matches_context ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line3 ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line4 ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_one_match ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count ... ok
[INFO] [stdout] test standard::tests::no_heading ... ok
[INFO] [stdout] test standard::tests::max_matches ... ok
[INFO] [stdout] test standard::tests::no_heading_multiple ... ok
[INFO] [stdout] test standard::tests::only_matching ... ok
[INFO] [stdout] test standard::tests::line_number_multi_line ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview ... ok
[INFO] [stdout] test standard::tests::invert_context_multi_line ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_two_matches ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns ... ok
[INFO] [stdout] test standard::tests::max_matches_context_invert ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_no_match ... ok
[INFO] [stdout] test standard::tests::per_match ... ok
[INFO] [stdout] test standard::tests::path ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line2 ... ok
[INFO] [stdout] test standard::tests::path_terminator ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview_multi_line1 ... ok
[INFO] [stdout] test standard::tests::only_matching_multi_line1 ... ok
[INFO] [stdout] test standard::tests::regression_after_context_with_match ... ok
[INFO] [stdout] test standard::tests::regression_search_empty_with_crlf ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line1 ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line1_only_first_line ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_multi_line1 ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns_preview2 ... ok
[INFO] [stdout] test standard::tests::max_columns_preview ... ok
[INFO] [stdout] test standard::tests::regression_crlf_preserve ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line_diff_line_term ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview_multi_line2 ... ok
[INFO] [stdout] test standard::tests::only_matching_multi_line2 ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_multi_line2 ... ok
[INFO] [stdout] test standard::tests::reports_stats ... ok
[INFO] [stdout] test standard::tests::reports_stats_multiple ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line_combine_lines ... ok
[INFO] [stdout] test standard::tests::reports_match ... ok
[INFO] [stdout] test standard::tests::reports_binary ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line2_only_first_line ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line2 ... ok
[INFO] [stdout] test standard::tests::separator_field ... ok
[INFO] [stdout] test standard::tests::trim_ascii ... ok
[INFO] [stdout] test standard::tests::max_columns_multi_line ... ok
[INFO] [stdout] test standard::tests::trim_ascii_multi_line ... ok
[INFO] [stdout] test standard::tests::trim_ascii_with_line_term ... ok
[INFO] [stdout] test summary::tests::count_no_path_even_with_path ... ok
[INFO] [stdout] test summary::tests::count_max_matches ... ok
[INFO] [stdout] test summary::tests::count_path_terminator ... ok
[INFO] [stdout] test summary::tests::count_path ... ok
[INFO] [stdout] test summary::tests::count_path_field_separator ... ok
[INFO] [stdout] test summary::tests::count_path_without_zero ... ok
[INFO] [stdout] test summary::tests::path_with_match_found ... ok
[INFO] [stdout] test summary::tests::count_matches ... ok
[INFO] [stdout] test summary::tests::count_no_path ... ok
[INFO] [stdout] test summary::tests::path_with_match_error ... ok
[INFO] [stdout] test standard::tests::max_columns_multi_line_preview ... ok
[INFO] [stdout] test summary::tests::path_without_match_error ... ok
[INFO] [stdout] test summary::tests::path_without_match_not_found ... ok
[INFO] [stdout] test summary::tests::path_with_match_not_found ... ok
[INFO] [stdout] test util::tests::custom_decimal_format ... ok
[INFO] [stdout] test summary::tests::path_without_match_found ... ok
[INFO] [stdout] test summary::tests::quiet ... ok
[INFO] [stdout] test summary::tests::quiet_with_stats ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line3 ... ok
[INFO] [stdout] test standard::tests::separator_path ... ok
[INFO] [stdout] test summary::tests::count_path_separator ... ok
[INFO] [stdout] test summary::tests::count_path_with_zero ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line3_only_first_line ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns_preview1 ... ok
[INFO] [stdout] test standard::tests::replacement ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns ... ok
[INFO] [stdout] test standard::tests::replacement_passthru ... ok
[INFO] [stdout] test standard::tests::replacement_per_match ... ok
[INFO] [stdout] test standard::tests::replacement_only_matching ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 109 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.40s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests grep_printer
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/lib.rs - (line 26) ... ok
[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] 
[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.16s; merged doctests compilation took 1.13s
[INFO] running `Command { std: "docker" "inspect" "049f1841eb2ce4c577652a690260a389e25318db9d83c8fd5b3420fcd1626436", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "049f1841eb2ce4c577652a690260a389e25318db9d83c8fd5b3420fcd1626436", kill_on_drop: false }`
[INFO] [stdout] 049f1841eb2ce4c577652a690260a389e25318db9d83c8fd5b3420fcd1626436