[INFO] fetching crate desync 0.7.0... [INFO] testing desync-0.7.0 against master#a77da2d454e6caa227a85b16410b95f93495e7e0 for pr-91031 [INFO] extracting crate desync 0.7.0 into /workspace/builds/worker-28/source [INFO] validating manifest of crates.io crate desync 0.7.0 on toolchain a77da2d454e6caa227a85b16410b95f93495e7e0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate desync 0.7.0 [INFO] finished tweaking crates.io crate desync 0.7.0 [INFO] tweaked toml for crates.io crate desync 0.7.0 written to /workspace/builds/worker-28/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] c24d12d3e7dfc26c98f67cadb33afa01b581aff582d6a1d498e444d1b44e3a12 [INFO] running `Command { std: "docker" "start" "-a" "c24d12d3e7dfc26c98f67cadb33afa01b581aff582d6a1d498e444d1b44e3a12", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "c24d12d3e7dfc26c98f67cadb33afa01b581aff582d6a1d498e444d1b44e3a12", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c24d12d3e7dfc26c98f67cadb33afa01b581aff582d6a1d498e444d1b44e3a12", kill_on_drop: false }` [INFO] [stdout] c24d12d3e7dfc26c98f67cadb33afa01b581aff582d6a1d498e444d1b44e3a12 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 2b8878f2f52b6635801e976dc6cbbdcff6dec12ff4a48992d57eba01cb6a68f3 [INFO] running `Command { std: "docker" "start" "-a" "2b8878f2f52b6635801e976dc6cbbdcff6dec12ff4a48992d57eba01cb6a68f3", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.32 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling futures-core v0.3.17 [INFO] [stderr] Compiling proc-macro-hack v0.5.19 [INFO] [stderr] Compiling futures-task v0.3.17 [INFO] [stderr] Compiling proc-macro-nested v0.1.7 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling futures-sink v0.3.17 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling libc v0.2.107 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling slab v0.4.5 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling futures-channel v0.3.17 [INFO] [stderr] Compiling futures-macro v0.3.17 [INFO] [stderr] Compiling futures-util v0.3.17 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling syn v1.0.81 [INFO] [stderr] Compiling futures-executor v0.3.17 [INFO] [stderr] Compiling futures v0.3.17 [INFO] [stderr] Compiling desync v0.7.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 13.66s [INFO] running `Command { std: "docker" "inspect" "2b8878f2f52b6635801e976dc6cbbdcff6dec12ff4a48992d57eba01cb6a68f3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2b8878f2f52b6635801e976dc6cbbdcff6dec12ff4a48992d57eba01cb6a68f3", kill_on_drop: false }` [INFO] [stdout] 2b8878f2f52b6635801e976dc6cbbdcff6dec12ff4a48992d57eba01cb6a68f3 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9c60e675b49c768627d65988454163fdae914f603ec16b0ad4ad8218c300ad87 [INFO] running `Command { std: "docker" "start" "-a" "9c60e675b49c768627d65988454163fdae914f603ec16b0ad4ad8218c300ad87", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling desync v0.7.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: unnecessary trailing semicolon [INFO] [stdout] --> tests/scheduler/timeout.rs:14:6 [INFO] [stdout] | [INFO] [stdout] 14 | }; [INFO] [stdout] | ^ help: remove this semicolon [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(redundant_semicolons)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 4.04s [INFO] running `Command { std: "docker" "inspect" "9c60e675b49c768627d65988454163fdae914f603ec16b0ad4ad8218c300ad87", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9c60e675b49c768627d65988454163fdae914f603ec16b0ad4ad8218c300ad87", kill_on_drop: false }` [INFO] [stdout] 9c60e675b49c768627d65988454163fdae914f603ec16b0ad4ad8218c300ad87 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-28/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+a77da2d454e6caa227a85b16410b95f93495e7e0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] fdeb02fbf2c8025861136826f146a26c1ec4c057b6e3728cec5e60115bc30f69 [INFO] running `Command { std: "docker" "start" "-a" "fdeb02fbf2c8025861136826f146a26c1ec4c057b6e3728cec5e60115bc30f69", kill_on_drop: false }` [INFO] [stderr] warning: unnecessary trailing semicolon [INFO] [stderr] --> tests/scheduler/timeout.rs:14:6 [INFO] [stderr] | [INFO] [stderr] 14 | }; [INFO] [stderr] | ^ help: remove this semicolon [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(redundant_semicolons)]` on by default [INFO] [stderr] [INFO] [stderr] warning: `desync` (test "desync") generated 1 warning [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.05s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/desync-8fb1d3b74557c821) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test scheduler::scheduler_future::test::returns_immediately_if_signaled ... ok [INFO] [stdout] test scheduler::scheduler_future::test::cancels_when_dropped ... ok [INFO] [stdout] test scheduler::scheduler_future::test::forces_queue_drain ... ok [INFO] [stdout] test scheduler::scheduler_future::test::signals_from_another_thread ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s [INFO] [stdout] [INFO] [stderr] Running tests/desync.rs (/opt/rustwide/target/debug/deps/desync-c0fd14e965b07832) [INFO] [stdout] [INFO] [stdout] running 52 tests [INFO] [stdout] test retrieve_data_into_local_var ... ok [INFO] [stdout] test retrieve_data_synchronously ... ok [INFO] [stdout] test scheduler::asynchronous::panicking_panics_with_future_queues - should panic ... FAILED [INFO] [stdout] test scheduler::asynchronous::schedule_after_queue_released ... ok [INFO] [stdout] test scheduler::asynchronous::schedule_async ... ok [INFO] [stdout] test scheduler::future_desync::poll_two_futures_on_one_queue ... ok [INFO] [stdout] test scheduler::future_sync::poll_two_futures_on_one_queue ... ok [INFO] [stdout] test scheduler::sync::try_sync_succeeds_on_idle_queue ... ok [INFO] [stdout] test scheduler::sync::try_sync_fails_on_busy_queue ... ok [INFO] [stdout] test scheduler::sync::schedule_sync ... ok [INFO] [stdout] test scheduler::asynchronous::will_schedule_in_order ... ok [INFO] [stdout] test try_sync_succeeds_on_idle_queue ... ok [INFO] [stdout] test try_sync_succeeds_on_idle_queue_after_async_job ... ok [INFO] [stdout] test scheduler::future_sync::future_waits_for_us ... ok [INFO] [stdout] test try_sync_fails_on_busy_queue ... ok [INFO] [stdout] test scheduler::asynchronous::will_schedule_separate_queues_in_parallel ... ok [INFO] [stdout] test scheduler::future_desync::schedule_future_with_no_scheduler_threads ... ok [INFO] [stdout] test scheduler::future_desync::schedule_future ... ok [INFO] [stdout] test scheduler::future_desync::read_sync_result ... ok [INFO] [stdout] test scheduler::future_sync::schedule_future_with_no_scheduler_threads ... ok [INFO] [stdout] test scheduler::sync::try_sync_succeeds_on_idle_queue_after_async_job ... ok [INFO] [stdout] test scheduler::sync::sync_has_synchronous_lifetime ... ok [INFO] [stdout] test scheduler::future_sync::wake_future_with_no_scheduler_threads ... ok [INFO] [stdout] test scheduler::future_desync::future_waits_for_us ... ok [INFO] [stdout] test dropping_while_running_isnt_obviously_bad ... ok [INFO] [stdout] test update_data_asynchronously ... ok [INFO] [stdout] test scheduler::asynchronous::async_only_runs_once ... FAILED [INFO] [stdout] test scheduler::suspend::safe_to_drop_suspended_queue ... ok [INFO] [stdout] test scheduler::future_desync::wait_for_future ... ok [INFO] [stdout] test scheduler::future_sync::wait_for_future ... ok [INFO] [stdout] test scheduler::future_sync::schedule_future ... ok [INFO] [stdout] test scheduler::future_desync::wake_future_with_no_scheduler_threads ... ok [INFO] [stdout] test scheduler::sync::reschedule_after_immediate_sync ... ok [INFO] [stdout] test scheduler::sync::sync_drains_with_no_threads ... ok [INFO] [stdout] test scheduler::suspend::suspend_queue_with_local_drain ... ok [INFO] [stdout] test wait_for_future ... ok [INFO] [stdout] test update_data_with_future_sync ... ok [INFO] [stdout] test scheduler::sync::schedule_sync_after_async ... ok [INFO] [stdout] test update_data_with_future ... ok [INFO] [stdout] test scheduler::thread_management::will_despawn_extra_threads ... ok [INFO] [stdout] test scheduler::future_sync::wait_for_sync_future_from_desync_future_without_awaiting ... FAILED [INFO] [stdout] test double_future_and_sync ... ok [INFO] [stdout] test scheduler::future_desync::wait_for_desync_future_from_desync_future ... ok [INFO] [stdout] test scheduler::future_sync::wait_for_sync_future_from_desync_future ... ok [INFO] [stdout] test scheduler::future_sync::wait_for_desync_future_from_sync_future ... ok [INFO] [stdout] test scheduler::future_sync::wait_for_sync_future_from_sync_future ... ok [INFO] [stdout] test future_and_sync ... ok [INFO] [stdout] test update_data_asynchronously_1000_times ... ok [INFO] [stdout] test update_data_with_future_sync_1000_times ... ok [INFO] [stdout] test update_data_with_future_1000_times ... ok [INFO] [stdout] test scheduler::asynchronous::async_runs_in_order_1000_iter ... ok [INFO] [stdout] test scheduler::suspend::suspend_queue_with_background_thread ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- scheduler::asynchronous::panicking_panics_with_future_queues stdout ---- [INFO] [stdout] note: test did not panic as expected [INFO] [stdout] ---- scheduler::asynchronous::async_only_runs_once stdout ---- [INFO] [stdout] BBBBBBBBBBBBBBBB Pending queue count: 97 [INFO] [stdout] thread 'scheduler::asynchronous::async_only_runs_once' panicked at 'Timeout', tests/scheduler/timeout.rs:56:13 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55cece92d18c - std::backtrace_rs::backtrace::libunwind::trace::h7630ba4cba718aa0 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x55cece92d18c - std::backtrace_rs::backtrace::trace_unsynchronized::he7498e79c157f5ac [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55cece92d18c - std::sys_common::backtrace::_print_fmt::hdaebadaee17bca49 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x55cece92d18c - ::fmt::h82b0e3aaf8a96140 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x55cece95002c - core::fmt::write::h72801a82c94e6ff1 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/fmt/mod.rs:1149:17 [INFO] [stdout] 5: 0x55cece928e15 - std::io::Write::write_fmt::h21d7683cabdb4c35 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/io/mod.rs:1697:15 [INFO] [stdout] 6: 0x55cece92ec30 - std::sys_common::backtrace::_print::h1c9a1d19c48821c1 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x55cece92ec30 - std::sys_common::backtrace::print::h7ce8802039fa9d0e [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x55cece92ec30 - std::panicking::default_hook::{{closure}}::hb2a74a8c1499c326 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:211:50 [INFO] [stdout] 9: 0x55cece92e816 - std::panicking::default_hook::hf4f180b00076f2b2 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:225:9 [INFO] [stdout] 10: 0x55cece92f2e4 - std::panicking::rust_panic_with_hook::he85ce8435493b711 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:606:17 [INFO] [stdout] 11: 0x55cece909f92 - std::panicking::begin_panic::{{closure}}::h493f32395bacc3be [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:526:9 [INFO] [stdout] 12: 0x55cece9095e9 - std::sys_common::backtrace::__rust_end_short_backtrace::he15d006531776f03 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:139:18 [INFO] [stdout] 13: 0x55cece909ed3 - std::panicking::begin_panic::h57ef656f56141f87 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:525:12 [INFO] [stdout] 14: 0x55cece7dcd39 - desync::scheduler::timeout::timeout::hf10b2cfa61225ea0 [INFO] [stdout] at /opt/rustwide/workdir/tests/scheduler/timeout.rs:56:13 [INFO] [stdout] 15: 0x55cece7e2489 - desync::scheduler::asynchronous::async_only_runs_once::hba57024ed939485f [INFO] [stdout] at /opt/rustwide/workdir/tests/scheduler/asynchronous.rs:45:9 [INFO] [stdout] 16: 0x55cece7e23fa - desync::scheduler::asynchronous::async_only_runs_once::{{closure}}::hc508bc3ad5eeb426 [INFO] [stdout] at /opt/rustwide/workdir/tests/scheduler/asynchronous.rs:43:1 [INFO] [stdout] 17: 0x55cece7e78fe - core::ops::function::FnOnce::call_once::hf0e571983686e80a [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 18: 0x55cece8b9203 - core::ops::function::FnOnce::call_once::h449577f1c5b077cb [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 19: 0x55cece8b9203 - test::__rust_begin_short_backtrace::h8c2a0a5090591869 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:585:5 [INFO] [stdout] 20: 0x55cece8b7d97 - as core::ops::function::FnOnce>::call_once::hea00a22128a38543 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 21: 0x55cece8b7d97 - as core::ops::function::FnOnce<()>>::call_once::he10b35c3c50d78a0 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 22: 0x55cece8b7d97 - std::panicking::try::do_call::hc868e78bbc5af2ab [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:406:40 [INFO] [stdout] 23: 0x55cece8b7d97 - std::panicking::try::he468aede74df1b04 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:370:19 [INFO] [stdout] 24: 0x55cece8b7d97 - std::panic::catch_unwind::hce3c9152e1cf772d [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panic.rs:133:14 [INFO] [stdout] 25: 0x55cece8b7d97 - test::run_test_in_process::h9c4ab8162080cf8c [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:608:18 [INFO] [stdout] 26: 0x55cece8b7d97 - test::run_test::run_test_inner::{{closure}}::he9483433cef16afe [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:500:39 [INFO] [stdout] 27: 0x55cece8850de - test::run_test::run_test_inner::{{closure}}::h479f1f872a5501ea [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:527:37 [INFO] [stdout] 28: 0x55cece8850de - std::sys_common::backtrace::__rust_begin_short_backtrace::h0f1e9b1f279687bc [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:123:18 [INFO] [stdout] 29: 0x55cece889f08 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he5560613c5f5cb83 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/thread/mod.rs:484:17 [INFO] [stdout] 30: 0x55cece889f08 - as core::ops::function::FnOnce<()>>::call_once::h8190a68cb05ab92f [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 31: 0x55cece889f08 - std::panicking::try::do_call::h6ae22f5ac22596e4 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:406:40 [INFO] [stdout] 32: 0x55cece889f08 - std::panicking::try::h2381c25487d6a7c2 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:370:19 [INFO] [stdout] 33: 0x55cece889f08 - std::panic::catch_unwind::hfe902f4d5c9d7b6d [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panic.rs:133:14 [INFO] [stdout] 34: 0x55cece889f08 - std::thread::Builder::spawn_unchecked::{{closure}}::h547fad40771a584e [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/thread/mod.rs:483:30 [INFO] [stdout] 35: 0x55cece889f08 - core::ops::function::FnOnce::call_once{{vtable.shim}}::he8602a9971738410 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 36: 0x55cece933de3 - as core::ops::function::FnOnce>::call_once::he162a5c338a10a39 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 37: 0x55cece933de3 - as core::ops::function::FnOnce>::call_once::hb27497b21740dd97 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 38: 0x55cece933de3 - std::sys::unix::thread::Thread::new::thread_start::he467e990e49c5136 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys/unix/thread.rs:106:17 [INFO] [stdout] 39: 0x7f882ea49609 - start_thread [INFO] [stdout] 40: 0x7f882e81b293 - clone [INFO] [stdout] 41: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- scheduler::future_sync::wait_for_sync_future_from_desync_future_without_awaiting stdout ---- [INFO] [stdout] BBBBBBBBBI Pending queue count: 1 [INFO] [stdout] thread 'scheduler::future_sync::wait_for_sync_future_from_desync_future_without_awaiting' panicked at 'Timeout', tests/scheduler/timeout.rs:56:13 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55cece92d18c - std::backtrace_rs::backtrace::libunwind::trace::h7630ba4cba718aa0 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 [INFO] [stdout] 1: 0x55cece92d18c - std::backtrace_rs::backtrace::trace_unsynchronized::he7498e79c157f5ac [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55cece92d18c - std::sys_common::backtrace::_print_fmt::hdaebadaee17bca49 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:67:5 [INFO] [stdout] 3: 0x55cece92d18c - ::fmt::h82b0e3aaf8a96140 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:46:22 [INFO] [stdout] 4: 0x55cece95002c - core::fmt::write::h72801a82c94e6ff1 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/fmt/mod.rs:1149:17 [INFO] [stdout] 5: 0x55cece928e15 - std::io::Write::write_fmt::h21d7683cabdb4c35 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/io/mod.rs:1697:15 [INFO] [stdout] 6: 0x55cece92ec30 - std::sys_common::backtrace::_print::h1c9a1d19c48821c1 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:49:5 [INFO] [stdout] 7: 0x55cece92ec30 - std::sys_common::backtrace::print::h7ce8802039fa9d0e [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:36:9 [INFO] [stdout] 8: 0x55cece92ec30 - std::panicking::default_hook::{{closure}}::hb2a74a8c1499c326 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:211:50 [INFO] [stdout] 9: 0x55cece92e816 - std::panicking::default_hook::hf4f180b00076f2b2 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:225:9 [INFO] [stdout] 10: 0x55cece92f2e4 - std::panicking::rust_panic_with_hook::he85ce8435493b711 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:606:17 [INFO] [stdout] 11: 0x55cece909f92 - std::panicking::begin_panic::{{closure}}::h493f32395bacc3be [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:526:9 [INFO] [stdout] 12: 0x55cece9095e9 - std::sys_common::backtrace::__rust_end_short_backtrace::he15d006531776f03 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:139:18 [INFO] [stdout] 13: 0x55cece909ed3 - std::panicking::begin_panic::h57ef656f56141f87 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:525:12 [INFO] [stdout] 14: 0x55cece7d8f19 - desync::scheduler::timeout::timeout::hc525bc402a7d91c5 [INFO] [stdout] at /opt/rustwide/workdir/tests/scheduler/timeout.rs:56:13 [INFO] [stdout] 15: 0x55cece80664b - desync::scheduler::future_sync::wait_for_sync_future_from_desync_future_without_awaiting::hb8d8bde55d0c4a53 [INFO] [stdout] at /opt/rustwide/workdir/tests/scheduler/future_sync.rs:219:5 [INFO] [stdout] 16: 0x55cece80662a - desync::scheduler::future_sync::wait_for_sync_future_from_desync_future_without_awaiting::{{closure}}::h42873267d7600ae3 [INFO] [stdout] at /opt/rustwide/workdir/tests/scheduler/future_sync.rs:218:1 [INFO] [stdout] 17: 0x55cece7e729e - core::ops::function::FnOnce::call_once::h822bcc27a0792305 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 18: 0x55cece8b9203 - core::ops::function::FnOnce::call_once::h449577f1c5b077cb [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 19: 0x55cece8b9203 - test::__rust_begin_short_backtrace::h8c2a0a5090591869 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:585:5 [INFO] [stdout] 20: 0x55cece8b7d97 - as core::ops::function::FnOnce>::call_once::hea00a22128a38543 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 21: 0x55cece8b7d97 - as core::ops::function::FnOnce<()>>::call_once::he10b35c3c50d78a0 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 22: 0x55cece8b7d97 - std::panicking::try::do_call::hc868e78bbc5af2ab [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:406:40 [INFO] [stdout] 23: 0x55cece8b7d97 - std::panicking::try::he468aede74df1b04 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:370:19 [INFO] [stdout] 24: 0x55cece8b7d97 - std::panic::catch_unwind::hce3c9152e1cf772d [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panic.rs:133:14 [INFO] [stdout] 25: 0x55cece8b7d97 - test::run_test_in_process::h9c4ab8162080cf8c [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:608:18 [INFO] [stdout] 26: 0x55cece8b7d97 - test::run_test::run_test_inner::{{closure}}::he9483433cef16afe [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:500:39 [INFO] [stdout] 27: 0x55cece8850de - test::run_test::run_test_inner::{{closure}}::h479f1f872a5501ea [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/test/src/lib.rs:527:37 [INFO] [stdout] 28: 0x55cece8850de - std::sys_common::backtrace::__rust_begin_short_backtrace::h0f1e9b1f279687bc [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys_common/backtrace.rs:123:18 [INFO] [stdout] 29: 0x55cece889f08 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::he5560613c5f5cb83 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/thread/mod.rs:484:17 [INFO] [stdout] 30: 0x55cece889f08 - as core::ops::function::FnOnce<()>>::call_once::h8190a68cb05ab92f [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/panic/unwind_safe.rs:271:9 [INFO] [stdout] 31: 0x55cece889f08 - std::panicking::try::do_call::h6ae22f5ac22596e4 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:406:40 [INFO] [stdout] 32: 0x55cece889f08 - std::panicking::try::h2381c25487d6a7c2 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panicking.rs:370:19 [INFO] [stdout] 33: 0x55cece889f08 - std::panic::catch_unwind::hfe902f4d5c9d7b6d [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/panic.rs:133:14 [INFO] [stdout] 34: 0x55cece889f08 - std::thread::Builder::spawn_unchecked::{{closure}}::h547fad40771a584e [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/thread/mod.rs:483:30 [INFO] [stdout] 35: 0x55cece889f08 - core::ops::function::FnOnce::call_once{{vtable.shim}}::he8602a9971738410 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/core/src/ops/function.rs:227:5 [INFO] [stdout] 36: 0x55cece933de3 - as core::ops::function::FnOnce>::call_once::he162a5c338a10a39 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 37: 0x55cece933de3 - as core::ops::function::FnOnce>::call_once::hb27497b21740dd97 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/alloc/src/boxed.rs:1694:9 [INFO] [stdout] 38: 0x55cece933de3 - std::sys::unix::thread::Thread::new::thread_start::he467e990e49c5136 [INFO] [stdout] at /rustc/a77da2d454e6caa227a85b16410b95f93495e7e0/library/std/src/sys/unix/thread.rs:106:17 [INFO] [stdout] 39: 0x7f882ea49609 - start_thread [INFO] [stdout] 40: 0x7f882e81b293 - clone [INFO] [stdout] 41: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] scheduler::asynchronous::async_only_runs_once [INFO] [stdout] scheduler::asynchronous::panicking_panics_with_future_queues [INFO] [stdout] scheduler::future_sync::wait_for_sync_future_from_desync_future_without_awaiting [INFO] [stdout] [INFO] [stdout] test result: FAILED. 49 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.50s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test desync' [INFO] running `Command { std: "docker" "inspect" "fdeb02fbf2c8025861136826f146a26c1ec4c057b6e3728cec5e60115bc30f69", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "fdeb02fbf2c8025861136826f146a26c1ec4c057b6e3728cec5e60115bc30f69", kill_on_drop: false }` [INFO] [stdout] fdeb02fbf2c8025861136826f146a26c1ec4c057b6e3728cec5e60115bc30f69