[INFO] cloning repository https://github.com/rubberduck203/cryptopals-challenges
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/rubberduck203/cryptopals-challenges" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frubberduck203%2Fcryptopals-challenges", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frubberduck203%2Fcryptopals-challenges'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 22317fde2c5029601e86e5353ce2a9e3d3383866
[INFO] testing rubberduck203/cryptopals-challenges against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frubberduck203%2Fcryptopals-challenges" "/workspace/builds/worker-93/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-93/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/rubberduck203/cryptopals-challenges on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/rubberduck203/cryptopals-challenges
[INFO] finished tweaking git repo https://github.com/rubberduck203/cryptopals-challenges
[INFO] tweaked toml for git repo https://github.com/rubberduck203/cryptopals-challenges written to /workspace/builds/worker-93/source/Cargo.toml
[INFO] crate git repo https://github.com/rubberduck203/cryptopals-challenges already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 528b6f24f1823ab700a1bf2d164c44f0a79a53f9a6921ca1d2394e5b4ce1f220
[INFO] running `Command { std: "docker" "start" "-a" "528b6f24f1823ab700a1bf2d164c44f0a79a53f9a6921ca1d2394e5b4ce1f220", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "528b6f24f1823ab700a1bf2d164c44f0a79a53f9a6921ca1d2394e5b4ce1f220", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "528b6f24f1823ab700a1bf2d164c44f0a79a53f9a6921ca1d2394e5b4ce1f220", kill_on_drop: false }`
[INFO] [stdout] 528b6f24f1823ab700a1bf2d164c44f0a79a53f9a6921ca1d2394e5b4ce1f220
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 07941b33b26f1b35f4ceebad80d2490d34776346dd870658b1f4a4ca559b576b
[INFO] running `Command { std: "docker" "start" "-a" "07941b33b26f1b35f4ceebad80d2490d34776346dd870658b1f4a4ca559b576b", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling safemem v0.3.0
[INFO] [stderr]    Compiling byteorder v1.2.6
[INFO] [stderr]    Compiling cryptopals v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling base64 v0.9.3
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 07s
[INFO] running `Command { std: "docker" "inspect" "07941b33b26f1b35f4ceebad80d2490d34776346dd870658b1f4a4ca559b576b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "07941b33b26f1b35f4ceebad80d2490d34776346dd870658b1f4a4ca559b576b", kill_on_drop: false }`
[INFO] [stdout] 07941b33b26f1b35f4ceebad80d2490d34776346dd870658b1f4a4ca559b576b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 53b5cdfe2ef4b2d6f87d89cb19e1883ee925a703a42222c9460e803e75758157
[INFO] running `Command { std: "docker" "start" "-a" "53b5cdfe2ef4b2d6f87d89cb19e1883ee925a703a42222c9460e803e75758157", kill_on_drop: false }`
[INFO] [stderr]    Compiling cryptopals v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.21s
[INFO] running `Command { std: "docker" "inspect" "53b5cdfe2ef4b2d6f87d89cb19e1883ee925a703a42222c9460e803e75758157", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "53b5cdfe2ef4b2d6f87d89cb19e1883ee925a703a42222c9460e803e75758157", kill_on_drop: false }`
[INFO] [stdout] 53b5cdfe2ef4b2d6f87d89cb19e1883ee925a703a42222c9460e803e75758157
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-93/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7dc3c0ea67dcdff1e7e887db31659f5cc5ea4a883d031b745dc0fd450d15481d
[INFO] running `Command { std: "docker" "start" "-a" "7dc3c0ea67dcdff1e7e887db31659f5cc5ea4a883d031b745dc0fd450d15481d", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/cryptopals-4797a10011c447b1)
[INFO] [stdout] running 11 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/cryptopals-36e4afd6542c1a45)
[INFO] [stdout] test byte_array::tests::xor_two_equal_length_byte_arrays ... ok
[INFO] [stdout] test frequency::tests::bacon_message_is_english ... ok
[INFO] [stdout] test frequency::tests::message_with_new_line_is_english ... ok
[INFO] [stdout] test frequency::tests::message_with_unprintable_chars_is_not_english ... ok
[INFO] [stdout] test hex::tests::can_convert_hex_to_base64 ... ok
[INFO] [stdout] test hex::tests::ff_byte_hex_string_to_byte_vector ... ok
[INFO] [stdout] test frequency::tests::printable_nonsense_is_not_english ... ok
[INFO] [stdout] test frequency::tests::readable_but_incorrect_is_not_english ... ok
[INFO] [stdout] test hex::tests::multibyte_hex_string_to_byte_vector ... ok
[INFO] [stdout] test hex::tests::single_byte_hex_string_to_byte_vector ... ok
[INFO] [stdout] test hex::tests::odd_length_string_is_not_hex - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::analysis_matches_bacon_message ... ok
[INFO] [stderr]    Doc-tests cryptopals
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[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" "7dc3c0ea67dcdff1e7e887db31659f5cc5ea4a883d031b745dc0fd450d15481d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7dc3c0ea67dcdff1e7e887db31659f5cc5ea4a883d031b745dc0fd450d15481d", kill_on_drop: false }`
[INFO] [stdout] 7dc3c0ea67dcdff1e7e887db31659f5cc5ea4a883d031b745dc0fd450d15481d