Dec 15 00:22:11.420 INFO testing r2fa-0.5.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 00:22:11.420 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 00:22:11.668 INFO [stdout] 4047376d7a94d9ea8c24e8327913b6791fefd4a5ee675a5b517a56e9ce0189b4
Dec 15 00:22:11.668 INFO running `"docker" "start" "-a" "4047376d7a94d9ea8c24e8327913b6791fefd4a5ee675a5b517a56e9ce0189b4"`
Dec 15 00:22:12.166 INFO [stderr] usermod: no changes
Dec 15 00:22:12.240 INFO [stderr]    Compiling r2fa v0.5.0 (/source)
Dec 15 00:22:14.293 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.10s
Dec 15 00:22:14.299 INFO [stderr] su: No module specific data is present
Dec 15 00:22:14.603 INFO running `"docker" "inspect" "4047376d7a94d9ea8c24e8327913b6791fefd4a5ee675a5b517a56e9ce0189b4"`
Dec 15 00:22:14.811 INFO running `"docker" "rm" "-f" "4047376d7a94d9ea8c24e8327913b6791fefd4a5ee675a5b517a56e9ce0189b4"`
Dec 15 00:22:15.004 INFO [stdout] 4047376d7a94d9ea8c24e8327913b6791fefd4a5ee675a5b517a56e9ce0189b4
Dec 15 00:22:15.008 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 00:22:15.308 INFO [stdout] 07dba9e944f3a2d86fae8613eac08636a6f934839be3a3a238c286e4ab96cb8c
Dec 15 00:22:15.310 INFO running `"docker" "start" "-a" "07dba9e944f3a2d86fae8613eac08636a6f934839be3a3a238c286e4ab96cb8c"`
Dec 15 00:22:16.022 INFO [stderr] usermod: no changes
Dec 15 00:22:16.119 INFO [stderr]    Compiling r2fa v0.5.0 (/source)
Dec 15 00:22:19.315 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.26s
Dec 15 00:22:19.318 INFO [stderr] su: No module specific data is present
Dec 15 00:22:20.587 INFO running `"docker" "inspect" "07dba9e944f3a2d86fae8613eac08636a6f934839be3a3a238c286e4ab96cb8c"`
Dec 15 00:22:20.832 INFO running `"docker" "rm" "-f" "07dba9e944f3a2d86fae8613eac08636a6f934839be3a3a238c286e4ab96cb8c"`
Dec 15 00:22:21.103 INFO [stdout] 07dba9e944f3a2d86fae8613eac08636a6f934839be3a3a238c286e4ab96cb8c
Dec 15 00:22:21.111 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 00:22:21.674 INFO [stdout] 09dad61dd5d10bfc2be00d645025580e758ab3c336385cc0a0e19dac2853f45f
Dec 15 00:22:21.675 INFO running `"docker" "start" "-a" "09dad61dd5d10bfc2be00d645025580e758ab3c336385cc0a0e19dac2853f45f"`
Dec 15 00:22:22.457 INFO [stderr] usermod: no changes
Dec 15 00:22:22.544 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 00:22:22.546 INFO [stderr]      Running /target/debug/deps/r2fa-5d33f8d10f438761
Dec 15 00:22:22.548 INFO [stdout] 
Dec 15 00:22:22.548 INFO [stdout] running 52 tests
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_big_result_base64 ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_empty_code ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_empty_output_base ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_hotp_asciikey_simple ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_big_result_base10 ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_bad_code ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_hotp_asciikey_full ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_invalid_hexkey ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::hotp::tests::test_hotp_hexkey_full ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_invalid_output_base ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_hotp_key_simple ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_hotp_key_full ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_invalid_base32key ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_hotp_base32key_simple ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_hotp_hexkey_simple ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_hotp_base32key_full ... ok
Dec 15 00:22:22.556 INFO [stdout] test otp::hotp::tests::test_invalid_sha1_code ... ok
Dec 15 00:22:22.557 INFO [stdout] test otp::hotp::tests::test_invalid_sha512_code ... ok
Dec 15 00:22:22.557 INFO [stdout] test otp::hotp::tests::test_result_ok_base10 ... ok
Dec 15 00:22:22.557 INFO [stdout] test otp::hotp::tests::test_nokey ... ok
Dec 15 00:22:22.557 INFO [stdout] test otp::hotp::tests::test_invalid_sha256_code ... ok
Dec 15 00:22:22.557 INFO [stdout] test otp::hotp::tests::test_valid_sha256_code ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_bad_code ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::hotp::tests::test_valid_sha1_code ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::hotp::tests::test_small_result_base64 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::hotp::tests::test_small_result_base10 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_invalid_code ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_invalid_hexkey ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_nokey ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_result_ok_base10 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_result_ok_base64 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::hotp::tests::test_valid_sha512_code ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::hotp::tests::test_rfc4226_examples ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_invalid_base32key ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_empty_code ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha1 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_small_result_base10 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_big_result_base10 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_big_result_base64 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_small_result_base64 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha256 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha512 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_totp_asciikey_simple ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::hotp::tests::test_result_ok_base64 ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_totp_base32key_full ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_totp_asciikeu_full ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_totp_key_simple ... ok
Dec 15 00:22:22.563 INFO [stdout] test otp::totp::tests::test_totp_kexkey_simple ... ok
Dec 15 00:22:22.570 INFO [stdout] test otp::totp::tests::test_totp_base32key_simple ... ok
Dec 15 00:22:22.570 INFO [stdout] test otp::totp::tests::test_totp_hexkey_full ... ok
Dec 15 00:22:22.570 INFO [stdout] test otp::totp::tests::test_totp_keu_full ... ok
Dec 15 00:22:22.570 INFO [stdout] test otp::totp::tests::test_valid_code ... ok
Dec 15 00:22:22.570 INFO [stdout] 
Dec 15 00:22:22.570 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:22:22.570 INFO [stdout] 
Dec 15 00:22:22.570 INFO [stderr]    Doc-tests r2fa
Dec 15 00:22:23.992 INFO [stdout] 
Dec 15 00:22:23.992 INFO [stdout] running 12 tests
Dec 15 00:22:28.723 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 167) ... ok
Dec 15 00:22:29.631 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTP::is_valid (line 119) ... ok
Dec 15 00:22:30.198 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTP::generate (line 77) ... ok
Dec 15 00:22:31.387 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 157) ... ok
Dec 15 00:22:31.723 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 148) ... ok
Dec 15 00:22:32.483 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 177) ... ok
Dec 15 00:22:32.680 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTP::generate (line 46) ... ok
Dec 15 00:22:33.096 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTP::is_valid (line 74) ... ok
Dec 15 00:22:35.294 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 102) ... ok
Dec 15 00:22:35.916 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 120) ... ok
Dec 15 00:22:36.128 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 111) ... ok
Dec 15 00:22:36.475 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 129) ... ok
Dec 15 00:22:36.475 INFO [stdout] 
Dec 15 00:22:36.475 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:22:36.475 INFO [stdout] 
Dec 15 00:22:36.487 INFO [stderr] su: No module specific data is present
Dec 15 00:22:36.825 INFO running `"docker" "inspect" "09dad61dd5d10bfc2be00d645025580e758ab3c336385cc0a0e19dac2853f45f"`
Dec 15 00:22:36.935 INFO running `"docker" "rm" "-f" "09dad61dd5d10bfc2be00d645025580e758ab3c336385cc0a0e19dac2853f45f"`
Dec 15 00:22:37.042 INFO [stdout] 09dad61dd5d10bfc2be00d645025580e758ab3c336385cc0a0e19dac2853f45f