Nov 17 22:06:05.493 INFO testing spin-0.4.9 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982 Nov 17 22:06:05.494 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 22:06:05.972 INFO [stdout] 6d1f4e28de35234990c9881fb4db3aa5fd26ce77ae267c46639ad1d9d84f6aa0 Nov 17 22:06:05.979 INFO running `"docker" "start" "-a" "6d1f4e28de35234990c9881fb4db3aa5fd26ce77ae267c46639ad1d9d84f6aa0"` Nov 17 22:06:07.070 INFO [stderr] usermod: no changes Nov 17 22:06:07.115 INFO [stderr] Compiling spin v0.4.9 (/source) Nov 17 22:06:07.354 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.26s Nov 17 22:06:07.356 INFO [stderr] su: No module specific data is present Nov 17 22:06:07.880 INFO running `"docker" "inspect" "6d1f4e28de35234990c9881fb4db3aa5fd26ce77ae267c46639ad1d9d84f6aa0"` Nov 17 22:06:08.165 INFO running `"docker" "rm" "-f" "6d1f4e28de35234990c9881fb4db3aa5fd26ce77ae267c46639ad1d9d84f6aa0"` Nov 17 22:06:08.368 INFO [stdout] 6d1f4e28de35234990c9881fb4db3aa5fd26ce77ae267c46639ad1d9d84f6aa0 Nov 17 22:06:08.371 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 22:06:08.807 INFO [stdout] 50d96a5e2e962f4547c4ab7983746b1fa13718ee7e766c36d47f4aaed85f07da Nov 17 22:06:08.815 INFO running `"docker" "start" "-a" "50d96a5e2e962f4547c4ab7983746b1fa13718ee7e766c36d47f4aaed85f07da"` Nov 17 22:06:10.670 INFO [stderr] usermod: no changes Nov 17 22:06:10.747 INFO [stderr] Compiling spin v0.4.9 (/source) Nov 17 22:06:13.623 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.92s Nov 17 22:06:13.623 INFO [stderr] su: No module specific data is present Nov 17 22:06:14.515 INFO running `"docker" "inspect" "50d96a5e2e962f4547c4ab7983746b1fa13718ee7e766c36d47f4aaed85f07da"` Nov 17 22:06:14.855 INFO running `"docker" "rm" "-f" "50d96a5e2e962f4547c4ab7983746b1fa13718ee7e766c36d47f4aaed85f07da"` Nov 17 22:06:15.082 INFO [stdout] 50d96a5e2e962f4547c4ab7983746b1fa13718ee7e766c36d47f4aaed85f07da Nov 17 22:06:15.091 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 22:06:15.573 INFO [stdout] 7276d74821fb94ece30d51e53d2afd7b705d07f9d385ea87440590c00964ff26 Nov 17 22:06:15.576 INFO running `"docker" "start" "-a" "7276d74821fb94ece30d51e53d2afd7b705d07f9d385ea87440590c00964ff26"` Nov 17 22:06:16.611 INFO [stderr] usermod: no changes Nov 17 22:06:16.655 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.01s Nov 17 22:06:16.657 INFO [stderr] Running /target/debug/deps/spin-1a375bbfe757f2ca Nov 17 22:06:16.666 INFO [stdout] Nov 17 22:06:16.666 INFO [stdout] running 25 tests Nov 17 22:06:16.669 INFO [stdout] test mutex::tests::test_mutex_unsized ... ok Nov 17 22:06:16.670 INFO [stdout] test mutex::tests::test_into_inner ... ok Nov 17 22:06:16.670 INFO [stdout] test mutex::tests::test_mutex_force_lock ... ok Nov 17 22:06:16.670 INFO [stdout] test mutex::tests::smoke ... ok Nov 17 22:06:16.670 INFO [stdout] test mutex::tests::try_lock ... ok Nov 17 22:06:16.670 INFO [stdout] test mutex::tests::test_into_inner_drop ... ok Nov 17 22:06:16.671 INFO [stderr] thread '' panicked at 'explicit panic', src/mutex.rs:391:13 Nov 17 22:06:16.671 INFO [stderr] stack backtrace: Nov 17 22:06:16.671 INFO [stdout] test mutex::tests::test_mutex_arc_nested ... ok Nov 17 22:06:16.690 INFO [stdout] test once::tests::smoke_once ... ok Nov 17 22:06:16.690 INFO [stdout] test once::tests::smoke_once_value ... ok Nov 17 22:06:16.691 INFO [stdout] test once::tests::try ... ok Nov 17 22:06:16.691 INFO [stdout] test mutex::tests::lots_and_lots ... ok Nov 17 22:06:16.695 INFO [stdout] test rw_lock::tests::smoke ... ok Nov 17 22:06:16.695 INFO [stdout] test rw_lock::tests::test_force_read_decrement ... ok Nov 17 22:06:16.695 INFO [stdout] test once::tests::try_no_wait ... ok Nov 17 22:06:16.707 INFO [stdout] test rw_lock::tests::test_into_inner ... ok Nov 17 22:06:16.707 INFO [stderr] 0: 0x55a995ef1ad3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h26df0f6fdb27c709 Nov 17 22:06:16.707 INFO [stdout] test rw_lock::tests::test_into_inner_drop ... ok Nov 17 22:06:16.719 INFO [stdout] test once::tests::wait ... ok Nov 17 22:06:16.719 INFO [stdout] test rw_lock::tests::test_force_write_unlock ... ok Nov 17 22:06:16.719 INFO [stdout] test rw_lock::tests::test_rwlock_try_write ... ok Nov 17 22:06:16.731 INFO [stdout] test rw_lock::tests::test_rw_arc ... ok Nov 17 22:06:16.731 INFO [stderr] thread '' panicked at 'explicit panic', src/rw_lock.rs:491:13 Nov 17 22:06:16.731 INFO [stdout] test rw_lock::tests::test_rwlock_unsized ... ok Nov 17 22:06:16.731 INFO [stdout] test once::tests::stampede_once ... ok Nov 17 22:06:16.807 INFO [stdout] test mutex::tests::test_mutex_arc_access_in_unwind ... ok Nov 17 22:06:16.807 INFO [stderr] at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Nov 17 22:06:16.807 INFO [stderr] 1: 0x55a995eec3a8 - std::sys_common::backtrace::_print::h84c40fecda6d638e Nov 17 22:06:16.807 INFO [stderr] at libstd/sys_common/backtrace.rs:71 Nov 17 22:06:16.807 INFO [stderr] 2: 0x55a995ef0a44 - std::panicking::default_hook::{{closure}}::h77e370c0567fc0a7 Nov 17 22:06:16.807 INFO [stderr] at libstd/sys_common/backtrace.rs:59 Nov 17 22:06:16.807 INFO [stderr] at libstd/panicking.rs:211 Nov 17 22:06:16.807 INFO [stderr] 3: 0x55a995ef07ad - std::panicking::default_hook::hb9a45c11a33bbcb2 Nov 17 22:06:16.807 INFO [stderr] at libstd/panicking.rs:227 Nov 17 22:06:16.807 INFO [stderr] 4: 0x55a995ef1150 - std::panicking::rust_panic_with_hook::ha8d95048d940f754 Nov 17 22:06:16.807 INFO [stderr] at libstd/panicking.rs:476 Nov 17 22:06:16.807 INFO [stderr] 5: 0x55a995e7b3b3 - std::panicking::begin_panic::hc9ce0b130a3a82e8 Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:410 Nov 17 22:06:16.807 INFO [stderr] 6: 0x55a995e7ae4a - spin::mutex::tests::test_mutex_arc_access_in_unwind::{{closure}}::hffeb90094a7fe970 Nov 17 22:06:16.807 INFO [stderr] at src/mutex.rs:391 Nov 17 22:06:16.807 INFO [stderr] 7: 0x55a995e7cf42 - std::sys_common::backtrace::__rust_begin_short_backtrace::h537424c21f5f7a9c Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/sys_common/backtrace.rs:136 Nov 17 22:06:16.807 INFO [stderr] 8: 0x55a995e95f3d - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h4db3fbec79288a3a Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:477 Nov 17 22:06:16.807 INFO [stderr] 9: 0x55a995e74810 - as core::ops::function::FnOnce<()>>::call_once::h91b95034168049a0 Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:319 Nov 17 22:06:16.807 INFO [stderr] 10: 0x55a995e7c044 - std::panicking::try::do_call::hc444ce5143021caf Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:310 Nov 17 22:06:16.807 INFO [stderr] 11: 0x55a995eff9d9 - __rust_maybe_catch_panic Nov 17 22:06:16.807 INFO [stderr] at libpanic_unwind/lib.rs:102 Nov 17 22:06:16.807 INFO [stderr] 12: 0x55a995e7ba4d - std::panicking::try::ha31ff7285359b76e Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289 Nov 17 22:06:16.807 INFO [stderr] 13: 0x55a995e74c02 - std::panic::catch_unwind::hcec2347e600c5050 Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398 Nov 17 22:06:16.807 INFO [stderr] 14: 0x55a995e95a0c - std::thread::Builder::spawn_unchecked::{{closure}}::hb11a88c47ce74f98 Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:476 Nov 17 22:06:16.807 INFO [stderr] 15: 0x55a995e968e6 - >::call_box::hebced61182a6f694 Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673 Nov 17 22:06:16.807 INFO [stderr] 16: 0x55a995ef381d - std::sys::unix::thread::Thread::new::thread_start::h8526625243d2f13b Nov 17 22:06:16.807 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:683 Nov 17 22:06:16.807 INFO [stderr] at libstd/sys_common/thread.rs:24 Nov 17 22:06:16.807 INFO [stderr] at libstd/sys/unix/thread.rs:90 Nov 17 22:06:16.807 INFO [stderr] 17: 0x7f07e2ba06b9 - start_thread Nov 17 22:06:16.807 INFO [stderr] 18: 0x7f07e26c041c - clone Nov 17 22:06:16.807 INFO [stderr] 19: 0x0 - Nov 17 22:06:16.825 INFO [stderr] stack backtrace: Nov 17 22:06:16.825 INFO [stderr] 0: 0x55a995ef1ad3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h26df0f6fdb27c709 Nov 17 22:06:16.826 INFO [stderr] at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Nov 17 22:06:16.827 INFO [stderr] 1: 0x55a995eec3a8 - std::sys_common::backtrace::_print::h84c40fecda6d638e Nov 17 22:06:16.827 INFO [stdout] test rw_lock::tests::test_rw_arc_access_in_unwind ... ok Nov 17 22:06:16.827 INFO [stderr] at libstd/sys_common/backtrace.rs:71 Nov 17 22:06:16.827 INFO [stderr] 2: 0x55a995ef0a44 - std::panicking::default_hook::{{closure}}::h77e370c0567fc0a7 Nov 17 22:06:16.827 INFO [stderr] at libstd/sys_common/backtrace.rs:59 Nov 17 22:06:16.827 INFO [stderr] at libstd/panicking.rs:211 Nov 17 22:06:16.827 INFO [stderr] 3: 0x55a995ef07ad - std::panicking::default_hook::hb9a45c11a33bbcb2 Nov 17 22:06:16.827 INFO [stderr] at libstd/panicking.rs:227 Nov 17 22:06:16.827 INFO [stderr] 4: 0x55a995ef1150 - std::panicking::rust_panic_with_hook::ha8d95048d940f754 Nov 17 22:06:16.827 INFO [stderr] at libstd/panicking.rs:476 Nov 17 22:06:16.827 INFO [stderr] 5: 0x55a995e7b3b3 - std::panicking::begin_panic::hc9ce0b130a3a82e8 Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:410 Nov 17 22:06:16.827 INFO [stderr] 6: 0x55a995e7fd6a - spin::rw_lock::tests::test_rw_arc_access_in_unwind::{{closure}}::h0ec533e10cfd4c2e Nov 17 22:06:16.827 INFO [stderr] at src/rw_lock.rs:491 Nov 17 22:06:16.827 INFO [stderr] 7: 0x55a995e7cf62 - std::sys_common::backtrace::__rust_begin_short_backtrace::h80c61d8848a3990c Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/sys_common/backtrace.rs:136 Nov 17 22:06:16.827 INFO [stderr] 8: 0x55a995e95fad - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hc681feb93a5fe3d7 Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:477 Nov 17 22:06:16.827 INFO [stderr] 9: 0x55a995e74780 - as core::ops::function::FnOnce<()>>::call_once::h3370b15874d9de55 Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:319 Nov 17 22:06:16.827 INFO [stderr] 10: 0x55a995e7be74 - std::panicking::try::do_call::h1c7e1cce8b24182c Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:310 Nov 17 22:06:16.827 INFO [stderr] 11: 0x55a995eff9d9 - __rust_maybe_catch_panic Nov 17 22:06:16.827 INFO [stderr] at libpanic_unwind/lib.rs:102 Nov 17 22:06:16.827 INFO [stderr] 12: 0x55a995e7b61d - std::panicking::try::h448e03b8556c3f59 Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panicking.rs:289 Nov 17 22:06:16.827 INFO [stderr] 13: 0x55a995e74b52 - std::panic::catch_unwind::h704e60f6d8163585 Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/panic.rs:398 Nov 17 22:06:16.827 INFO [stderr] 14: 0x55a995e950dc - std::thread::Builder::spawn_unchecked::{{closure}}::h9b8f016ea79e1e37 Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/libstd/thread/mod.rs:476 Nov 17 22:06:16.827 INFO [stderr] 15: 0x55a995e967b6 - >::call_box::h64e0232e5995499a Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:673 Nov 17 22:06:16.827 INFO [stderr] 16: 0x55a995ef381d - std::sys::unix::thread::Thread::new::thread_start::h8526625243d2f13b Nov 17 22:06:16.827 INFO [stderr] at /rustc/2e026d6e5d7621634147ad4c8074f1d964dbb1be/src/liballoc/boxed.rs:683 Nov 17 22:06:16.827 INFO [stderr] at libstd/sys_common/thread.rs:24 Nov 17 22:06:16.827 INFO [stderr] at libstd/sys/unix/thread.rs:90 Nov 17 22:06:16.827 INFO [stderr] 17: 0x7f07e2ba06b9 - start_thread Nov 17 22:06:16.827 INFO [stderr] 18: 0x7f07e26c041c - clone Nov 17 22:06:16.827 INFO [stderr] 19: 0x0 - Nov 17 22:06:16.827 INFO [stdout] test once::tests::panic ... ok Nov 17 22:06:16.827 INFO [stdout] Nov 17 22:06:16.827 INFO [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 22:06:16.827 INFO [stdout] Nov 17 22:06:16.833 INFO [stderr] Doc-tests spin Nov 17 22:06:16.975 INFO [stdout] Nov 17 22:06:16.975 INFO [stdout] running 12 tests Nov 17 22:06:20.330 INFO [stdout] test src/once.rs - once::Once::call_once (line 70) ... ok Nov 17 22:06:20.459 INFO [stdout] test src/once.rs - once::Once (line 11) ... ok Nov 17 22:06:21.488 INFO [stdout] test src/mutex.rs - mutex::Mutex::new (line 103) ... ok Nov 17 22:06:21.815 INFO [stdout] test src/rw_lock.rs - rw_lock::RwLock (line 25) ... ok Nov 17 22:06:21.822 INFO [stdout] test src/mutex.rs - mutex::Mutex::lock (line 177) ... ok Nov 17 22:06:21.903 INFO [stdout] test src/rw_lock.rs - rw_lock::RwLock::new (line 82) ... ok Nov 17 22:06:21.999 INFO [stdout] test src/mutex.rs - mutex::Mutex (line 26) ... ok Nov 17 22:06:23.071 INFO [stdout] test src/mutex.rs - mutex::Mutex (line 48) ... ok Nov 17 22:06:23.718 INFO [stdout] test src/rw_lock.rs - rw_lock::RwLock::read (line 154) ... ok Nov 17 22:06:23.846 INFO [stdout] test src/rw_lock.rs - rw_lock::RwLock::try_read (line 205) ... ok Nov 17 22:06:24.028 INFO [stdout] test src/rw_lock.rs - rw_lock::RwLock::try_write (line 310) ... ok Nov 17 22:06:24.161 INFO [stdout] test src/rw_lock.rs - rw_lock::RwLock::write (line 269) ... ok Nov 17 22:06:24.161 INFO [stdout] Nov 17 22:06:24.161 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 22:06:24.161 INFO [stdout] Nov 17 22:06:24.180 INFO [stderr] su: No module specific data is present Nov 17 22:06:24.561 INFO running `"docker" "inspect" "7276d74821fb94ece30d51e53d2afd7b705d07f9d385ea87440590c00964ff26"` Nov 17 22:06:24.660 INFO running `"docker" "rm" "-f" "7276d74821fb94ece30d51e53d2afd7b705d07f9d385ea87440590c00964ff26"` Nov 17 22:06:24.766 INFO [stdout] 7276d74821fb94ece30d51e53d2afd7b705d07f9d385ea87440590c00964ff26