[INFO] cloning repository https://github.com/ustulation/using-quinn [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ustulation/using-quinn" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fustulation%2Fusing-quinn", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fustulation%2Fusing-quinn'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] e68ff37204a005d60e6fb1f3f3e4a36784846124 [INFO] testing ustulation/using-quinn against try#613d1972a772987ed4ee06faccbab0e2fc839871+rustflags=-Copt-level=3 for pr-107051 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fustulation%2Fusing-quinn" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/ustulation/using-quinn on toolchain 613d1972a772987ed4ee06faccbab0e2fc839871 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+613d1972a772987ed4ee06faccbab0e2fc839871" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/ustulation/using-quinn [INFO] removed 0 missing examples [INFO] finished tweaking git repo https://github.com/ustulation/using-quinn [INFO] tweaked toml for git repo https://github.com/ustulation/using-quinn written to /workspace/builds/worker-5-tc2/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" __CARGO_TEST_CHANNEL_OVERRIDE_DO_NOT_USE_THIS="nightly" "/workspace/cargo-home/bin/cargo" "+613d1972a772987ed4ee06faccbab0e2fc839871" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+613d1972a772987ed4ee06faccbab0e2fc839871" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7c93e6f9a94679f34221d1005849d4c83862f85b14a264fa0883942f4d043a66" "/opt/rustwide/cargo-home/bin/cargo" "+613d1972a772987ed4ee06faccbab0e2fc839871" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] a82b71075604171eb57366ad3264ca12792b33248a94497b0f6ba0e632220bc1 [INFO] running `Command { std: "docker" "start" "-a" "a82b71075604171eb57366ad3264ca12792b33248a94497b0f6ba0e632220bc1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "a82b71075604171eb57366ad3264ca12792b33248a94497b0f6ba0e632220bc1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a82b71075604171eb57366ad3264ca12792b33248a94497b0f6ba0e632220bc1", kill_on_drop: false }` [INFO] [stdout] a82b71075604171eb57366ad3264ca12792b33248a94497b0f6ba0e632220bc1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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 -Copt-level=3" "-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:7c93e6f9a94679f34221d1005849d4c83862f85b14a264fa0883942f4d043a66" "/opt/rustwide/cargo-home/bin/cargo" "+613d1972a772987ed4ee06faccbab0e2fc839871" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e87a626634819216925e1fb0dd63605109404df39ad1b9f5f13f7c87cb5be116 [INFO] running `Command { std: "docker" "start" "-a" "e87a626634819216925e1fb0dd63605109404df39ad1b9f5f13f7c87cb5be116", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.50 [INFO] [stderr] Compiling unicode-ident v1.0.6 [INFO] [stderr] Compiling quote v1.0.23 [INFO] [stderr] Compiling syn v1.0.107 [INFO] [stderr] Compiling libc v0.2.139 [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling cc v1.0.78 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling once_cell v1.17.0 [INFO] [stderr] Compiling untrusted v0.7.1 [INFO] [stderr] Compiling serde_derive v1.0.152 [INFO] [stderr] Compiling pin-project-lite v0.2.9 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling serde v1.0.152 [INFO] [stderr] Compiling futures-core v0.3.25 [INFO] [stderr] Compiling thiserror v1.0.38 [INFO] [stderr] Compiling log v0.4.17 [INFO] [stderr] Compiling ppv-lite86 v0.2.17 [INFO] [stderr] Compiling futures-task v0.3.25 [INFO] [stderr] Compiling rustls v0.20.8 [INFO] [stderr] Compiling memchr v2.5.0 [INFO] [stderr] Compiling futures-channel v0.3.25 [INFO] [stderr] Compiling tracing-core v0.1.30 [INFO] [stderr] Compiling futures-util v0.3.25 [INFO] [stderr] Compiling tinyvec_macros v0.1.0 [INFO] [stderr] Compiling futures-sink v0.3.25 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling time-core v0.1.0 [INFO] [stderr] Compiling futures-io v0.3.25 [INFO] [stderr] Compiling rustc-hash v1.1.0 [INFO] [stderr] Compiling base64 v0.13.1 [INFO] [stderr] Compiling time v0.3.17 [INFO] [stderr] Compiling pem v1.1.1 [INFO] [stderr] Compiling slab v0.4.7 [INFO] [stderr] Compiling tokio v1.24.2 [INFO] [stderr] Compiling yasna v0.5.1 [INFO] [stderr] Compiling getrandom v0.2.8 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling socket2 v0.4.7 [INFO] [stderr] Compiling mio v0.8.5 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling webpki v0.22.0 [INFO] [stderr] Compiling sct v0.7.0 [INFO] [stderr] Compiling rcgen v0.9.3 [INFO] [stderr] Compiling tracing-attributes v0.1.23 [INFO] [stderr] Compiling thiserror-impl v1.0.38 [INFO] [stderr] Compiling futures-macro v0.3.25 [INFO] [stderr] Compiling futures-executor v0.3.25 [INFO] [stderr] Compiling futures v0.3.25 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling bytes v1.3.0 [INFO] [stderr] Compiling bincode v1.3.3 [INFO] [stderr] Compiling quinn-proto v0.9.2 [INFO] [stderr] Compiling quinn-udp v0.3.2 [INFO] [stderr] Compiling quinn v0.9.3 [INFO] [stderr] Compiling qp2p v0.35.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3m 07s [INFO] running `Command { std: "docker" "inspect" "e87a626634819216925e1fb0dd63605109404df39ad1b9f5f13f7c87cb5be116", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e87a626634819216925e1fb0dd63605109404df39ad1b9f5f13f7c87cb5be116", kill_on_drop: false }` [INFO] [stdout] e87a626634819216925e1fb0dd63605109404df39ad1b9f5f13f7c87cb5be116 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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 -Copt-level=3" "-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:7c93e6f9a94679f34221d1005849d4c83862f85b14a264fa0883942f4d043a66" "/opt/rustwide/cargo-home/bin/cargo" "+613d1972a772987ed4ee06faccbab0e2fc839871" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] ae1648481302f0007d954d6241ffa8f3c806b2979316623493e80a17c9127ded [INFO] running `Command { std: "docker" "start" "-a" "ae1648481302f0007d954d6241ffa8f3c806b2979316623493e80a17c9127ded", kill_on_drop: false }` [INFO] [stderr] Compiling log v0.4.17 [INFO] [stderr] Compiling regex-syntax v0.6.28 [INFO] [stderr] Compiling tracing-core v0.1.30 [INFO] [stderr] Compiling num-traits v0.2.15 [INFO] [stderr] Compiling num-integer v0.1.45 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling serde_json v1.0.91 [INFO] [stderr] Compiling itoa v1.0.5 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling iana-time-zone v0.1.53 [INFO] [stderr] Compiling ryu v1.0.12 [INFO] [stderr] Compiling thread_local v1.1.4 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling smallvec v1.10.0 [INFO] [stderr] Compiling tokio v1.24.2 [INFO] [stderr] Compiling tokio-macros v1.8.2 [INFO] [stderr] Compiling sharded-slab v0.1.4 [INFO] [stderr] Compiling num_cpus v1.15.0 [INFO] [stderr] Compiling backtrace v0.3.67 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling mio v0.8.5 [INFO] [stderr] Compiling eyre v0.6.8 [INFO] [stderr] Compiling crunchy v0.2.2 [INFO] [stderr] Compiling tracing v0.1.37 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling tracing-log v0.1.3 [INFO] [stderr] Compiling quinn-proto v0.9.2 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling gimli v0.27.0 [INFO] [stderr] Compiling miniz_oxide v0.6.2 [INFO] [stderr] Compiling object v0.30.2 [INFO] [stderr] Compiling tiny-keccak v2.0.2 [INFO] [stderr] Compiling owo-colors v1.3.0 [INFO] [stderr] Compiling rustc-demangle v0.1.21 [INFO] [stderr] Compiling indenter v0.3.3 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling regex v1.7.1 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling chrono v0.4.23 [INFO] [stderr] Compiling rand_pcg v0.2.1 [INFO] [stderr] Compiling tracing-test-macro v0.1.0 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling ctor v0.1.26 [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling tracing-subscriber v0.2.25 [INFO] [stderr] Compiling addr2line v0.19.0 [INFO] [stderr] Compiling quinn-udp v0.3.2 [INFO] [stderr] Compiling tracing-error v0.1.2 [INFO] [stderr] Compiling color-spantrace v0.1.6 [INFO] [stderr] Compiling color-eyre v0.5.11 [INFO] [stderr] Compiling tracing-test v0.1.0 [INFO] [stderr] Compiling quinn v0.9.3 [INFO] [stderr] Compiling qp2p v0.35.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 2m 11s [INFO] running `Command { std: "docker" "inspect" "ae1648481302f0007d954d6241ffa8f3c806b2979316623493e80a17c9127ded", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ae1648481302f0007d954d6241ffa8f3c806b2979316623493e80a17c9127ded", kill_on_drop: false }` [INFO] [stdout] ae1648481302f0007d954d6241ffa8f3c806b2979316623493e80a17c9127ded [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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 -Copt-level=3" "-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:7c93e6f9a94679f34221d1005849d4c83862f85b14a264fa0883942f4d043a66" "/opt/rustwide/cargo-home/bin/cargo" "+613d1972a772987ed4ee06faccbab0e2fc839871" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 36362a015442f4f09c35c54cfe63355a6d59fa81d9ed5ed158d76c79de5b0a86 [INFO] running `Command { std: "docker" "start" "-a" "36362a015442f4f09c35c54cfe63355a6d59fa81d9ed5ed158d76c79de5b0a86", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.33s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/qp2p-86a1db749052b85d) [INFO] [stdout] [INFO] [stdout] running 14 tests [INFO] [stdout] test tests::common::successful_connection ... ok [INFO] [stdout] test tests::common::single_message ... ok [INFO] [stdout] test tests::common::simultaneous_incoming_and_outgoing_connections ... ok [INFO] [stdout] test tests::common::client ... ok [INFO] [stdout] test connection::tests::basic_usage ... FAILED [INFO] [stdout] test connection::tests::connection_loss ... ok [INFO] [stdout] test tests::common::multiple_connections_with_many_concurrent_messages ... ok [INFO] [stdout] test tests::common::no_reuse_outgoing_connection ... ok [INFO] [stdout] test tests::common::no_reuse_incoming_connection ... ok [INFO] [stdout] test tests::common::many_messages ... ok [INFO] [stdout] test tests::common::no_client_keep_alive_times_out ... ok [INFO] [stdout] test tests::common::client_keep_alive_works ... ok [INFO] [stdout] test tests::common::multiple_concurrent_connects_to_the_same_peer ... ok [INFO] [stdout] test tests::common::multiple_connections_with_many_larger_concurrent_messages ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- connection::tests::basic_usage stdout ---- [INFO] [stdout] Jan 22 08:47:22.905 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:59091140574279829440: listening for incoming uni-streams [INFO] [stdout] Jan 22 08:47:23.181 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:59091140574279829440: listening for incoming bi-streams [INFO] [stdout] Jan 22 08:47:23.181 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:38346140574279979856: listening for incoming uni-streams [INFO] [stdout] Jan 22 08:47:23.181 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:38346140574279979856: listening for incoming bi-streams [INFO] [stdout] Jan 22 08:47:23.181 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:38346140574279979856: incoming uni-stream accepted [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:59091140574279829440: incoming uni-stream accepted [INFO] [stdout] Jan 22 08:47:23.182 WARN basic_usage: qp2p::connection: Connection handle dropped, thus closing it, conn_id=127.0.0.1:38346140574279979856 [INFO] [stdout] Jan 22 08:47:23.182 WARN basic_usage: qp2p::connection: Connection handle dropped, thus closing it, conn_id=127.0.0.1:59091140574279829440 [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:38346140574279979856: failure when awaiting incoming uni-streams: Closed(Local) [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:38346140574279979856: stopped listening for uni-streams [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:38346140574279979856: failure when awaiting incoming bi-streams: Closed(Local) [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:38346140574279979856: stopped listening for bi-streams [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:59091140574279829440: failure when awaiting incoming uni-streams: Closed(Local) [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:59091140574279829440: stopped listening for uni-streams [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:59091140574279829440: failure when awaiting incoming bi-streams: Closed(Local) [INFO] [stdout] Jan 22 08:47:23.182 TRACE basic_usage: qp2p::connection: Connection 127.0.0.1:59091140574279829440: stopped listening for bi-streams [INFO] [stdout] Error: [INFO] [stdout] 0: deadline has elapsed [INFO] [stdout] [INFO] [stdout] Location: [INFO] [stdout] src/connection.rs:429 [INFO] [stdout] [INFO] [stdout] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ BACKTRACE ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ [INFO] [stdout]  ⋮ 5 frames hidden ⋮  [INFO] [stdout] 6:  as core::ops::try_trait::FromResidual>>::from_residual::ha588d3dab23bd97c [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/core/src/result.rs:2107 [INFO] [stdout] 7: qp2p::connection::tests::basic_usage::{{closure}}::hc49442f340c88092 [INFO] [stdout] at /opt/rustwide/workdir/src/connection.rs:429 [INFO] [stdout] 427 │ [INFO] [stdout] 428 │ // check the connections were shutdown on drop [INFO] [stdout]  429 >  timeout(peer1.wait_idle()).await?; [INFO] [stdout] 430 │ timeout(peer2.wait_idle()).await?; [INFO] [stdout] 431 │ [INFO] [stdout] 8:  as core::future::future::Future>::poll::h76548d96ab899ced [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/core/src/future/future.rs:125 [INFO] [stdout] 9:  as core::future::future::Future>::poll::h12d6dd97486bf5ef [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/core/src/future/future.rs:125 [INFO] [stdout] 10: tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::hf33ae3de9abd2acb [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:541 [INFO] [stdout] 539 │ if handle.reset_woken() { [INFO] [stdout] 540 │ let (c, res) = context.enter(core, || { [INFO] [stdout]  541 >  crate::runtime::coop::budget(|| future.as_mut().poll(&mut cx)) [INFO] [stdout] 542 │ }); [INFO] [stdout] 543 │ [INFO] [stdout] 11: tokio::runtime::coop::with_budget::h67a9306866ab9cee [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/coop.rs:102 [INFO] [stdout] 100 │ // The function is called regardless even if the budget is not successfully [INFO] [stdout] 101 │ // set due to the thread-local being destroyed. [INFO] [stdout]  102 >  f() [INFO] [stdout] 103 │ } [INFO] [stdout] 104 │ [INFO] [stdout] 12: tokio::runtime::coop::budget::h68ada38409281353 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/coop.rs:68 [INFO] [stdout] 66 │ #[inline(always)] [INFO] [stdout] 67 │ pub(crate) fn budget(f: impl FnOnce() -> R) -> R { [INFO] [stdout]  68 >  with_budget(Budget::initial(), f) [INFO] [stdout] 69 │ } [INFO] [stdout] 70 │ [INFO] [stdout] 13: tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h29884af45caaaf42 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:541 [INFO] [stdout] 539 │ if handle.reset_woken() { [INFO] [stdout] 540 │ let (c, res) = context.enter(core, || { [INFO] [stdout]  541 >  crate::runtime::coop::budget(|| future.as_mut().poll(&mut cx)) [INFO] [stdout] 542 │ }); [INFO] [stdout] 543 │ [INFO] [stdout] 14: tokio::runtime::scheduler::current_thread::Context::enter::h50a2930389ede07d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:350 [INFO] [stdout] 348 │ [INFO] [stdout] 349 │ // Execute the closure while tracking the execution budget [INFO] [stdout]  350 >  let ret = f(); [INFO] [stdout] 351 │ [INFO] [stdout] 352 │ // Take the scheduler core back [INFO] [stdout] 15: tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h1362ef20a0694ddb [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:540 [INFO] [stdout] 538 │ [INFO] [stdout] 539 │ if handle.reset_woken() { [INFO] [stdout]  540 >  let (c, res) = context.enter(core, || { [INFO] [stdout] 541 │ crate::runtime::coop::budget(|| future.as_mut().poll(&mut cx)) [INFO] [stdout] 542 │ }); [INFO] [stdout] 16: tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h53b2f397b2a13a45 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:615 [INFO] [stdout] 613 │ [INFO] [stdout] 614 │ // Call the closure and place `core` back [INFO] [stdout]  615 >  let (core, ret) = CURRENT.set(&self.context, || f(core, &self.context)); [INFO] [stdout] 616 │ [INFO] [stdout] 617 │ *self.context.core.borrow_mut() = Some(core); [INFO] [stdout] 17: tokio::macros::scoped_tls::ScopedKey::set::hfc3ddf86f748f6f8 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/macros/scoped_tls.rs:61 [INFO] [stdout] 59 │ }; [INFO] [stdout] 60 │ [INFO] [stdout]  61 >  f() [INFO] [stdout] 62 │ } [INFO] [stdout] 63 │ [INFO] [stdout] 18: tokio::runtime::scheduler::current_thread::CoreGuard::enter::h8dfe7e3b45dfb77e [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:615 [INFO] [stdout] 613 │ [INFO] [stdout] 614 │ // Call the closure and place `core` back [INFO] [stdout]  615 >  let (core, ret) = CURRENT.set(&self.context, || f(core, &self.context)); [INFO] [stdout] 616 │ [INFO] [stdout] 617 │ *self.context.core.borrow_mut() = Some(core); [INFO] [stdout] 19: tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h0a0effd474d63b77 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:530 [INFO] [stdout] 528 │ #[track_caller] [INFO] [stdout] 529 │ fn block_on(self, future: F) -> F::Output { [INFO] [stdout]  530 >  let ret = self.enter(|mut core, context| { [INFO] [stdout] 531 │ let waker = Handle::waker_ref(&context.handle); [INFO] [stdout] 532 │ let mut cx = std::task::Context::from_waker(&waker); [INFO] [stdout] 20: tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h423d6b9c95e5a6d1 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/scheduler/current_thread.rs:154 [INFO] [stdout] 152 │ loop { [INFO] [stdout] 153 │ if let Some(core) = self.take_core(handle) { [INFO] [stdout]  154 >  return core.block_on(future); [INFO] [stdout] 155 │ } else { [INFO] [stdout] 156 │ let notified = self.notify.notified(); [INFO] [stdout] 21: tokio::runtime::runtime::Runtime::block_on::h0e9193357eee9de5 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-1.24.2/src/runtime/runtime.rs:282 [INFO] [stdout] 280 │ [INFO] [stdout] 281 │ match &self.scheduler { [INFO] [stdout]  282 >  Scheduler::CurrentThread(exec) => exec.block_on(&self.handle.inner, future), [INFO] [stdout] 283 │ #[cfg(all(feature = "rt-multi-thread", not(tokio_wasi)))] [INFO] [stdout] 284 │ Scheduler::MultiThread(exec) => exec.block_on(&self.handle.inner, future), [INFO] [stdout] 22: qp2p::connection::tests::basic_usage::h28dbb4b658c36407 [INFO] [stdout] at /opt/rustwide/workdir/src/connection.rs:432 [INFO] [stdout] 430 │ timeout(peer2.wait_idle()).await?; [INFO] [stdout] 431 │ [INFO] [stdout]  432 >  Ok(()) [INFO] [stdout] 433 │ } [INFO] [stdout] 434 │ [INFO] [stdout] 23: qp2p::connection::tests::basic_usage::{{closure}}::hd4a04db5fb9937fe [INFO] [stdout] at /opt/rustwide/workdir/src/connection.rs:381 [INFO] [stdout] 379 │ #[tokio::test] [INFO] [stdout] 380 │ #[tracing_test::traced_test] [INFO] [stdout]  381 >  async fn basic_usage() -> Result<()> { [INFO] [stdout] 382 │ let (cfg_srv, cfg_cli) = crate::Endpoint::builder().config()?; [INFO] [stdout] 383 │ [INFO] [stdout] 24: core::ops::function::FnOnce::call_once::h50c0451725230509 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/core/src/ops/function.rs:250 [INFO] [stdout] 25: core::ops::function::FnOnce::call_once::h01f8fec7cfa52c10 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/core/src/ops/function.rs:250 [INFO] [stdout] 26: test::__rust_begin_short_backtrace::hd9df3824e14a263a [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/test/src/lib.rs:656 [INFO] [stdout] 27: test::run_test::{{closure}}::h14eccc3df692cf45 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/test/src/lib.rs:647 [INFO] [stdout] 28: core::ops::function::FnOnce::call_once{{vtable.shim}}::h22daa4200e93d413 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/core/src/ops/function.rs:250 [INFO] [stdout] 29:  as core::ops::function::FnOnce>::call_once::hf53e6a300c60e24c [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/alloc/src/boxed.rs:1988 [INFO] [stdout] 30:  as core::ops::function::FnOnce<()>>::call_once::h6791832c0d80daf4 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/core/src/panic/unwind_safe.rs:271 [INFO] [stdout] 31: std::panicking::try::do_call::h8cc8eae26cdc3fd4 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/std/src/panicking.rs:483 [INFO] [stdout] 32: std::panicking::try::hda02a22cf2e8baa4 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/std/src/panicking.rs:447 [INFO] [stdout] 33: std::panic::catch_unwind::h3eae6cdd2df69f71 [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/std/src/panic.rs:140 [INFO] [stdout] 34: test::run_test_in_process::h16fa719e43e0b71b [INFO] [stdout] at /rustc/613d1972a772987ed4ee06faccbab0e2fc839871/library/test/src/lib.rs:679 [INFO] [stdout]  ⋮ 14 frames hidden ⋮  [INFO] [stdout] [INFO] [stdout] Run with COLORBT_SHOW_HIDDEN=1 environment variable to disable frame filtering. [INFO] [stdout] Warning: SpanTrace capture is Unsupported. [INFO] [stdout] Ensure that you've setup a tracing-error ErrorLayer and the semver versions are compatible [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] connection::tests::basic_usage [INFO] [stdout] [INFO] [stdout] test result: FAILED. 13 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 24.85s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "36362a015442f4f09c35c54cfe63355a6d59fa81d9ed5ed158d76c79de5b0a86", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "36362a015442f4f09c35c54cfe63355a6d59fa81d9ed5ed158d76c79de5b0a86", kill_on_drop: false }` [INFO] [stdout] 36362a015442f4f09c35c54cfe63355a6d59fa81d9ed5ed158d76c79de5b0a86