Nov 16 17:56:44.560 INFO testing not-an-aardvark/lucky-commit against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 17:56:44.560 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 16 17:56:44.927 INFO [stdout] 5056e2e58bcfade58438740537379aa6024cc3ac786fffab00bcfdc8c47b2d03
Nov 16 17:56:44.927 INFO running `"docker" "start" "-a" "5056e2e58bcfade58438740537379aa6024cc3ac786fffab00bcfdc8c47b2d03"`
Nov 16 17:56:45.607 INFO [stderr] usermod: no changes
Nov 16 17:56:45.719 INFO [stderr]    Compiling rust-crypto v0.2.36
Nov 16 17:56:45.719 INFO [stderr]    Compiling flate2 v1.0.1
Nov 16 17:56:55.180 INFO [stderr]    Compiling lucky_commit v1.0.1 (/source)
Nov 16 17:56:57.955 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.30s
Nov 16 17:56:57.959 INFO [stderr] su: No module specific data is present
Nov 16 17:56:58.911 INFO running `"docker" "inspect" "5056e2e58bcfade58438740537379aa6024cc3ac786fffab00bcfdc8c47b2d03"`
Nov 16 17:56:59.165 INFO running `"docker" "rm" "-f" "5056e2e58bcfade58438740537379aa6024cc3ac786fffab00bcfdc8c47b2d03"`
Nov 16 17:56:59.419 INFO [stdout] 5056e2e58bcfade58438740537379aa6024cc3ac786fffab00bcfdc8c47b2d03
Nov 16 17:56:59.421 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 16 17:56:59.801 INFO [stdout] dccb34ef0e6d4fd05dd14239eef5e898f51bca0470857e9bd949609bdb65c79e
Nov 16 17:56:59.803 INFO running `"docker" "start" "-a" "dccb34ef0e6d4fd05dd14239eef5e898f51bca0470857e9bd949609bdb65c79e"`
Nov 16 17:57:00.902 INFO [stderr] usermod: no changes
Nov 16 17:57:00.991 INFO [stderr]    Compiling lucky_commit v1.0.1 (/source)
Nov 16 17:57:02.695 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.76s
Nov 16 17:57:02.699 INFO [stderr] su: No module specific data is present
Nov 16 17:57:03.427 INFO running `"docker" "inspect" "dccb34ef0e6d4fd05dd14239eef5e898f51bca0470857e9bd949609bdb65c79e"`
Nov 16 17:57:03.715 INFO running `"docker" "rm" "-f" "dccb34ef0e6d4fd05dd14239eef5e898f51bca0470857e9bd949609bdb65c79e"`
Nov 16 17:57:04.011 INFO [stdout] dccb34ef0e6d4fd05dd14239eef5e898f51bca0470857e9bd949609bdb65c79e
Nov 16 17:57:04.015 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 16 17:57:04.464 INFO [stdout] 61ce16bf12c0a6fd3f4ef9b42bc70c522274b84352481ef524cb552f1a1fcdeb
Nov 16 17:57:04.468 INFO running `"docker" "start" "-a" "61ce16bf12c0a6fd3f4ef9b42bc70c522274b84352481ef524cb552f1a1fcdeb"`
Nov 16 17:57:05.178 INFO [stderr] usermod: no changes
Nov 16 17:57:05.242 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Nov 16 17:57:05.256 INFO [stderr]      Running /target/debug/deps/lucky_commit-4a28f1d2ab0d649e
Nov 16 17:57:05.256 INFO [stdout] 
Nov 16 17:57:05.256 INFO [stdout] running 25 tests
Nov 16 17:57:05.293 INFO [stdout] test tests::matches_desired_prefix_data_without_half ... ok
Nov 16 17:57:05.293 INFO [stdout] test tests::matches_desired_prefix_matching_data_and_half ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::matches_desired_prefix_empty ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::matches_desired_prefix_single_half ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::matches_desired_prefix_matching_data_mismatching_half ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::matches_desired_prefix_mismatching_data_matching_half ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::iterate_for_match_failure ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::matches_desired_prefix_single_half_mismatch ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::parse_prefix_capital_letters ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::parse_prefix_empty ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::parse_prefix_even_chars ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::parse_prefix_invalid_even_chars ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::parse_prefix_single_char ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::process_commit_message_already_padded ... ok
Nov 16 17:57:05.294 INFO [stdout] test tests::process_commit_message_with_gpg_signature ... ok
Nov 16 17:57:05.295 INFO [stdout] test tests::process_commit_message_without_gpg_signature ... ok
Nov 16 17:57:05.307 INFO [stdout] test tests::parse_prefix_invalid_odd_char ... ok
Nov 16 17:57:05.307 INFO [stdout] test tests::parse_prefix_odd_chars ... ok
Nov 16 17:57:05.307 INFO [stdout] test tests::split_range_u64_one_segment ... ok
Nov 16 17:57:05.307 INFO [stdout] test tests::split_range_u32_multiple_segments ... ok
Nov 16 17:57:05.307 INFO [stdout] test tests::split_range_u32_one_segment ... ok
Nov 16 17:57:05.308 INFO [stdout] test tests::to_hex_string_multichar ... ok
Nov 16 17:57:05.308 INFO [stdout] test tests::search_for_match_success ... ok
Nov 16 17:57:05.308 INFO [stdout] test tests::split_range_u64_multiple_segments ... ok
Nov 16 17:57:05.308 INFO [stdout] test tests::to_hex_string_basic ... ok
Nov 16 17:57:05.308 INFO [stdout] 
Nov 16 17:57:05.308 INFO [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:57:05.309 INFO [stdout] 
Nov 16 17:57:05.318 INFO [stderr] su: No module specific data is present
Nov 16 17:57:05.832 INFO running `"docker" "inspect" "61ce16bf12c0a6fd3f4ef9b42bc70c522274b84352481ef524cb552f1a1fcdeb"`
Nov 16 17:57:05.981 INFO running `"docker" "rm" "-f" "61ce16bf12c0a6fd3f4ef9b42bc70c522274b84352481ef524cb552f1a1fcdeb"`
Nov 16 17:57:06.156 INFO [stdout] 61ce16bf12c0a6fd3f4ef9b42bc70c522274b84352481ef524cb552f1a1fcdeb