Dec 15 09:37:09.840 INFO testing grep-printer-0.1.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 09:37:09.840 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 09:37:10.217 INFO [stdout] 2bc6068f2680e132e26c4ea1b11e615fab73cb4b8dfb49fe3db8e5132f765202
Dec 15 09:37:10.223 INFO running `"docker" "start" "-a" "2bc6068f2680e132e26c4ea1b11e615fab73cb4b8dfb49fe3db8e5132f765202"`
Dec 15 09:37:11.099 INFO [stderr] usermod: no changes
Dec 15 09:37:11.203 INFO [stderr]    Compiling encoding_rs_io v0.1.3
Dec 15 09:37:11.203 INFO [stderr]    Compiling grep-matcher v0.1.1
Dec 15 09:37:12.694 INFO [stderr]    Compiling grep-searcher v0.1.1
Dec 15 09:37:14.593 INFO [stderr]    Compiling grep-printer v0.1.1 (/source)
Dec 15 09:37:17.739 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.62s
Dec 15 09:37:17.744 INFO [stderr] su: No module specific data is present
Dec 15 09:37:19.211 INFO running `"docker" "inspect" "2bc6068f2680e132e26c4ea1b11e615fab73cb4b8dfb49fe3db8e5132f765202"`
Dec 15 09:37:19.423 INFO running `"docker" "rm" "-f" "2bc6068f2680e132e26c4ea1b11e615fab73cb4b8dfb49fe3db8e5132f765202"`
Dec 15 09:37:19.707 INFO [stdout] 2bc6068f2680e132e26c4ea1b11e615fab73cb4b8dfb49fe3db8e5132f765202
Dec 15 09:37:19.715 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 09:37:20.230 INFO [stdout] 7d550bd90b0c02380db9868c89761a0d5c059c39ce3ce8834b209746dc8ee492
Dec 15 09:37:20.239 INFO running `"docker" "start" "-a" "7d550bd90b0c02380db9868c89761a0d5c059c39ce3ce8834b209746dc8ee492"`
Dec 15 09:37:21.037 INFO [stderr] usermod: no changes
Dec 15 09:37:21.142 INFO [stderr]    Compiling grep-regex v0.1.1
Dec 15 09:37:23.487 INFO [stderr]    Compiling grep-printer v0.1.1 (/source)
Dec 15 09:37:30.165 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.10s
Dec 15 09:37:30.171 INFO [stderr] su: No module specific data is present
Dec 15 09:37:30.520 INFO running `"docker" "inspect" "7d550bd90b0c02380db9868c89761a0d5c059c39ce3ce8834b209746dc8ee492"`
Dec 15 09:37:30.633 INFO running `"docker" "rm" "-f" "7d550bd90b0c02380db9868c89761a0d5c059c39ce3ce8834b209746dc8ee492"`
Dec 15 09:37:30.798 INFO [stdout] 7d550bd90b0c02380db9868c89761a0d5c059c39ce3ce8834b209746dc8ee492
Dec 15 09:37:30.803 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +bd47d6825bf4090517549d33cfef10d3300b4a75-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 15 09:37:31.060 INFO [stdout] 9137864acc7fd5f2964e2b2cbcbb60bac0fe406cf286bec5454ba39788cd546d
Dec 15 09:37:31.062 INFO running `"docker" "start" "-a" "9137864acc7fd5f2964e2b2cbcbb60bac0fe406cf286bec5454ba39788cd546d"`
Dec 15 09:37:31.549 INFO [stderr] usermod: no changes
Dec 15 09:37:31.641 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 15 09:37:31.641 INFO [stderr]      Running /target/debug/deps/grep_printer-20dc8f029344741a
Dec 15 09:37:31.651 INFO [stdout] 
Dec 15 09:37:31.651 INFO [stdout] running 74 tests
Dec 15 09:37:31.651 INFO [stdout] test json::tests::no_match ... ok
Dec 15 09:37:31.651 INFO [stdout] test json::tests::always_begin_end_no_match ... ok
Dec 15 09:37:31.691 INFO [stdout] test standard::tests::column_number_multi_line ... ok
Dec 15 09:37:31.695 INFO [stdout] test standard::tests::context_break_multiple_no_heading ... ok
Dec 15 09:37:31.695 INFO [stdout] test standard::tests::context_break_multiple_heading ... ok
Dec 15 09:37:31.695 INFO [stdout] test json::tests::binary_detection ... ok
Dec 15 09:37:31.695 INFO [stdout] test json::tests::max_matches ... ok
Dec 15 09:37:31.697 INFO [stdout] test standard::tests::context_break ... ok
Dec 15 09:37:31.702 INFO [stdout] test standard::tests::invert_context ... ok
Dec 15 09:37:31.702 INFO [stdout] test standard::tests::column_number ... ok
Dec 15 09:37:31.702 INFO [stdout] test standard::tests::byte_offset ... ok
Dec 15 09:37:31.703 INFO [stdout] test standard::tests::invert_context_multi_line ... ok
Dec 15 09:37:31.703 INFO [stdout] test standard::tests::byte_offset_multi_line ... ok
Dec 15 09:37:31.703 INFO [stdout] test standard::tests::heading ... ok
Dec 15 09:37:31.706 INFO [stdout] test standard::tests::invert ... ok
Dec 15 09:37:31.708 INFO [stdout] test standard::tests::line_number ... ok
Dec 15 09:37:31.708 INFO [stdout] test standard::tests::heading_multiple ... ok
Dec 15 09:37:31.708 INFO [stdout] test standard::tests::invert_context_only_matching ... ok
Dec 15 09:37:31.711 INFO [stdout] test standard::tests::invert_multi_line ... ok
Dec 15 09:37:31.711 INFO [stdout] test standard::tests::max_columns_with_count ... ok
Dec 15 09:37:31.711 INFO [stdout] test standard::tests::max_matches ... ok
Dec 15 09:37:31.719 INFO [stdout] test standard::tests::line_number_multi_line ... ok
Dec 15 09:37:31.723 INFO [stdout] test standard::tests::invert_context_only_matching_multi_line ... ok
Dec 15 09:37:31.723 INFO [stdout] test standard::tests::max_columns_multi_line ... ok
Dec 15 09:37:31.739 INFO [stdout] test standard::tests::max_columns ... ok
Dec 15 09:37:31.739 INFO [stdout] test standard::tests::no_heading_multiple ... ok
Dec 15 09:37:31.744 INFO [stdout] test standard::tests::no_heading ... ok
Dec 15 09:37:31.746 INFO [stdout] test standard::tests::max_matches_multi_line1 ... ok
Dec 15 09:37:31.779 INFO [stdout] test standard::tests::max_matches_context ... ok
Dec 15 09:37:31.781 INFO [stdout] test standard::tests::max_matches_multi_line2 ... ok
Dec 15 09:37:31.790 INFO [stdout] test standard::tests::only_matching_multi_line2 ... ok
Dec 15 09:37:31.790 INFO [stdout] test standard::tests::only_matching_multi_line1 ... ok
Dec 15 09:37:31.799 INFO [stdout] test standard::tests::only_matching_max_columns_multi_line1 ... ok
Dec 15 09:37:31.803 INFO [stdout] test standard::tests::only_matching_max_columns_multi_line2 ... ok
Dec 15 09:37:31.811 INFO [stdout] test standard::tests::only_matching_max_columns ... ok
Dec 15 09:37:31.811 INFO [stdout] test standard::tests::only_matching ... ok
Dec 15 09:37:31.811 INFO [stdout] test standard::tests::path ... ok
Dec 15 09:37:31.828 INFO [stdout] test standard::tests::per_match_multi_line1 ... ok
Dec 15 09:37:31.833 INFO [stdout] test standard::tests::per_match_multi_line2 ... ok
Dec 15 09:37:31.835 INFO [stdout] test standard::tests::path_terminator ... ok
Dec 15 09:37:31.843 INFO [stdout] test standard::tests::per_match_multi_line3 ... ok
Dec 15 09:37:31.851 INFO [stdout] test standard::tests::per_match ... ok
Dec 15 09:37:31.857 INFO [stdout] test standard::tests::reports_binary ... ok
Dec 15 09:37:31.937 INFO [stdout] test standard::tests::reports_match ... ok
Dec 15 09:37:31.944 INFO [stdout] test standard::tests::reports_stats_multiple ... ok
Dec 15 09:37:31.947 INFO [stdout] test standard::tests::reports_stats ... ok
Dec 15 09:37:31.948 INFO [stdout] test standard::tests::separator_field ... ok
Dec 15 09:37:31.950 INFO [stdout] test standard::tests::trim_ascii_multi_line ... ok
Dec 15 09:37:31.950 INFO [stdout] test standard::tests::separator_path ... ok
Dec 15 09:37:31.951 INFO [stdout] test standard::tests::trim_ascii_with_line_term ... ok
Dec 15 09:37:31.952 INFO [stdout] test standard::tests::trim_ascii ... ok
Dec 15 09:37:31.953 INFO [stdout] test summary::tests::count_matches ... ok
Dec 15 09:37:31.956 INFO [stdout] test summary::tests::count_no_path ... ok
Dec 15 09:37:31.965 INFO [stdout] test summary::tests::count_max_matches ... ok
Dec 15 09:37:31.965 INFO [stdout] test summary::tests::count_no_path_even_with_path ... ok
Dec 15 09:37:31.966 INFO [stdout] test summary::tests::count_path ... ok
Dec 15 09:37:31.981 INFO [stdout] test summary::tests::count_path_terminator ... ok
Dec 15 09:37:31.981 INFO [stdout] test summary::tests::count_path_separator ... ok
Dec 15 09:37:31.981 INFO [stdout] test summary::tests::count_path_field_separator ... ok
Dec 15 09:37:31.999 INFO [stdout] test summary::tests::count_path_with_zero ... ok
Dec 15 09:37:31.999 INFO [stdout] test summary::tests::count_path_without_zero ... ok
Dec 15 09:37:31.999 INFO [stdout] test summary::tests::path_with_match_error ... ok
Dec 15 09:37:32.004 INFO [stdout] test summary::tests::path_with_match_found ... ok
Dec 15 09:37:32.005 INFO [stdout] test summary::tests::path_with_match_not_found ... ok
Dec 15 09:37:32.005 INFO [stdout] test summary::tests::path_without_match_found ... ok
Dec 15 09:37:32.005 INFO [stdout] test summary::tests::path_without_match_error ... ok
Dec 15 09:37:32.005 INFO [stdout] test summary::tests::path_without_match_not_found ... ok
Dec 15 09:37:32.015 INFO [stdout] test summary::tests::quiet ... ok
Dec 15 09:37:32.027 INFO [stdout] test summary::tests::quiet_with_stats ... ok
Dec 15 09:37:32.150 INFO [stdout] test standard::tests::replacement ... ok
Dec 15 09:37:32.299 INFO [stdout] test standard::tests::replacement_only_matching ... ok
Dec 15 09:37:32.307 INFO [stdout] test standard::tests::replacement_max_columns ... ok
Dec 15 09:37:32.307 INFO [stdout] test standard::tests::replacement_passthru ... ok
Dec 15 09:37:32.311 INFO [stdout] test standard::tests::replacement_per_match ... ok
Dec 15 09:37:32.311 INFO [stdout] 
Dec 15 09:37:32.311 INFO [stdout] test result: ok. 74 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:37:32.311 INFO [stdout] 
Dec 15 09:37:32.312 INFO [stderr]    Doc-tests grep-printer
Dec 15 09:37:34.834 INFO [stdout] 
Dec 15 09:37:34.834 INFO [stdout] running 2 tests
Dec 15 09:37:40.022 INFO [stdout] test src/color.rs - color::UserColorSpec (line 159) ... ok
Dec 15 09:37:42.135 INFO [stdout] test src/lib.rs -  (line 28) ... ok
Dec 15 09:37:42.135 INFO [stdout] 
Dec 15 09:37:42.135 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 09:37:42.135 INFO [stdout] 
Dec 15 09:37:42.163 INFO [stderr] su: No module specific data is present
Dec 15 09:37:42.895 INFO running `"docker" "inspect" "9137864acc7fd5f2964e2b2cbcbb60bac0fe406cf286bec5454ba39788cd546d"`
Dec 15 09:37:43.147 INFO running `"docker" "rm" "-f" "9137864acc7fd5f2964e2b2cbcbb60bac0fe406cf286bec5454ba39788cd546d"`
Dec 15 09:37:43.362 INFO [stdout] 9137864acc7fd5f2964e2b2cbcbb60bac0fe406cf286bec5454ba39788cd546d