Nov 18 16:46:16.795 INFO testing crux-0.3.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 16:46:16.796 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 18 16:46:17.201 INFO [stdout] e4c98b4dce98c6471053bdb2bda1d0cfdd7270ca35e96fee1a1a61e435b60091
Nov 18 16:46:17.205 INFO running `"docker" "start" "-a" "e4c98b4dce98c6471053bdb2bda1d0cfdd7270ca35e96fee1a1a61e435b60091"`
Nov 18 16:46:18.245 INFO [stderr] usermod: no changes
Nov 18 16:46:18.267 INFO [stderr]    Compiling crux v0.3.0 (/source)
Nov 18 16:46:18.703 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.44s
Nov 18 16:46:18.708 INFO [stderr] su: No module specific data is present
Nov 18 16:46:19.069 INFO running `"docker" "inspect" "e4c98b4dce98c6471053bdb2bda1d0cfdd7270ca35e96fee1a1a61e435b60091"`
Nov 18 16:46:19.221 INFO running `"docker" "rm" "-f" "e4c98b4dce98c6471053bdb2bda1d0cfdd7270ca35e96fee1a1a61e435b60091"`
Nov 18 16:46:19.447 INFO [stdout] e4c98b4dce98c6471053bdb2bda1d0cfdd7270ca35e96fee1a1a61e435b60091
Nov 18 16:46:19.451 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 18 16:46:19.748 INFO [stdout] 8ae3fdc8cee5e5f8894c501bcfcdf8c4719606b09798bfe85f50975634f9cbdb
Nov 18 16:46:19.755 INFO running `"docker" "start" "-a" "8ae3fdc8cee5e5f8894c501bcfcdf8c4719606b09798bfe85f50975634f9cbdb"`
Nov 18 16:46:21.171 INFO [stderr] usermod: no changes
Nov 18 16:46:21.215 INFO [stderr]    Compiling crux v0.3.0 (/source)
Nov 18 16:46:24.031 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.84s
Nov 18 16:46:24.031 INFO [stderr] su: No module specific data is present
Nov 18 16:46:24.714 INFO running `"docker" "inspect" "8ae3fdc8cee5e5f8894c501bcfcdf8c4719606b09798bfe85f50975634f9cbdb"`
Nov 18 16:46:25.059 INFO running `"docker" "rm" "-f" "8ae3fdc8cee5e5f8894c501bcfcdf8c4719606b09798bfe85f50975634f9cbdb"`
Nov 18 16:46:25.379 INFO [stdout] 8ae3fdc8cee5e5f8894c501bcfcdf8c4719606b09798bfe85f50975634f9cbdb
Nov 18 16:46:25.388 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 18 16:46:25.812 INFO [stdout] 2d095d46a78d96fcf6607934e98c9bc3fe0070ee8e3144cf2b700e9843cc7db5
Nov 18 16:46:25.819 INFO running `"docker" "start" "-a" "2d095d46a78d96fcf6607934e98c9bc3fe0070ee8e3144cf2b700e9843cc7db5"`
Nov 18 16:46:27.338 INFO [stderr] usermod: no changes
Nov 18 16:46:27.373 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Nov 18 16:46:27.373 INFO [stderr]      Running /target/debug/deps/crux-b5411d6ef4f7d46a
Nov 18 16:46:27.383 INFO [stderr]      Running /target/debug/deps/lib-a9e5ed767f336009
Nov 18 16:46:27.383 INFO [stdout] 
Nov 18 16:46:27.383 INFO [stdout] running 0 tests
Nov 18 16:46:27.383 INFO [stdout] 
Nov 18 16:46:27.383 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:46:27.383 INFO [stdout] 
Nov 18 16:46:27.391 INFO [stdout] 
Nov 18 16:46:27.391 INFO [stdout] running 2 tests
Nov 18 16:46:27.443 INFO [stdout] test example_async ... ok
Nov 18 16:46:27.503 INFO [stdout] test example_sync ... FAILED
Nov 18 16:46:27.503 INFO [stderr] error: test failed, to rerun pass '--test lib'
Nov 18 16:46:27.503 INFO [stdout] 
Nov 18 16:46:27.503 INFO [stderr] su: No module specific data is present
Nov 18 16:46:27.503 INFO [stdout] failures:
Nov 18 16:46:27.503 INFO [stdout] 
Nov 18 16:46:27.503 INFO [stdout] ---- example_sync stdout ----
Nov 18 16:46:27.503 INFO [stdout] thread 'example_sync' panicked at 'assertion failed: `(left == right)`
Nov 18 16:46:27.503 INFO [stdout]   left: `5`,
Nov 18 16:46:27.503 INFO [stdout]  right: `7`', tests/lib.rs:106:5
Nov 18 16:46:27.503 INFO [stdout] stack backtrace:
Nov 18 16:46:27.503 INFO [stdout]    0:     0x563bd001aa23 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h1a944b80a560daa8
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 18 16:46:27.503 INFO [stdout]    1:     0x563bd00151b8 - std::sys_common::backtrace::_print::h18f735b4c3a49bdb
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Nov 18 16:46:27.503 INFO [stdout]    2:     0x563bd0019994 - std::panicking::default_hook::{{closure}}::h97ab3548a215c097
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/panicking.rs:211
Nov 18 16:46:27.503 INFO [stdout]    3:     0x563bd001967c - std::panicking::default_hook::h98c2a01ef734e4b0
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/panicking.rs:221
Nov 18 16:46:27.503 INFO [stdout]    4:     0x563bd001a0a0 - std::panicking::rust_panic_with_hook::hb4b3f28eb79ea752
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/panicking.rs:476
Nov 18 16:46:27.503 INFO [stdout]    5:     0x563bd0019c21 - std::panicking::continue_panic_fmt::h61fd5a7b1a268752
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/panicking.rs:390
Nov 18 16:46:27.503 INFO [stdout]    6:     0x563bd0019b6e - std::panicking::begin_panic_fmt::hfa6f19d29682fcb6
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/panicking.rs:345
Nov 18 16:46:27.503 INFO [stdout]    7:     0x563bcffccf6f - lib::example_sync::hbc9b6bc6ed69a7d8
Nov 18 16:46:27.503 INFO [stdout]                                at tests/lib.rs:106
Nov 18 16:46:27.503 INFO [stdout]    8:     0x563bcffcc149 - lib::example_sync::{{closure}}::h14f0f28e185ddfb2
Nov 18 16:46:27.503 INFO [stdout]                                at tests/lib.rs:73
Nov 18 16:46:27.503 INFO [stdout]    9:     0x563bcffc59cd - core::ops::function::FnOnce::call_once::h80e5816d2ef79594
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libcore/ops/function.rs:238
Nov 18 16:46:27.503 INFO [stdout]   10:     0x563bcffd68be - <F as alloc::boxed::FnBox<A>>::call_box::h9dcb7fc9b8bb4240
Nov 18 16:46:27.503 INFO [stdout]                                at libtest/lib.rs:1471
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libcore/ops/function.rs:238
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/liballoc/boxed.rs:673
Nov 18 16:46:27.503 INFO [stdout]   11:     0x563bd0028779 - __rust_maybe_catch_panic
Nov 18 16:46:27.503 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 18 16:46:27.503 INFO [stdout]   12:     0x563bcffce923 - std::sys_common::backtrace::__rust_begin_short_backtrace::h89ea8afe71e36f86
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panicking.rs:289
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panic.rs:398
Nov 18 16:46:27.503 INFO [stdout]                                at libtest/lib.rs:1426
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/sys_common/backtrace.rs:136
Nov 18 16:46:27.503 INFO [stdout]   13:     0x563bcffcf7d4 - std::panicking::try::do_call::h4132042e0cbea3ae
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/thread/mod.rs:477
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panic.rs:319
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panicking.rs:310
Nov 18 16:46:27.503 INFO [stdout]   14:     0x563bd0028779 - __rust_maybe_catch_panic
Nov 18 16:46:27.503 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 18 16:46:27.503 INFO [stdout]   15:     0x563bcffd69ec - <F as alloc::boxed::FnBox<A>>::call_box::hab7f616f05880bf6
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panicking.rs:289
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panic.rs:398
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/thread/mod.rs:476
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/liballoc/boxed.rs:673
Nov 18 16:46:27.503 INFO [stdout]   16:     0x563bd001c65d - std::sys::unix::thread::Thread::new::thread_start::h5f8d67158a1ca038
Nov 18 16:46:27.503 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/liballoc/boxed.rs:683
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Nov 18 16:46:27.503 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Nov 18 16:46:27.503 INFO [stdout]   17:     0x7f5d68cf16b9 - start_thread
Nov 18 16:46:27.503 INFO [stdout]   18:     0x7f5d6881141c - clone
Nov 18 16:46:27.503 INFO [stdout]   19:                0x0 - <unknown>
Nov 18 16:46:27.503 INFO [stdout] 
Nov 18 16:46:27.503 INFO [stdout] 
Nov 18 16:46:27.503 INFO [stdout] failures:
Nov 18 16:46:27.503 INFO [stdout]     example_sync
Nov 18 16:46:27.503 INFO [stdout] 
Nov 18 16:46:27.503 INFO [stdout] test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:46:27.503 INFO [stdout] 
Nov 18 16:46:28.109 INFO running `"docker" "inspect" "2d095d46a78d96fcf6607934e98c9bc3fe0070ee8e3144cf2b700e9843cc7db5"`
Nov 18 16:46:28.487 INFO running `"docker" "rm" "-f" "2d095d46a78d96fcf6607934e98c9bc3fe0070ee8e3144cf2b700e9843cc7db5"`
Nov 18 16:46:28.871 INFO [stdout] 2d095d46a78d96fcf6607934e98c9bc3fe0070ee8e3144cf2b700e9843cc7db5