[INFO] fetching crate cryptographic_primitives 0.2.0...
[INFO] testing cryptographic_primitives-0.2.0 against master#350d0ef0ec0493e6d21cfb265cb8211a0e74d766 for pr-145330-1
[INFO] extracting crate cryptographic_primitives 0.2.0 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate cryptographic_primitives 0.2.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate cryptographic_primitives 0.2.0
[INFO] tweaked toml for crates.io crate cryptographic_primitives 0.2.0 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate cryptographic_primitives 0.2.0 on toolchain 350d0ef0ec0493e6d21cfb265cb8211a0e74d766
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 17 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 355dc83dd9a88ad08f121e8968745956c2c72fec9ff02f05cc41963c968c9290
[INFO] running `Command { std: "docker" "start" "-a" "355dc83dd9a88ad08f121e8968745956c2c72fec9ff02f05cc41963c968c9290", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "355dc83dd9a88ad08f121e8968745956c2c72fec9ff02f05cc41963c968c9290", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "355dc83dd9a88ad08f121e8968745956c2c72fec9ff02f05cc41963c968c9290", kill_on_drop: false }`
[INFO] [stdout] 355dc83dd9a88ad08f121e8968745956c2c72fec9ff02f05cc41963c968c9290
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 43c3a12eedc64f2cd28a07afe6a128b5ae710ae70e10b25050c3fa91497525d3
[INFO] running `Command { std: "docker" "start" "-a" "43c3a12eedc64f2cd28a07afe6a128b5ae710ae70e10b25050c3fa91497525d3", kill_on_drop: false }`
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling cryptographic_primitives v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.03s
[INFO] running `Command { std: "docker" "inspect" "43c3a12eedc64f2cd28a07afe6a128b5ae710ae70e10b25050c3fa91497525d3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "43c3a12eedc64f2cd28a07afe6a128b5ae710ae70e10b25050c3fa91497525d3", kill_on_drop: false }`
[INFO] [stdout] 43c3a12eedc64f2cd28a07afe6a128b5ae710ae70e10b25050c3fa91497525d3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5d164b0e490a5e5f097868aaa38575d4981e0fe257777dba222b9e8a7deb0a0e
[INFO] running `Command { std: "docker" "start" "-a" "5d164b0e490a5e5f097868aaa38575d4981e0fe257777dba222b9e8a7deb0a0e", kill_on_drop: false }`
[INFO] [stderr]    Compiling cryptographic_primitives v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.83s
[INFO] running `Command { std: "docker" "inspect" "5d164b0e490a5e5f097868aaa38575d4981e0fe257777dba222b9e8a7deb0a0e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5d164b0e490a5e5f097868aaa38575d4981e0fe257777dba222b9e8a7deb0a0e", kill_on_drop: false }`
[INFO] [stdout] 5d164b0e490a5e5f097868aaa38575d4981e0fe257777dba222b9e8a7deb0a0e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a60fa8da31b17f49e1aacb4fb88d2bc75ca29fe6be7916bedf917df05dffdbb4
[INFO] running `Command { std: "docker" "start" "-a" "a60fa8da31b17f49e1aacb4fb88d2bc75ca29fe6be7916bedf917df05dffdbb4", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/cryptographic_primitives-675f2950ef45a116)
[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] [stderr]      Running tests/block_cipher_tests.rs (/opt/rustwide/target/debug/deps/block_cipher_tests-9d6afd5fa3a94de9)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test tests::cbc_rail_fence_cipher_test ... ok
[INFO] [stdout] test tests::ecb_route_cipher_test ... ok
[INFO] [stdout] test tests::ecb_rail_fence_cipher_test ... ok
[INFO] [stdout] test tests::ctr_route_cipher_test ... ok
[INFO] [stdout] test tests::ctr_rail_fence_cipher_test ... ok
[INFO] [stdout] test tests::ofb_route_cipher_test ... ok
[INFO] [stdout] test tests::cbc_route_cipher_test ... ok
[INFO] [stdout] test tests::ofb_rail_fence_cipher_test ... ok
[INFO] [stdout] test tests::ecb_aes_128_test ... ok
[INFO] [stdout] test tests::ecb_feistel_network_test ... ok
[INFO] [stdout] test tests::ecb_sub_per_box_test ... ok
[INFO] [stdout] test tests::ctr_aes_128_test ... ok
[INFO] [stdout] test tests::ofb_aes_128_test ... ok
[INFO] [stdout] test tests::cbc_aes_128_test ... ok
[INFO] [stdout] test tests::ctr_feistel_network_test ... ok
[INFO] [stdout] test tests::ofb_feistel_network_test ... ok
[INFO] [stdout] test tests::cbc_feistel_network_test ... ok
[INFO] [stdout] test tests::ofb_sub_per_box_test ... ok
[INFO] [stdout] test tests::ctr_sub_per_box_test ... ok
[INFO] [stdout] test tests::cbc_sub_per_box_test ... ok
[INFO] [stderr]      Running tests/helpers_tests.rs (/opt/rustwide/target/debug/deps/helpers_tests-b703af556f91b0ae)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 9.59s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test tests::test_gmix_column ... ok
[INFO] [stdout] test tests::test_feistel_round_function ... ok
[INFO] [stdout] test tests::test_permute ... ok
[INFO] [stdout] test tests::test_initialize_aes_sbox ... ok
[INFO] [stdout] test tests::test_xor_bytes ... ok
[INFO] [stdout] test tests::test_kdf ... ok
[INFO] [stderr]      Running tests/primitives_tests.rs (/opt/rustwide/target/debug/deps/primitives_tests-5424b68a17fbcc74)
[INFO] [stdout] test tests::test_gmix_column_inv ... ok
[INFO] [stdout] test tests::test_rotl8 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test tests::test_route_cipher ... ok
[INFO] [stdout] test tests::test_rail_fence_cipher ... ok
[INFO] [stdout] test tests::test_aes_128_cipher ... ok
[INFO] [stdout] test tests::test_feistel_network_cipher ... ok
[INFO] [stdout] test tests::test_sub_per_box_cipher ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.48s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests cryptographic_primitives
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ctr_encrypt (line 495) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::cbc_decrypt (line 279) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ofb_decrypt (line 424) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::permute (line 131) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::kdf (line 219) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ctr_decrypt (line 563) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::cbc_encrypt (line 212) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::initialize_aes_sbox (line 74) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ecb_decrypt (line 150) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers (line 35) ... ok
[INFO] [stdout] test src/lib.rs - aes_128_decrypt (line 810) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::xor_bytes (line 334) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ofb_encrypt (line 357) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::gmix_column (line 255) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ecb_encrypt (line 93) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::gmix_column_inv (line 287) ... ok
[INFO] [stdout] test src/lib.rs - aes_128_encrypt (line 701) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers (line 18) ... ok
[INFO] [stdout] test src/lib.rs - rail_fence_cipher_encrypt (line 70) ... ok
[INFO] [stdout] test src/lib.rs - rail_fence_cipher_decrypt (line 141) ... ok
[INFO] [stdout] test src/lib.rs - feistel_network_decrypt (line 433) ... ok
[INFO] [stdout] test src/lib.rs - route_cipher_decrypt (line 290) ... ok
[INFO] [stdout] test src/lib.rs - (line 26) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::feistel_round_function (line 184) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::rotl8 (line 41) ... ok
[INFO] [stdout] test src/lib.rs - sub_per_box_encrypt (line 513) ... ok
[INFO] [stdout] test src/lib.rs - route_cipher_encrypt (line 230) ... ok
[INFO] [stdout] test src/lib.rs - feistel_network_encrypt (line 355) ... ok
[INFO] [stdout] test src/lib.rs - sub_per_box_decrypt (line 608) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.96s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "a60fa8da31b17f49e1aacb4fb88d2bc75ca29fe6be7916bedf917df05dffdbb4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a60fa8da31b17f49e1aacb4fb88d2bc75ca29fe6be7916bedf917df05dffdbb4", kill_on_drop: false }`
[INFO] [stdout] a60fa8da31b17f49e1aacb4fb88d2bc75ca29fe6be7916bedf917df05dffdbb4