[INFO] cloning repository https://github.com/foudfou/cryptopals
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/foudfou/cryptopals" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffoudfou%2Fcryptopals", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffoudfou%2Fcryptopals'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] cc9ab543c71637e1be045fcec712274be6e54ac4
[INFO] testing foudfou/cryptopals against try#b83b707f97d809763b7861afa7638871f3339a33 for pr-145838-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffoudfou%2Fcryptopals" "/workspace/builds/worker-1-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/foudfou/cryptopals
[INFO] finished tweaking git repo https://github.com/foudfou/cryptopals
[INFO] tweaked toml for git repo https://github.com/foudfou/cryptopals written to /workspace/builds/worker-1-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/foudfou/cryptopals on toolchain b83b707f97d809763b7861afa7638871f3339a33
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/foudfou/cryptopals 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" "+b83b707f97d809763b7861afa7638871f3339a33" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 434eaccda96cb135fee2c3aaa311451b5d3d341ad82e11641e25e46fdec0ea95
[INFO] running `Command { std: "docker" "start" "-a" "434eaccda96cb135fee2c3aaa311451b5d3d341ad82e11641e25e46fdec0ea95", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "434eaccda96cb135fee2c3aaa311451b5d3d341ad82e11641e25e46fdec0ea95", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "434eaccda96cb135fee2c3aaa311451b5d3d341ad82e11641e25e46fdec0ea95", kill_on_drop: false }`
[INFO] [stdout] 434eaccda96cb135fee2c3aaa311451b5d3d341ad82e11641e25e46fdec0ea95
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 85ade4d444ba171403201a2fcc45270d626d875d7cdae192bbe53c3b4cc7e56f
[INFO] running `Command { std: "docker" "start" "-a" "85ade4d444ba171403201a2fcc45270d626d875d7cdae192bbe53c3b4cc7e56f", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling openssl v0.10.73
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling bitflags v2.9.1
[INFO] [stderr]    Compiling cc v1.2.25
[INFO] [stderr]    Compiling chrono v0.4.41
[INFO] [stderr]    Compiling getopts v0.2.21
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling num-iter v0.1.45
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling openssl-sys v0.9.109
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling num v0.4.3
[INFO] [stderr]    Compiling cryptopals v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.81s
[INFO] running `Command { std: "docker" "inspect" "85ade4d444ba171403201a2fcc45270d626d875d7cdae192bbe53c3b4cc7e56f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "85ade4d444ba171403201a2fcc45270d626d875d7cdae192bbe53c3b4cc7e56f", kill_on_drop: false }`
[INFO] [stdout] 85ade4d444ba171403201a2fcc45270d626d875d7cdae192bbe53c3b4cc7e56f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3b37b9a08275433497703ffd1619c616165078c102546958126d5e33252fed5c
[INFO] running `Command { std: "docker" "start" "-a" "3b37b9a08275433497703ffd1619c616165078c102546958126d5e33252fed5c", kill_on_drop: false }`
[INFO] [stderr]    Compiling cryptopals v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.14s
[INFO] running `Command { std: "docker" "inspect" "3b37b9a08275433497703ffd1619c616165078c102546958126d5e33252fed5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3b37b9a08275433497703ffd1619c616165078c102546958126d5e33252fed5c", kill_on_drop: false }`
[INFO] [stdout] 3b37b9a08275433497703ffd1619c616165078c102546958126d5e33252fed5c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc2/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0383426d9a6c22e06f0a2daa00241ec5b1e8c246cf141459857f29f42052768e
[INFO] running `Command { std: "docker" "start" "-a" "0383426d9a6c22e06f0a2daa00241ec5b1e8c246cf141459857f29f42052768e", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.19s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cryptopals-89cd24c106ec2718)
[INFO] [stdout] 
[INFO] [stdout] running 77 tests
[INFO] [stdout] test aes::tests::test_detect_ecb ... ok
[INFO] [stdout] test b64::tests::test_decode ... ok
[INFO] [stdout] test b64::tests::test_encode ... ok
[INFO] [stdout] test b64::tests::test_hex2bytes_fail ... ok
[INFO] [stdout] test b64::tests::test_hex2bytes_success ... ok
[INFO] [stdout] test hmac::tests::test_hmac ... ok
[INFO] [stdout] test md4::tests::test_md4 ... ok
[INFO] [stdout] test pkcs::tests::test_pkcs7_pad ... ok
[INFO] [stdout] test md4::tests::test_md_padding ... ok
[INFO] [stdout] test b64::tests::test_hex2base64 ... ok
[INFO] [stdout] test md4::tests::test_md4_collision ... ok
[INFO] [stdout] test pkcs::tests::test_pkcs7_unpad ... ok
[INFO] [stdout] test pkcs::tests::test_pkcs7_unpad_2 ... ok
[INFO] [stdout] test pkcs::tests::test_pkcs7_unpad_fail ... ok
[INFO] [stdout] test pkcs::tests::test_pkcs7_unpad_fail_3 ... ok
[INFO] [stdout] test pkcs::tests::test_pkcs7_unpad_fail_2 ... ok
[INFO] [stdout] test rng::tests::test_clone_mt19937 ... ok
[INFO] [stdout] test par::tests::test_thread_pool ... ok
[INFO] [stdout] test rng::tests::test_mt19937 ... ok
[INFO] [stdout] test rng::tests::test_reverse_lshift_and_xor ... ok
[INFO] [stdout] test rng::tests::test_reverse_rshift_xor ... ok
[INFO] [stdout] test rng::tests::test_stream_cipher ... ok
[INFO] [stdout] test rng::tests::test_untemper ... ok
[INFO] [stdout] test aes::tests::test_detect_ecb_sample ... ok
[INFO] [stdout] test rng::tests::test_crack_stream_cipher ... ok
[INFO] [stdout] test set2::chall12::tests::test_aes_128_cbc_encrypt ... ok
[INFO] [stdout] test aes::tests::test_decrypt_cbc_sample ... ok
[INFO] [stdout] test aes::tests::test_encrypt_cbc_sample ... ok
[INFO] [stdout] test set2::chall13::tests::test_profile_for_plain ... ok
[INFO] [stdout] test set2::chall13::tests::test_profile_oracle ... ok
[INFO] [stdout] test aes::tests::test_aes_128_ctr_encrypt ... ok
[INFO] [stdout] test set2::chall12::tests::test_aes_rand_detect ... ok
[INFO] [stdout] test aes::tests::test_aes_128_ecb_decrypt ... ok
[INFO] [stdout] test aes::tests::test_crack_ctr_random_access ... ok
[INFO] [stdout] test set2::chall13::tests::test_kv_parse ... ok
[INFO] [stdout] test set2::chall16::tests::test_cbc_bitflip ... ok
[INFO] [stdout] test set4::chall26::tests::test_ctr_bitflip ... ok
[INFO] [stdout] test set2::chall17::tests::test_blk_size ... ok
[INFO] [stdout] test set2::chall16::tests::test_detect_prefix_size ... ok
[INFO] [stdout] test set4::chall31::tests::test_hmac_sha1_timing_attack_artificial ... ignored
[INFO] [stdout] test set4::chall30::tests::test_md4_beak_keyed_mac_using_length_extension ... ok
[INFO] [stdout] test set4::chall27::tests::test_crack_cbc_with_iv_eq_key ... ok
[INFO] [stdout] test set5::chall34::tests::test_diffie_hellman_proto_mitm ... ok
[INFO] [stdout] test set4::chall29::tests::test_sha1_beak_keyed_mac_using_length_extension ... ok
[INFO] [stdout] test rng::tests::test_get_bits ... ok
[INFO] [stdout] test rng::tests::test_crack_password_reset_token ... ok
[INFO] [stdout] test set5::chall34::tests::test_diffie_hellman_proto_ok ... ok
[INFO] [stdout] test sha::tests::test_md_padding ... ok
[INFO] [stdout] test aes::tests::test_fixed_nonce_ctr_2 ... ok
[INFO] [stdout] test sha::tests::test_sha1_mac_verify ... ok
[INFO] [stdout] test sha::tests::test_sha256 ... ok
[INFO] [stdout] test set2::chall12::tests::test_ecb_oracle ... ok
[INFO] [stdout] test xor::tests::test_fixed_xor ... ok
[INFO] [stdout] test xor::tests::test_guess_single_byte_xor ... ok
[INFO] [stdout] test aes::tests::test_fixed_nonce_ctr ... ok
[INFO] [stdout] test set5::chall33::tests::test_diffie_hellman_impl ... ok
[INFO] [stdout] test xor::tests::test_guess_xor_keylen ... ok
[INFO] [stdout] test xor::tests::test_hamming_distance ... ok
[INFO] [stdout] test xor::tests::test_popcount ... ok
[INFO] [stdout] test xor::tests::test_xor ... ok
[INFO] [stdout] test xor::tests::test_xor2 ... ok
[INFO] [stdout] test xor::tests::test_xor_strict ... ok
[INFO] [stdout] test xor::tests::test_guess_xor_short ... ok
[INFO] [stdout] test rng::tests::test_get_bits_len_zero - should panic ... ok
[INFO] [stdout] test rng::tests::test_get_bits_too_much - should panic ... ok
[INFO] [stdout] test rng::tests::test_crack_mt19937_seed ... ok
[INFO] [stdout] test set5::chall35::tests::test_diffie_hellman_proto_pminusone ... ok
[INFO] [stdout] test set5::chall39::tests::test_rsa_impl ... ok
[INFO] [stdout] test aes::tests::test_fixed_nonce_ctr_3 ... ok
[INFO] [stdout] test xor::tests::test_guess_xor_long ... ok
[INFO] [stdout] test set2::chall14::tests::test_ecb_oracle ... ok
[INFO] [stdout] test xor::tests::test_detect_single_byte_xor ... ok
[INFO] [stdout] test set5::chall36::tests::test_srp_ok ... ok
[INFO] [stdout] test sha::tests::test_sha1 ... ok
[INFO] [stdout] test set5::chall37::tests::test_srp_zero_key ... ok
[INFO] [stdout] test set2::chall17::tests::test_cbc_padding_oracle_blk ... ok
[INFO] [stdout] test set2::chall17::tests::test_cbc_padding_oracle ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 76 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 6.27s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/cryptopals-31fbe84be4b1f199)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests cryptopals
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "0383426d9a6c22e06f0a2daa00241ec5b1e8c246cf141459857f29f42052768e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0383426d9a6c22e06f0a2daa00241ec5b1e8c246cf141459857f29f42052768e", kill_on_drop: false }`
[INFO] [stdout] 0383426d9a6c22e06f0a2daa00241ec5b1e8c246cf141459857f29f42052768e