[INFO] fetching crate futex-queue 0.1.1... [INFO] testing futex-queue-0.1.1 against try#5bc97a20e5cc382ae6d19f727a9e73eeb2734548 for pr-99093 [INFO] extracting crate futex-queue 0.1.1 into /workspace/builds/worker-0/source [INFO] validating manifest of crates.io crate futex-queue 0.1.1 on toolchain 5bc97a20e5cc382ae6d19f727a9e73eeb2734548 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+5bc97a20e5cc382ae6d19f727a9e73eeb2734548" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate futex-queue 0.1.1 [INFO] finished tweaking crates.io crate futex-queue 0.1.1 [INFO] tweaked toml for crates.io crate futex-queue 0.1.1 written to /workspace/builds/worker-0/source/Cargo.toml [INFO] crate crates.io crate futex-queue 0.1.1 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+5bc97a20e5cc382ae6d19f727a9e73eeb2734548" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+5bc97a20e5cc382ae6d19f727a9e73eeb2734548" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] b9c28192a6206cd908ea776ce79577eea51467bc7c8dc17353e0b73c6d3ed519 [INFO] running `Command { std: "docker" "start" "-a" "b9c28192a6206cd908ea776ce79577eea51467bc7c8dc17353e0b73c6d3ed519", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "b9c28192a6206cd908ea776ce79577eea51467bc7c8dc17353e0b73c6d3ed519", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b9c28192a6206cd908ea776ce79577eea51467bc7c8dc17353e0b73c6d3ed519", kill_on_drop: false }` [INFO] [stdout] b9c28192a6206cd908ea776ce79577eea51467bc7c8dc17353e0b73c6d3ed519 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+5bc97a20e5cc382ae6d19f727a9e73eeb2734548" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e4313a062d3f49859ac6411843c871a1ca5cda6b0f8b742fae19c3ca63e668e2 [INFO] running `Command { std: "docker" "start" "-a" "e4313a062d3f49859ac6411843c871a1ca5cda6b0f8b742fae19c3ca63e668e2", kill_on_drop: false }` [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling libc v0.2.102 [INFO] [stderr] Compiling heapless v0.7.7 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling stable_deref_trait v1.2.0 [INFO] [stderr] Compiling lock_api v0.4.5 [INFO] [stderr] Compiling hash32 v0.2.1 [INFO] [stderr] Compiling spin v0.9.2 [INFO] [stderr] Compiling linux-futex v0.1.1 [INFO] [stderr] Compiling futex-queue v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2.42s [INFO] running `Command { std: "docker" "inspect" "e4313a062d3f49859ac6411843c871a1ca5cda6b0f8b742fae19c3ca63e668e2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e4313a062d3f49859ac6411843c871a1ca5cda6b0f8b742fae19c3ca63e668e2", kill_on_drop: false }` [INFO] [stdout] e4313a062d3f49859ac6411843c871a1ca5cda6b0f8b742fae19c3ca63e668e2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+5bc97a20e5cc382ae6d19f727a9e73eeb2734548" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 70b9931728ab8b09c3e314836ed2749dceb4d600fe9e24ec56703cf8d0652504 [INFO] running `Command { std: "docker" "start" "-a" "70b9931728ab8b09c3e314836ed2749dceb4d600fe9e24ec56703cf8d0652504", kill_on_drop: false }` [INFO] [stderr] Compiling futex-queue v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.61s [INFO] running `Command { std: "docker" "inspect" "70b9931728ab8b09c3e314836ed2749dceb4d600fe9e24ec56703cf8d0652504", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "70b9931728ab8b09c3e314836ed2749dceb4d600fe9e24ec56703cf8d0652504", kill_on_drop: false }` [INFO] [stdout] 70b9931728ab8b09c3e314836ed2749dceb4d600fe9e24ec56703cf8d0652504 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "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:5873ed620acfc3295992aedd9294443d62a478a48ba243bc5e6c4f5abaffa05f" "/opt/rustwide/cargo-home/bin/cargo" "+5bc97a20e5cc382ae6d19f727a9e73eeb2734548" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 4202f68782c79ac25926d880ce0fc5ddcf36bb2804b80de1a2dfe84bc940b6d7 [INFO] running `Command { std: "docker" "start" "-a" "4202f68782c79ac25926d880ce0fc5ddcf36bb2804b80de1a2dfe84bc940b6d7", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.01s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/futex_queue-f7c84c38aeb28679) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/test.rs (/opt/rustwide/target/debug/deps/test-f356ff65074f871e) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test simple_send_recv ... ok [INFO] [stdout] test sorting ... ok [INFO] [stdout] test timing ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- timing stdout ---- [INFO] [stdout] thread 'timing' panicked at 'assertion failed: Instant::now() - later < Duration::from_micros(100)', tests/test.rs:45:5 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5587200bce00 - std::backtrace_rs::backtrace::libunwind::trace::h552106febb15e17e [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 1: 0x5587200bce00 - std::backtrace_rs::backtrace::trace_unsynchronized::hf7774f161cb6a040 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5587200bce00 - std::sys_common::backtrace::_print_fmt::h0c305f5052d81630 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/sys_common/backtrace.rs:66:5 [INFO] [stdout] 3: 0x5587200bce00 - ::fmt::h64b3e0a8deb0a611 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/sys_common/backtrace.rs:45:22 [INFO] [stdout] 4: 0x5587200dfa7c - core::fmt::write::h8f671d0f7992fdc6 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/fmt/mod.rs:1198:17 [INFO] [stdout] 5: 0x5587200b9755 - std::io::Write::write_fmt::hd208f914b48a2290 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/io/mod.rs:1672:15 [INFO] [stdout] 6: 0x5587200be841 - std::sys_common::backtrace::_print::h9fa97aca0ed3f804 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/sys_common/backtrace.rs:48:5 [INFO] [stdout] 7: 0x5587200be841 - std::sys_common::backtrace::print::haab86c3a36d9a53e [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/sys_common/backtrace.rs:35:9 [INFO] [stdout] 8: 0x5587200be841 - std::panicking::default_hook::{{closure}}::h97ac82ba40b3820b [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x5587200be496 - std::panicking::default_hook::h3a2e40383cd02365 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:311:9 [INFO] [stdout] 10: 0x5587200beee3 - std::panicking::rust_panic_with_hook::h91242c0d4adecfe2 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:698:17 [INFO] [stdout] 11: 0x5587200bed99 - std::panicking::begin_panic_handler::{{closure}}::h627cf56a9a0a9517 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:586:13 [INFO] [stdout] 12: 0x5587200bd2d4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf13451d299824903 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/sys_common/backtrace.rs:138:18 [INFO] [stdout] 13: 0x5587200beb02 - rust_begin_unwind [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:584:5 [INFO] [stdout] 14: 0x558720059d23 - core::panicking::panic_fmt::ha6799a5d9621aa13 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/panicking.rs:142:14 [INFO] [stdout] 15: 0x558720059bed - core::panicking::panic::h95f2f565de971b85 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/panicking.rs:48:5 [INFO] [stdout] 16: 0x55872005ca88 - test::timing::ha1330c31b2221fa0 [INFO] [stdout] at /opt/rustwide/workdir/tests/test.rs:45:5 [INFO] [stdout] 17: 0x55872005c85a - test::timing::{{closure}}::ha441de70c44fdcd0 [INFO] [stdout] at /opt/rustwide/workdir/tests/test.rs:38:1 [INFO] [stdout] 18: 0x55872006001e - core::ops::function::FnOnce::call_once::hadf74544b7f6738b [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 19: 0x558720096e43 - core::ops::function::FnOnce::call_once::h0f9e5c16f2fad3fe [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 20: 0x558720096e43 - test::__rust_begin_short_backtrace::h6b395b12fb47e0c7 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/test/src/lib.rs:572:5 [INFO] [stdout] 21: 0x558720095bdc - as core::ops::function::FnOnce>::call_once::h116a04ad1adfbba8 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 22: 0x558720095bdc - as core::ops::function::FnOnce<()>>::call_once::h237703400c3f95d2 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 23: 0x558720095bdc - std::panicking::try::do_call::hb6f7087c5161b13a [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:492:40 [INFO] [stdout] 24: 0x558720095bdc - std::panicking::try::h40eb70910e5ec9fc [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:456:19 [INFO] [stdout] 25: 0x558720095bdc - std::panic::catch_unwind::h9011aaff4baefe1e [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panic.rs:137:14 [INFO] [stdout] 26: 0x558720095bdc - test::run_test_in_process::haab9d5dbf92a97fd [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/test/src/lib.rs:595:18 [INFO] [stdout] 27: 0x558720095bdc - test::run_test::run_test_inner::{{closure}}::h431ff305408eb101 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/test/src/lib.rs:489:39 [INFO] [stdout] 28: 0x55872006181c - test::run_test::run_test_inner::{{closure}}::h1761b84f3aff0780 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/test/src/lib.rs:516:37 [INFO] [stdout] 29: 0x55872006181c - std::sys_common::backtrace::__rust_begin_short_backtrace::heac1883bddbbfcd9 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/sys_common/backtrace.rs:122:18 [INFO] [stdout] 30: 0x55872006782f - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h509e89854d46123e [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/thread/mod.rs:505:17 [INFO] [stdout] 31: 0x55872006782f - as core::ops::function::FnOnce<()>>::call_once::h1b05c47dc35673b3 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 32: 0x55872006782f - std::panicking::try::do_call::hd58695587ce4c228 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:492:40 [INFO] [stdout] 33: 0x55872006782f - std::panicking::try::hc017871f7aa94d61 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panicking.rs:456:19 [INFO] [stdout] 34: 0x55872006782f - std::panic::catch_unwind::h38b4473a1f81bb80 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/panic.rs:137:14 [INFO] [stdout] 35: 0x55872006782f - std::thread::Builder::spawn_unchecked_::{{closure}}::h361d7687a745025a [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/thread/mod.rs:504:30 [INFO] [stdout] 36: 0x55872006782f - core::ops::function::FnOnce::call_once{{vtable.shim}}::h647e812f95f891a3 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/core/src/ops/function.rs:248:5 [INFO] [stdout] 37: 0x5587200c3453 - as core::ops::function::FnOnce>::call_once::hd2e3a9e0ae7d8026 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 38: 0x5587200c3453 - as core::ops::function::FnOnce>::call_once::h4798a92ee79456cc [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/alloc/src/boxed.rs:1934:9 [INFO] [stdout] 39: 0x5587200c3453 - std::sys::unix::thread::Thread::new::thread_start::h9be4f412ada0f0f9 [INFO] [stdout] at /rustc/5bc97a20e5cc382ae6d19f727a9e73eeb2734548/library/std/src/sys/unix/thread.rs:108:17 [INFO] [stdout] 40: 0x7ff014c3c609 - start_thread [INFO] [stdout] 41: 0x7ff014a0c133 - clone [INFO] [stdout] 42: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] timing [INFO] [stdout] [INFO] [stdout] test result: FAILED. 2 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.01s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test test' [INFO] running `Command { std: "docker" "inspect" "4202f68782c79ac25926d880ce0fc5ddcf36bb2804b80de1a2dfe84bc940b6d7", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4202f68782c79ac25926d880ce0fc5ddcf36bb2804b80de1a2dfe84bc940b6d7", kill_on_drop: false }` [INFO] [stdout] 4202f68782c79ac25926d880ce0fc5ddcf36bb2804b80de1a2dfe84bc940b6d7