Oct 10 22:26:49.959 INFO testing grantlindberg4/wsu-crypt against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling Oct 10 22:26:49.959 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen Oct 10 22:26:49.959 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 10 22:26:50.108 INFO blam! 2890d03aa78d3121d109a7b9a59e888010799d0a62d12cfa813ce5194b0aa2da Oct 10 22:26:50.109 INFO running `"docker" "start" "-a" "2890d03aa78d3121d109a7b9a59e888010799d0a62d12cfa813ce5194b0aa2da"` Oct 10 22:26:50.491 INFO kablam! usermod: no changes Oct 10 22:26:50.531 INFO kablam! Compiling wsu_crypt v0.1.0 (/source) Oct 10 22:26:51.522 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 1.00s Oct 10 22:26:51.523 INFO kablam! su: No module specific data is present Oct 10 22:26:51.738 INFO running `"docker" "rm" "-f" "2890d03aa78d3121d109a7b9a59e888010799d0a62d12cfa813ce5194b0aa2da"` Oct 10 22:26:51.832 INFO blam! 2890d03aa78d3121d109a7b9a59e888010799d0a62d12cfa813ce5194b0aa2da Oct 10 22:26:51.836 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run Oct 10 22:26:51.836 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 10 22:26:52.029 INFO blam! ec1f899fcfe0ed79e32586f2d433a4cbfd405445c43686159ee2110f264cbb19 Oct 10 22:26:52.032 INFO running `"docker" "start" "-a" "ec1f899fcfe0ed79e32586f2d433a4cbfd405445c43686159ee2110f264cbb19"` Oct 10 22:26:52.793 INFO kablam! usermod: no changes Oct 10 22:26:52.820 INFO kablam! Compiling wsu_crypt v0.1.0 (/source) Oct 10 22:26:54.213 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 1.40s Oct 10 22:26:54.215 INFO kablam! su: No module specific data is present Oct 10 22:26:54.494 INFO running `"docker" "rm" "-f" "ec1f899fcfe0ed79e32586f2d433a4cbfd405445c43686159ee2110f264cbb19"` Oct 10 22:26:54.662 INFO blam! ec1f899fcfe0ed79e32586f2d433a4cbfd405445c43686159ee2110f264cbb19 Oct 10 22:26:54.664 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen Oct 10 22:26:54.664 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"` Oct 10 22:26:54.881 INFO blam! 90ed6d52ca3dc411f33b96d293b1a5e640f66fbaae4ee7aa1165aeefa53d2af8 Oct 10 22:26:54.883 INFO running `"docker" "start" "-a" "90ed6d52ca3dc411f33b96d293b1a5e640f66fbaae4ee7aa1165aeefa53d2af8"` Oct 10 22:26:55.890 INFO kablam! usermod: no changes Oct 10 22:26:55.960 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.03s Oct 10 22:26:55.960 INFO kablam! Running /target/debug/deps/wsu_crypt-52d858ce77bba827 Oct 10 22:26:55.968 INFO blam! Oct 10 22:26:55.968 INFO blam! running 12 tests Oct 10 22:26:55.980 INFO blam! test test::test_file_handling ... ok Oct 10 22:26:55.985 INFO blam! test test::test_encrypt ... ok Oct 10 22:26:55.985 INFO blam! test test::test_block_creation ... ok Oct 10 22:26:55.988 INFO blam! test test::test_g_function ... ok Oct 10 22:26:55.988 INFO blam! test test::test_f_function ... ok Oct 10 22:26:55.997 INFO blam! test test::test_get_values_from_f_table ... ok Oct 10 22:26:56.001 INFO blam! test test::test_whitening_stage ... ok Oct 10 22:26:56.001 INFO blam! test test::test_subkey_generation_for_encrypt ... ok Oct 10 22:26:56.004 INFO blam! test test::test_output_whitening ... ok Oct 10 22:26:56.008 INFO blam! test test::test_subkey_generation_in_f_function ... ok Oct 10 22:26:56.039 INFO blam! test test::test_subkey_generation_for_decrypt ... FAILED Oct 10 22:26:56.039 INFO blam! test test::test_decrypt ... FAILED Oct 10 22:26:56.039 INFO blam! Oct 10 22:26:56.039 INFO blam! failures: Oct 10 22:26:56.039 INFO blam! Oct 10 22:26:56.039 INFO blam! ---- test::test_subkey_generation_for_decrypt stdout ---- Oct 10 22:26:56.039 INFO blam! thread 'test::test_subkey_generation_for_decrypt' panicked at 'assertion failed: actual == expected', src/test.rs:135:5 Oct 10 22:26:56.039 INFO blam! stack backtrace: Oct 10 22:26:56.039 INFO blam! 0: 0x55e57bb7545e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 10 22:26:56.040 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 10 22:26:56.040 INFO blam! 1: 0x55e57bb7e306 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 10 22:26:56.040 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 10 22:26:56.040 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 10 22:26:56.040 INFO blam! 2: 0x55e57bb7905d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:211 Oct 10 22:26:56.040 INFO blam! 3: 0x55e57bb78d6b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:221 Oct 10 22:26:56.040 INFO blam! 4: 0x55e57bb7970c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:476 Oct 10 22:26:56.040 INFO blam! 5: 0x55e57bb1cd9f - std::panicking::begin_panic::h5d334c0f5357a8c5 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:410 Oct 10 22:26:56.040 INFO blam! 6: 0x55e57bb17c1e - wsu_crypt::test::test_subkey_generation_for_decrypt::h424bedaded86955e Oct 10 22:26:56.040 INFO blam! at src/test.rs:135 Oct 10 22:26:56.040 INFO blam! 7: 0x55e57bb16f89 - wsu_crypt::test::test_subkey_generation_for_decrypt::{{closure}}::hf7b6f41da078f403 Oct 10 22:26:56.040 INFO blam! at src/test.rs:104 Oct 10 22:26:56.040 INFO blam! 8: 0x55e57bb1ef0d - core::ops::function::FnOnce::call_once::h9b995f5daae477af Oct 10 22:26:56.040 INFO blam! at libcore/ops/function.rs:238 Oct 10 22:26:56.040 INFO blam! 9: 0x55e57bb2c3de - >::call_box::h95b7cb918af67b5d Oct 10 22:26:56.040 INFO blam! at libtest/lib.rs:1468 Oct 10 22:26:56.040 INFO blam! at libcore/ops/function.rs:238 Oct 10 22:26:56.040 INFO blam! at liballoc/boxed.rs:672 Oct 10 22:26:56.040 INFO blam! 10: 0x55e57bb894d9 - __rust_maybe_catch_panic Oct 10 22:26:56.040 INFO blam! at libpanic_unwind/lib.rs:102 Oct 10 22:26:56.040 INFO blam! 11: 0x55e57bb4cf2d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:289 Oct 10 22:26:56.040 INFO blam! at libstd/panic.rs:392 Oct 10 22:26:56.040 INFO blam! at libtest/lib.rs:1423 Oct 10 22:26:56.040 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 10 22:26:56.040 INFO blam! 12: 0x55e57bb4db34 - std::panicking::try::do_call::ha990a345054c2d63 Oct 10 22:26:56.040 INFO blam! at libstd/thread/mod.rs:409 Oct 10 22:26:56.040 INFO blam! at libstd/panic.rs:313 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:310 Oct 10 22:26:56.040 INFO blam! 13: 0x55e57bb894d9 - __rust_maybe_catch_panic Oct 10 22:26:56.040 INFO blam! at libpanic_unwind/lib.rs:102 Oct 10 22:26:56.040 INFO blam! 14: 0x55e57bb3b0f6 - >::call_box::h96125cb29a9ba44b Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:289 Oct 10 22:26:56.040 INFO blam! at libstd/panic.rs:392 Oct 10 22:26:56.040 INFO blam! at libstd/thread/mod.rs:408 Oct 10 22:26:56.040 INFO blam! at liballoc/boxed.rs:672 Oct 10 22:26:56.040 INFO blam! 15: 0x55e57bb7749a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 10 22:26:56.040 INFO blam! at liballoc/boxed.rs:682 Oct 10 22:26:56.040 INFO blam! at libstd/sys_common/thread.rs:24 Oct 10 22:26:56.040 INFO blam! 16: 0x55e57bb6cc25 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 10 22:26:56.040 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 10 22:26:56.040 INFO blam! 17: 0x7f4ced1846b9 - start_thread Oct 10 22:26:56.040 INFO blam! 18: 0x7f4cecca441c - clone Oct 10 22:26:56.040 INFO blam! 19: 0x0 - Oct 10 22:26:56.040 INFO blam! Oct 10 22:26:56.040 INFO blam! ---- test::test_decrypt stdout ---- Oct 10 22:26:56.040 INFO blam! thread 'test::test_decrypt' panicked at 'assertion failed: plaintext == 1311768467294899695', src/test.rs:247:5 Oct 10 22:26:56.040 INFO blam! stack backtrace: Oct 10 22:26:56.040 INFO blam! 0: 0x55e57bb7545e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h52ace5b3d4e95617 Oct 10 22:26:56.040 INFO blam! at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Oct 10 22:26:56.040 INFO blam! 1: 0x55e57bb7e306 - std::sys_common::backtrace::print::h6cfc8a66009c1cc9 Oct 10 22:26:56.040 INFO blam! at libstd/sys_common/backtrace.rs:71 Oct 10 22:26:56.040 INFO blam! at libstd/sys_common/backtrace.rs:59 Oct 10 22:26:56.040 INFO blam! 2: 0x55e57bb7905d - std::panicking::default_hook::{{closure}}::h47bedf778bf88480 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:211 Oct 10 22:26:56.040 INFO blam! 3: 0x55e57bb78d6b - std::panicking::default_hook::h1ef46fa7cd894809 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:221 Oct 10 22:26:56.040 INFO blam! 4: 0x55e57bb7970c - std::panicking::rust_panic_with_hook::h05510fde8841c579 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:476 Oct 10 22:26:56.040 INFO blam! 5: 0x55e57bb1cd9f - std::panicking::begin_panic::h5d334c0f5357a8c5 Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:410 Oct 10 22:26:56.040 INFO blam! 6: 0x55e57bb18b4b - wsu_crypt::test::test_decrypt::h1555ee0588d4c12d Oct 10 22:26:56.040 INFO blam! at src/test.rs:247 Oct 10 22:26:56.040 INFO blam! 7: 0x55e57bb18a29 - wsu_crypt::test::test_decrypt::{{closure}}::h760af62caa71989c Oct 10 22:26:56.040 INFO blam! at src/test.rs:241 Oct 10 22:26:56.040 INFO blam! 8: 0x55e57bb1ed8d - core::ops::function::FnOnce::call_once::h15ff2e5a4dad0098 Oct 10 22:26:56.040 INFO blam! at libcore/ops/function.rs:238 Oct 10 22:26:56.040 INFO blam! 9: 0x55e57bb2c3de - >::call_box::h95b7cb918af67b5d Oct 10 22:26:56.040 INFO blam! at libtest/lib.rs:1468 Oct 10 22:26:56.040 INFO blam! at libcore/ops/function.rs:238 Oct 10 22:26:56.040 INFO blam! at liballoc/boxed.rs:672 Oct 10 22:26:56.040 INFO blam! 10: 0x55e57bb894d9 - __rust_maybe_catch_panic Oct 10 22:26:56.040 INFO blam! at libpanic_unwind/lib.rs:102 Oct 10 22:26:56.040 INFO blam! 11: 0x55e57bb4cf2d - std::sys_common::backtrace::__rust_begin_short_backtrace::he1120aab928e481f Oct 10 22:26:56.040 INFO blam! at libstd/panicking.rs:289 Oct 10 22:26:56.040 INFO blam! at libstd/panic.rs:392 Oct 10 22:26:56.040 INFO blam! at libtest/lib.rs:1423 Oct 10 22:26:56.040 INFO blam! at libstd/sys_common/backtrace.rs:136 Oct 10 22:26:56.040 INFO blam! 12: 0x55e57bb4db34 - std::panicking::try::do_call::ha990a345054c2d63 Oct 10 22:26:56.040 INFO blam! at libstd/thread/mod.rs:409 Oct 10 22:26:56.041 INFO blam! at libstd/panic.rs:313 Oct 10 22:26:56.041 INFO blam! at libstd/panicking.rs:310 Oct 10 22:26:56.041 INFO blam! 13: 0x55e57bb894d9 - __rust_maybe_catch_panic Oct 10 22:26:56.041 INFO blam! at libpanic_unwind/lib.rs:102 Oct 10 22:26:56.041 INFO blam! 14: 0x55e57bb3b0f6 - >::call_box::h96125cb29a9ba44b Oct 10 22:26:56.041 INFO blam! at libstd/panicking.rs:289 Oct 10 22:26:56.041 INFO blam! at libstd/panic.rs:392 Oct 10 22:26:56.041 INFO blam! at libstd/thread/mod.rs:408 Oct 10 22:26:56.041 INFO blam! at liballoc/boxed.rs:672 Oct 10 22:26:56.041 INFO blam! 15: 0x55e57bb7749a - std::sys_common::thread::start_thread::h97c4c5d82028f6b1 Oct 10 22:26:56.041 INFO blam! at liballoc/boxed.rs:682 Oct 10 22:26:56.041 INFO blam! at libstd/sys_common/thread.rs:24 Oct 10 22:26:56.041 INFO blam! 16: 0x55e57bb6cc25 - std::sys::unix::thread::Thread::new::thread_start::he7d65efc4dd16886 Oct 10 22:26:56.041 INFO blam! at libstd/sys/unix/thread.rs:90 Oct 10 22:26:56.041 INFO blam! 17: 0x7f4ced1846b9 - start_thread Oct 10 22:26:56.041 INFO blam! 18: 0x7f4cecca441c - clone Oct 10 22:26:56.041 INFO blam! 19: 0x0 - Oct 10 22:26:56.041 INFO blam! Oct 10 22:26:56.041 INFO blam! Oct 10 22:26:56.041 INFO blam! failures: Oct 10 22:26:56.041 INFO blam! test::test_decrypt Oct 10 22:26:56.041 INFO blam! test::test_subkey_generation_for_decrypt Oct 10 22:26:56.041 INFO blam! Oct 10 22:26:56.041 INFO blam! test result: FAILED. 10 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out Oct 10 22:26:56.041 INFO blam! Oct 10 22:26:56.041 INFO kablam! error: test failed, to rerun pass '--bin wsu_crypt' Oct 10 22:26:56.041 INFO kablam! su: No module specific data is present Oct 10 22:26:56.543 INFO running `"docker" "rm" "-f" "90ed6d52ca3dc411f33b96d293b1a5e640f66fbaae4ee7aa1165aeefa53d2af8"` Oct 10 22:26:56.668 INFO blam! 90ed6d52ca3dc411f33b96d293b1a5e640f66fbaae4ee7aa1165aeefa53d2af8