Dec 01 14:28:38.198 INFO testing jakecraige/pals against 1.30.1 for beta-1.31-5
Dec 01 14:28:38.198 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 14:28:38.406 INFO [stdout] 3192e51600f5cec4615aeb9906a522304b86a8542454acab1c4ae2f134a5aa17
Dec 01 14:28:38.412 INFO running `"docker" "start" "-a" "3192e51600f5cec4615aeb9906a522304b86a8542454acab1c4ae2f134a5aa17"`
Dec 01 14:28:38.896 INFO [stderr] usermod: no changes
Dec 01 14:28:38.970 INFO [stderr]    Compiling openssl v0.10.12
Dec 01 14:28:45.085 INFO [stderr]    Compiling pals v0.1.0 (/source)
Dec 01 14:28:47.035 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.11s
Dec 01 14:28:47.043 INFO [stderr] su: No module specific data is present
Dec 01 14:28:47.689 INFO running `"docker" "inspect" "3192e51600f5cec4615aeb9906a522304b86a8542454acab1c4ae2f134a5aa17"`
Dec 01 14:28:48.065 INFO running `"docker" "rm" "-f" "3192e51600f5cec4615aeb9906a522304b86a8542454acab1c4ae2f134a5aa17"`
Dec 01 14:28:48.370 INFO [stdout] 3192e51600f5cec4615aeb9906a522304b86a8542454acab1c4ae2f134a5aa17
Dec 01 14:28:48.379 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 14:28:48.843 INFO [stdout] f77e028bf629f3658def7d03d5dbfb2aceb3c1e3993e924c7b8c98baa1820186
Dec 01 14:28:48.851 INFO running `"docker" "start" "-a" "f77e028bf629f3658def7d03d5dbfb2aceb3c1e3993e924c7b8c98baa1820186"`
Dec 01 14:28:50.039 INFO [stderr] usermod: no changes
Dec 01 14:28:50.159 INFO [stderr]    Compiling pals v0.1.0 (/source)
Dec 01 14:28:54.720 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.63s
Dec 01 14:28:54.725 INFO [stderr] su: No module specific data is present
Dec 01 14:28:55.680 INFO running `"docker" "inspect" "f77e028bf629f3658def7d03d5dbfb2aceb3c1e3993e924c7b8c98baa1820186"`
Dec 01 14:28:56.005 INFO running `"docker" "rm" "-f" "f77e028bf629f3658def7d03d5dbfb2aceb3c1e3993e924c7b8c98baa1820186"`
Dec 01 14:28:56.320 INFO [stdout] f77e028bf629f3658def7d03d5dbfb2aceb3c1e3993e924c7b8c98baa1820186
Dec 01 14:28:56.325 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 14:28:56.891 INFO [stdout] e4074ba78296c546c8cddcd4ef1288ac8dc4be6f80533736d23485d5ad3fd270
Dec 01 14:28:56.899 INFO running `"docker" "start" "-a" "e4074ba78296c546c8cddcd4ef1288ac8dc4be6f80533736d23485d5ad3fd270"`
Dec 01 14:28:58.058 INFO [stderr] usermod: no changes
Dec 01 14:28:58.207 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.11s
Dec 01 14:28:58.211 INFO [stderr]      Running /target/debug/deps/pals-e975bf8c34cd436c
Dec 01 14:28:58.239 INFO [stdout] 
Dec 01 14:28:58.239 INFO [stdout] running 32 tests
Dec 01 14:28:58.263 INFO [stdout] test set1::tests::byte_triple_to_6bit ... ok
Dec 01 14:28:58.263 INFO [stdout] test set1::tests::aes_ecb_decrypt ... ok
Dec 01 14:28:58.263 INFO [stdout] test set1::tests::bytes_to_16byte_blocks ... ok
Dec 01 14:28:58.283 INFO [stdout] test set1::tests::bytes_to_base64 ... ok
Dec 01 14:28:58.283 INFO [stdout] test set1::tests::frequency_score ... ok
Dec 01 14:28:58.283 INFO [stdout] test set1::tests::hamming_distance ... ok
Dec 01 14:28:58.295 INFO [stdout] test set1::tests::hex_to_nibbles ... ok
Dec 01 14:28:58.295 INFO [stdout] test set1::tests::hex_to_base64 ... ok
Dec 01 14:28:58.295 INFO [stdout] test set1::tests::nibs_to_bytes ... ok
Dec 01 14:28:58.295 INFO [stdout] test set1::tests::nibs_to_byte ... ok
Dec 01 14:28:58.295 INFO [stdout] test set1::tests::xor_encrypt_with_key ... ok
Dec 01 14:28:58.303 INFO [stdout] test set1::tests::text_frequency ... ok
Dec 01 14:28:58.303 INFO [stdout] test set1::tests::transpose ... ok
Dec 01 14:28:58.303 INFO [stdout] test set1::tests::xor ... ok
Dec 01 14:28:58.303 INFO [stdout] test set2::aes_cbc::tests::aes_cbc_decrypt_example ... ok
Dec 01 14:28:58.303 INFO [stdout] test set2::aes_cbc::tests::aes_cbc_encrypt_and_decrypt ... ok
Dec 01 14:28:58.331 INFO [stdout] test set2::aes_cbc::tests::remove_padding ... ok
Dec 01 14:28:58.331 INFO [stdout] test set2::aes_cbc::tests::remove_padding_with_challenge_input ... ok
Dec 01 14:28:58.335 INFO [stdout] test set2::cbc_bitflip::tests::bitflip_attack ... ok
Dec 01 14:28:58.335 INFO [stdout] test set2::cbc_bitflip::tests::is_admin ... ok
Dec 01 14:28:58.335 INFO [stdout] test set2::ecb_cut_and_paste::tests::gen_admin_cookie ... ok
Dec 01 14:28:58.335 INFO [stdout] test set2::ecb_cut_and_paste::tests::profile_for ... ok
Dec 01 14:28:58.346 INFO [stdout] test set2::mode_detection::tests::detect_encryption ... ok
Dec 01 14:28:58.355 INFO [stdout] test set2::cbc_bitflip::tests::encrypt_with_extra_works ... ok
Dec 01 14:28:58.359 INFO [stdout] test set2::tests::pkcs_7_pad ... ok
Dec 01 14:28:58.375 INFO [stdout] test set1::tests::decrypt_single_byte_xor ... ok
Dec 01 14:28:58.383 INFO [stdout] test set2::mode_detection::tests::encryption_oracle ... ok
Dec 01 14:28:58.988 INFO [stdout] test set1::tests::detect_aes_ecb_from_hex_lines ... ok
Dec 01 14:28:59.279 INFO [stdout] test set2::byte_decryption::tests::ecb_decrypt_using_oracle ... ok
Dec 01 14:28:59.427 INFO [stdout] test set2::byte_decryption::tests::ecb_decrypt_w_prefix_using_oracle ... ok
Dec 01 14:29:03.679 INFO [stdout] test set1::tests::detect_single_byte_xor ... ok
Dec 01 14:29:06.477 INFO [stdout] test set1::tests::decrypt_repeating_xor ... ok
Dec 01 14:29:06.477 INFO [stdout] 
Dec 01 14:29:06.477 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 14:29:06.477 INFO [stdout] 
Dec 01 14:29:06.480 INFO [stderr] su: No module specific data is present
Dec 01 14:29:08.011 INFO running `"docker" "inspect" "e4074ba78296c546c8cddcd4ef1288ac8dc4be6f80533736d23485d5ad3fd270"`
Dec 01 14:29:08.387 INFO running `"docker" "rm" "-f" "e4074ba78296c546c8cddcd4ef1288ac8dc4be6f80533736d23485d5ad3fd270"`
Dec 01 14:29:08.719 INFO [stdout] e4074ba78296c546c8cddcd4ef1288ac8dc4be6f80533736d23485d5ad3fd270
