Dec 15 05:04:32.943 INFO testing mcs-0.1.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 05:04:32.943 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 05:04:33.196 INFO [stdout] 4a680398ba50d3823df93fa8bcf217e71441e656e4bf708dec79caf490013a36
Dec 15 05:04:33.203 INFO running `"docker" "start" "-a" "4a680398ba50d3823df93fa8bcf217e71441e656e4bf708dec79caf490013a36"`
Dec 15 05:04:34.075 INFO [stderr] usermod: no changes
Dec 15 05:04:34.109 INFO [stderr]    Compiling mcs v0.1.1 (/source)
Dec 15 05:04:34.311 INFO [stderr] warning: unnecessary `unsafe` block
Dec 15 05:04:34.311 INFO [stderr]    --> src/mutex.rs:117:9
Dec 15 05:04:34.311 INFO [stderr]     |
Dec 15 05:04:34.311 INFO [stderr] 117 |         unsafe {
Dec 15 05:04:34.311 INFO [stderr]     |         ^^^^^^ unnecessary `unsafe` block
Dec 15 05:04:34.311 INFO [stderr]     |
Dec 15 05:04:34.311 INFO [stderr]     = note: #[warn(unused_unsafe)] on by default
Dec 15 05:04:34.311 INFO [stderr] 
Dec 15 05:04:34.311 INFO [stderr] warning: the feature `generic_param_attrs` has been stable since 1.27.0 and no longer requires an attribute to enable
Dec 15 05:04:34.311 INFO [stderr]  --> src/lib.rs:1:58
Dec 15 05:04:34.311 INFO [stderr]   |
Dec 15 05:04:34.311 INFO [stderr] 1 | #![cfg_attr(feature = "unstable", feature(asm, const_fn, generic_param_attrs, dropck_eyepatch))]
Dec 15 05:04:34.311 INFO [stderr]   |                                                          ^^^^^^^^^^^^^^^^^^^
Dec 15 05:04:34.311 INFO [stderr]   |
Dec 15 05:04:34.311 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 15 05:04:34.311 INFO [stderr] 
Dec 15 05:04:34.365 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.27s
Dec 15 05:04:34.379 INFO [stderr] su: No module specific data is present
Dec 15 05:04:34.800 INFO running `"docker" "inspect" "4a680398ba50d3823df93fa8bcf217e71441e656e4bf708dec79caf490013a36"`
Dec 15 05:04:35.031 INFO running `"docker" "rm" "-f" "4a680398ba50d3823df93fa8bcf217e71441e656e4bf708dec79caf490013a36"`
Dec 15 05:04:35.355 INFO [stdout] 4a680398ba50d3823df93fa8bcf217e71441e656e4bf708dec79caf490013a36
Dec 15 05:04:35.361 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 05:04:35.639 INFO [stdout] 900981f8c880a812b5d82cefa2dad916b3c20d14c5a6e6684718c77c0a901c9b
Dec 15 05:04:35.644 INFO running `"docker" "start" "-a" "900981f8c880a812b5d82cefa2dad916b3c20d14c5a6e6684718c77c0a901c9b"`
Dec 15 05:04:36.403 INFO [stderr] usermod: no changes
Dec 15 05:04:36.432 INFO [stderr]    Compiling mcs v0.1.1 (/source)
Dec 15 05:04:37.082 INFO [stderr] warning: unnecessary `unsafe` block
Dec 15 05:04:37.082 INFO [stderr]    --> src/mutex.rs:117:9
Dec 15 05:04:37.082 INFO [stderr]     |
Dec 15 05:04:37.082 INFO [stderr] 117 |         unsafe {
Dec 15 05:04:37.082 INFO [stderr]     |         ^^^^^^ unnecessary `unsafe` block
Dec 15 05:04:37.082 INFO [stderr]     |
Dec 15 05:04:37.082 INFO [stderr]     = note: #[warn(unused_unsafe)] on by default
Dec 15 05:04:37.082 INFO [stderr] 
Dec 15 05:04:37.082 INFO [stderr] warning: the feature `generic_param_attrs` has been stable since 1.27.0 and no longer requires an attribute to enable
Dec 15 05:04:37.082 INFO [stderr]  --> src/lib.rs:1:58
Dec 15 05:04:37.082 INFO [stderr]   |
Dec 15 05:04:37.082 INFO [stderr] 1 | #![cfg_attr(feature = "unstable", feature(asm, const_fn, generic_param_attrs, dropck_eyepatch))]
Dec 15 05:04:37.082 INFO [stderr]   |                                                          ^^^^^^^^^^^^^^^^^^^
Dec 15 05:04:37.082 INFO [stderr]   |
Dec 15 05:04:37.082 INFO [stderr]   = note: #[warn(stable_features)] on by default
Dec 15 05:04:37.082 INFO [stderr] 
Dec 15 05:04:37.860 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.44s
Dec 15 05:04:37.863 INFO [stderr] su: No module specific data is present
Dec 15 05:04:38.172 INFO running `"docker" "inspect" "900981f8c880a812b5d82cefa2dad916b3c20d14c5a6e6684718c77c0a901c9b"`
Dec 15 05:04:38.344 INFO running `"docker" "rm" "-f" "900981f8c880a812b5d82cefa2dad916b3c20d14c5a6e6684718c77c0a901c9b"`
Dec 15 05:04:38.455 INFO [stdout] 900981f8c880a812b5d82cefa2dad916b3c20d14c5a6e6684718c77c0a901c9b
Dec 15 05:04:38.457 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 15 05:04:38.678 INFO [stdout] afc8ed552b27ddce7f2b30cb509aa51af9e38aaedc67a18616e73597839918f4
Dec 15 05:04:38.680 INFO running `"docker" "start" "-a" "afc8ed552b27ddce7f2b30cb509aa51af9e38aaedc67a18616e73597839918f4"`
Dec 15 05:04:39.548 INFO [stderr] usermod: no changes
Dec 15 05:04:39.636 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 05:04:39.653 INFO [stderr]      Running /target/debug/deps/mcs-f0022dd880ad1097
Dec 15 05:04:39.660 INFO [stdout] 
Dec 15 05:04:39.660 INFO [stdout] running 9 tests
Dec 15 05:04:39.660 INFO [stdout] test mutex::test::test_into_inner_drop ... ok
Dec 15 05:04:39.660 INFO [stdout] test mutex::test::test_into_inner ... ok
Dec 15 05:04:39.660 INFO [stdout] test mutex::test::test_get_mut ... ok
Dec 15 05:04:39.661 INFO [stdout] test mutex::test::try_lock ... ok
Dec 15 05:04:39.662 INFO [stdout] test mutex::test::lots_and_lots ... ok
Dec 15 05:04:39.663 INFO [stdout] test mutex::test::test_lock_unsized ... ok
Dec 15 05:04:39.663 INFO [stdout] test mutex::test::smoke ... ok
Dec 15 05:04:39.667 INFO [stderr] thread '<unnamed>' panicked at 'explicit panic', src/mutex.rs:384:13
Dec 15 05:04:39.667 INFO [stderr] stack backtrace:
Dec 15 05:04:39.685 INFO [stderr]    0:     0x559a29da2f13 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h2c40bdfb30f25bdd
Dec 15 05:04:39.687 INFO [stdout] test mutex::test::test_lock_arc_nested ... ok
Dec 15 05:04:39.739 INFO [stderr]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 15 05:04:39.743 INFO [stderr]    1:     0x559a29d9d718 - std::sys_common::backtrace::_print::he11ceebc70626ac9
Dec 15 05:04:39.744 INFO [stderr]                                at src/libstd/sys_common/backtrace.rs:71
Dec 15 05:04:39.745 INFO [stderr]    2:     0x559a29da1e82 - std::panicking::default_hook::{{closure}}::h4fde3ffb19c01413
Dec 15 05:04:39.745 INFO [stderr]                                at src/libstd/sys_common/backtrace.rs:59
Dec 15 05:04:39.746 INFO [stderr]                                at src/libstd/panicking.rs:210
Dec 15 05:04:39.746 INFO [stderr]    3:     0x559a29da1bf4 - std::panicking::default_hook::hf0c15a583008ed0d
Dec 15 05:04:39.747 INFO [stderr]                                at src/libstd/panicking.rs:224
Dec 15 05:04:39.747 INFO [stderr]    4:     0x559a29da2590 - std::panicking::rust_panic_with_hook::hc1663f6bc7813185
Dec 15 05:04:39.747 INFO [stderr]                                at src/libstd/panicking.rs:487
Dec 15 05:04:39.748 INFO [stderr]    5:     0x559a29da2111 - std::panicking::continue_panic_fmt::h42bc2d03ddf03b3e
Dec 15 05:04:39.748 INFO [stderr]                                at src/libstd/panicking.rs:394
Dec 15 05:04:39.748 INFO [stderr]    6:     0x559a29da1ff5 - rust_begin_unwind
Dec 15 05:04:39.749 INFO [stderr]                                at src/libstd/panicking.rs:321
Dec 15 05:04:39.749 INFO [stderr]    7:     0x559a29db23bc - core::panicking::panic_fmt::h44df04385fc0c5a6
Dec 15 05:04:39.763 INFO [stderr]                                at src/libcore/panicking.rs:95
Dec 15 05:04:39.764 INFO [stderr]    8:     0x559a29db22eb - core::panicking::panic::h9bf4acd59e412f30
Dec 15 05:04:39.765 INFO [stderr]                                at src/libcore/panicking.rs:59
Dec 15 05:04:39.765 INFO [stderr]    9:     0x559a29d48732 - mcs::mutex::test::test_lock_arc_access_in_unwind::{{closure}}::h0c17e5c7a1bf501e
Dec 15 05:04:39.766 INFO [stderr]                                at src/mutex.rs:384
Dec 15 05:04:39.767 INFO [stderr]   10:     0x559a29d4e052 - std::sys_common::backtrace::__rust_begin_short_backtrace::h416d392cd7a111ba
Dec 15 05:04:39.768 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/sys_common/backtrace.rs:136
Dec 15 05:04:39.769 INFO [stderr]   11:     0x559a29d4182d - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hff8164ee4b679824
Dec 15 05:04:39.770 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:479
Dec 15 05:04:39.771 INFO [stderr]   12:     0x559a29d55070 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h306f27934aede63a
Dec 15 05:04:39.772 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:319
Dec 15 05:04:39.774 INFO [stderr]   13:     0x559a29d4e554 - std::panicking::try::do_call::h34fefa421a5baf01
Dec 15 05:04:39.779 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:306
Dec 15 05:04:39.780 INFO [stderr]   14:     0x559a29db0bf9 - __rust_maybe_catch_panic
Dec 15 05:04:39.782 INFO [stderr]                                at src/libpanic_unwind/lib.rs:102
Dec 15 05:04:39.783 INFO [stderr]   15:     0x559a29d4e14d - std::panicking::try::h78de5dc1f73e01f0
Dec 15 05:04:39.785 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panicking.rs:285
Dec 15 05:04:39.785 INFO [stderr]   16:     0x559a29d55302 - std::panic::catch_unwind::h02799f8cb37968ec
Dec 15 05:04:39.785 INFO [stdout] test mutex::test::test_lock_arc_access_in_unwind ... ok
Dec 15 05:04:39.785 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/panic.rs:398
Dec 15 05:04:39.785 INFO [stdout] 
Dec 15 05:04:39.785 INFO [stderr]   17:     0x559a29d415b5 - std::thread::Builder::spawn_unchecked::{{closure}}::haee86d004ff96fd3
Dec 15 05:04:39.785 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:04:39.785 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/libstd/thread/mod.rs:478
Dec 15 05:04:39.785 INFO [stdout] 
Dec 15 05:04:39.785 INFO [stderr]   18:     0x559a29d41b66 - <F as alloc::boxed::FnBox<A>>::call_box::h61f1ceb59fe05252
Dec 15 05:04:39.785 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:673
Dec 15 05:04:39.785 INFO [stderr]   19:     0x559a29da4b1d - std::sys::unix::thread::Thread::new::thread_start::h42c32b292fdd228f
Dec 15 05:04:39.785 INFO [stderr]                                at /rustc/aa49d8ef14939ddec0e34b346b60174a5673d48f/src/liballoc/boxed.rs:683
Dec 15 05:04:39.785 INFO [stderr]                                at src/libstd/sys_common/thread.rs:24
Dec 15 05:04:39.785 INFO [stderr]                                at src/libstd/sys/unix/thread.rs:91
Dec 15 05:04:39.785 INFO [stderr]   20:     0x7f28683fe6b9 - start_thread
Dec 15 05:04:39.785 INFO [stderr]   21:     0x7f2867f1e41c - clone
Dec 15 05:04:39.785 INFO [stderr]   22:                0x0 - <unknown>
Dec 15 05:04:39.787 INFO [stderr]    Doc-tests mcs
Dec 15 05:04:40.071 INFO [stdout] 
Dec 15 05:04:40.071 INFO [stdout] running 1 test
Dec 15 05:04:41.981 INFO [stdout] test src/mutex.rs - mutex::Mutex (line 34) ... ok
Dec 15 05:04:41.981 INFO [stdout] 
Dec 15 05:04:41.981 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 05:04:41.981 INFO [stdout] 
Dec 15 05:04:42.003 INFO [stderr] su: No module specific data is present
Dec 15 05:04:42.951 INFO running `"docker" "inspect" "afc8ed552b27ddce7f2b30cb509aa51af9e38aaedc67a18616e73597839918f4"`
Dec 15 05:04:43.333 INFO running `"docker" "rm" "-f" "afc8ed552b27ddce7f2b30cb509aa51af9e38aaedc67a18616e73597839918f4"`
Dec 15 05:04:43.616 INFO [stdout] afc8ed552b27ddce7f2b30cb509aa51af9e38aaedc67a18616e73597839918f4