[INFO] fetching crate osshkeys 0.5.0...
[INFO] testing osshkeys-0.5.0 against try#ce59db7a1b1b012fb2793c4641c1bdecad7a128b for pr-85530
[INFO] extracting crate osshkeys 0.5.0 into /workspace/builds/worker-1/source
[INFO] validating manifest of crates.io crate osshkeys 0.5.0 on toolchain ce59db7a1b1b012fb2793c4641c1bdecad7a128b
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate osshkeys 0.5.0
[INFO] finished tweaking crates.io crate osshkeys 0.5.0
[INFO] tweaked toml for crates.io crate osshkeys 0.5.0 written to /workspace/builds/worker-1/source/Cargo.toml
[INFO] crate crates.io crate osshkeys 0.5.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded blowfish v0.7.0
[INFO] [stderr]   Downloaded pbkdf2 v0.7.4
[INFO] [stderr]   Downloaded nom_pem v4.0.0
[INFO] [stderr]   Downloaded cryptovec v0.6.1
[INFO] [stderr]   Downloaded bcrypt-pbkdf v0.5.0
[INFO] [stderr]   Downloaded openssl-src v111.14.0+1.1.1j
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e5b62110e61c5fc8d6c8bfbb8ac3d03df4d777bd5a79115a4fc421012dc27fbd
[INFO] running `Command { std: "docker" "start" "-a" "e5b62110e61c5fc8d6c8bfbb8ac3d03df4d777bd5a79115a4fc421012dc27fbd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e5b62110e61c5fc8d6c8bfbb8ac3d03df4d777bd5a79115a4fc421012dc27fbd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e5b62110e61c5fc8d6c8bfbb8ac3d03df4d777bd5a79115a4fc421012dc27fbd", kill_on_drop: false }`
[INFO] [stdout] e5b62110e61c5fc8d6c8bfbb8ac3d03df4d777bd5a79115a4fc421012dc27fbd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a05d14231be19587d43c7ea6b9041c6a9924a929b9bbf1fb463ab17aeeab8723
[INFO] running `Command { std: "docker" "start" "-a" "a05d14231be19587d43c7ea6b9041c6a9924a929b9bbf1fb463ab17aeeab8723", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling typenum v1.13.0
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling libc v0.2.90
[INFO] [stderr]    Compiling proc-macro2 v1.0.24
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling syn v1.0.64
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling cc v1.0.67
[INFO] [stderr]    Compiling subtle v2.4.0
[INFO] [stderr]    Compiling pkg-config v0.3.19
[INFO] [stderr]    Compiling cpuid-bool v0.1.2
[INFO] [stderr]    Compiling memchr v2.3.4
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling serde v1.0.124
[INFO] [stderr]    Compiling winapi v0.3.9
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling openssl v0.10.33
[INFO] [stderr]    Compiling adler v1.0.2
[INFO] [stderr]    Compiling gimli v0.23.0
[INFO] [stderr]    Compiling signature v1.3.0
[INFO] [stderr]    Compiling once_cell v1.7.2
[INFO] [stderr]    Compiling rustc-demangle v0.1.18
[INFO] [stderr]    Compiling object v0.23.0
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling generic-array v0.14.4
[INFO] [stderr]    Compiling nom v4.2.3
[INFO] [stderr]    Compiling ed25519 v1.0.3
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling miniz_oxide v0.4.4
[INFO] [stderr]    Compiling cryptovec v0.6.1
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling nom_pem v4.0.0
[INFO] [stderr]    Compiling openssl-sys v0.9.61
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling crypto-mac v0.10.0
[INFO] [stderr]    Compiling cipher v0.2.5
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling pbkdf2 v0.7.4
[INFO] [stderr]    Compiling addr2line v0.14.1
[INFO] [stderr]    Compiling sha2 v0.9.3
[INFO] [stderr]    Compiling md-5 v0.9.1
[INFO] [stderr]    Compiling sha-1 v0.9.4
[INFO] [stderr]    Compiling blowfish v0.7.0
[INFO] [stderr]    Compiling backtrace v0.3.56
[INFO] [stderr]    Compiling synstructure v0.12.4
[INFO] [stderr]    Compiling zeroize_derive v1.0.1
[INFO] [stderr]    Compiling zeroize v1.2.0
[INFO] [stderr]    Compiling curve25519-dalek v3.0.2
[INFO] [stderr]    Compiling bcrypt-pbkdf v0.5.0
[INFO] [stderr]    Compiling ed25519-dalek v1.0.1
[INFO] [stderr]    Compiling osshkeys v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 30.24s
[INFO] running `Command { std: "docker" "inspect" "a05d14231be19587d43c7ea6b9041c6a9924a929b9bbf1fb463ab17aeeab8723", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a05d14231be19587d43c7ea6b9041c6a9924a929b9bbf1fb463ab17aeeab8723", kill_on_drop: false }`
[INFO] [stdout] a05d14231be19587d43c7ea6b9041c6a9924a929b9bbf1fb463ab17aeeab8723
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d9c76481985b0660426f8ccd8ee9a036658d5da9a5cded25a90157d490c5630b
[INFO] running `Command { std: "docker" "start" "-a" "d9c76481985b0660426f8ccd8ee9a036658d5da9a5cded25a90157d490c5630b", kill_on_drop: false }`
[INFO] [stderr]    Compiling hex-literal v0.3.1
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling osshkeys v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.98s
[INFO] running `Command { std: "docker" "inspect" "d9c76481985b0660426f8ccd8ee9a036658d5da9a5cded25a90157d490c5630b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d9c76481985b0660426f8ccd8ee9a036658d5da9a5cded25a90157d490c5630b", kill_on_drop: false }`
[INFO] [stdout] d9c76481985b0660426f8ccd8ee9a036658d5da9a5cded25a90157d490c5630b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] db686c7b1af570584619eb9de92378e6f5bef26cdcdf4c9e23999f3500e4b954
[INFO] running `Command { std: "docker" "start" "-a" "db686c7b1af570584619eb9de92378e6f5bef26cdcdf4c9e23999f3500e4b954", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/osshkeys-bf642641db3fc31c)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test format::ossh_pubkey::test::ed25519_publickey_parse_serialize ... ok
[INFO] [stdout] test format::ossh_pubkey::test::rsa256_publickey_parse_serialize ... ok
[INFO] [stdout] test format::ossh_pubkey::test::ecdsa_publickey_parse_serialize ... ok
[INFO] [stdout] test format::ossh_pubkey::test::rsa_publickey_parse_serialize ... ok
[INFO] [stdout] test format::ossh_pubkey::test::dsa_publickey_parse_serialize ... ok
[INFO] [stdout] test keys::dsa::test::dsa_publickey_size ... ok
[INFO] [stdout] test keys::ecdsa::test::ecdsa_publickey_serialize ... ok
[INFO] [stdout] test keys::ecdsa::test::ecdsa_publickey_size ... ok
[INFO] [stdout] test keys::ed25519::test::ed25519_publickey_serialize ... ok
[INFO] [stdout] test keys::test_size ... ignored
[INFO] [stdout] test keys::ed25519::test::ed25519_publickey_size ... ok
[INFO] [stdout] test keys::dsa::test::dsa_publickey_serialize ... ok
[INFO] [stdout] test keys::rsa::test::rsa_publickey_serialize ... ok
[INFO] [stdout] test keys::rsa::test::rsa_publickey_size ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/keyfiles.rs (/opt/rustwide/target/debug/deps/keyfiles-4a765f00098b3d8a)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test keyfile_openssh_ed25519 ... ok
[INFO] [stdout] test keyfile_pem_ecdsa_enc ... ok
[INFO] [stdout] test keyfile_pem_rsa ... ok
[INFO] [stdout] test keyfile_pem_dsa_enc ... ok
[INFO] [stdout] test keyfile_pem_rsa_enc ... ok
[INFO] [stdout] test keyfile_pem_dsa ... ok
[INFO] [stdout] test keyfile_openssh_rsa ... ok
[INFO] [stdout] test keyfile_openssh_dsa ... ok
[INFO] [stdout] test keyfile_pem_ecdsa ... ok
[INFO] [stdout] test keyfile_pkcs8_rsa ... ok
[INFO] [stdout] test keyfile_pkcs8_rsa_enc ... ok
[INFO] [stdout] test keyfile_openssh_ecdsa ... ok
[INFO] [stdout] test keyfile_pem_ed25519_wrong ... ok
[INFO] [stdout] test keyfile_pem_ecdsa_wrong ... ok
[INFO] [stdout] test keyfile_pem_dsa_wrong ... ok
[INFO] [stdout] test keyfile_pem_rsa_wrong ... ok
[INFO] [stdout] test keyfile_openssh_dsa_enc ... ok
[INFO] [stdout] test keyfile_openssh_ecdsa_enc ... ok
[INFO] [stdout] test keyfile_openssh_rsa_enc ... ok
[INFO] [stdout] test keyfile_openssh_ed25519_enc ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.69s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/keyfiles_serde.rs (/opt/rustwide/target/debug/deps/keyfiles_serde-a0f20936ffa33368)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test serde_pem ... ok
[INFO] [stdout] test serde_pkcs8 ... ok
[INFO] [stdout] test serde_pem_encrypt ... ok
[INFO] [stdout] test serde_openssh ... ok
[INFO] [stdout] test serde_pkcs8_encrypt ... ok
[INFO] [stdout] test serde_openssh_encrypt has been running for over 60 seconds
[INFO] [stderr]      Running tests/keypair_gererate.rs (/opt/rustwide/target/debug/deps/keypair_gererate-1beaaf3d13daac06)
[INFO] [stdout] test serde_openssh_encrypt ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 130.14s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test ecdsa_256_generate ... ok
[INFO] [stdout] test ecdsa_384_generate ... ok
[INFO] [stdout] test ed25519_generate ... ok
[INFO] [stdout] test ecdsa_521_generate ... ok
[INFO] [stdout] test dsa_generate ... ok
[INFO] [stdout] test rsa_generate ... ok
[INFO] [stdout] test rsa_generate_strange ... ok
[INFO] [stdout] test rsa_generate_minsize ... ok
[INFO] [stdout] test ed25519_generate_invalid ... ok
[INFO] [stdout] test ecdsa_generate_invalid ... ok
[INFO] [stdout] test dsa_generate_invalid_size ... ok
[INFO] [stdout] test rsa_generate_maxsize ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.72s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pubkey_serialize_pem.rs (/opt/rustwide/target/debug/deps/pubkey_serialize_pem-c8583c8f960b9bf2)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stderr]      Running tests/random_sign_verify.rs (/opt/rustwide/target/debug/deps/random_sign_verify-e49c8f936a6b3ae2)
[INFO] [stdout] test pem_serialize_openssh_ecdsa ... ok
[INFO] [stdout] test pem_serialize_openssh_dsa ... ok
[INFO] [stdout] test pem_serialize_openssh_rsa ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test ed25519_sign_verify ... ok
[INFO] [stdout] test ecdsa_sign_verify ... ok
[INFO] [stdout] test dsa_sign_verify ... ok
[INFO] [stdout] test rsa_sign_sha256_verify ... ok
[INFO] [stdout] test rsa_sign_verify ... ok
[INFO] [stdout] test rsa_sign_sha512_verify ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/utils.rs (/opt/rustwide/target/debug/deps/utils-0daaf2c585a21a1d)
[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 osshkeys
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/cipher.rs - cipher::Cipher::calc_buffer_len (line 84) ... ok
[INFO] [stdout] test src/lib.rs - (line 25) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.65s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "db686c7b1af570584619eb9de92378e6f5bef26cdcdf4c9e23999f3500e4b954", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "db686c7b1af570584619eb9de92378e6f5bef26cdcdf4c9e23999f3500e4b954", kill_on_drop: false }`
[INFO] [stdout] db686c7b1af570584619eb9de92378e6f5bef26cdcdf4c9e23999f3500e4b954