[INFO] fetching crate snmp_usm 0.2.0...
[INFO] testing snmp_usm-0.2.0 against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041
[INFO] extracting crate snmp_usm 0.2.0 into /workspace/builds/worker-8/source
[INFO] validating manifest of crates.io crate snmp_usm 0.2.0 on toolchain 432e145bd5a974c5b6f4dd9b352891bd7502b69d
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "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-8/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 780fd063c83fddbc07eb8d0aeea05c78e71ef1c8f62e6cbcd66756609e75018b
[INFO] running `Command { std: "docker" "start" "-a" "780fd063c83fddbc07eb8d0aeea05c78e71ef1c8f62e6cbcd66756609e75018b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "780fd063c83fddbc07eb8d0aeea05c78e71ef1c8f62e6cbcd66756609e75018b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "780fd063c83fddbc07eb8d0aeea05c78e71ef1c8f62e6cbcd66756609e75018b", kill_on_drop: false }`
[INFO] [stdout] 780fd063c83fddbc07eb8d0aeea05c78e71ef1c8f62e6cbcd66756609e75018b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f4b7c9ed54c1bb9c787eeca3683a7c0b3de9dba55375fa98298e5f8b5c74c2a4
[INFO] running `Command { std: "docker" "start" "-a" "f4b7c9ed54c1bb9c787eeca3683a7c0b3de9dba55375fa98298e5f8b5c74c2a4", kill_on_drop: false }`
[INFO] [stderr]    Compiling version_check v0.9.3
[INFO] [stderr]    Compiling typenum v1.13.0
[INFO] [stderr]    Compiling opaque-debug v0.2.3
[INFO] [stderr]    Compiling opaque-debug v0.3.0
[INFO] [stderr]    Compiling byte-tools v0.3.1
[INFO] [stderr]    Compiling cpufeatures v0.1.5
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling yasna v0.3.2
[INFO] [stderr]    Compiling block-padding v0.1.5
[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 des v0.4.0
[INFO] [stderr]    Compiling block-modes v0.5.0
[INFO] [stderr]    Compiling cfb-mode v0.4.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 5.95s
[INFO] running `Command { std: "docker" "inspect" "f4b7c9ed54c1bb9c787eeca3683a7c0b3de9dba55375fa98298e5f8b5c74c2a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f4b7c9ed54c1bb9c787eeca3683a7c0b3de9dba55375fa98298e5f8b5c74c2a4", kill_on_drop: false }`
[INFO] [stdout] f4b7c9ed54c1bb9c787eeca3683a7c0b3de9dba55375fa98298e5f8b5c74c2a4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ded39ab75c2f982bb8934a709c9f858392fbfa2108ef51b0af797d095862dbd3
[INFO] running `Command { std: "docker" "start" "-a" "ded39ab75c2f982bb8934a709c9f858392fbfa2108ef51b0af797d095862dbd3", 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.48s
[INFO] running `Command { std: "docker" "inspect" "ded39ab75c2f982bb8934a709c9f858392fbfa2108ef51b0af797d095862dbd3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ded39ab75c2f982bb8934a709c9f858392fbfa2108ef51b0af797d095862dbd3", kill_on_drop: false }`
[INFO] [stdout] ded39ab75c2f982bb8934a709c9f858392fbfa2108ef51b0af797d095862dbd3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] b8ee16322e38cedacfb34b1df870ee229d91f1902656bd14c7c1112309a06d50
[INFO] running `Command { std: "docker" "start" "-a" "b8ee16322e38cedacfb34b1df870ee229d91f1902656bd14c7c1112309a06d50", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stdout] running 17 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/snmp_usm-ead56830024eb9e4)
[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_returns_invalid_error_for_invalid_long_len ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_invalid_error_for_indefinite_len ... ok
[INFO] [stdout] test pos_finder::tests::it_steps_into_seq ... 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_skips_int ... ok
[INFO] [stdout] test pos_finder::tests::it_skips_octet_str ... ok
[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_returns_error_for_wrong_tag ... 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_short_len ... ok
[INFO] [stdout] test pos_finder::tests::it_returns_invalid_error_for_high_tag_num ... ok
[INFO] [stdout] test localized_key::tests::it_panics_with_empty_passwd - should panic ... ok
[INFO] [stdout] test localized_key::tests::it_constructs_localized_key_with_sha1 ... ok
[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.22s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/aes128_priv_key.rs (/opt/rustwide/target/debug/deps/aes128_priv_key-9d92302c642acb13)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test it_encrypts_scoped_pdu_using_localized_sha1_key ... ok
[INFO] [stdout] test it_encrypts_scoped_pdu_using_localized_md5_key ... ok
[INFO] [stdout] test it_returns_empty_vec_when_decrypting_empty_scoped_pdu ... ok
[INFO] [stdout] test it_returns_empty_vec_when_encrypting_empty_scoped_pdu ... ok
[INFO] [stdout] test it_decrypts_scoped_pdu_using_localized_md5_key ... ok
[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] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.46s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/auth_key.rs (/opt/rustwide/target/debug/deps/auth_key-b0a82179d30c9de1)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[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_time_in_authoritative ... ok
[INFO] [stdout] test it_returns_malformed_msg_for_empty_out_msg ... ok
[INFO] [stdout] test it_returns_error_for_malformed_in_msg ... ok
[INFO] [stdout] test it_authenticates_in_msg_using_md5 ... ok
[INFO] [stdout] test it_returns_error_for_in_msg_with_malformed_security_params ... ok
[INFO] [stdout] test it_returns_not_in_time_window_error_for_invalid_engine_time_in_non_authoritative ... 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_non_authoritative ... ok
[INFO] [stdout] test it_authenticates_out_msg_using_sha1 ... ok
[INFO] [stdout] test it_authenticates_in_msg_using_sha1 ... ok
[INFO] [stdout] test it_returns_malformed_msg_for_malformed_out_msg ... ok
[INFO] [stdout] test it_returns_not_in_time_window_for_engine_boots_max ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.54s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/des_priv_key.rs (/opt/rustwide/target/debug/deps/des_priv_key-3a2095736356909e)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test it_returns_empty_vec_when_encrypting_empty_scoped_pdu ... ok
[INFO] [stdout] test it_decrypts_scoped_pdu_using_localized_md5_key ... ok
[INFO] [stdout] test it_returns_error_for_priv_params_with_wrong_len ... ok
[INFO] [stdout] test it_encrypts_scoped_pdu_using_localized_md5_key ... ok
[INFO] [stdout] test it_decrypts_scoped_pdu_using_localized_sha1_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.46s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test it_creates_security_params_with_username_and_auth_params ... ok
[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_time ... ok
[INFO] [stdout] test it_returns_malformed_security_params_error_for_negative_engine_boots ... ok
[INFO] [stderr]      Running tests/security_params.rs (/opt/rustwide/target/debug/deps/security_params-58ea731ae03d5751)
[INFO] [stdout] test it_encodes_empty_security_params ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests snmp_usm
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test src/lib.rs - (line 36) - compile ... ok
[INFO] [stdout] test src/security_params.rs - security_params::SecurityParams::decode (line 337) - compile ... ok
[INFO] [stdout] test src/auth_key.rs - auth_key::AuthKey::auth_in_msg (line 194) - compile ... ok
[INFO] [stdout] test src/priv_key.rs - priv_key::PrivKey::decrypt (line 64) - compile ... 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::username (line 192) ... ok
[INFO] [stdout] test src/auth_key.rs - auth_key::AuthKey::auth_out_msg (line 250) - compile ... 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::set_username (line 206) ... 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_id (line 95) ... 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 (line 17) ... 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_id (line 109) ... 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::for_discovery (line 76) ... 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::engine_boots (line 126) ... 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::set_engine_boots (line 143) ... 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_time (line 176) ... ok
[INFO] [stdout] test src/localized_key.rs - localized_key::LocalizedKey::new (line 48) ... ok
[INFO] [stdout] test src/localized_key.rs - localized_key::WithLocalizedKey::with_localized_key (line 102) ... ok
[INFO] [stdout] test src/auth_key.rs - auth_key::AuthKey::new (line 32) ... ok
[INFO] [stdout] test src/priv_key.rs - priv_key::PrivKey::encrypt (line 33) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.41s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "b8ee16322e38cedacfb34b1df870ee229d91f1902656bd14c7c1112309a06d50", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b8ee16322e38cedacfb34b1df870ee229d91f1902656bd14c7c1112309a06d50", kill_on_drop: false }`
[INFO] [stdout] b8ee16322e38cedacfb34b1df870ee229d91f1902656bd14c7c1112309a06d50