Dec 15 03:05:33.768 INFO testing oath-0.10.2 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 03:05:33.768 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 03:05:34.035 INFO [stdout] a123c8e519a87c913fd16ef2f6b46c5c091fcabd60abf9b3664596fb76cd2396
Dec 15 03:05:34.037 INFO running `"docker" "start" "-a" "a123c8e519a87c913fd16ef2f6b46c5c091fcabd60abf9b3664596fb76cd2396"`
Dec 15 03:05:34.598 INFO [stderr] usermod: no changes
Dec 15 03:05:34.696 INFO [stderr]    Compiling oath v0.10.2 (/source)
Dec 15 03:05:36.695 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.06s
Dec 15 03:05:36.695 INFO [stderr] su: No module specific data is present
Dec 15 03:05:37.492 INFO running `"docker" "inspect" "a123c8e519a87c913fd16ef2f6b46c5c091fcabd60abf9b3664596fb76cd2396"`
Dec 15 03:05:37.727 INFO running `"docker" "rm" "-f" "a123c8e519a87c913fd16ef2f6b46c5c091fcabd60abf9b3664596fb76cd2396"`
Dec 15 03:05:38.015 INFO [stdout] a123c8e519a87c913fd16ef2f6b46c5c091fcabd60abf9b3664596fb76cd2396
Dec 15 03:05:38.017 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 03:05:38.562 INFO [stdout] cde60b8c61c7b4732c32c7ad8d2669ff20d89fdac6443ed807f500ec166ca1f9
Dec 15 03:05:38.564 INFO running `"docker" "start" "-a" "cde60b8c61c7b4732c32c7ad8d2669ff20d89fdac6443ed807f500ec166ca1f9"`
Dec 15 03:05:39.974 INFO [stderr] usermod: no changes
Dec 15 03:05:40.087 INFO [stderr]    Compiling oath v0.10.2 (/source)
Dec 15 03:05:43.455 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.45s
Dec 15 03:05:43.458 INFO [stderr] su: No module specific data is present
Dec 15 03:05:44.195 INFO running `"docker" "inspect" "cde60b8c61c7b4732c32c7ad8d2669ff20d89fdac6443ed807f500ec166ca1f9"`
Dec 15 03:05:44.463 INFO running `"docker" "rm" "-f" "cde60b8c61c7b4732c32c7ad8d2669ff20d89fdac6443ed807f500ec166ca1f9"`
Dec 15 03:05:44.739 INFO [stdout] cde60b8c61c7b4732c32c7ad8d2669ff20d89fdac6443ed807f500ec166ca1f9
Dec 15 03:05:44.744 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 03:05:45.291 INFO [stdout] 5005e6930ce0a45d1cae6d6a10cd7531cec4e04bcbbe64e67df6988782bd4daa
Dec 15 03:05:45.293 INFO running `"docker" "start" "-a" "5005e6930ce0a45d1cae6d6a10cd7531cec4e04bcbbe64e67df6988782bd4daa"`
Dec 15 03:05:46.442 INFO [stderr] usermod: no changes
Dec 15 03:05:46.547 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 15 03:05:46.555 INFO [stderr]      Running /target/debug/deps/oath-e44364e89f417eae
Dec 15 03:05:46.556 INFO [stdout] 
Dec 15 03:05:46.556 INFO [stdout] running 0 tests
Dec 15 03:05:46.556 INFO [stdout] 
Dec 15 03:05:46.556 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 03:05:46.556 INFO [stdout] 
Dec 15 03:05:46.562 INFO [stderr]      Running /target/debug/deps/lib-ef5037bbc0d291b2
Dec 15 03:05:46.563 INFO [stdout] 
Dec 15 03:05:46.564 INFO [stdout] running 12 tests
Dec 15 03:05:46.567 INFO [stdout] test sha1_pin_correct ... ok
Dec 15 03:05:46.567 INFO [stdout] test negative_tests_ocra ... ok
Dec 15 03:05:46.569 INFO [stdout] test test_hotp ... ok
Dec 15 03:05:46.569 INFO [stdout] test test_ocra_64byte_sha512 ... ok
Dec 15 03:05:46.569 INFO [stdout] test test_ocra_32byte_sha256 ... ok
Dec 15 03:05:46.571 INFO [stdout] test test_ocra_20byte_sha1 ... ok
Dec 15 03:05:46.571 INFO [stdout] test test_ocra_64byte_sha512_t ... ok
Dec 15 03:05:46.571 INFO [stdout] test test_ocra_64byte_sha512_mutual ... ok
Dec 15 03:05:46.573 INFO [stdout] test test_ocra_32byte_sha256_mutual ... ok
Dec 15 03:05:46.575 INFO [stdout] test test_ocra_32byte_sha256_signature ... ok
Dec 15 03:05:46.577 INFO [stdout] test test_ocra_64byte_sha512_signature_t ... ok
Dec 15 03:05:46.577 INFO [stdout] test test_totp ... ok
Dec 15 03:05:46.577 INFO [stdout] 
Dec 15 03:05:46.577 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 03:05:46.577 INFO [stdout] 
Dec 15 03:05:46.579 INFO [stderr]    Doc-tests oath
Dec 15 03:05:48.445 INFO [stdout] 
Dec 15 03:05:48.445 INFO [stdout] running 9 tests
Dec 15 03:05:53.927 INFO [stdout] test src/lib.rs - hotp (line 126) ... ok
Dec 15 03:05:55.775 INFO [stdout] test src/lib.rs - totp_now (line 283) ... ok
Dec 15 03:05:57.667 INFO [stdout] test src/lib.rs - hotp_raw (line 99) ... ok
Dec 15 03:05:58.023 INFO [stdout] test src/lib.rs - totp_custom (line 157) ... ok
Dec 15 03:05:58.261 INFO [stdout] test src/lib.rs - ocra_debug (line 331) ... ok
Dec 15 03:05:58.416 INFO [stdout] test src/lib.rs - totp_custom_time (line 252) ... ok
Dec 15 03:05:58.428 INFO [stdout] test src/lib.rs - from_hex (line 38) ... ok
Dec 15 03:05:58.543 INFO [stdout] test src/lib.rs - totp_raw_custom_time (line 191) ... ok
Dec 15 03:05:59.067 INFO [stdout] test src/lib.rs - totp_raw_now (line 222) ... ok
Dec 15 03:05:59.067 INFO [stdout] 
Dec 15 03:05:59.067 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 03:05:59.067 INFO [stdout] 
Dec 15 03:05:59.084 INFO [stderr] su: No module specific data is present
Dec 15 03:05:59.490 INFO running `"docker" "inspect" "5005e6930ce0a45d1cae6d6a10cd7531cec4e04bcbbe64e67df6988782bd4daa"`
Dec 15 03:05:59.576 INFO running `"docker" "rm" "-f" "5005e6930ce0a45d1cae6d6a10cd7531cec4e04bcbbe64e67df6988782bd4daa"`
Dec 15 03:05:59.673 INFO [stdout] 5005e6930ce0a45d1cae6d6a10cd7531cec4e04bcbbe64e67df6988782bd4daa