Nov 17 00:13:19.409 INFO testing jakecraige/pals against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 00:13:19.409 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 00:13:19.583 INFO [stdout] 02b3976115ab442b62e16f8699d5c08c5693cbd3077f93d8ce21417515857624
Nov 17 00:13:19.588 INFO running `"docker" "start" "-a" "02b3976115ab442b62e16f8699d5c08c5693cbd3077f93d8ce21417515857624"`
Nov 17 00:13:20.101 INFO [stderr] usermod: no changes
Nov 17 00:13:20.175 INFO [stderr]    Compiling pals v0.1.0 (/source)
Nov 17 00:13:21.403 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.28s
Nov 17 00:13:21.411 INFO [stderr] su: No module specific data is present
Nov 17 00:13:21.907 INFO running `"docker" "inspect" "02b3976115ab442b62e16f8699d5c08c5693cbd3077f93d8ce21417515857624"`
Nov 17 00:13:22.297 INFO running `"docker" "rm" "-f" "02b3976115ab442b62e16f8699d5c08c5693cbd3077f93d8ce21417515857624"`
Nov 17 00:13:22.624 INFO [stdout] 02b3976115ab442b62e16f8699d5c08c5693cbd3077f93d8ce21417515857624
Nov 17 00:13:22.635 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 00:13:23.006 INFO [stdout] 020d85f0b963bc688ec67c4b72ea964399e87974f5b29cd9804995d235bad779
Nov 17 00:13:23.011 INFO running `"docker" "start" "-a" "020d85f0b963bc688ec67c4b72ea964399e87974f5b29cd9804995d235bad779"`
Nov 17 00:13:24.114 INFO [stderr] usermod: no changes
Nov 17 00:13:24.203 INFO [stderr]    Compiling pals v0.1.0 (/source)
Nov 17 00:13:28.807 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.66s
Nov 17 00:13:28.811 INFO [stderr] su: No module specific data is present
Nov 17 00:13:29.915 INFO running `"docker" "inspect" "020d85f0b963bc688ec67c4b72ea964399e87974f5b29cd9804995d235bad779"`
Nov 17 00:13:30.165 INFO running `"docker" "rm" "-f" "020d85f0b963bc688ec67c4b72ea964399e87974f5b29cd9804995d235bad779"`
Nov 17 00:13:30.519 INFO [stdout] 020d85f0b963bc688ec67c4b72ea964399e87974f5b29cd9804995d235bad779
Nov 17 00:13:30.525 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 17 00:13:30.973 INFO [stdout] 47172b865254735af6868b7d46acd3c2c9ac7add7064a416fb144dd80cc09a3e
Nov 17 00:13:30.976 INFO running `"docker" "start" "-a" "47172b865254735af6868b7d46acd3c2c9ac7add7064a416fb144dd80cc09a3e"`
Nov 17 00:13:33.190 INFO [stderr] usermod: no changes
Nov 17 00:13:33.363 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Nov 17 00:13:33.363 INFO [stderr]      Running /target/debug/deps/pals-f23837031127de7a
Nov 17 00:13:33.374 INFO [stdout] 
Nov 17 00:13:33.374 INFO [stdout] running 32 tests
Nov 17 00:13:33.395 INFO [stdout] test set1::tests::byte_triple_to_6bit ... ok
Nov 17 00:13:33.411 INFO [stdout] test set1::tests::bytes_to_16byte_blocks ... ok
Nov 17 00:13:33.411 INFO [stdout] test set1::tests::bytes_to_base64 ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::hamming_distance ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::hex_to_base64 ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::hex_to_nibbles ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::nibs_to_byte ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::nibs_to_bytes ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::text_frequency ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::transpose ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::xor ... ok
Nov 17 00:13:33.412 INFO [stdout] test set1::tests::xor_encrypt_with_key ... ok
Nov 17 00:13:33.423 INFO [stdout] test set1::tests::frequency_score ... ok
Nov 17 00:13:33.423 INFO [stdout] test set2::aes_cbc::tests::remove_padding ... ok
Nov 17 00:13:33.423 INFO [stdout] test set2::aes_cbc::tests::remove_padding_with_challenge_input ... ok
Nov 17 00:13:33.447 INFO [stdout] test set1::tests::aes_ecb_decrypt ... ok
Nov 17 00:13:33.447 INFO [stdout] test set2::aes_cbc::tests::aes_cbc_encrypt_and_decrypt ... ok
Nov 17 00:13:33.447 INFO [stdout] test set2::aes_cbc::tests::aes_cbc_decrypt_example ... ok
Nov 17 00:13:33.459 INFO [stdout] test set2::cbc_bitflip::tests::bitflip_attack ... ok
Nov 17 00:13:33.459 INFO [stdout] test set2::cbc_bitflip::tests::encrypt_with_extra_works ... ok
Nov 17 00:13:33.462 INFO [stdout] test set2::ecb_cut_and_paste::tests::gen_admin_cookie ... ok
Nov 17 00:13:33.462 INFO [stdout] test set2::ecb_cut_and_paste::tests::profile_for ... ok
Nov 17 00:13:33.463 INFO [stdout] test set2::mode_detection::tests::detect_encryption ... ok
Nov 17 00:13:33.463 INFO [stdout] test set2::mode_detection::tests::encryption_oracle ... ok
Nov 17 00:13:33.463 INFO [stdout] test set2::tests::pkcs_7_pad ... ok
Nov 17 00:13:33.495 INFO [stdout] test set2::cbc_bitflip::tests::is_admin ... ok
Nov 17 00:13:33.495 INFO [stdout] test set1::tests::decrypt_single_byte_xor ... ok
Nov 17 00:13:34.219 INFO [stdout] test set1::tests::detect_aes_ecb_from_hex_lines ... ok
Nov 17 00:13:34.631 INFO [stdout] test set2::byte_decryption::tests::ecb_decrypt_using_oracle ... ok
Nov 17 00:13:34.946 INFO [stdout] test set2::byte_decryption::tests::ecb_decrypt_w_prefix_using_oracle ... ok
Nov 17 00:13:39.994 INFO [stdout] test set1::tests::detect_single_byte_xor ... ok
Nov 17 00:13:43.173 INFO [stdout] test set1::tests::decrypt_repeating_xor ... ok
Nov 17 00:13:43.173 INFO [stdout] 
Nov 17 00:13:43.173 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 00:13:43.173 INFO [stdout] 
Nov 17 00:13:43.175 INFO [stderr] su: No module specific data is present
Nov 17 00:13:44.529 INFO running `"docker" "inspect" "47172b865254735af6868b7d46acd3c2c9ac7add7064a416fb144dd80cc09a3e"`
Nov 17 00:13:44.933 INFO running `"docker" "rm" "-f" "47172b865254735af6868b7d46acd3c2c9ac7add7064a416fb144dd80cc09a3e"`
Nov 17 00:13:45.217 INFO [stdout] 47172b865254735af6868b7d46acd3c2c9ac7add7064a416fb144dd80cc09a3e