[INFO] cloning repository https://github.com/andrewgonzales/otp
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/andrewgonzales/otp" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fandrewgonzales%2Fotp", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fandrewgonzales%2Fotp'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 35921ac806b1a508acd1f82c710274cf348b0ade
[INFO] testing andrewgonzales/otp against try#8de4c7234dd9b97c9d76b58671343fdbbc9a433e+target=x86_64-unknown-linux-musl for musl_upgrade_1_2_5_with_getrandom_patch_0
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fandrewgonzales%2Fotp" "/workspace/builds/worker-2-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/andrewgonzales/otp
[INFO] finished tweaking git repo https://github.com/andrewgonzales/otp
[INFO] tweaked toml for git repo https://github.com/andrewgonzales/otp written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/andrewgonzales/otp on toolchain 8de4c7234dd9b97c9d76b58671343fdbbc9a433e
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/andrewgonzales/otp already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 2b5d708cfcca1d4a5608070ec06abd1fcb4b5c288bd5a4192d39c61e77e784f9
[INFO] running `Command { std: "docker" "start" "-a" "2b5d708cfcca1d4a5608070ec06abd1fcb4b5c288bd5a4192d39c61e77e784f9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2b5d708cfcca1d4a5608070ec06abd1fcb4b5c288bd5a4192d39c61e77e784f9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2b5d708cfcca1d4a5608070ec06abd1fcb4b5c288bd5a4192d39c61e77e784f9", kill_on_drop: false }`
[INFO] [stdout] 2b5d708cfcca1d4a5608070ec06abd1fcb4b5c288bd5a4192d39c61e77e784f9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "build" "--frozen" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 354916526a34ff195a6036c94f062cd081e42eda0f05887eb6671ffb64ec885c
[INFO] running `Command { std: "docker" "start" "-a" "354916526a34ff195a6036c94f062cd081e42eda0f05887eb6671ffb64ec885c", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.89
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling zeroize v1.4.3
[INFO] [stderr]    Compiling heck v0.4.0
[INFO] [stderr]    Compiling constant_time_eq v0.1.5
[INFO] [stderr]    Compiling arrayref v0.3.6
[INFO] [stderr]    Compiling getrandom v0.2.5
[INFO] [stderr]    Compiling arrayvec v0.7.2
[INFO] [stderr]    Compiling dirs-sys v0.3.7
[INFO] [stderr]    Compiling os_str_bytes v6.0.0
[INFO] [stderr]    Compiling digest v0.10.3
[INFO] [stderr]    Compiling aead v0.4.3
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling textwrap v0.15.0
[INFO] [stderr]    Compiling termcolor v1.1.3
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling chacha20 v0.8.1
[INFO] [stderr]    Compiling dirs v4.0.0
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling sha2 v0.10.2
[INFO] [stderr]    Compiling sha1 v0.10.1
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling blake2b_simd v1.0.0
[INFO] [stderr]    Compiling data-encoding v2.3.2
[INFO] [stderr]    Compiling chacha20poly1305 v0.9.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling rust-argon2 v1.0.0
[INFO] [stderr]    Compiling serde_derive v1.0.136
[INFO] [stderr]    Compiling clap_derive v3.1.4
[INFO] [stderr]    Compiling clap v3.1.6
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling otp v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 22.83s
[INFO] running `Command { std: "docker" "inspect" "354916526a34ff195a6036c94f062cd081e42eda0f05887eb6671ffb64ec885c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "354916526a34ff195a6036c94f062cd081e42eda0f05887eb6671ffb64ec885c", kill_on_drop: false }`
[INFO] [stdout] 354916526a34ff195a6036c94f062cd081e42eda0f05887eb6671ffb64ec885c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--no-run" "--message-format=json" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] a6237627bc51d1fb35b18feb3c408231d439162874b372d3d3d27d264830fc93
[INFO] running `Command { std: "docker" "start" "-a" "a6237627bc51d1fb35b18feb3c408231d439162874b372d3d3d27d264830fc93", kill_on_drop: false }`
[INFO] [stderr]    Compiling otp v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.02s
[INFO] running `Command { std: "docker" "inspect" "a6237627bc51d1fb35b18feb3c408231d439162874b372d3d3d27d264830fc93", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a6237627bc51d1fb35b18feb3c408231d439162874b372d3d3d27d264830fc93", kill_on_drop: false }`
[INFO] [stdout] a6237627bc51d1fb35b18feb3c408231d439162874b372d3d3d27d264830fc93
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:90999bfc7ae267e83380e433d8e61a7c072ca6729e92edbae886d3423b3a6f4c" "/opt/rustwide/cargo-home/bin/cargo" "+8de4c7234dd9b97c9d76b58671343fdbbc9a433e" "test" "--frozen" "--target" "x86_64-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 55b58d06b0e79e4b423ac44a7a7787190c70b643d64cd394f6142e2d0af92a9d
[INFO] running `Command { std: "docker" "start" "-a" "55b58d06b0e79e4b423ac44a7a7787190c70b643d64cd394f6142e2d0af92a9d", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/x86_64-unknown-linux-musl/debug/deps/otp-c0e288e3cab09a4d)
[INFO] [stdout] 
[INFO] [stdout] running 62 tests
[INFO] [stdout] test account::tests::is_initialized_false ... ok
[INFO] [stdout] test cmd::add::tests::requires_key ... ok
[INFO] [stdout] test cmd::add::tests::requires_account_name ... ok
[INFO] [stdout] test cmd::add::tests::validates_key_encoding ... ok
[INFO] [stdout] test cmd::delete::tests::requires_account_name ... ok
[INFO] [stdout] test cmd::generate::tests::generates_a_20_byte_secret_for_hotp ... ok
[INFO] [stdout] test cmd::generate::tests::generates_a_32_byte_secret_for_totp ... ok
[INFO] [stdout] test account::tests::sets_secrets ... ok
[INFO] [stdout] test account::tests::is_initialized_true ... ok
[INFO] [stdout] test account::tests::adds_an_account ... ok
[INFO] [stdout] test cmd::add::tests::adds_an_account_with_hotp ... ok
[INFO] [stdout] test cmd::add::tests::errors_on_save_failure ... ok
[INFO] [stdout] test cmd::get::tests::requires_account_name ... ok
[INFO] [stdout] test cmd::add::tests::errors_if_account_exists ... ok
[INFO] [stdout] test cmd::init::tests::requires_pin ... ok
[INFO] [stdout] test account::tests::validates_incorrect_pin ... ok
[INFO] [stdout] test cmd::add::tests::adds_an_account ... ok
[INFO] [stdout] test cmd::get::tests::gets_hotp_for_account ... ok
[INFO] [stdout] test cmd::get::tests::gets_totp_for_account ... ok
[INFO] [stdout] test cmd::get::tests::does_not_get_when_account_does_not_exist ... ok
[INFO] [stdout] test account::tests::deletes_an_account ... ok
[INFO] [stdout] test account::tests::sets_counter_value ... ok
[INFO] [stdout] test cmd::validate::tests::requires_account_name ... ok
[INFO] [stdout] test cmd::validate::tests::requires_token ... ok
[INFO] [stdout] test cmd::get::tests::records_errors_on_save_failure ... ok
[INFO] [stdout] test cmd::delete::tests::deletes_an_account ... ok
[INFO] [stdout] test cmd::validate::tests::does_not_accept_invalid_hotp ... ok
[INFO] [stdout] test crypto::tests::generates_a_24_byte_nonce ... ok
[INFO] [stdout] test account::tests::lists_accounts ... ok
[INFO] [stdout] test hotp::tests::gets_an_otp_value ... ok
[INFO] [stdout] test hotp::tests::validate_otp_looks_ahead ... ok
[INFO] [stdout] test hotp::tests::validate_otp_returns_error_for_invalid_code ... ok
[INFO] [stdout] test hotp::tests::validates_an_otp_value ... ok
[INFO] [stdout] test main_tests::checks_for_account_store_initialized ... ok
[INFO] [stdout] test cmd::list::tests::lists_account_names ... ok
[INFO] [stdout] test totp::tests::gets_a_totp_value ... ok
[INFO] [stdout] test totp::tests::gets_moving_factor_from_system_time ... ok
[INFO] [stdout] test cmd::get::tests::increments_hotp_counter ... ok
[INFO] [stdout] test totp::tests::validate_totp_fails_when_wrong ... ok
[INFO] [stdout] test totp::tests::validate_totp_looks_ahead_and_behind ... ok
[INFO] [stdout] test cmd::validate::tests::does_not_accept_invalid_totp ... ok
[INFO] [stdout] test utils::tests::generates_a_20_byte_base32_secret ... ok
[INFO] [stdout] test utils::tests::is_base32_key_returns_ok_if_base32 ... ok
[INFO] [stdout] test utils::tests::is_base32_key_returns_error_if_not_base32 ... ok
[INFO] [stdout] test utils::tests::validate_pin_checks_pin_length ... ok
[INFO] [stdout] test totp::tests::validates_a_totp_value ... ok
[INFO] [stdout] test utils::tests::validate_pin_returns_error_if_account_store_is_not_initialized ... ok
[INFO] [stdout] test cmd::init::tests::initializes_a_new_account_store ... ok
[INFO] [stdout] test cmd::delete::tests::does_not_delete_an_account_that_does_not_exist ... ok
[INFO] [stdout] test cmd::delete::tests::records_errors_on_save_failure ... ok
[INFO] [stdout] test cmd::validate::tests::validates_totp ... ok
[INFO] [stdout] test cmd::validate::tests::errors_when_account_not_found ... ok
[INFO] [stdout] test cmd::validate::tests::validates_hotp ... ok
[INFO] [stdout] test account::tests::validates_correct_pin ... ok
[INFO] [stdout] test crypto::tests::encrypts_and_decrypts_a_string ... ok
[INFO] [stdout] test cmd::validate::tests::errors_when_token_cannot_be_parsed ... ok
[INFO] [stdout] test cmd::init::tests::returns_error_on_save_failure ... ok
[INFO] [stdout] test crypto::tests::fails_to_verify_a_password_with_wrong_hash ... ok
[INFO] [stdout] test crypto::tests::hashes_and_verifies_a_password ... ok
[INFO] [stdout] test main_tests::verifies_pin ... ok
[INFO] [stdout] test utils::tests::validate_pin_returns_ok_if_pin_is_valid ... ok
[INFO] [stdout] test utils::tests::validate_pin_returns_error_if_pin_is_invalid ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 62 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.04s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "55b58d06b0e79e4b423ac44a7a7787190c70b643d64cd394f6142e2d0af92a9d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "55b58d06b0e79e4b423ac44a7a7787190c70b643d64cd394f6142e2d0af92a9d", kill_on_drop: false }`
[INFO] [stdout] 55b58d06b0e79e4b423ac44a7a7787190c70b643d64cd394f6142e2d0af92a9d