Dec 15 00:22:11.420 INFO testing r2fa-0.5.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 00:22:11.420 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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.624 INFO [stdout] 2e490141ab71d9ddcca6184513447a0abad0a1ffa75888970c65b0be627926f5
Dec 15 00:22:11.628 INFO running `"docker" "start" "-a" "2e490141ab71d9ddcca6184513447a0abad0a1ffa75888970c65b0be627926f5"`
Dec 15 00:22:12.147 INFO [stderr] usermod: no changes
Dec 15 00:22:12.229 INFO [stderr]    Compiling r2fa v0.5.0 (/source)
Dec 15 00:22:14.388 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.21s
Dec 15 00:22:14.392 INFO [stderr] su: No module specific data is present
Dec 15 00:22:14.687 INFO running `"docker" "inspect" "2e490141ab71d9ddcca6184513447a0abad0a1ffa75888970c65b0be627926f5"`
Dec 15 00:22:14.873 INFO running `"docker" "rm" "-f" "2e490141ab71d9ddcca6184513447a0abad0a1ffa75888970c65b0be627926f5"`
Dec 15 00:22:15.183 INFO [stdout] 2e490141ab71d9ddcca6184513447a0abad0a1ffa75888970c65b0be627926f5
Dec 15 00:22:15.186 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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.489 INFO [stdout] 08d9fb1a42889892a9f5efb473d2a0e0fd900822e63f00f00393fdf5aec02217
Dec 15 00:22:15.492 INFO running `"docker" "start" "-a" "08d9fb1a42889892a9f5efb473d2a0e0fd900822e63f00f00393fdf5aec02217"`
Dec 15 00:22:16.303 INFO [stderr] usermod: no changes
Dec 15 00:22:16.395 INFO [stderr]    Compiling r2fa v0.5.0 (/source)
Dec 15 00:22:19.823 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.49s
Dec 15 00:22:19.827 INFO [stderr] su: No module specific data is present
Dec 15 00:22:20.873 INFO running `"docker" "inspect" "08d9fb1a42889892a9f5efb473d2a0e0fd900822e63f00f00393fdf5aec02217"`
Dec 15 00:22:21.124 INFO running `"docker" "rm" "-f" "08d9fb1a42889892a9f5efb473d2a0e0fd900822e63f00f00393fdf5aec02217"`
Dec 15 00:22:21.399 INFO [stdout] 08d9fb1a42889892a9f5efb473d2a0e0fd900822e63f00f00393fdf5aec02217
Dec 15 00:22:21.405 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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.738 INFO [stdout] fa0bf66332e465376d75aa263b094f6a78390f8f9a842c9a9f8a1aac9c13c735
Dec 15 00:22:21.745 INFO running `"docker" "start" "-a" "fa0bf66332e465376d75aa263b094f6a78390f8f9a842c9a9f8a1aac9c13c735"`
Dec 15 00:22:22.446 INFO [stderr] usermod: no changes
Dec 15 00:22:22.522 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 00:22:22.544 INFO [stderr]      Running /target/debug/deps/r2fa-f9079f16b021917b
Dec 15 00:22:22.544 INFO [stdout] 
Dec 15 00:22:22.544 INFO [stdout] running 52 tests
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_empty_output_base ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_empty_code ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_asciikey_full ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_base32key_full ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_base32key_simple ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_asciikey_simple ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_hexkey_full ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_hexkey_simple ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_key_full ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_big_result_base64 ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_bad_code ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_hotp_key_simple ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_invalid_sha1_code ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_result_ok_base10 ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_invalid_sha512_code ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_result_ok_base64 ... ok
Dec 15 00:22:22.544 INFO [stdout] test otp::hotp::tests::test_nokey ... ok
Dec 15 00:22:22.546 INFO [stdout] test otp::hotp::tests::test_rfc4226_examples ... ok
Dec 15 00:22:22.546 INFO [stdout] test otp::hotp::tests::test_small_result_base10 ... ok
Dec 15 00:22:22.546 INFO [stdout] test otp::hotp::tests::test_small_result_base64 ... ok
Dec 15 00:22:22.546 INFO [stdout] test otp::hotp::tests::test_big_result_base10 ... ok
Dec 15 00:22:22.547 INFO [stdout] test otp::hotp::tests::test_valid_sha1_code ... ok
Dec 15 00:22:22.547 INFO [stdout] test otp::hotp::tests::test_invalid_base32key ... ok
Dec 15 00:22:22.548 INFO [stdout] test otp::hotp::tests::test_invalid_hexkey ... ok
Dec 15 00:22:22.548 INFO [stdout] test otp::hotp::tests::test_valid_sha256_code ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::hotp::tests::test_invalid_output_base ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::hotp::tests::test_invalid_sha256_code ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_invalid_hexkey ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_big_result_base10 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_big_result_base64 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_empty_code ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_invalid_base32key ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_invalid_code ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_bad_code ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_nokey ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_result_ok_base10 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_result_ok_base64 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha1 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_totp_asciikeu_full ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::hotp::tests::test_valid_sha512_code ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_small_result_base10 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_small_result_base64 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_totp_keu_full ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha256 ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_totp_kexkey_simple ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_totp_key_simple ... ok
Dec 15 00:22:22.549 INFO [stdout] test otp::totp::tests::test_valid_code ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::totp::tests::test_rfc6238_examples_sha512 ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::totp::tests::test_totp_asciikey_simple ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::totp::tests::test_totp_base32key_simple ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::totp::tests::test_totp_hexkey_full ... ok
Dec 15 00:22:22.550 INFO [stdout] test otp::totp::tests::test_totp_base32key_full ... ok
Dec 15 00:22:22.550 INFO [stdout] 
Dec 15 00:22:22.550 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:22:22.550 INFO [stdout] 
Dec 15 00:22:22.550 INFO [stderr]    Doc-tests r2fa
Dec 15 00:22:23.967 INFO [stdout] 
Dec 15 00:22:23.967 INFO [stdout] running 12 tests
Dec 15 00:22:29.979 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 148) ... ok
Dec 15 00:22:30.055 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTP::generate (line 46) ... ok
Dec 15 00:22:30.559 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 157) ... ok
Dec 15 00:22:31.891 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 167) ... ok
Dec 15 00:22:32.875 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTP::generate (line 77) ... ok
Dec 15 00:22:33.272 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTP::is_valid (line 74) ... ok
Dec 15 00:22:33.723 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTPBuilder (line 177) ... ok
Dec 15 00:22:33.723 INFO [stdout] test src/otp/hotp.rs - otp::hotp::HOTP::is_valid (line 119) ... ok
Dec 15 00:22:35.823 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 111) ... ok
Dec 15 00:22:36.288 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 102) ... ok
Dec 15 00:22:36.288 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 129) ... ok
Dec 15 00:22:36.678 INFO [stdout] test src/otp/totp.rs - otp::totp::TOTPBuilder (line 120) ... ok
Dec 15 00:22:36.678 INFO [stdout] 
Dec 15 00:22:36.678 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 00:22:36.678 INFO [stdout] 
Dec 15 00:22:36.694 INFO [stderr] su: No module specific data is present
Dec 15 00:22:37.025 INFO running `"docker" "inspect" "fa0bf66332e465376d75aa263b094f6a78390f8f9a842c9a9f8a1aac9c13c735"`
Dec 15 00:22:37.128 INFO running `"docker" "rm" "-f" "fa0bf66332e465376d75aa263b094f6a78390f8f9a842c9a9f8a1aac9c13c735"`
Dec 15 00:22:37.299 INFO [stdout] fa0bf66332e465376d75aa263b094f6a78390f8f9a842c9a9f8a1aac9c13c735