Dec 14 18:38:39.324 INFO testing sshkeys-0.1.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 18:38:39.324 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 18:38:39.905 INFO [stdout] e36f58151bcef65bebd1396fd45c4024077c10ca1fe97b08a086855cff4dd153
Dec 14 18:38:39.911 INFO running `"docker" "start" "-a" "e36f58151bcef65bebd1396fd45c4024077c10ca1fe97b08a086855cff4dd153"`
Dec 14 18:38:40.723 INFO [stderr] usermod: no changes
Dec 14 18:38:40.830 INFO [stderr]    Compiling block-buffer v0.2.0
Dec 14 18:38:41.283 INFO [stderr]    Compiling sha2 v0.6.0
Dec 14 18:38:42.164 INFO [stderr]    Compiling sshkeys v0.1.1 (/source)
Dec 14 18:38:44.988 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.24s
Dec 14 18:38:45.002 INFO [stderr] su: No module specific data is present
Dec 14 18:38:46.093 INFO running `"docker" "inspect" "e36f58151bcef65bebd1396fd45c4024077c10ca1fe97b08a086855cff4dd153"`
Dec 14 18:38:46.377 INFO running `"docker" "rm" "-f" "e36f58151bcef65bebd1396fd45c4024077c10ca1fe97b08a086855cff4dd153"`
Dec 14 18:38:46.631 INFO [stdout] e36f58151bcef65bebd1396fd45c4024077c10ca1fe97b08a086855cff4dd153
Dec 14 18:38:46.635 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 18:38:47.159 INFO [stdout] ac275f8e27159cdf2f4a54d93c0217536ca32bab26b7b920c7feefbca7426298
Dec 14 18:38:47.165 INFO running `"docker" "start" "-a" "ac275f8e27159cdf2f4a54d93c0217536ca32bab26b7b920c7feefbca7426298"`
Dec 14 18:38:48.555 INFO [stderr] usermod: no changes
Dec 14 18:38:48.635 INFO [stderr]    Compiling sshkeys v0.1.1 (/source)
Dec 14 18:38:54.202 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.59s
Dec 14 18:38:54.202 INFO [stderr] su: No module specific data is present
Dec 14 18:38:54.763 INFO running `"docker" "inspect" "ac275f8e27159cdf2f4a54d93c0217536ca32bab26b7b920c7feefbca7426298"`
Dec 14 18:38:55.103 INFO running `"docker" "rm" "-f" "ac275f8e27159cdf2f4a54d93c0217536ca32bab26b7b920c7feefbca7426298"`
Dec 14 18:38:55.323 INFO [stdout] ac275f8e27159cdf2f4a54d93c0217536ca32bab26b7b920c7feefbca7426298
Dec 14 18:38:55.331 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 18:38:55.713 INFO [stdout] 22681cbbea39b2f04992bd9e8fb75423da0a5f35cb45ad8b8966a38f8b37049d
Dec 14 18:38:55.721 INFO running `"docker" "start" "-a" "22681cbbea39b2f04992bd9e8fb75423da0a5f35cb45ad8b8966a38f8b37049d"`
Dec 14 18:38:56.742 INFO [stderr] usermod: no changes
Dec 14 18:38:56.799 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Dec 14 18:38:56.811 INFO [stderr]      Running /target/debug/deps/sshkeys-9b5f901a153f2c45
Dec 14 18:38:56.815 INFO [stderr]      Running /target/debug/deps/keys-89125a6c5d4c9e08
Dec 14 18:38:56.815 INFO [stdout] 
Dec 14 18:38:56.815 INFO [stdout] running 0 tests
Dec 14 18:38:56.815 INFO [stdout] 
Dec 14 18:38:56.815 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:38:56.815 INFO [stdout] 
Dec 14 18:38:56.817 INFO [stdout] 
Dec 14 18:38:56.817 INFO [stdout] running 15 tests
Dec 14 18:38:56.820 INFO [stdout] test test_dsa_pubkey_1024 ... ok
Dec 14 18:38:56.820 INFO [stdout] test test_ecdsa_nistp521_pubkey ... ok
Dec 14 18:38:56.820 INFO [stdout] test test_dsa_user_cert ... ok
Dec 14 18:38:56.821 INFO [stdout] test test_ecdsa_nistp256_pubkey ... ok
Dec 14 18:38:56.821 INFO [stdout] test test_ecdsa_nistp384_pubkey ... ok
Dec 14 18:38:56.821 INFO [stdout] test test_ed25519_pubkey ... ok
Dec 14 18:38:56.822 INFO [stdout] test test_ed25519_host_cert ... ok
Dec 14 18:38:56.823 INFO [stdout] test test_ed25519_user_cert ... ok
Dec 14 18:38:56.827 INFO [stdout] test test_ecdsa_user_cert ... ok
Dec 14 18:38:56.827 INFO [stdout] test test_rsa_pubkey_2048 ... ok
Dec 14 18:38:56.827 INFO [stdout] test test_rsa_pubkey_1024 ... ok
Dec 14 18:38:56.839 INFO [stdout] test test_rsa_user_cert ... ok
Dec 14 18:38:56.874 INFO [stdout] test test_rsa_not_cert ... ok
Dec 14 18:38:56.874 INFO [stdout] test test_rsa_pubkey_2048_invalid_format ... ok
Dec 14 18:38:56.874 INFO [stdout] test test_rsa_pubkey_2048_unknown_keytype ... ok
Dec 14 18:38:56.874 INFO [stdout] 
Dec 14 18:38:56.874 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:38:56.874 INFO [stdout] 
Dec 14 18:38:56.876 INFO [stderr]    Doc-tests sshkeys
Dec 14 18:38:58.698 INFO [stdout] 
Dec 14 18:38:58.698 INFO [stdout] running 25 tests
Dec 14 18:39:05.827 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::bits (line 386) ... ok
Dec 14 18:39:06.919 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::fingerprint (line 449) ... ok
Dec 14 18:39:07.035 INFO [stdout] test src/pubkey.rs - pubkey::Fingerprint::compute (line 210) ... ok
Dec 14 18:39:07.051 INFO [stdout] test src/cert.rs - cert::Certificate::from_path (line 91) ... ok
Dec 14 18:39:07.127 INFO [stdout] test src/pubkey.rs - pubkey::Curve::from_identifier (line 86) ... ok
Dec 14 18:39:07.262 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::encode (line 412) ... ok
Dec 14 18:39:08.875 INFO [stdout] test src/cert.rs - cert::Certificate::from_string (line 109) ... ok
Dec 14 18:39:09.275 INFO [stdout] test src/keytype.rs - keytype::KeyType::from_name (line 54) ... ok
Dec 14 18:39:13.191 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::from_path (line 245) ... ok
Dec 14 18:39:14.454 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::fingerprint_with (line 467) ... ok
Dec 14 18:39:14.943 INFO [stdout] test src/reader.rs - reader::Reader<'a>::read_bytes (line 56) ... ok
Dec 14 18:39:15.935 INFO [stdout] test src/reader.rs - reader::Reader<'a>::new (line 17) ... ok
Dec 14 18:39:15.968 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::from_string (line 262) ... ok
Dec 14 18:39:16.203 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::write (line 483) ... ok
Dec 14 18:39:16.422 INFO [stdout] test src/pubkey.rs - pubkey::PublicKey::from_bytes (line 307) ... ok
Dec 14 18:39:18.335 INFO [stdout] test src/reader.rs - reader::Reader<'a>::read_mpint (line 91) ... ok
Dec 14 18:39:20.752 INFO [stdout] test src/reader.rs - reader::Reader<'a>::read_string (line 112) ... ok
Dec 14 18:39:21.459 INFO [stdout] test src/writer.rs - writer::Writer::into_bytes (line 83) ... ok
Dec 14 18:39:21.699 INFO [stdout] test src/reader.rs - reader::Reader<'a>::read_u32 (line 129) ... ok
Dec 14 18:39:22.937 INFO [stdout] test src/reader.rs - reader::Reader<'a>::read_u64 (line 155) ... ok
Dec 14 18:39:23.250 INFO [stdout] test src/writer.rs - writer::Writer::new (line 13) ... ok
Dec 14 18:39:23.631 INFO [stdout] test src/reader.rs - reader::Reader<'a>::set_offset (line 34) ... ok
Dec 14 18:39:23.890 INFO [stdout] test src/writer.rs - writer::Writer::write_bytes (line 25) ... ok
Dec 14 18:39:24.290 INFO [stdout] test src/writer.rs - writer::Writer::write_mpint (line 60) ... ok
Dec 14 18:39:24.860 INFO [stdout] test src/writer.rs - writer::Writer::write_string (line 43) ... ok
Dec 14 18:39:24.860 INFO [stdout] 
Dec 14 18:39:24.861 INFO [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 18:39:24.861 INFO [stdout] 
Dec 14 18:39:24.897 INFO [stderr] su: No module specific data is present
Dec 14 18:39:25.501 INFO running `"docker" "inspect" "22681cbbea39b2f04992bd9e8fb75423da0a5f35cb45ad8b8966a38f8b37049d"`
Dec 14 18:39:25.837 INFO running `"docker" "rm" "-f" "22681cbbea39b2f04992bd9e8fb75423da0a5f35cb45ad8b8966a38f8b37049d"`
Dec 14 18:39:26.107 INFO [stdout] 22681cbbea39b2f04992bd9e8fb75423da0a5f35cb45ad8b8966a38f8b37049d