Dec 05 12:34:53.414 INFO testing not-an-aardvark/lucky-commit against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 12:34:53.414 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 12:34:53.843 INFO [stdout] 729057d9d5aef3ec45947d870c8fe2d9335ab8e17d5d6848a2f49802c9644932
Dec 05 12:34:53.846 INFO running `"docker" "start" "-a" "729057d9d5aef3ec45947d870c8fe2d9335ab8e17d5d6848a2f49802c9644932"`
Dec 05 12:34:55.637 INFO [stderr] usermod: no changes
Dec 05 12:34:55.752 INFO [stderr]    Compiling time v0.1.38
Dec 05 12:34:57.248 INFO [stderr]    Compiling rust-crypto v0.2.36
Dec 05 12:35:06.364 INFO [stderr]    Compiling lucky_commit v1.0.1 (/source)
Dec 05 12:35:08.824 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 13.16s
Dec 05 12:35:08.828 INFO [stderr] su: No module specific data is present
Dec 05 12:35:09.606 INFO running `"docker" "inspect" "729057d9d5aef3ec45947d870c8fe2d9335ab8e17d5d6848a2f49802c9644932"`
Dec 05 12:35:09.900 INFO running `"docker" "rm" "-f" "729057d9d5aef3ec45947d870c8fe2d9335ab8e17d5d6848a2f49802c9644932"`
Dec 05 12:35:10.184 INFO [stdout] 729057d9d5aef3ec45947d870c8fe2d9335ab8e17d5d6848a2f49802c9644932
Dec 05 12:35:10.190 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 12:35:10.614 INFO [stdout] fecc897b0e5dc8b44df799746cf3dd9abc6dd712c1680031ea143ff4e39ac0e3
Dec 05 12:35:10.622 INFO running `"docker" "start" "-a" "fecc897b0e5dc8b44df799746cf3dd9abc6dd712c1680031ea143ff4e39ac0e3"`
Dec 05 12:35:11.761 INFO [stderr] usermod: no changes
Dec 05 12:35:11.840 INFO [stderr]    Compiling lucky_commit v1.0.1 (/source)
Dec 05 12:35:13.792 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.00s
Dec 05 12:35:13.795 INFO [stderr] su: No module specific data is present
Dec 05 12:35:14.412 INFO running `"docker" "inspect" "fecc897b0e5dc8b44df799746cf3dd9abc6dd712c1680031ea143ff4e39ac0e3"`
Dec 05 12:35:14.766 INFO running `"docker" "rm" "-f" "fecc897b0e5dc8b44df799746cf3dd9abc6dd712c1680031ea143ff4e39ac0e3"`
Dec 05 12:35:15.099 INFO [stdout] fecc897b0e5dc8b44df799746cf3dd9abc6dd712c1680031ea143ff4e39ac0e3
Dec 05 12:35:15.101 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 12:35:15.676 INFO [stdout] 8ac8af3aea94eac33a21e382a438387f11109a65671d5b4064c3923e2d59dc26
Dec 05 12:35:15.684 INFO running `"docker" "start" "-a" "8ac8af3aea94eac33a21e382a438387f11109a65671d5b4064c3923e2d59dc26"`
Dec 05 12:35:16.820 INFO [stderr] usermod: no changes
Dec 05 12:35:16.936 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Dec 05 12:35:16.936 INFO [stdout] 
Dec 05 12:35:16.936 INFO [stderr]      Running /target/debug/deps/lucky_commit-1dc6d03ad15922c0
Dec 05 12:35:16.936 INFO [stdout] running 25 tests
Dec 05 12:35:16.949 INFO [stdout] test tests::iterate_for_match_failure ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::matches_desired_prefix_data_without_half ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::matches_desired_prefix_empty ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::matches_desired_prefix_matching_data_mismatching_half ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::matches_desired_prefix_matching_data_and_half ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::parse_prefix_invalid_odd_char ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::parse_prefix_even_chars ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::matches_desired_prefix_mismatching_data_matching_half ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::parse_prefix_invalid_even_chars ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::matches_desired_prefix_single_half ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::parse_prefix_capital_letters ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::parse_prefix_empty ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::matches_desired_prefix_single_half_mismatch ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::parse_prefix_odd_chars ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::split_range_u32_multiple_segments ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::split_range_u32_one_segment ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::process_commit_message_without_gpg_signature ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::process_commit_message_with_gpg_signature ... ok
Dec 05 12:35:16.949 INFO [stdout] test tests::to_hex_string_multichar ... ok
Dec 05 12:35:16.956 INFO [stdout] test tests::process_commit_message_already_padded ... ok
Dec 05 12:35:16.956 INFO [stdout] test tests::parse_prefix_single_char ... ok
Dec 05 12:35:16.956 INFO [stdout] test tests::split_range_u64_multiple_segments ... ok
Dec 05 12:35:16.956 INFO [stdout] test tests::split_range_u64_one_segment ... ok
Dec 05 12:35:16.956 INFO [stdout] test tests::to_hex_string_basic ... ok
Dec 05 12:35:16.956 INFO [stdout] test tests::search_for_match_success ... ok
Dec 05 12:35:16.956 INFO [stdout] 
Dec 05 12:35:16.956 INFO [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:35:16.956 INFO [stdout] 
Dec 05 12:35:16.968 INFO [stderr] su: No module specific data is present
Dec 05 12:35:17.634 INFO running `"docker" "inspect" "8ac8af3aea94eac33a21e382a438387f11109a65671d5b4064c3923e2d59dc26"`
Dec 05 12:35:17.942 INFO running `"docker" "rm" "-f" "8ac8af3aea94eac33a21e382a438387f11109a65671d5b4064c3923e2d59dc26"`
Dec 05 12:35:18.172 INFO [stdout] 8ac8af3aea94eac33a21e382a438387f11109a65671d5b4064c3923e2d59dc26