[INFO] updating cached repository grantlindberg4/wsu-crypt [INFO] running `"git" "fetch" "--all"` [INFO] [stdout] Fetching origin [INFO] [stderr] From git://github.com/grantlindberg4/wsu-crypt [INFO] [stderr] * branch HEAD -> FETCH_HEAD [INFO] running `"git" "clone" "work/cache/sources/gh/grantlindberg4/wsu-crypt" "work/ex/beta-1.37-6/sources/1.36.0/gh/grantlindberg4/wsu-crypt"` [INFO] [stderr] Cloning into 'work/ex/beta-1.37-6/sources/1.36.0/gh/grantlindberg4/wsu-crypt'... [INFO] [stderr] done. [INFO] running `"git" "clone" "work/cache/sources/gh/grantlindberg4/wsu-crypt" "work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/grantlindberg4/wsu-crypt"` [INFO] [stderr] Cloning into 'work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/grantlindberg4/wsu-crypt'... [INFO] [stderr] done. [INFO] running `"git" "rev-parse" "HEAD"` [INFO] [stdout] 932fed3333b312e6a2da714935c24962bca1df75 [INFO] sha for GitHub repo grantlindberg4/wsu-crypt: 932fed3333b312e6a2da714935c24962bca1df75 [INFO] validating manifest of grantlindberg4/wsu-crypt on toolchain 1.36.0 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.36.0" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] validating manifest of grantlindberg4/wsu-crypt on toolchain beta-2019-07-23 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-07-23" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started frobbing grantlindberg4/wsu-crypt [INFO] finished frobbing grantlindberg4/wsu-crypt [INFO] frobbed toml for grantlindberg4/wsu-crypt written to work/ex/beta-1.37-6/sources/1.36.0/gh/grantlindberg4/wsu-crypt/Cargo.toml [INFO] started frobbing grantlindberg4/wsu-crypt [INFO] finished frobbing grantlindberg4/wsu-crypt [INFO] frobbed toml for grantlindberg4/wsu-crypt written to work/ex/beta-1.37-6/sources/beta-2019-07-23/gh/grantlindberg4/wsu-crypt/Cargo.toml [INFO] crate grantlindberg4/wsu-crypt already has a lockfile, it will not be regenerated [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.36.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-07-23" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] testing grantlindberg4/wsu-crypt against 1.36.0 for beta-1.37-6 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-6/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/gh/grantlindberg4/wsu-crypt:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "build" "--frozen"` [INFO] [stdout] 91da480bfc2d2710a6d993bd31bb1b2e446025a4d968b43ad6e4f0a4c09ec03a [INFO] running `"docker" "start" "-a" "91da480bfc2d2710a6d993bd31bb1b2e446025a4d968b43ad6e4f0a4c09ec03a"` [INFO] [stderr] Compiling wsu_crypt v0.1.0 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.33s [INFO] running `"docker" "inspect" "91da480bfc2d2710a6d993bd31bb1b2e446025a4d968b43ad6e4f0a4c09ec03a"` [INFO] running `"docker" "rm" "-f" "91da480bfc2d2710a6d993bd31bb1b2e446025a4d968b43ad6e4f0a4c09ec03a"` [INFO] [stdout] 91da480bfc2d2710a6d993bd31bb1b2e446025a4d968b43ad6e4f0a4c09ec03a [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-6/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/gh/grantlindberg4/wsu-crypt:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "test" "--frozen" "--no-run"` [INFO] [stdout] e409f21cf5888b7956c1a0870c97713459169b0f8a012259ed7b3a404ab01609 [INFO] running `"docker" "start" "-a" "e409f21cf5888b7956c1a0870c97713459169b0f8a012259ed7b3a404ab01609"` [INFO] [stderr] Compiling wsu_crypt v0.1.0 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.38s [INFO] running `"docker" "inspect" "e409f21cf5888b7956c1a0870c97713459169b0f8a012259ed7b3a404ab01609"` [INFO] running `"docker" "rm" "-f" "e409f21cf5888b7956c1a0870c97713459169b0f8a012259ed7b3a404ab01609"` [INFO] [stdout] e409f21cf5888b7956c1a0870c97713459169b0f8a012259ed7b3a404ab01609 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.37-6/worker-6/1.36.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.37-6/sources/1.36.0/gh/grantlindberg4/wsu-crypt:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.36.0" "test" "--frozen"` [INFO] [stdout] 0e4a1c7c2bfb0e775ce42798eb023d0d5a0e0f51eeb1ad664f196575453c0664 [INFO] running `"docker" "start" "-a" "0e4a1c7c2bfb0e775ce42798eb023d0d5a0e0f51eeb1ad664f196575453c0664"` [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.04s [INFO] [stderr] Running /opt/crater/target/debug/deps/wsu_crypt-975e59903738d538 [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test test::test_block_creation ... ok [INFO] [stdout] test test::test_f_function ... ok [INFO] [stdout] test test::test_file_handling ... ok [INFO] [stdout] test test::test_encrypt ... ok [INFO] [stdout] test test::test_get_values_from_f_table ... ok [INFO] [stdout] test test::test_g_function ... ok [INFO] [stdout] test test::test_subkey_generation_for_encrypt ... ok [INFO] [stdout] test test::test_subkey_generation_in_f_function ... ok [INFO] [stdout] test test::test_output_whitening ... ok [INFO] [stdout] test test::test_whitening_stage ... ok [INFO] [stdout] test test::test_subkey_generation_for_decrypt ... FAILED [INFO] [stdout] test test::test_decrypt ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test::test_subkey_generation_for_decrypt stdout ---- [INFO] [stdout] thread 'test::test_subkey_generation_for_decrypt' panicked at 'assertion failed: actual == expected', src/test.rs:135:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55b0154782a3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h6485381528590a55 [INFO] [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:39 [INFO] [stdout] 1: 0x55b015473c4b - std::sys_common::backtrace::_print::h49a82ae9552e35c7 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:71 [INFO] [stdout] 2: 0x55b015476fe6 - std::panicking::default_hook::{{closure}}::he20974adbefcc046 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:59 [INFO] [stdout] at src/libstd/panicking.rs:197 [INFO] [stdout] 3: 0x55b015476d0e - std::panicking::default_hook::he4af6af4ac7fef7b [INFO] [stdout] at src/libstd/panicking.rs:208 [INFO] [stdout] 4: 0x55b0154776ef - std::panicking::rust_panic_with_hook::h057ff03eb4c8000f [INFO] [stdout] at src/libstd/panicking.rs:474 [INFO] [stdout] 5: 0x55b01541e4d3 - std::panicking::begin_panic::h19b2da48a07e78c5 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:408 [INFO] [stdout] 6: 0x55b01541d0a7 - wsu_crypt::test::test_subkey_generation_for_decrypt::h90ae05b9abf29578 [INFO] [stdout] at src/test.rs:135 [INFO] [stdout] 7: 0x55b01541c409 - wsu_crypt::test::test_subkey_generation_for_decrypt::{{closure}}::h2088bb3a139b52bb [INFO] [stdout] at src/test.rs:104 [INFO] [stdout] 8: 0x55b01542031d - core::ops::function::FnOnce::call_once::h3ee81e8d286d0722 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libcore/ops/function.rs:231 [INFO] [stdout] 9: 0x55b01543844e - as core::ops::function::FnOnce>::call_once::h6b004fa8f4fc1608 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/liballoc/boxed.rs:704 [INFO] [stdout] 10: 0x55b01547a409 - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:85 [INFO] [stdout] 11: 0x55b015452d47 - test::run_test::run_test_inner::{{closure}}::h9a4d23c41d058d37 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:272 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panic.rs:394 [INFO] [stdout] at src/libtest/lib.rs:1468 [INFO] [stdout] 12: 0x55b01542d764 - std::sys_common::backtrace::__rust_begin_short_backtrace::h3765d76361a33ff7 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/sys_common/backtrace.rs:136 [INFO] [stdout] 13: 0x55b015431814 - std::panicking::try::do_call::h6f86e980b52f74d5 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/thread/mod.rs:470 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panic.rs:315 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:293 [INFO] [stdout] 14: 0x55b01547a409 - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:85 [INFO] [stdout] 15: 0x55b015431e21 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h760b8a2b155f54c3 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:272 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panic.rs:394 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/thread/mod.rs:469 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libcore/ops/function.rs:231 [INFO] [stdout] 16: 0x55b01546ba2e - as core::ops::function::FnOnce>::call_once::h805c3cc89d534c05 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/liballoc/boxed.rs:704 [INFO] [stdout] 17: 0x55b015479aef - std::sys::unix::thread::Thread::new::thread_start::h6f10b78f26c98dc6 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/liballoc/boxed.rs:704 [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 18: 0x7f34a87604a3 - start_thread [INFO] [stdout] 19: 0x7f34a828bd0e - __clone [INFO] [stdout] 20: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- test::test_decrypt stdout ---- [INFO] [stdout] thread 'test::test_decrypt' panicked at 'assertion failed: plaintext == 0x01234567890abcdef', src/test.rs:247:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55b0154782a3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h6485381528590a55 [INFO] [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:39 [INFO] [stdout] 1: 0x55b015473c4b - std::sys_common::backtrace::_print::h49a82ae9552e35c7 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:71 [INFO] [stdout] 2: 0x55b015476fe6 - std::panicking::default_hook::{{closure}}::he20974adbefcc046 [INFO] [stdout] at src/libstd/sys_common/backtrace.rs:59 [INFO] [stdout] at src/libstd/panicking.rs:197 [INFO] [stdout] 3: 0x55b015476d0e - std::panicking::default_hook::he4af6af4ac7fef7b [INFO] [stdout] at src/libstd/panicking.rs:208 [INFO] [stdout] 4: 0x55b0154776ef - std::panicking::rust_panic_with_hook::h057ff03eb4c8000f [INFO] [stdout] at src/libstd/panicking.rs:474 [INFO] [stdout] 5: 0x55b01541e4d3 - std::panicking::begin_panic::h19b2da48a07e78c5 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:408 [INFO] [stdout] 6: 0x55b01541dfa5 - wsu_crypt::test::test_decrypt::h409683ac7e98da34 [INFO] [stdout] at src/test.rs:247 [INFO] [stdout] 7: 0x55b01541de89 - wsu_crypt::test::test_decrypt::{{closure}}::hfda646a5f9c72de2 [INFO] [stdout] at src/test.rs:241 [INFO] [stdout] 8: 0x55b01542045d - core::ops::function::FnOnce::call_once::h72336c97ab100681 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libcore/ops/function.rs:231 [INFO] [stdout] 9: 0x55b01543844e - as core::ops::function::FnOnce>::call_once::h6b004fa8f4fc1608 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/liballoc/boxed.rs:704 [INFO] [stdout] 10: 0x55b01547a409 - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:85 [INFO] [stdout] 11: 0x55b015452d47 - test::run_test::run_test_inner::{{closure}}::h9a4d23c41d058d37 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:272 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panic.rs:394 [INFO] [stdout] at src/libtest/lib.rs:1468 [INFO] [stdout] 12: 0x55b01542d764 - std::sys_common::backtrace::__rust_begin_short_backtrace::h3765d76361a33ff7 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/sys_common/backtrace.rs:136 [INFO] [stdout] 13: 0x55b015431814 - std::panicking::try::do_call::h6f86e980b52f74d5 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/thread/mod.rs:470 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panic.rs:315 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:293 [INFO] [stdout] 14: 0x55b01547a409 - __rust_maybe_catch_panic [INFO] [stdout] at src/libpanic_unwind/lib.rs:85 [INFO] [stdout] 15: 0x55b015431e21 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h760b8a2b155f54c3 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panicking.rs:272 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/panic.rs:394 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libstd/thread/mod.rs:469 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/libcore/ops/function.rs:231 [INFO] [stdout] 16: 0x55b01546ba2e - as core::ops::function::FnOnce>::call_once::h805c3cc89d534c05 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/liballoc/boxed.rs:704 [INFO] [stdout] 17: 0x55b015479aef - std::sys::unix::thread::Thread::new::thread_start::h6f10b78f26c98dc6 [INFO] [stdout] at /rustc/a53f9df32fbb0b5f4382caaad8f1a46f36ea887c/src/liballoc/boxed.rs:704 [INFO] [stdout] at src/libstd/sys_common/thread.rs:13 [INFO] [stdout] at src/libstd/sys/unix/thread.rs:79 [INFO] [stdout] 18: 0x7f34a87604a3 - start_thread [INFO] [stdout] 19: 0x7f34a828bd0e - __clone [INFO] [stdout] 20: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test::test_decrypt [INFO] [stdout] test::test_subkey_generation_for_decrypt [INFO] [stdout] [INFO] [stdout] test result: FAILED. 10 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--bin wsu_crypt' [INFO] running `"docker" "inspect" "0e4a1c7c2bfb0e775ce42798eb023d0d5a0e0f51eeb1ad664f196575453c0664"` [INFO] running `"docker" "rm" "-f" "0e4a1c7c2bfb0e775ce42798eb023d0d5a0e0f51eeb1ad664f196575453c0664"` [INFO] [stdout] 0e4a1c7c2bfb0e775ce42798eb023d0d5a0e0f51eeb1ad664f196575453c0664