Dec 15 23:03:47.515 INFO testing aes_frast-0.1.2 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 23:03:47.516 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 15 23:03:47.783 INFO [stdout] 73df3ff67c05b6e751a2e734e07488cbdb951f14dfa2ae89d780025ebe35250d
Dec 15 23:03:47.785 INFO running `"docker" "start" "-a" "73df3ff67c05b6e751a2e734e07488cbdb951f14dfa2ae89d780025ebe35250d"`
Dec 15 23:03:48.424 INFO [stderr] usermod: no changes
Dec 15 23:03:48.470 INFO [stderr]    Compiling aes_frast v0.1.2 (/source)
Dec 15 23:03:50.571 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.16s
Dec 15 23:03:50.573 INFO [stderr] su: No module specific data is present
Dec 15 23:03:50.935 INFO running `"docker" "inspect" "73df3ff67c05b6e751a2e734e07488cbdb951f14dfa2ae89d780025ebe35250d"`
Dec 15 23:03:51.085 INFO running `"docker" "rm" "-f" "73df3ff67c05b6e751a2e734e07488cbdb951f14dfa2ae89d780025ebe35250d"`
Dec 15 23:03:51.171 INFO [stdout] 73df3ff67c05b6e751a2e734e07488cbdb951f14dfa2ae89d780025ebe35250d
Dec 15 23:03:51.176 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 15 23:03:51.427 INFO [stdout] be6e9cb02f694c15999b60a679afbd244f9d658f634be51e64f425899673c5b2
Dec 15 23:03:51.429 INFO running `"docker" "start" "-a" "be6e9cb02f694c15999b60a679afbd244f9d658f634be51e64f425899673c5b2"`
Dec 15 23:03:51.959 INFO [stderr] usermod: no changes
Dec 15 23:03:52.011 INFO [stderr]    Compiling aes_frast v0.1.2 (/source)
Dec 15 23:03:53.983 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.00s
Dec 15 23:03:53.985 INFO [stderr] su: No module specific data is present
Dec 15 23:03:54.433 INFO running `"docker" "inspect" "be6e9cb02f694c15999b60a679afbd244f9d658f634be51e64f425899673c5b2"`
Dec 15 23:03:54.578 INFO running `"docker" "rm" "-f" "be6e9cb02f694c15999b60a679afbd244f9d658f634be51e64f425899673c5b2"`
Dec 15 23:03:54.704 INFO [stdout] be6e9cb02f694c15999b60a679afbd244f9d658f634be51e64f425899673c5b2
Dec 15 23:03:54.706 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 15 23:03:54.915 INFO [stdout] de75cb4e66fc6cb621f13f5cc2f98c6b67e6e271fd8310de520ab0573ff65968
Dec 15 23:03:54.918 INFO running `"docker" "start" "-a" "de75cb4e66fc6cb621f13f5cc2f98c6b67e6e271fd8310de520ab0573ff65968"`
Dec 15 23:03:55.647 INFO [stderr] usermod: no changes
Dec 15 23:03:55.690 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Dec 15 23:03:55.691 INFO [stderr]      Running /target/debug/deps/aes_frast-c5abb7355beea6d9
Dec 15 23:03:55.693 INFO [stdout] 
Dec 15 23:03:55.693 INFO [stdout] running 5 tests
Dec 15 23:03:55.693 INFO [stdout] test aes_core::tests::setkey_dec_auto_works ... ok
Dec 15 23:03:55.693 INFO [stdout] test aes_core::tests::setkey_enc_auto_works ... ok
Dec 15 23:03:55.693 INFO [stdout] test aes_core::tests::setkey_dec_k192_works ... ok
Dec 15 23:03:55.693 INFO [stdout] test aes_core::tests::setkey_dec_k256_works ... ok
Dec 15 23:03:55.695 INFO [stdout] test aes_core::tests::setkey_dec_k128_works ... ok
Dec 15 23:03:55.695 INFO [stdout] 
Dec 15 23:03:55.695 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 23:03:55.695 INFO [stdout] 
Dec 15 23:03:55.695 INFO [stderr]    Doc-tests aes_frast
Dec 15 23:03:56.755 INFO [stdout] 
Dec 15 23:03:56.755 INFO [stdout] running 21 tests
Dec 15 23:04:00.475 INFO [stdout] test src/aes_core.rs - aes_core::block_dec_k256 (line 919) ... ok
Dec 15 23:04:02.180 INFO [stdout] test src/aes_core.rs - aes_core::setkey_enc_k128 (line 450) ... ok
Dec 15 23:04:02.368 INFO [stdout] test src/aes_core.rs - aes_core::block_enc_k256 (line 764) ... ok
Dec 15 23:04:02.561 INFO [stdout] test src/aes_core.rs - aes_core::block_enc_k192 (line 731) ... ok
Dec 15 23:04:02.727 INFO [stdout] test src/aes_core.rs - aes_core::block_dec_k192 (line 886) ... ok
Dec 15 23:04:02.872 INFO [stdout] test src/aes_core.rs - aes_core::block_dec_k128 (line 854) ... ok
Dec 15 23:04:03.071 INFO [stdout] test src/aes_core.rs - aes_core::block_enc_k128 (line 699) ... ok
Dec 15 23:04:04.615 INFO [stdout] test src/aes_core.rs - aes_core::setkey_enc_k192 (line 485) ... ok
Dec 15 23:04:10.575 INFO [stdout] test src/aes_core.rs - aes_core::setkey_enc_k256 (line 523) ... ok
Dec 15 23:04:11.228 INFO [stdout] test src/aes_with_operation_mode.rs - aes_with_operation_mode::cbc_enc (line 115) ... ok
Dec 15 23:04:11.371 INFO [stdout] test src/padding_128bit.rs - padding_128bit::de_ansix923_pkcs7 (line 42) ... ok
Dec 15 23:04:12.564 INFO [stdout] test src/aes_with_operation_mode.rs - aes_with_operation_mode::pcbc_enc (line 511) ... ok
Dec 15 23:04:12.597 INFO [stdout] test src/aes_with_operation_mode.rs - aes_with_operation_mode::cfb_enc (line 238) ... ok
Dec 15 23:04:13.173 INFO [stdout] test src/aes_with_operation_mode.rs - aes_with_operation_mode::ofb_enc_dec (line 403) ... ok
Dec 15 23:04:13.295 INFO [stdout] test src/aes_with_operation_mode.rs - aes_with_operation_mode::ecb_enc (line 13) ... ok
Dec 15 23:04:13.379 INFO [stdout] test src/padding_128bit.rs - padding_128bit::de_zeros (line 132) ... ok
Dec 15 23:04:15.042 INFO [stdout] test src/padding_128bit.rs - padding_128bit::pa_ansix923 (line 22) ... ok
Dec 15 23:04:15.183 INFO [stdout] test src/padding_128bit.rs - padding_128bit::pa_zeros_ifnotcomplete (line 105) ... ok
Dec 15 23:04:15.188 INFO [stdout] test src/padding_128bit.rs - padding_128bit::pa_pkcs7 (line 6) ... ok
Dec 15 23:04:15.220 INFO [stdout] test src/padding_128bit.rs - padding_128bit::pa_zeros (line 74) ... ok
Dec 15 23:04:15.298 INFO [stdout] test src/padding_128bit.rs - padding_128bit::drop_last_block (line 154) ... ok
Dec 15 23:04:15.298 INFO [stdout] 
Dec 15 23:04:15.298 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 23:04:15.298 INFO [stdout] 
Dec 15 23:04:15.339 INFO [stderr] su: No module specific data is present
Dec 15 23:04:15.649 INFO running `"docker" "inspect" "de75cb4e66fc6cb621f13f5cc2f98c6b67e6e271fd8310de520ab0573ff65968"`
Dec 15 23:04:15.801 INFO running `"docker" "rm" "-f" "de75cb4e66fc6cb621f13f5cc2f98c6b67e6e271fd8310de520ab0573ff65968"`
Dec 15 23:04:15.997 INFO [stdout] de75cb4e66fc6cb621f13f5cc2f98c6b67e6e271fd8310de520ab0573ff65968