[INFO] fetching crate popol 3.0.0... [INFO] testing popol-3.0.0 against try#f23b22458132fb20faeb8a915b1c252478696f25 for pr-131095 [INFO] extracting crate popol 3.0.0 into /workspace/builds/worker-7-tc2/source [INFO] validating manifest of crates.io crate popol 3.0.0 on toolchain f23b22458132fb20faeb8a915b1c252478696f25 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+f23b22458132fb20faeb8a915b1c252478696f25" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] removed /workspace/builds/worker-7-tc2/source/rust-toolchain [INFO] started tweaking crates.io crate popol 3.0.0 [INFO] finished tweaking crates.io crate popol 3.0.0 [INFO] tweaked toml for crates.io crate popol 3.0.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml [INFO] crate crates.io crate popol 3.0.0 already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+f23b22458132fb20faeb8a915b1c252478696f25" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:6252d7ea7fb8caaf7af6d800c5fb250a9cd862b9a7f9508afb3c54fa7fe1102e" "/opt/rustwide/cargo-home/bin/cargo" "+f23b22458132fb20faeb8a915b1c252478696f25" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] cefbd7803d2d9f505d81805d0489a6e435ccd86be16f11581a2ea41554e9dbef [INFO] running `Command { std: "docker" "start" "-a" "cefbd7803d2d9f505d81805d0489a6e435ccd86be16f11581a2ea41554e9dbef", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "cefbd7803d2d9f505d81805d0489a6e435ccd86be16f11581a2ea41554e9dbef", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "cefbd7803d2d9f505d81805d0489a6e435ccd86be16f11581a2ea41554e9dbef", kill_on_drop: false }` [INFO] [stdout] cefbd7803d2d9f505d81805d0489a6e435ccd86be16f11581a2ea41554e9dbef [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:6252d7ea7fb8caaf7af6d800c5fb250a9cd862b9a7f9508afb3c54fa7fe1102e" "/opt/rustwide/cargo-home/bin/cargo" "+f23b22458132fb20faeb8a915b1c252478696f25" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0df775517e83ce501b99201838d67b340a042fc041d1b203cef1d053702dfa5a [INFO] running `Command { std: "docker" "start" "-a" "0df775517e83ce501b99201838d67b340a042fc041d1b203cef1d053702dfa5a", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.139 [INFO] [stderr] Compiling popol v3.0.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.01s [INFO] running `Command { std: "docker" "inspect" "0df775517e83ce501b99201838d67b340a042fc041d1b203cef1d053702dfa5a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0df775517e83ce501b99201838d67b340a042fc041d1b203cef1d053702dfa5a", kill_on_drop: false }` [INFO] [stdout] 0df775517e83ce501b99201838d67b340a042fc041d1b203cef1d053702dfa5a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:6252d7ea7fb8caaf7af6d800c5fb250a9cd862b9a7f9508afb3c54fa7fe1102e" "/opt/rustwide/cargo-home/bin/cargo" "+f23b22458132fb20faeb8a915b1c252478696f25" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 15f8e03af99f41c6894cf24f4d9b96365a08cdfc0a16ed51802e5bfb6b86f9f1 [INFO] running `Command { std: "docker" "start" "-a" "15f8e03af99f41c6894cf24f4d9b96365a08cdfc0a16ed51802e5bfb6b86f9f1", kill_on_drop: false }` [INFO] [stderr] Compiling popol v3.0.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.93s [INFO] running `Command { std: "docker" "inspect" "15f8e03af99f41c6894cf24f4d9b96365a08cdfc0a16ed51802e5bfb6b86f9f1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "15f8e03af99f41c6894cf24f4d9b96365a08cdfc0a16ed51802e5bfb6b86f9f1", kill_on_drop: false }` [INFO] [stdout] 15f8e03af99f41c6894cf24f4d9b96365a08cdfc0a16ed51802e5bfb6b86f9f1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:6252d7ea7fb8caaf7af6d800c5fb250a9cd862b9a7f9508afb3c54fa7fe1102e" "/opt/rustwide/cargo-home/bin/cargo" "+f23b22458132fb20faeb8a915b1c252478696f25" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8e1a91656079efa95e5ffd14127206685d89cc7abe059e4996bf01295df722da [INFO] running `Command { std: "docker" "start" "-a" "8e1a91656079efa95e5ffd14127206685d89cc7abe059e4996bf01295df722da", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.01s [INFO] [stdout] [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/popol-b0e13aac2b611efb) [INFO] [stdout] running 8 tests [INFO] [stdout] test tests::test_empty ... ok [INFO] [stdout] test tests::test_readable ... ok [INFO] [stdout] test tests::test_unregister ... ok [INFO] [stdout] test tests::test_timeout ... ok [INFO] [stdout] test tests::test_set ... ok [INFO] [stdout] test tests::test_waker ... ok [INFO] [stdout] test tests::test_threaded ... ok [INFO] [stdout] test tests::test_waker_threaded ... FAILED [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::test_waker_threaded stdout ---- [INFO] [stdout] thread 'tests::test_waker_threaded' panicked at src/lib.rs:1003:48: [INFO] [stdout] called `Result::unwrap_err()` on an `Ok` value: () [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5f63981ca00a - std::backtrace_rs::backtrace::libunwind::trace::h24270b8ca84976f5 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x5f63981ca00a - std::backtrace_rs::backtrace::trace_unsynchronized::h02001f29f8a7f873 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5f63981ca00a - std::sys::backtrace::_print_fmt::hec0fad1ff9d0ced9 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5f63981ca00a - ::fmt::h64292488f7f2250f [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5f63981f0363 - core::fmt::rt::Argument::fmt::h5a186eb42f172f83 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x5f63981f0363 - core::fmt::write::h481de9317912dd10 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/fmt/mod.rs:1186:21 [INFO] [stdout] 6: 0x5f63981c6c33 - std::io::Write::write_fmt::hf3775693c09b4454 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/io/mod.rs:1839:15 [INFO] [stdout] 7: 0x5f63981c9e52 - std::sys::backtrace::BacktraceLock::print::h8adcaf0142651003 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x5f63981cb4b5 - std::panicking::default_hook::{{closure}}::h15fb66ff6c6741f9 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:268:22 [INFO] [stdout] 9: 0x5f63981cb2a8 - std::panicking::default_hook::hb9ad284307d8f928 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:292:9 [INFO] [stdout] 10: 0x5f6398195fa9 - as core::ops::function::Fn>::call::h7b6ff508218c42a0 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/alloc/src/boxed.rs:2468:9 [INFO] [stdout] 11: 0x5f6398195fa9 - test::test_main::{{closure}}::hbc464be6eb0d2a52 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/test/src/lib.rs:133:21 [INFO] [stdout] 12: 0x5f63981cbbb8 - as core::ops::function::Fn>::call::h4be8ec3e201e2cf3 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/alloc/src/boxed.rs:2468:9 [INFO] [stdout] 13: 0x5f63981cbbb8 - std::panicking::rust_panic_with_hook::h66f68b895f94d79f [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:809:13 [INFO] [stdout] 14: 0x5f63981cb97a - std::panicking::begin_panic_handler::{{closure}}::hca74b9b22568e264 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:674:13 [INFO] [stdout] 15: 0x5f63981ca4e9 - std::sys::backtrace::__rust_end_short_backtrace::h74dd0769b8a109e0 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/sys/backtrace.rs:170:18 [INFO] [stdout] 16: 0x5f63981cb60c - rust_begin_unwind [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:665:5 [INFO] [stdout] 17: 0x5f63981eee00 - core::panicking::panic_fmt::h9d563f5dc1b01cab [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/panicking.rs:74:14 [INFO] [stdout] 18: 0x5f63981ef1a6 - core::result::unwrap_failed::he99f077262f32dcd [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/result.rs:1695:5 [INFO] [stdout] 19: 0x5f639813331e - core::result::Result::unwrap_err::h9e5ecd5ab1763643 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/result.rs:1197:22 [INFO] [stdout] 20: 0x5f63981403e1 - popol::tests::test_waker_threaded::hbf72703d028dd6a6 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:1003:21 [INFO] [stdout] 21: 0x5f639813fbc7 - popol::tests::test_waker_threaded::{{closure}}::hf7d94782ec3390f2 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:965:29 [INFO] [stdout] 22: 0x5f63981531f6 - core::ops::function::FnOnce::call_once::h10b41c76d3da86cc [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x5f639819a86b - core::ops::function::FnOnce::call_once::h2b334953e617de9b [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x5f639819a86b - test::__rust_begin_short_backtrace::h8faab66b1ff1d0c8 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/test/src/lib.rs:621:18 [INFO] [stdout] 25: 0x5f639819a158 - test::run_test_in_process::{{closure}}::hfb9c1a00854dd37d [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/test/src/lib.rs:644:60 [INFO] [stdout] 26: 0x5f639819a158 - as core::ops::function::FnOnce<()>>::call_once::h74c9970fa5634840 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 27: 0x5f639819a158 - std::panicking::try::do_call::hc4c1295047d6f2d7 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:557:40 [INFO] [stdout] 28: 0x5f639819a158 - std::panicking::try::h67266f7a45240585 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:520:19 [INFO] [stdout] 29: 0x5f639819a158 - std::panic::catch_unwind::h9bd43337d7e40f31 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panic.rs:358:14 [INFO] [stdout] 30: 0x5f639819a158 - test::run_test_in_process::hcd26e1ba57fd34c2 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/test/src/lib.rs:644:27 [INFO] [stdout] 31: 0x5f639819a158 - test::run_test::{{closure}}::h7249fd59f504e406 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/test/src/lib.rs:565:43 [INFO] [stdout] 32: 0x5f639815e384 - test::run_test::{{closure}}::h9278596bd856801d [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/test/src/lib.rs:595:41 [INFO] [stdout] 33: 0x5f639815e384 - std::sys::backtrace::__rust_begin_short_backtrace::h81ab71768b07ffb5 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/sys/backtrace.rs:154:18 [INFO] [stdout] 34: 0x5f6398161a32 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hd39edce2d4305e8d [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/thread/mod.rs:521:17 [INFO] [stdout] 35: 0x5f6398161a32 - as core::ops::function::FnOnce<()>>::call_once::hffcde42bb45e43d3 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 36: 0x5f6398161a32 - std::panicking::try::do_call::h30d61604663dff17 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:557:40 [INFO] [stdout] 37: 0x5f6398161a32 - std::panicking::try::h7b8b36119ae94880 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panicking.rs:520:19 [INFO] [stdout] 38: 0x5f6398161a32 - std::panic::catch_unwind::h4a4bb2ef7a88f652 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/panic.rs:358:14 [INFO] [stdout] 39: 0x5f6398161a32 - std::thread::Builder::spawn_unchecked_::{{closure}}::hd62ab97c763f4e34 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/thread/mod.rs:520:30 [INFO] [stdout] 40: 0x5f6398161a32 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h0a89a60c6ceef6b4 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x5f63981cf93b - as core::ops::function::FnOnce>::call_once::h5de9072f83a0d37c [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/alloc/src/boxed.rs:2454:9 [INFO] [stdout] 42: 0x5f63981cf93b - as core::ops::function::FnOnce>::call_once::hbbf67a38c5e8c30f [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/alloc/src/boxed.rs:2454:9 [INFO] [stdout] 43: 0x5f63981cf93b - std::sys::pal::unix::thread::Thread::new::thread_start::hb547260a5233ab58 [INFO] [stdout] at /rustc/f23b22458132fb20faeb8a915b1c252478696f25/library/std/src/sys/pal/unix/thread.rs:105:17 [INFO] [stdout] 44: 0x7ce60cc02ac3 - [INFO] [stdout] 45: 0x7ce60cc93a04 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::test_waker_threaded [INFO] [stdout] [INFO] [stdout] test result: FAILED. 7 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.35s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "8e1a91656079efa95e5ffd14127206685d89cc7abe059e4996bf01295df722da", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8e1a91656079efa95e5ffd14127206685d89cc7abe059e4996bf01295df722da", kill_on_drop: false }` [INFO] [stdout] 8e1a91656079efa95e5ffd14127206685d89cc7abe059e4996bf01295df722da