Nov 18 02:42:53.795 INFO testing r2fa-0.5.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 02:42:53.796 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 02:42:54.085 INFO [stdout] 46f3852dbf5cb222e7459c3a1b96f135825a72803ef3b035707def90600f6554
Nov 18 02:42:54.089 INFO running `"docker" "start" "-a" "46f3852dbf5cb222e7459c3a1b96f135825a72803ef3b035707def90600f6554"`
Nov 18 02:42:55.091 INFO [stderr] usermod: no changes
Nov 18 02:42:55.179 INFO [stderr]    Compiling base32 v0.3.1
Nov 18 02:42:56.164 INFO [stderr]    Compiling r2fa v0.5.0 (/source)
Nov 18 02:42:58.683 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.57s
Nov 18 02:42:58.690 INFO [stderr] su: No module specific data is present
Nov 18 02:42:59.426 INFO running `"docker" "inspect" "46f3852dbf5cb222e7459c3a1b96f135825a72803ef3b035707def90600f6554"`
Nov 18 02:42:59.650 INFO running `"docker" "rm" "-f" "46f3852dbf5cb222e7459c3a1b96f135825a72803ef3b035707def90600f6554"`
Nov 18 02:42:59.890 INFO [stdout] 46f3852dbf5cb222e7459c3a1b96f135825a72803ef3b035707def90600f6554
Nov 18 02:42:59.894 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 02:43:00.234 INFO [stdout] 25d8f27f11f1a7a40a658361d0771307c1581c3f65614800767553c52c5084eb
Nov 18 02:43:00.236 INFO running `"docker" "start" "-a" "25d8f27f11f1a7a40a658361d0771307c1581c3f65614800767553c52c5084eb"`
Nov 18 02:43:01.204 INFO [stderr] usermod: no changes
Nov 18 02:43:01.296 INFO [stderr]    Compiling r2fa v0.5.0 (/source)
Nov 18 02:43:04.343 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.09s
Nov 18 02:43:04.344 INFO [stderr] su: No module specific data is present
Nov 18 02:43:04.817 INFO running `"docker" "inspect" "25d8f27f11f1a7a40a658361d0771307c1581c3f65614800767553c52c5084eb"`
Nov 18 02:43:05.101 INFO running `"docker" "rm" "-f" "25d8f27f11f1a7a40a658361d0771307c1581c3f65614800767553c52c5084eb"`
Nov 18 02:43:05.417 INFO [stdout] 25d8f27f11f1a7a40a658361d0771307c1581c3f65614800767553c52c5084eb
Nov 18 02:43:05.422 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 02:43:05.802 INFO [stdout] 935594cbfea62ee5175cbf5e307708dc4fff6202450c250d7d9a07dd7b81d2bf
Nov 18 02:43:05.805 INFO running `"docker" "start" "-a" "935594cbfea62ee5175cbf5e307708dc4fff6202450c250d7d9a07dd7b81d2bf"`
Nov 18 02:43:06.715 INFO [stderr] usermod: no changes
Nov 18 02:43:06.827 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Nov 18 02:43:06.843 INFO [stderr]      Running /target/debug/deps/r2fa-c1c23b727a845e12
Nov 18 02:43:06.843 INFO [stdout] 
Nov 18 02:43:06.843 INFO [stdout] running 52 tests
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_empty_code ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_empty_output_base ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_big_result_base64 ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_hexkey_simple ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_hexkey_full ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_big_result_base10 ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_base32key_simple ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_asciikey_simple ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_bad_code ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_asciikey_full ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_base32key_full ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_invalid_hexkey ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_invalid_output_base ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_invalid_sha512_code ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_invalid_sha256_code ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_invalid_base32key ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_invalid_sha1_code ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_key_full ... ok
Nov 18 02:43:06.851 INFO [stdout] test otp::hotp::tests::test_hotp_key_simple ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_small_result_base10 ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_small_result_base64 ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_nokey ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_result_ok_base10 ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_result_ok_base64 ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_valid_sha1_code ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_rfc4226_examples ... ok
Nov 18 02:43:06.861 INFO [stdout] test otp::hotp::tests::test_valid_sha512_code ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_bad_code ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_big_result_base10 ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_big_result_base64 ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_empty_code ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_invalid_base32key ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_invalid_code ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_invalid_hexkey ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_nokey ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_result_ok_base10 ... ok
Nov 18 02:43:06.862 INFO [stdout] test otp::totp::tests::test_result_ok_base64 ... ok
Nov 18 02:43:06.869 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha1 ... ok
Nov 18 02:43:06.869 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha256 ... ok
Nov 18 02:43:06.869 INFO [stdout] test otp::hotp::tests::test_valid_sha256_code ... ok
Nov 18 02:43:06.869 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha512 ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_small_result_base10 ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_small_result_base64 ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_asciikeu_full ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_asciikey_simple ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_base32key_simple ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_keu_full ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_hexkey_full ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_base32key_full ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_kexkey_simple ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_totp_key_simple ... ok
Nov 18 02:43:06.877 INFO [stdout] test otp::totp::tests::test_valid_code ... ok
Nov 18 02:43:06.877 INFO [stdout] 
Nov 18 02:43:06.877 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:43:06.877 INFO [stdout] 
Nov 18 02:43:06.877 INFO [stderr]    Doc-tests r2fa
Nov 18 02:43:08.039 INFO [stdout] 
Nov 18 02:43:08.040 INFO [stdout] running 12 tests
Nov 18 02:43:12.479 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTP::generate (line 46) ... ok
Nov 18 02:43:12.947 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 148) ... ok
Nov 18 02:43:14.635 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 177) ... ok
Nov 18 02:43:14.931 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTP::is_valid (line 74) ... ok
Nov 18 02:43:15.183 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 157) ... ok
Nov 18 02:43:15.555 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTP::is_valid (line 119) ... ok
Nov 18 02:43:15.728 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 167) ... ok
Nov 18 02:43:16.095 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTP::generate (line 77) ... ok
Nov 18 02:43:17.091 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 102) ... ok
Nov 18 02:43:17.645 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 111) ... ok
Nov 18 02:43:18.340 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 129) ... ok
Nov 18 02:43:18.340 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 120) ... ok
Nov 18 02:43:18.340 INFO [stdout] 
Nov 18 02:43:18.340 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:43:18.340 INFO [stdout] 
Nov 18 02:43:18.370 INFO [stderr] su: No module specific data is present
Nov 18 02:43:18.644 INFO running `"docker" "inspect" "935594cbfea62ee5175cbf5e307708dc4fff6202450c250d7d9a07dd7b81d2bf"`
Nov 18 02:43:18.727 INFO running `"docker" "rm" "-f" "935594cbfea62ee5175cbf5e307708dc4fff6202450c250d7d9a07dd7b81d2bf"`
Nov 18 02:43:18.815 INFO [stdout] 935594cbfea62ee5175cbf5e307708dc4fff6202450c250d7d9a07dd7b81d2bf