[INFO] fetching crate grep-printer 0.3.1...
[INFO] testing grep-printer-0.3.1 against master#c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 for pr-146098-7
[INFO] extracting crate grep-printer 0.3.1 into /workspace/builds/worker-7-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-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate grep-printer 0.3.1 on toolchain c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "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" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded grep-searcher v0.1.16
[INFO] [stderr]   Downloaded grep-regex v0.1.14
[INFO] [stderr]   Downloaded grep-matcher v0.1.8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 656f8af084bd88ea1d7706e00549bda622489532cf5999bb000c1060514a8e28
[INFO] running `Command { std: "docker" "start" "-a" "656f8af084bd88ea1d7706e00549bda622489532cf5999bb000c1060514a8e28", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "656f8af084bd88ea1d7706e00549bda622489532cf5999bb000c1060514a8e28", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "656f8af084bd88ea1d7706e00549bda622489532cf5999bb000c1060514a8e28", kill_on_drop: false }`
[INFO] [stdout] 656f8af084bd88ea1d7706e00549bda622489532cf5999bb000c1060514a8e28
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] fea188fa5a4c8727c924a384f0a1c069571653f650cdfb9ab44d70172ddbcd4a
[INFO] running `Command { std: "docker" "start" "-a" "fea188fa5a4c8727c924a384f0a1c069571653f650cdfb9ab44d70172ddbcd4a", kill_on_drop: false }`
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling memmap2 v0.9.9
[INFO] [stderr]    Compiling grep-matcher v0.1.8
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling bstr v1.12.0
[INFO] [stderr]    Compiling encoding_rs_io v0.1.7
[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.46s
[INFO] running `Command { std: "docker" "inspect" "fea188fa5a4c8727c924a384f0a1c069571653f650cdfb9ab44d70172ddbcd4a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fea188fa5a4c8727c924a384f0a1c069571653f650cdfb9ab44d70172ddbcd4a", kill_on_drop: false }`
[INFO] [stdout] fea188fa5a4c8727c924a384f0a1c069571653f650cdfb9ab44d70172ddbcd4a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2cb2e92ad9683a4f4b9199e75e44871d791d068413a1b6074aa7891267236385
[INFO] running `Command { std: "docker" "start" "-a" "2cb2e92ad9683a4f4b9199e75e44871d791d068413a1b6074aa7891267236385", 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.56s
[INFO] running `Command { std: "docker" "inspect" "2cb2e92ad9683a4f4b9199e75e44871d791d068413a1b6074aa7891267236385", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2cb2e92ad9683a4f4b9199e75e44871d791d068413a1b6074aa7891267236385", kill_on_drop: false }`
[INFO] [stdout] 2cb2e92ad9683a4f4b9199e75e44871d791d068413a1b6074aa7891267236385
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] b857c97bd72de9ef3a70fb1751797f582440f71fee90398548cfcf63124ee465
[INFO] running `Command { std: "docker" "start" "-a" "b857c97bd72de9ef3a70fb1751797f582440f71fee90398548cfcf63124ee465", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/grep_printer-75bd169c90756939)
[INFO] [stdout] 
[INFO] [stdout] running 109 tests
[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::build_empty_format ... ok
[INFO] [stdout] test hyperlink::tests::parse_format ... ok
[INFO] [stdout] test hyperlink::tests::handle_alias ... ok
[INFO] [stdout] test hyperlink::tests::parse_valid ... ok
[INFO] [stdout] test hyperlink::tests::alias_names_are_reasonable ... ok
[INFO] [stdout] test hyperlink::tests::parse_invalid ... ok
[INFO] [stdout] test jsont::tests::base64_basic ... ok
[INFO] [stdout] test json::tests::always_begin_end_no_match ... ok
[INFO] [stdout] test json::tests::max_matches ... ok
[INFO] [stdout] test standard::tests::byte_offset ... ok
[INFO] [stdout] test json::tests::max_matches_after_context ... ok
[INFO] [stdout] test standard::tests::heading ... ok
[INFO] [stdout] test standard::tests::heading_multiple ... ok
[INFO] [stdout] test standard::tests::column_number ... ok
[INFO] [stdout] test standard::tests::invert ... ok
[INFO] [stdout] test json::tests::binary_detection ... 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_context_only_matching ... ok
[INFO] [stdout] test standard::tests::context_break ... ok
[INFO] [stdout] test standard::tests::invert_context_multi_line ... ok
[INFO] [stdout] test json::tests::no_match ... ok
[INFO] [stdout] test standard::tests::context_break_multiple_no_heading ... ok
[INFO] [stdout] test standard::tests::line_number ... ok
[INFO] [stdout] test standard::tests::invert_multi_line ... ok
[INFO] [stdout] test standard::tests::max_matches ... ok
[INFO] [stdout] test standard::tests::max_matches_context ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line1 ... ok
[INFO] [stdout] test standard::tests::max_matches_context_invert ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count ... ok
[INFO] [stdout] test standard::tests::invert_context_only_matching_multi_line ... ok
[INFO] [stdout] test standard::tests::column_number_multi_line ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line3 ... ok
[INFO] [stdout] test json::tests::missing_crlf ... ok
[INFO] [stdout] test standard::tests::max_columns ... ok
[INFO] [stdout] test standard::tests::byte_offset_multi_line ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line4 ... ok
[INFO] [stdout] test standard::tests::max_columns_preview ... ok
[INFO] [stdout] test standard::tests::no_heading_multiple ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_two_matches ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_no_match ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns ... ok
[INFO] [stdout] test standard::tests::no_heading ... ok
[INFO] [stdout] test standard::tests::max_columns_with_count_preview_one_match ... 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_multi_line1 ... ok
[INFO] [stdout] test standard::tests::per_match ... ok
[INFO] [stdout] test standard::tests::path ... ok
[INFO] [stdout] test standard::tests::path_terminator ... ok
[INFO] [stdout] test standard::tests::regression_after_context_with_match ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview_multi_line2 ... ok
[INFO] [stdout] test standard::tests::regression_search_empty_with_crlf ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_multi_line2 ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line1_only_first_line ... ok
[INFO] [stdout] test standard::tests::regression_crlf_preserve ... ok
[INFO] [stdout] test standard::tests::max_columns_multi_line ... ok
[INFO] [stdout] test standard::tests::line_number_multi_line ... ok
[INFO] [stdout] test standard::tests::max_columns_multi_line_preview ... ok
[INFO] [stdout] test standard::tests::only_matching_multi_line1 ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line2_only_first_line ... ok
[INFO] [stdout] test standard::tests::only_matching_max_columns_preview_multi_line1 ... 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::only_matching_multi_line2 ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line_combine_lines ... ok
[INFO] [stdout] test standard::tests::replacement_multi_line_diff_line_term ... ok
[INFO] [stdout] test standard::tests::reports_match ... ok
[INFO] [stdout] test standard::tests::trim_ascii ... ok
[INFO] [stdout] test standard::tests::reports_stats ... ok
[INFO] [stdout] test standard::tests::reports_stats_multiple ... ok
[INFO] [stdout] test standard::tests::trim_ascii_with_line_term ... ok
[INFO] [stdout] test standard::tests::max_matches_multi_line2 ... ok
[INFO] [stdout] test standard::tests::separator_field ... ok
[INFO] [stdout] test summary::tests::count_no_path ... ok
[INFO] [stdout] test summary::tests::count_matches ... ok
[INFO] [stdout] test standard::tests::separator_path ... ok
[INFO] [stdout] test summary::tests::count_max_matches ... ok
[INFO] [stdout] test summary::tests::count_no_path_even_with_path ... ok
[INFO] [stdout] test summary::tests::count_path_field_separator ... ok
[INFO] [stdout] test summary::tests::count_path_terminator ... ok
[INFO] [stdout] test summary::tests::count_path_separator ... ok
[INFO] [stdout] test summary::tests::count_path_without_zero ... ok
[INFO] [stdout] test standard::tests::trim_ascii_multi_line ... ok
[INFO] [stdout] test summary::tests::path_with_match_error ... ok
[INFO] [stdout] test summary::tests::count_path_with_zero ... ok
[INFO] [stdout] test summary::tests::path_with_match_found ... ok
[INFO] [stdout] test summary::tests::path_without_match_error ... 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_not_found ... ok
[INFO] [stdout] test standard::tests::reports_binary ... ok
[INFO] [stdout] test summary::tests::quiet ... ok
[INFO] [stdout] test summary::tests::path_without_match_found ... ok
[INFO] [stdout] test summary::tests::quiet_with_stats ... ok
[INFO] [stdout] test summary::tests::count_path ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line2 ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line3_only_first_line ... ok
[INFO] [stdout] test standard::tests::per_match_multi_line3 ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns_preview1 ... ok
[INFO] [stdout] test standard::tests::replacement_only_matching ... ok
[INFO] [stdout] test standard::tests::replacement_max_columns ... ok
[INFO] [stdout] test standard::tests::replacement ... ok
[INFO] [stdout] test standard::tests::replacement_passthru ... ok
[INFO] [stdout] test standard::tests::replacement_per_match ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 109 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.39s
[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/lib.rs - (line 26) ... 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.04s; merged doctests compilation took 1.01s
[INFO] running `Command { std: "docker" "inspect" "b857c97bd72de9ef3a70fb1751797f582440f71fee90398548cfcf63124ee465", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b857c97bd72de9ef3a70fb1751797f582440f71fee90398548cfcf63124ee465", kill_on_drop: false }`
[INFO] [stdout] b857c97bd72de9ef3a70fb1751797f582440f71fee90398548cfcf63124ee465