[INFO] fetching crate cryptographic_primitives 0.2.0...
[INFO] testing cryptographic_primitives-0.2.0 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] extracting crate cryptographic_primitives 0.2.0 into /workspace/builds/worker-6-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-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate cryptographic_primitives 0.2.0 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "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" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] b29b0c8475523c2bb71336893008837c9f92ae6e4ddc93c85b2de3a700bcc4f5
[INFO] running `Command { std: "docker" "start" "-a" "b29b0c8475523c2bb71336893008837c9f92ae6e4ddc93c85b2de3a700bcc4f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "b29b0c8475523c2bb71336893008837c9f92ae6e4ddc93c85b2de3a700bcc4f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b29b0c8475523c2bb71336893008837c9f92ae6e4ddc93c85b2de3a700bcc4f5", kill_on_drop: false }`
[INFO] [stdout] b29b0c8475523c2bb71336893008837c9f92ae6e4ddc93c85b2de3a700bcc4f5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 71a781ba551d13e0e6d30a271cec0ecde7054be031b991bde4cb0ad42900d4d0
[INFO] running `Command { std: "docker" "start" "-a" "71a781ba551d13e0e6d30a271cec0ecde7054be031b991bde4cb0ad42900d4d0", kill_on_drop: false }`
[INFO] [stderr]    Compiling cryptographic_primitives v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.55s
[INFO] running `Command { std: "docker" "inspect" "71a781ba551d13e0e6d30a271cec0ecde7054be031b991bde4cb0ad42900d4d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "71a781ba551d13e0e6d30a271cec0ecde7054be031b991bde4cb0ad42900d4d0", kill_on_drop: false }`
[INFO] [stdout] 71a781ba551d13e0e6d30a271cec0ecde7054be031b991bde4cb0ad42900d4d0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 92c330a8140dc45ee9b380965b63032e02aa574a46b5f12b4f1be5ab9a189dc3
[INFO] running `Command { std: "docker" "start" "-a" "92c330a8140dc45ee9b380965b63032e02aa574a46b5f12b4f1be5ab9a189dc3", 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.88s
[INFO] running `Command { std: "docker" "inspect" "92c330a8140dc45ee9b380965b63032e02aa574a46b5f12b4f1be5ab9a189dc3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "92c330a8140dc45ee9b380965b63032e02aa574a46b5f12b4f1be5ab9a189dc3", kill_on_drop: false }`
[INFO] [stdout] 92c330a8140dc45ee9b380965b63032e02aa574a46b5f12b4f1be5ab9a189dc3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 69382c938c1de2b3ef397f770486615722b02d1e86de6901fb683b83b106d387
[INFO] running `Command { std: "docker" "start" "-a" "69382c938c1de2b3ef397f770486615722b02d1e86de6901fb683b83b106d387", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[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] [stdout] 
[INFO] [stderr]      Running tests/block_cipher_tests.rs (/opt/rustwide/target/debug/deps/block_cipher_tests-9d6afd5fa3a94de9)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test tests::cbc_rail_fence_cipher_test ... ok
[INFO] [stdout] test tests::cbc_route_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_rail_fence_cipher_test ... ok
[INFO] [stdout] test tests::ctr_route_cipher_test ... ok
[INFO] [stdout] test tests::ofb_rail_fence_cipher_test ... ok
[INFO] [stdout] test tests::ofb_route_cipher_test ... ok
[INFO] [stdout] test tests::ecb_aes_128_test ... ok
[INFO] [stdout] test tests::ofb_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::ctr_feistel_network_test ... ok
[INFO] [stdout] test tests::cbc_aes_128_test ... ok
[INFO] [stdout] test tests::cbc_feistel_network_test ... ok
[INFO] [stdout] test tests::ctr_sub_per_box_test ... ok
[INFO] [stdout] test tests::ofb_sub_per_box_test ... ok
[INFO] [stdout] test tests::ofb_feistel_network_test ... ok
[INFO] [stdout] test tests::cbc_sub_per_box_test ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 9.56s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/helpers_tests.rs (/opt/rustwide/target/debug/deps/helpers_tests-b703af556f91b0ae)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test tests::test_feistel_round_function ... ok
[INFO] [stdout] test tests::test_gmix_column ... ok
[INFO] [stdout] test tests::test_initialize_aes_sbox ... ok
[INFO] [stdout] test tests::test_kdf ... ok
[INFO] [stdout] test tests::test_xor_bytes ... ok
[INFO] [stdout] test tests::test_rotl8 ... ok
[INFO] [stdout] test tests::test_gmix_column_inv ... ok
[INFO] [stdout] test tests::test_permute ... 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] [stderr]      Running tests/primitives_tests.rs (/opt/rustwide/target/debug/deps/primitives_tests-5424b68a17fbcc74)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test tests::test_rail_fence_cipher ... ok
[INFO] [stdout] test tests::test_route_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.64s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests cryptographic_primitives
[INFO] [stdout] 
[INFO] [stdout] running 29 tests
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers (line 35) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ofb_encrypt (line 357) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ecb_decrypt (line 150) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::gmix_column (line 255) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ctr_encrypt (line 495) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ecb_encrypt (line 93) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::permute (line 131) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::xor_bytes (line 334) ... ok
[INFO] [stdout] test src/lib.rs - aes_128_decrypt (line 810) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ctr_decrypt (line 563) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::kdf (line 219) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::gmix_column_inv (line 287) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::initialize_aes_sbox (line 74) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers (line 18) ... ok
[INFO] [stdout] test src/lib.rs - feistel_network_encrypt (line 355) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::ofb_decrypt (line 424) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::rotl8 (line 41) ... ok
[INFO] [stdout] test src/lib.rs - feistel_network_decrypt (line 433) ... ok
[INFO] [stdout] test src/lib.rs - rail_fence_cipher_decrypt (line 141) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::cbc_encrypt (line 212) ... ok
[INFO] [stdout] test src/block_ciphers.rs - block_ciphers::cbc_decrypt (line 279) ... ok
[INFO] [stdout] test src/lib.rs - rail_fence_cipher_encrypt (line 70) ... ok
[INFO] [stdout] test src/lib.rs - aes_128_encrypt (line 701) ... ok
[INFO] [stdout] test src/helpers.rs - helpers::feistel_round_function (line 184) ... ok
[INFO] [stdout] test src/lib.rs - sub_per_box_decrypt (line 608) ... ok
[INFO] [stdout] test src/lib.rs - route_cipher_decrypt (line 290) ... 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 - (line 26) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.07s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "69382c938c1de2b3ef397f770486615722b02d1e86de6901fb683b83b106d387", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "69382c938c1de2b3ef397f770486615722b02d1e86de6901fb683b83b106d387", kill_on_drop: false }`
[INFO] [stdout] 69382c938c1de2b3ef397f770486615722b02d1e86de6901fb683b83b106d387