Dec 15 20:49:29.560 INFO testing boringauth-0.7.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 20:49:29.560 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 20:49:29.794 INFO [stdout] 7e4eee7521f0c14a5472fcb704de585d313ac92e34d7a675554ddb161ee2dfdf
Dec 15 20:49:29.797 INFO running `"docker" "start" "-a" "7e4eee7521f0c14a5472fcb704de585d313ac92e34d7a675554ddb161ee2dfdf"`
Dec 15 20:49:30.318 INFO [stderr] usermod: no changes
Dec 15 20:49:30.406 INFO [stderr]    Compiling boringauth v0.7.0 (/source)
Dec 15 20:49:32.713 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.38s
Dec 15 20:49:32.716 INFO [stderr] su: No module specific data is present
Dec 15 20:49:33.076 INFO running `"docker" "inspect" "7e4eee7521f0c14a5472fcb704de585d313ac92e34d7a675554ddb161ee2dfdf"`
Dec 15 20:49:33.203 INFO running `"docker" "rm" "-f" "7e4eee7521f0c14a5472fcb704de585d313ac92e34d7a675554ddb161ee2dfdf"`
Dec 15 20:49:33.367 INFO [stdout] 7e4eee7521f0c14a5472fcb704de585d313ac92e34d7a675554ddb161ee2dfdf
Dec 15 20:49:33.369 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 20:49:33.666 INFO [stdout] 7c51816a5c559e982d39467321a94862455281083f61d42e30c54e7179780951
Dec 15 20:49:33.668 INFO running `"docker" "start" "-a" "7c51816a5c559e982d39467321a94862455281083f61d42e30c54e7179780951"`
Dec 15 20:49:34.406 INFO [stderr] usermod: no changes
Dec 15 20:49:34.483 INFO [stderr]    Compiling boringauth v0.7.0 (/source)
Dec 15 20:49:37.906 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.46s
Dec 15 20:49:37.910 INFO [stderr] su: No module specific data is present
Dec 15 20:49:38.331 INFO running `"docker" "inspect" "7c51816a5c559e982d39467321a94862455281083f61d42e30c54e7179780951"`
Dec 15 20:49:38.448 INFO running `"docker" "rm" "-f" "7c51816a5c559e982d39467321a94862455281083f61d42e30c54e7179780951"`
Dec 15 20:49:38.751 INFO [stdout] 7c51816a5c559e982d39467321a94862455281083f61d42e30c54e7179780951
Dec 15 20:49:38.752 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 20:49:39.133 INFO [stdout] 8a4b879a937271710403b441e77c711757bd3510e662b4ea6996293769a5cdf4
Dec 15 20:49:39.136 INFO running `"docker" "start" "-a" "8a4b879a937271710403b441e77c711757bd3510e662b4ea6996293769a5cdf4"`
Dec 15 20:49:39.974 INFO [stderr] usermod: no changes
Dec 15 20:49:40.075 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Dec 15 20:49:40.077 INFO [stderr]      Running /target/debug/deps/boringauth-91cb1b3e4d41bddc
Dec 15 20:49:40.084 INFO [stdout] 
Dec 15 20:49:40.084 INFO [stdout] running 70 tests
Dec 15 20:49:40.084 INFO [stdout] test oath::hotp::tests::test_bad_code ... ok
Dec 15 20:49:40.084 INFO [stdout] test oath::hotp::tests::test_big_result_base10 ... ok
Dec 15 20:49:40.084 INFO [stdout] test oath::hotp::tests::test_empty_code ... ok
Dec 15 20:49:40.084 INFO [stdout] test oath::hotp::tests::test_empty_output_base ... ok
Dec 15 20:49:40.084 INFO [stdout] test oath::hotp::tests::test_big_result_base64 ... ok
Dec 15 20:49:40.091 INFO [stdout] test oath::hotp::tests::test_hotp_asciikey_full ... ok
Dec 15 20:49:40.091 INFO [stdout] test oath::hotp::tests::test_hotp_asciikey_simple ... ok
Dec 15 20:49:40.091 INFO [stdout] test oath::hotp::tests::test_invalid_hexkey ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_hotp_base32key_full ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_hotp_base32key_simple ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_hotp_hexkey_full ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_hotp_hexkey_simple ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_invalid_base32key ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_invalid_output_base ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_invalid_sha1_code ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_invalid_sha256_code ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_hotp_key_simple ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_hotp_key_full ... ok
Dec 15 20:49:40.096 INFO [stdout] test oath::hotp::tests::test_nokey ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::hotp::tests::test_small_result_base10 ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::hotp::tests::test_result_ok_base64 ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::hotp::tests::test_result_ok_base10 ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::hotp::tests::test_invalid_sha512_code ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::hotp::tests::test_rfc4226_examples ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::totp::tests::test_big_result_base10 ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::totp::tests::test_big_result_base64 ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::totp::tests::test_empty_code ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::totp::tests::test_invalid_code ... ok
Dec 15 20:49:40.102 INFO [stdout] test oath::totp::tests::test_invalid_hexkey ... ok
Dec 15 20:49:40.107 INFO [stdout] test oath::hotp::tests::test_small_result_base64 ... ok
Dec 15 20:49:40.107 INFO [stdout] test oath::hotp::tests::test_valid_sha256_code ... ok
Dec 15 20:49:40.107 INFO [stdout] test oath::hotp::tests::test_valid_sha1_code ... ok
Dec 15 20:49:40.107 INFO [stdout] test oath::totp::tests::test_invalid_base32key ... ok
Dec 15 20:49:40.116 INFO [stdout] test oath::hotp::tests::test_valid_sha512_code ... ok
Dec 15 20:49:40.116 INFO [stdout] test oath::totp::tests::test_negative_tolerance ... ok
Dec 15 20:49:40.116 INFO [stdout] test oath::totp::tests::test_bad_code ... ok
Dec 15 20:49:40.123 INFO [stdout] test oath::totp::tests::test_result_ok_base10 ... ok
Dec 15 20:49:40.123 INFO [stdout] test oath::totp::tests::test_result_ok_base64 ... ok
Dec 15 20:49:40.123 INFO [stdout] test oath::totp::tests::test_small_result_base10 ... ok
Dec 15 20:49:40.131 INFO [stdout] test oath::totp::tests::test_totp_asciikeu_full ... ok
Dec 15 20:49:40.131 INFO [stdout] test oath::totp::tests::test_rfc6238_examples_sha1 ... ok
Dec 15 20:49:40.131 INFO [stdout] test oath::totp::tests::test_rfc6238_examples_sha256 ... ok
Dec 15 20:49:40.131 INFO [stdout] test oath::totp::tests::test_rfc6238_examples_sha512 ... ok
Dec 15 20:49:40.131 INFO [stdout] test oath::totp::tests::test_small_result_base64 ... ok
Dec 15 20:49:40.131 INFO [stdout] test oath::totp::tests::test_totp_hexkey_full ... ok
Dec 15 20:49:40.131 INFO [stdout] test oath::totp::tests::test_totp_asciikey_simple ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_positive_tolerance ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_nokey ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_totp_keu_full ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_totp_base32key_simple ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_totp_base32key_full ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_tolerance ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_totp_kexkey_simple ... ok
Dec 15 20:49:40.151 INFO [stdout] test parser::hex::tests::test_invalid_size ... ok
Dec 15 20:49:40.151 INFO [stdout] test parser::hex::tests::test_no_data ... ok
Dec 15 20:49:40.151 INFO [stdout] test parser::hex::tests::test_invalid_data ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_valid_code ... ok
Dec 15 20:49:40.151 INFO [stdout] test oath::totp::tests::test_totp_key_simple ... ok
Dec 15 20:49:40.179 INFO [stdout] test parser::hex::tests::test_valid_data ... ok
Dec 15 20:49:40.527 INFO [stdout] test pass::tests::test_empty_password_deriv ... ok
Dec 15 20:49:40.528 INFO [stdout] test pass::tests::test_short_password_deriv ... ok
Dec 15 20:49:40.915 INFO [stdout] test pass::tests::test_empty_password_validation ... ok
Dec 15 20:49:41.403 INFO [stdout] test pass::tests::test_short_password_validation ... ok
Dec 15 20:49:41.768 INFO [stdout] test pass::tests::test_default_derivation ... ok
Dec 15 20:49:42.207 INFO [stdout] test pass::tests::test_format_without_salt ... ok
Dec 15 20:49:43.195 INFO [stdout] test pass::tests::test_random_salt ... ok
Dec 15 20:49:45.396 INFO [stdout] test pass::tests::test_password_with_null_byte ... ok
Dec 15 20:49:45.667 INFO [stdout] test pass::tests::test_format_with_salt ... ok
Dec 15 20:49:50.502 INFO [stdout] test pass::tests::test_utf8_passwords ... ok
Dec 15 20:49:55.118 INFO [stderr]    Doc-tests boringauth
Dec 15 20:49:55.118 INFO [stdout] test pass::tests::test_algos ... ok
Dec 15 20:49:55.118 INFO [stdout] 
Dec 15 20:49:55.118 INFO [stdout] test result: ok. 70 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 20:49:55.118 INFO [stdout] 
Dec 15 20:49:56.932 INFO [stdout] 
Dec 15 20:49:56.932 INFO [stdout] running 16 tests
Dec 15 20:50:07.887 INFO [stdout] test src/oath/hotp.rs - oath::hotp::HOTPBuilder (line 213) ... ok
Dec 15 20:50:08.323 INFO [stdout] test src/oath/hotp.rs - oath::hotp::HOTP::generate (line 120) ... ok
Dec 15 20:50:08.726 INFO [stdout] test src/oath/hotp.rs - oath::hotp::HOTPBuilder (line 193) ... ok
Dec 15 20:50:09.223 INFO [stdout] test src/oath/totp.rs - oath::totp::TOTP::generate (line 90) ... ok
Dec 15 20:50:10.163 INFO [stdout] test src/oath/hotp.rs - oath::hotp::HOTP::is_valid (line 156) ... ok
Dec 15 20:50:10.170 INFO [stdout] test src/oath/hotp.rs - oath::hotp::HOTPBuilder (line 184) ... ok
Dec 15 20:50:10.671 INFO [stdout] test src/oath/totp.rs - oath::totp::TOTP::is_valid (line 118) ... ok
Dec 15 20:50:10.996 INFO [stdout] test src/oath/hotp.rs - oath::hotp::HOTPBuilder (line 203) ... ok
Dec 15 20:50:18.039 INFO [stdout] test src/oath/totp.rs - oath::totp::TOTPBuilder (line 162) ... ok
Dec 15 20:50:18.413 INFO [stdout] test src/oath/totp.rs - oath::totp::TOTPBuilder (line 171) ... ok
Dec 15 20:50:19.543 INFO [stdout] test src/oath/totp.rs - oath::totp::TOTPBuilder (line 153) ... ok
Dec 15 20:50:19.911 INFO [stdout] test src/pass/mod.rs - pass::is_valid (line 388) ... ok
Dec 15 20:50:20.071 INFO [stdout] test src/oath/totp.rs - oath::totp::TOTPBuilder (line 180) ... ok
Dec 15 20:50:20.517 INFO [stdout] test src/pass/mod.rs - pass::is_valid (line 381) ... ok
Dec 15 20:50:20.659 INFO [stdout] test src/pass/mod.rs - pass::derive_password (line 344) ... ok
Dec 15 20:50:21.863 INFO [stdout] test src/pass/mod.rs - pass (line 120) ... ok
Dec 15 20:50:21.863 INFO [stdout] 
Dec 15 20:50:21.863 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 20:50:21.863 INFO [stdout] 
Dec 15 20:50:21.895 INFO [stderr] su: No module specific data is present
Dec 15 20:50:22.146 INFO running `"docker" "inspect" "8a4b879a937271710403b441e77c711757bd3510e662b4ea6996293769a5cdf4"`
Dec 15 20:50:22.237 INFO running `"docker" "rm" "-f" "8a4b879a937271710403b441e77c711757bd3510e662b4ea6996293769a5cdf4"`
Dec 15 20:50:22.382 INFO [stdout] 8a4b879a937271710403b441e77c711757bd3510e662b4ea6996293769a5cdf4