[INFO] fetching crate snmp_usm 0.2.0...
[INFO] testing snmp_usm-0.2.0 against master#99e3aef02079e9c10583638520cd0c134dc3a01d for pr-85530
[INFO] extracting crate snmp_usm 0.2.0 into /workspace/builds/worker-3/source
[INFO] validating manifest of crates.io crate snmp_usm 0.2.0 on toolchain 99e3aef02079e9c10583638520cd0c134dc3a01d
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate snmp_usm 0.2.0
[INFO] finished tweaking crates.io crate snmp_usm 0.2.0
[INFO] tweaked toml for crates.io crate snmp_usm 0.2.0 written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3e8fc4d34df7efac43f6ea7aade4d75e4607009d610ad2634e0b2b1b7efb1282
[INFO] running `Command { std: "docker" "start" "-a" "3e8fc4d34df7efac43f6ea7aade4d75e4607009d610ad2634e0b2b1b7efb1282", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3e8fc4d34df7efac43f6ea7aade4d75e4607009d610ad2634e0b2b1b7efb1282", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3e8fc4d34df7efac43f6ea7aade4d75e4607009d610ad2634e0b2b1b7efb1282", kill_on_drop: false }`
[INFO] [stdout] 3e8fc4d34df7efac43f6ea7aade4d75e4607009d610ad2634e0b2b1b7efb1282
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 76a125b0427d402f787d1bfb92754b7a51757675d9fa631e78c5410c2c83a97b
[INFO] running `Command { std: "docker" "start" "-a" "76a125b0427d402f787d1bfb92754b7a51757675d9fa631e78c5410c2c83a97b", kill_on_drop: false }`
[INFO] [stderr]    Compiling subtle v2.4.0
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling yasna v0.3.2
[INFO] [stderr]    Compiling generic-array v0.14.4
[INFO] [stderr]    Compiling block-cipher v0.7.1
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling stream-cipher v0.4.1
[INFO] [stderr]    Compiling crypto-mac v0.8.0
[INFO] [stderr]    Compiling aes-soft v0.4.0
[INFO] [stderr]    Compiling cfb-mode v0.4.0
[INFO] [stderr]    Compiling des v0.4.0
[INFO] [stderr]    Compiling block-modes v0.5.0
[INFO] [stderr]    Compiling hmac v0.8.1
[INFO] [stderr]    Compiling sha-1 v0.9.6
[INFO] [stderr]    Compiling md-5 v0.9.1
[INFO] [stderr]    Compiling aes v0.4.0
[INFO] [stderr]    Compiling snmp_usm v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.54s
[INFO] running `Command { std: "docker" "inspect" "76a125b0427d402f787d1bfb92754b7a51757675d9fa631e78c5410c2c83a97b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "76a125b0427d402f787d1bfb92754b7a51757675d9fa631e78c5410c2c83a97b", kill_on_drop: false }`
[INFO] [stdout] 76a125b0427d402f787d1bfb92754b7a51757675d9fa631e78c5410c2c83a97b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a2c3d6ce733fb70ab30e52cfa03a2c1d7a58db72edc0aaca044f21dbc3dc0c48
[INFO] running `Command { std: "docker" "start" "-a" "a2c3d6ce733fb70ab30e52cfa03a2c1d7a58db72edc0aaca044f21dbc3dc0c48", kill_on_drop: false }`
[INFO] [stderr]    Compiling snmp_usm v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.39s
[INFO] running `Command { std: "docker" "inspect" "a2c3d6ce733fb70ab30e52cfa03a2c1d7a58db72edc0aaca044f21dbc3dc0c48", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a2c3d6ce733fb70ab30e52cfa03a2c1d7a58db72edc0aaca044f21dbc3dc0c48", kill_on_drop: false }`
[INFO] [stdout] a2c3d6ce733fb70ab30e52cfa03a2c1d7a58db72edc0aaca044f21dbc3dc0c48
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] b2fc2890c1ef2c3df3850ed94bf2f77affc044db46bb6629a791b6d44729831b
[INFO] running `Command { std: "docker" "start" "-a" "b2fc2890c1ef2c3df3850ed94bf2f77affc044db46bb6629a791b6d44729831b", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stdout] running 17 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/snmp_usm-2505a08fe524e73a)
[INFO] [stdout] test pos_finder::tests::it_skips_seq ... ok
[INFO] [stdout] test pos_finder::tests::it_steps_into_octet_str ... ok
[INFO] [stdout] test pos_finder::tests::it_steps_into_seq ... ok
[INFO] [stdout] test priv_key::des_priv_key::tests::it_adds_padding_if_not_multiple_of_block_size ... ok
[INFO] [stdout] test priv_key::des_priv_key::tests::it_does_not_add_padding_if_multiple_of_block_size ... ok
[INFO] [stdout] test pos_finder::tests::it_skips_octet_str ... ok
[INFO] [stdout] test pos_finder::tests::it_skips_int ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_invalid_error_for_len_larger_than_usize_max ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_invalid_error_for_invalid_short_len ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_error_when_reading_end_of_buf ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_invalid_error_for_invalid_long_len ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_invalid_error_for_high_tag_num ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_invalid_error_for_indefinite_len ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_error_for_wrong_tag ... ok
[INFO] [stdout] test localized_key::tests::it_panics_with_empty_passwd ... ok
[INFO] [stdout] test localized_key::tests::it_constructs_localized_key_with_sha1 ... ok
[INFO] [stderr]      Running tests/aes128_priv_key.rs (/opt/rustwide/target/debug/deps/aes128_priv_key-c1d2123143481df0)
[INFO] [stdout] test localized_key::tests::it_constructs_localized_key_with_md5 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 17 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.31s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test it_returns_error_for_priv_params_with_wrong_len ... ok
[INFO] [stdout] test it_decrypts_scoped_pdu_using_localized_sha1_key ... ok
[INFO] [stdout] test it_returns_empty_vec_when_encrypting_empty_scoped_pdu ... ok
[INFO] [stdout] test it_returns_empty_vec_when_decrypting_empty_scoped_pdu ... ok
[INFO] [stdout] test it_encrypts_scoped_pdu_using_localized_sha1_key ... ok
[INFO] [stdout] test it_decrypts_scoped_pdu_using_localized_md5_key ... ok
[INFO] [stdout] test it_encrypts_scoped_pdu_using_localized_md5_key ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.58s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/auth_key.rs (/opt/rustwide/target/debug/deps/auth_key-f42cb921ce2d241d)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test it_returns_error_for_in_msg_with_malformed_security_params ... ok
[INFO] [stdout] test it_authenticates_out_msg_using_md5 ... ok
[INFO] [stdout] test it_returns_not_in_time_window_error_for_invalid_engine_boots_in_authoritative ... ok
[INFO] [stdout] test it_returns_not_in_time_window_error_for_invalid_engine_boots_in_non_authoritative ... ok
[INFO] [stdout] test it_returns_not_in_time_window_for_engine_boots_max ... ok
[INFO] [stdout] test it_authenticates_in_msg_using_sha1 ... ok
[INFO] [stdout] test it_authenticates_out_msg_using_sha1 ... ok
[INFO] [stdout] test it_returns_error_for_malformed_in_msg ... ok
[INFO] [stdout] test it_returns_malformed_msg_for_malformed_out_msg ... ok
[INFO] [stdout] test it_returns_malformed_msg_for_empty_out_msg ... ok
[INFO] [stdout] test it_returns_not_in_time_window_error_for_invalid_engine_time_in_authoritative ... ok
[INFO] [stdout] test it_returns_not_in_time_window_error_for_invalid_engine_time_in_non_authoritative ... ok
[INFO] [stderr]      Running tests/des_priv_key.rs (/opt/rustwide/target/debug/deps/des_priv_key-adb79a07ac6296a0)
[INFO] [stdout] test it_authenticates_in_msg_using_md5 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.82s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test it_decrypts_scoped_pdu_using_localized_md5_key ... ok
[INFO] [stdout] test it_decrypts_scoped_pdu_using_localized_sha1_key ... ok
[INFO] [stdout] test it_returns_empty_vec_when_encrypting_empty_scoped_pdu ... ok
[INFO] [stdout] test it_returns_error_for_priv_params_with_wrong_len ... ok
[INFO] [stderr]      Running tests/security_params.rs (/opt/rustwide/target/debug/deps/security_params-d6fa34727f2d45f5)
[INFO] [stdout] test it_encrypts_scoped_pdu_using_localized_md5_key ... ok
[INFO] [stdout] test it_encrypts_scoped_pdu_using_localized_sha1_key ... ok
[INFO] [stdout] test it_returns_empty_vec_when_decrypting_empty_scoped_pdu ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.52s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stderr]    Doc-tests snmp_usm
[INFO] [stdout] test it_returns_malformed_security_params_error_for_empty_security_params ... ok
[INFO] [stdout] test it_returns_malformed_security_params_error_for_negative_engine_boots ... ok
[INFO] [stdout] test it_returns_malformed_security_params_error_for_negative_engine_time ... ok
[INFO] [stdout] test it_encodes_empty_security_params ... ok
[INFO] [stdout] test it_creates_security_params_with_username_and_auth_params ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::decode (line 337) ... ok
[INFO] [stdout] test src/auth_key.rs - auth_key::AuthKey::auth_out_msg (line 250) ... ok
[INFO] [stdout] test src/auth_key.rs - auth_key::AuthKey::auth_in_msg (line 194) ... ok
[INFO] [stdout] test src/lib.rs - (line 36) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::ENGINE_TIME_MAX (line 54) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::set_engine_id (line 109) ... ok
[INFO] [stdout] test src/priv_key.rs - priv_key::PrivKey::decrypt (line 64) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::priv_params (line 272) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::set_priv_params (line 286) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::username (line 192) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::auth_params (line 223) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::engine_time (line 159) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::ENGINE_BOOTS_MAX (line 44) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::encode (line 306) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::engine_id (line 95) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::set_auth_params_placeholder (line 254) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::set_engine_time (line 176) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::set_username (line 206) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::engine_boots (line 126) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::set_auth_params (line 237) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::set_engine_boots (line 143) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::for_discovery (line 76) ... ok
[INFO] [stdout] test src/auth_key.rs - auth_key::AuthKey::new (line 32) ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams (line 17) ... ok
[INFO] [stdout] test src/localized_key.rs - localized_key::WithLocalizedKey::with_localized_key (line 102) ... ok
[INFO] [stdout] test src/priv_key.rs - priv_key::PrivKey::encrypt (line 33) ... ok
[INFO] [stdout] test src/localized_key.rs - localized_key::LocalizedKey::new (line 48) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.22s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "b2fc2890c1ef2c3df3850ed94bf2f77affc044db46bb6629a791b6d44729831b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b2fc2890c1ef2c3df3850ed94bf2f77affc044db46bb6629a791b6d44729831b", kill_on_drop: false }`
[INFO] [stdout] b2fc2890c1ef2c3df3850ed94bf2f77affc044db46bb6629a791b6d44729831b