[INFO] fetching crate chidori-pow 0.2.0...
[INFO] testing chidori-pow-0.2.0 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate chidori-pow 0.2.0 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate chidori-pow 0.2.0
[INFO] finished tweaking crates.io crate chidori-pow 0.2.0
[INFO] tweaked toml for crates.io crate chidori-pow 0.2.0 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate chidori-pow 0.2.0 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate chidori-pow 0.2.0 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" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded num-bigint v0.5.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c
[INFO] running `Command { std: "docker" "start" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling semver v1.0.28
[INFO] [stderr]    Compiling signature v3.0.0
[INFO] [stderr]    Compiling zeroize v1.9.0
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling base64 v0.23.1
[INFO] [stderr]    Compiling libc v0.2.189
[INFO] [stderr]    Compiling digest v0.11.3
[INFO] [stderr]    Compiling syn v2.0.119
[INFO] [stderr]    Compiling chacha20 v0.10.1
[INFO] [stderr]    Compiling num-integer v0.1.47
[INFO] [stderr]    Compiling ed25519 v3.0.0
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling curve25519-dalek v5.0.0
[INFO] [stderr]    Compiling num-bigint v0.5.1
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling rand v0.10.2
[INFO] [stderr]    Compiling curve25519-dalek-derive v0.1.1
[INFO] [stderr]    Compiling ed25519-dalek v3.0.0
[INFO] [stderr]    Compiling chidori-pow v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 9.16s
[INFO] running `Command { std: "docker" "inspect" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling chidori-pow v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.37s
[INFO] running `Command { std: "docker" "inspect" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/chidori_pow-b00c5f843c9a85ba)
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test rsa::tests::test_generate_retries_equal_factors ... ok
[INFO] [stdout] test rsa::tests::test_derive_base_handles_invalid_modulus ... ok
[INFO] [stdout] test prime::tests::test_random_biguint_range_handles_empty_range ... ok
[INFO] [stdout] test prime::tests::test_generate_prime_mod_3_4 ... ok
[INFO] [stdout] test prime::tests::test_is_probably_prime_composites ... ok
[INFO] [stdout] test tests::test_builder_clamps_work_limits ... ok
[INFO] [stdout] test rsa::tests::test_crt_verification_matches_solver_across_block_boundaries ... ok
[INFO] [stdout] test tests::test_challenge_tickets ... ok
[INFO] [stdout] test rsa::tests::test_schedule_changes_solution ... ok
[INFO] [stdout] test prime::tests::test_is_probably_prime has been running for over 60 seconds
[INFO] [stdout] test rsa::tests::test_binding_data_is_bound has been running for over 60 seconds
[INFO] [stdout] test rsa::tests::test_rsa_trapdoor has been running for over 60 seconds
[INFO] [stdout] test tests::test_builder_helpers has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_binding_data_is_bound has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_binding_data_mismatch has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_expired has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_incorrect has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_invalid_challenge has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_invalid_data has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_invalid_signature has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_previous_ticket_reuse_attack has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_reuse_attack has been running for over 60 seconds
[INFO] [stdout] test prime::tests::test_is_probably_prime ... ok
[INFO] [stdout] test tests::test_generate_factors_retries_until_valid_pair ... ok
[INFO] [stdout] test tests::test_invalid_factors_fail_build ... ok
[INFO] [stdout] test tests::test_challenge_too_far_in_future has been running for over 60 seconds
[INFO] [stdout] test tests::test_default_difficulty has been running for over 60 seconds
[INFO] [stdout] test tests::test_issue_challenge_reports_serialize_error has been running for over 60 seconds
[INFO] [stdout] test tests::test_issue_challenge_reports_serialize_error ... ok
[INFO] [stdout] test tests::test_default_difficulty ... ok
[INFO] [stdout] test tests::test_modulus_bits_are_configurable has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_incorrect ... ok
[INFO] [stdout] test tests::test_builder_helpers ... ok
[INFO] [stdout] test tests::test_public_errors_implement_error ... ok
[INFO] [stdout] test tests::test_puzzle_codec_is_strict_and_versioned ... ok
[INFO] [stdout] test tests::test_puzzle_codec_properties ... ok
[INFO] [stdout] test tests::test_challenge_expired ... ok
[INFO] [stdout] test tests::test_modulus_bits_have_minimum has been running for over 60 seconds
[INFO] [stdout] test tests::test_modulus_bits_are_configurable ... ok
[INFO] [stdout] test rsa::tests::test_rsa_trapdoor ... ok
[INFO] [stdout] test tests::test_solve_rejects_implausible_payload ... ok
[INFO] [stdout] test tests::test_solve_rejects_malformed_inputs ... ok
[INFO] [stdout] test tests::test_challenge_invalid_challenge ... ok
[INFO] [stdout] test tests::test_challenge_previous_ticket_reuse_attack ... ok
[INFO] [stdout] test tests::test_poisoned_locks_fail_closed has been running for over 60 seconds
[INFO] [stdout] test tests::test_replay_check_remains_atomic_against_rotation has been running for over 60 seconds
[INFO] [stdout] test tests::test_rotation_rechecks_after_write_lock has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_binding_data_mismatch ... ok
[INFO] [stdout] test tests::test_server_rejects_signed_policy_violations ... ok
[INFO] [stdout] test tests::test_rotation_rechecks_after_write_lock ... ok
[INFO] [stdout] test tests::test_ticket_cache_capacity_fails_closed has been running for over 60 seconds
[INFO] [stdout] test tests::test_challenge_too_far_in_future ... ok
[INFO] [stdout] test tests::test_replay_check_remains_atomic_against_rotation ... ok
[INFO] [stdout] test tests::test_challenge_binding_data_is_bound ... ok
[INFO] [stdout] test tests::test_challenge ... ok
[INFO] [stdout] test tests::test_ticket_cache_capacity_fails_closed ... ok
[INFO] [stdout] test tests::test_challenge_reuse_attack ... ok
[INFO] [stdout] test tests::test_challenge_invalid_signature ... ok
[INFO] [stdout] test tests::test_poisoned_locks_fail_closed ... ok
[INFO] [stdout] test rsa::tests::test_binding_data_is_bound ... ok
[INFO] [stdout] test tests::test_modulus_bits_have_minimum ... ok
[INFO] [stdout] test tests::test_challenge_invalid_data ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 633.72s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests chidori_pow
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/../README.md - (line 71) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.66s; merged doctests compilation took 0.65s
[INFO] running `Command { std: "docker" "inspect" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c", kill_on_drop: false }`
[INFO] [stdout] 32c4dda47c2fe0d22ce2fb76bed0df55f9a3cfd753e55fb7fd32654df700d63c
