[INFO] cloning repository https://github.com/iKevinY/ultra
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/iKevinY/ultra" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FiKevinY%2Fultra", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FiKevinY%2Fultra'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 5ac5ef0e0dacf199f22c6c2248467ccc6e631589
[INFO] testing iKevinY/ultra against try#ecabaf78506b7a4668d42dc20268c086b93f0fad for pr-87041
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FiKevinY%2Fultra" "/workspace/builds/worker-10/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-10/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/iKevinY/ultra on toolchain ecabaf78506b7a4668d42dc20268c086b93f0fad
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/iKevinY/ultra
[INFO] finished tweaking git repo https://github.com/iKevinY/ultra
[INFO] tweaked toml for git repo https://github.com/iKevinY/ultra written to /workspace/builds/worker-10/source/Cargo.toml
[INFO] crate git repo https://github.com/iKevinY/ultra already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded ordered-float v2.1.1
[INFO] [stderr]   Downloaded cast v0.2.5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b7beeae09b20e54ed0fb99a383888293bee396a0cd11cbdf4c0c5ba02df93a81
[INFO] running `Command { std: "docker" "start" "-a" "b7beeae09b20e54ed0fb99a383888293bee396a0cd11cbdf4c0c5ba02df93a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b7beeae09b20e54ed0fb99a383888293bee396a0cd11cbdf4c0c5ba02df93a81", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b7beeae09b20e54ed0fb99a383888293bee396a0cd11cbdf4c0c5ba02df93a81", kill_on_drop: false }`
[INFO] [stdout] b7beeae09b20e54ed0fb99a383888293bee396a0cd11cbdf4c0c5ba02df93a81
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8a6557cde9c038ed55e3206c70fd054815f130cab00df58d70d663b40da51b06
[INFO] running `Command { std: "docker" "start" "-a" "8a6557cde9c038ed55e3206c70fd054815f130cab00df58d70d663b40da51b06", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.93
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling getrandom v0.2.2
[INFO] [stderr]    Compiling rayon-core v1.9.0
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling crossbeam-utils v0.8.3
[INFO] [stderr]    Compiling memoffset v0.6.3
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling rayon v1.5.0
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling itertools v0.10.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.3
[INFO] [stderr]    Compiling crossbeam-channel v0.5.1
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling crossbeam-deque v0.8.0
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling rand_core v0.6.2
[INFO] [stderr]    Compiling rand_chacha v0.3.0
[INFO] [stderr]    Compiling rand v0.8.3
[INFO] [stderr]    Compiling ordered-float v2.1.1
[INFO] [stderr]    Compiling ultra v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [optimized + debuginfo] target(s) in 22.99s
[INFO] running `Command { std: "docker" "inspect" "8a6557cde9c038ed55e3206c70fd054815f130cab00df58d70d663b40da51b06", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8a6557cde9c038ed55e3206c70fd054815f130cab00df58d70d663b40da51b06", kill_on_drop: false }`
[INFO] [stdout] 8a6557cde9c038ed55e3206c70fd054815f130cab00df58d70d663b40da51b06
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] fafa5f00a70daf6dc9a1d81770d1a0befef8f587733889572ea8cd2f4d49e42c
[INFO] running `Command { std: "docker" "start" "-a" "fafa5f00a70daf6dc9a1d81770d1a0befef8f587733889572ea8cd2f4d49e42c", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.125
[INFO] [stderr]    Compiling semver-parser v0.7.0
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling proc-macro2 v1.0.26
[INFO] [stderr]    Compiling memchr v2.3.4
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling itoa v0.4.7
[INFO] [stderr]    Compiling syn v1.0.69
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling plotters-backend v0.3.0
[INFO] [stderr]    Compiling serde_derive v1.0.125
[INFO] [stderr]    Compiling half v1.7.1
[INFO] [stderr]    Compiling regex-syntax v0.6.23
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling oorandom v11.1.3
[INFO] [stderr]    Compiling serde_json v1.0.64
[INFO] [stderr]    Compiling itertools v0.9.0
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling regex-automata v0.1.9
[INFO] [stderr]    Compiling plotters-svg v0.3.0
[INFO] [stderr]    Compiling semver v0.9.0
[INFO] [stderr]    Compiling plotters v0.3.0
[INFO] [stderr]    Compiling rustc_version v0.2.3
[INFO] [stderr]    Compiling csv-core v0.1.10
[INFO] [stderr]    Compiling cast v0.2.5
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling criterion-plot v0.4.3
[INFO] [stderr]    Compiling regex v1.4.5
[INFO] [stderr]    Compiling bstr v0.2.15
[INFO] [stderr]    Compiling serde_cbor v0.11.1
[INFO] [stderr]    Compiling csv v1.1.6
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.3.4
[INFO] [stderr]    Compiling ultra v0.6.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [optimized + debuginfo] target(s) in 1m 17s
[INFO] running `Command { std: "docker" "inspect" "fafa5f00a70daf6dc9a1d81770d1a0befef8f587733889572ea8cd2f4d49e42c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fafa5f00a70daf6dc9a1d81770d1a0befef8f587733889572ea8cd2f4d49e42c", kill_on_drop: false }`
[INFO] [stdout] fafa5f00a70daf6dc9a1d81770d1a0befef8f587733889572ea8cd2f4d49e42c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a1efd28a197aa87a62b3551ad815eaa4205366376fce46c80a9d4274d8d57daf
[INFO] running `Command { std: "docker" "start" "-a" "a1efd28a197aa87a62b3551ad815eaa4205366376fce46c80a9d4274d8d57daf", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stdout] 
[INFO] [stderr]     Finished test [optimized + debuginfo] target(s) in 0.42s
[INFO] [stdout] running 25 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/ultra-b43ad1250f5b1bb9)
[INFO] [stdout] test enigma::tests::identical_from_same_seed ... ok
[INFO] [stdout] test rotor::tests::inverse_mapping ... ok
[INFO] [stdout] test rotor::tests::key_setting ... ok
[INFO] [stdout] test plugboard::tests::multiple_connections ... ok
[INFO] [stdout] test rotor::tests::matching_inverses ... ok
[INFO] [stdout] test plugboard::tests::no_connections ... ok
[INFO] [stdout] test plugboard::tests::single_connection ... ok
[INFO] [stdout] test rotor::tests::reset_rotor ... ok
[INFO] [stdout] test reflector::tests::char_reflection ... ok
[INFO] [stdout] test rotor::tests::ring_setting ... ok
[INFO] [stdout] test enigma::tests::case_insensitive_encryption ... ok
[INFO] [stdout] test rotor::tests::char_substitution ... ok
[INFO] [stdout] test fitness::tests::sensible_ioc_scores ... ok
[INFO] [stdout] test enigma::tests::key_settings ... ok
[INFO] [stdout] test decrypt::tests::static_vars ... ok
[INFO] [stdout] test rotor::tests::step_inverse ... ok
[INFO] [stdout] test rotor::tests::step_rotor ... ok
[INFO] [stdout] test enigma::tests::symmetrical_behaviour ... ok
[INFO] [stdout] test enigma::tests::ring_settings ... ok
[INFO] [stdout] test enigma::tests::repetition_period ... ok
[INFO] [stdout] test rotor::tests::invalid_rotor - should panic ... ok
[INFO] [stdout] test enigma::tests::invalid_rotor_count - should panic ... ok
[INFO] [stdout] test fitness::tests::invalid_qgram_check - should panic ... ok
[INFO] [stdout] test fitness::tests::sensible_ngram_scores ... ok
[INFO] [stdout] test fitness::tests::quadgram_estimates ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/decrypt.rs (/opt/rustwide/target/debug/deps/decrypt-0767d72538a6304d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test two_cities_decryption ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 42.66s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/encrypt.rs (/opt/rustwide/target/debug/deps/encrypt-256eed1503b260ed)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/texts.rs (/opt/rustwide/target/debug/deps/texts-26c7258a7469978a)
[INFO] [stdout] running 2 tests
[INFO] [stdout] test turnover_points ... ok
[INFO] [stdout] test expected_ciphertext ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[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] [stderr]    Doc-tests ultra
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::rotor_list (line 205) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::new (line 36) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::plugboard (line 251) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::ring_settings (line 235) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::reset (line 180) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::random_from_u64_seed (line 83) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::key_settings (line 219) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::random (line 68) ... ok
[INFO] [stdout] test src/enigma.rs - enigma::Enigma::encrypt (line 127) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.86s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a1efd28a197aa87a62b3551ad815eaa4205366376fce46c80a9d4274d8d57daf", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a1efd28a197aa87a62b3551ad815eaa4205366376fce46c80a9d4274d8d57daf", kill_on_drop: false }`
[INFO] [stdout] a1efd28a197aa87a62b3551ad815eaa4205366376fce46c80a9d4274d8d57daf