[INFO] fetching crate tokio_serial_pacing 0.1.1... [INFO] testing tokio_serial_pacing-0.1.1 against try#ed7f3d77595b4831fdf085f2529aa13b5b51ff7d for pr-134530 [INFO] extracting crate tokio_serial_pacing 0.1.1 into /workspace/builds/worker-0-tc2/source [INFO] validating manifest of crates.io crate tokio_serial_pacing 0.1.1 on toolchain ed7f3d77595b4831fdf085f2529aa13b5b51ff7d [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ed7f3d77595b4831fdf085f2529aa13b5b51ff7d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate tokio_serial_pacing 0.1.1 [INFO] finished tweaking crates.io crate tokio_serial_pacing 0.1.1 [INFO] tweaked toml for crates.io crate tokio_serial_pacing 0.1.1 written to /workspace/builds/worker-0-tc2/source/Cargo.toml [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ed7f3d77595b4831fdf085f2529aa13b5b51ff7d" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Locking 72 packages to latest compatible versions [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ed7f3d77595b4831fdf085f2529aa13b5b51ff7d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+ed7f3d77595b4831fdf085f2529aa13b5b51ff7d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] e299bf129d434616158b44795858381adde0192764437e429bf72e14025e8016 [INFO] running `Command { std: "docker" "start" "-a" "e299bf129d434616158b44795858381adde0192764437e429bf72e14025e8016", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "e299bf129d434616158b44795858381adde0192764437e429bf72e14025e8016", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e299bf129d434616158b44795858381adde0192764437e429bf72e14025e8016", kill_on_drop: false }` [INFO] [stdout] e299bf129d434616158b44795858381adde0192764437e429bf72e14025e8016 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+ed7f3d77595b4831fdf085f2529aa13b5b51ff7d" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] dd626616430812c48f40142c7116d3e11116266598b4fc3bf602a2b77408d155 [INFO] running `Command { std: "docker" "start" "-a" "dd626616430812c48f40142c7116d3e11116266598b4fc3bf602a2b77408d155", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.92 [INFO] [stderr] Compiling autocfg v1.4.0 [INFO] [stderr] Compiling unicode-ident v1.0.14 [INFO] [stderr] Compiling libc v0.2.169 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling pin-project-lite v0.2.15 [INFO] [stderr] Compiling memchr v2.7.4 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling bitflags v1.3.2 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling log v0.4.22 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling bitflags v2.6.0 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling memoffset v0.7.1 [INFO] [stderr] Compiling quote v1.0.37 [INFO] [stderr] Compiling syn v2.0.90 [INFO] [stderr] Compiling nix v0.26.4 [INFO] [stderr] Compiling mio v1.0.3 [INFO] [stderr] Compiling socket2 v0.5.8 [INFO] [stderr] Compiling mio v0.8.11 [INFO] [stderr] Compiling tokio v1.42.0 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling unescaper v0.1.5 [INFO] [stderr] Compiling serialport v4.6.1 [INFO] [stderr] Compiling mio-serial v5.0.5 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling tokio-serial v5.4.4 [INFO] [stderr] Compiling tokio_serial_pacing v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 19.55s [INFO] running `Command { std: "docker" "inspect" "dd626616430812c48f40142c7116d3e11116266598b4fc3bf602a2b77408d155", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "dd626616430812c48f40142c7116d3e11116266598b4fc3bf602a2b77408d155", kill_on_drop: false }` [INFO] [stdout] dd626616430812c48f40142c7116d3e11116266598b4fc3bf602a2b77408d155 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+ed7f3d77595b4831fdf085f2529aa13b5b51ff7d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 222c1cdda94bdf0beebc203470e48fe89a3756b919f90aabea3df3f405917d6e [INFO] running `Command { std: "docker" "start" "-a" "222c1cdda94bdf0beebc203470e48fe89a3756b919f90aabea3df3f405917d6e", kill_on_drop: false }` [INFO] [stderr] Compiling tokio-macros v2.4.0 [INFO] [stderr] Compiling bytes v1.9.0 [INFO] [stderr] Compiling tokio v1.42.0 [INFO] [stderr] Compiling tokio-serial v5.4.4 [INFO] [stderr] Compiling tokio_serial_pacing v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 7.46s [INFO] running `Command { std: "docker" "inspect" "222c1cdda94bdf0beebc203470e48fe89a3756b919f90aabea3df3f405917d6e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "222c1cdda94bdf0beebc203470e48fe89a3756b919f90aabea3df3f405917d6e", kill_on_drop: false }` [INFO] [stdout] 222c1cdda94bdf0beebc203470e48fe89a3756b919f90aabea3df3f405917d6e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+ed7f3d77595b4831fdf085f2529aa13b5b51ff7d" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 5dcdb8032934eed9bb6d331febbcf9c596eb96e9c430e8b1a039dc0529929c0f [INFO] running `Command { std: "docker" "start" "-a" "5dcdb8032934eed9bb6d331febbcf9c596eb96e9c430e8b1a039dc0529929c0f", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tokio_serial_pacing-751b15b9194f5369) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test tests::check_wait_time ... ok [INFO] [stdout] test tests::ensure_sync_port_works ... ok [INFO] [stdout] test tests::check_read_pacing ... ok [INFO] [stdout] test tests::check_write_pacing ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- tests::check_write_pacing stdout ---- [INFO] [stdout] TX=>RX: Writing large buf [INFO] [stdout] RX>=TX Reading large(?) buf [INFO] [stdout] TX=>RX Flushing [INFO] [stdout] TX<=RX Reading ack [INFO] [stdout] RX=>TX, Writing ack data [INFO] [stdout] Test cycle complete [INFO] [stdout] thread 'tests::check_write_pacing' panicked at src/lib.rs:122:9: [INFO] [stdout] It should not take a millisecond normally. [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x58216e99627a - std::backtrace_rs::backtrace::libunwind::trace::h3dab7ffe210583a3 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x58216e99627a - std::backtrace_rs::backtrace::trace_unsynchronized::h85ec3139dd4f9047 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x58216e99627a - std::sys::backtrace::_print_fmt::h3447259688950eab [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x58216e99627a - ::fmt::ha8d24a0f27cc401d [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x58216e9bd543 - core::fmt::rt::Argument::fmt::h650b92642f481125 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x58216e9bd543 - core::fmt::write::h5becf96591c394eb [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/fmt/mod.rs:1437:21 [INFO] [stdout] 6: 0x58216e992e13 - std::io::Write::write_fmt::h61fb565ee25d88c6 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/io/mod.rs:1887:15 [INFO] [stdout] 7: 0x58216e9960c2 - std::sys::backtrace::BacktraceLock::print::hae1dc20f39b0ae80 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x58216e9976fe - std::panicking::default_hook::{{closure}}::hb3023fc9edf847a9 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:284:22 [INFO] [stdout] 9: 0x58216e997507 - std::panicking::default_hook::h271aee2d85880663 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:308:9 [INFO] [stdout] 10: 0x58216e90bfc8 - as core::ops::function::Fn>::call::hbfe4f2a7834d388d [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/alloc/src/boxed.rs:1984:9 [INFO] [stdout] 11: 0x58216e90bfc8 - test::test_main::{{closure}}::hbb7d4fde4185abc5 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/test/src/lib.rs:134:21 [INFO] [stdout] 12: 0x58216e997f18 - as core::ops::function::Fn>::call::hd4cbe0a9e8955cde [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/alloc/src/boxed.rs:1984:9 [INFO] [stdout] 13: 0x58216e997f18 - std::panicking::rust_panic_with_hook::he05f4a167c1908ac [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:825:13 [INFO] [stdout] 14: 0x58216e997b96 - std::panicking::begin_panic_handler::{{closure}}::h79780775730ab9df [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:683:13 [INFO] [stdout] 15: 0x58216e996749 - std::sys::backtrace::__rust_end_short_backtrace::h753217146a30d8a2 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x58216e99785d - rust_begin_unwind [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:681:5 [INFO] [stdout] 17: 0x58216e9bb9e0 - core::panicking::panic_fmt::h9ad4c3d87a3eb4ad [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x58216e8c157b - tokio_serial_pacing::tests::check_write_pacing::{{closure}}::hcbd960f0c03c2792 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:122:9 [INFO] [stdout] 19: 0x58216e8bb7c2 - as core::future::future::Future>::poll::h5c59767044fc2ebf [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/future/future.rs:124:9 [INFO] [stdout] 20: 0x58216e8bb73d - as core::future::future::Future>::poll::h2fb94dc5875be6e3 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/future/future.rs:124:9 [INFO] [stdout] 21: 0x58216e8a95bf - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h064e5d85f6de6926 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:729:57 [INFO] [stdout] 22: 0x58216e8a9345 - tokio::runtime::coop::with_budget::hbbb3d7e38d1d25c9 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/coop.rs:107:5 [INFO] [stdout] 23: 0x58216e8a9345 - tokio::runtime::coop::budget::h1dce086605d588f1 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/coop.rs:73:5 [INFO] [stdout] 24: 0x58216e8a9345 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h3950ac4d0c9a616e [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:729:25 [INFO] [stdout] 25: 0x58216e8a6e70 - tokio::runtime::scheduler::current_thread::Context::enter::hc78adfb7ffd838fc [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:428:19 [INFO] [stdout] 26: 0x58216e8a8bcb - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::hce63839d6418ff95 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:728:36 [INFO] [stdout] 27: 0x58216e8a8044 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h567c62288b866566 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:807:68 [INFO] [stdout] 28: 0x58216e8ca94b - tokio::runtime::context::scoped::Scoped::set::h670bba67262ecf20 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 29: 0x58216e8c7679 - tokio::runtime::context::set_scheduler::{{closure}}::h7b52d6b62a9e3ca3 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/context.rs:180:26 [INFO] [stdout] 30: 0x58216e8acdb2 - std::thread::local::LocalKey::try_with::h68c4545a35ce0017 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/thread/local.rs:308:12 [INFO] [stdout] 31: 0x58216e8ac17a - std::thread::local::LocalKey::with::h84f2b9d3d228eabb [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/thread/local.rs:272:9 [INFO] [stdout] 32: 0x58216e8c75ed - tokio::runtime::context::set_scheduler::h7eac46fb080f4c58 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/context.rs:180:9 [INFO] [stdout] 33: 0x58216e8a7df0 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::hfd8bd6bf73cd97ca [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:807:27 [INFO] [stdout] 34: 0x58216e8a80e3 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::hd8e6521fedc188b2 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:716:19 [INFO] [stdout] 35: 0x58216e8a3b25 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::ha7a99e0bf3e6fd13 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:196:28 [INFO] [stdout] 36: 0x58216e8d0de7 - tokio::runtime::context::runtime::enter_runtime::hdca4fde4f247fe4a [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 37: 0x58216e8a3831 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h9aed883ce8ad3c07 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/scheduler/current_thread/mod.rs:184:9 [INFO] [stdout] 38: 0x58216e8ba37a - tokio::runtime::runtime::Runtime::block_on_inner::h14c5807fbe682b8c [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/runtime.rs:368:47 [INFO] [stdout] 39: 0x58216e8ba627 - tokio::runtime::runtime::Runtime::block_on::h24623d4084c44dbf [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.42.0/src/runtime/runtime.rs:342:13 [INFO] [stdout] 40: 0x58216e8c0fac - tokio_serial_pacing::tests::check_write_pacing::h7e5f26dbc74fa5fe [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:138:9 [INFO] [stdout] 41: 0x58216e8c0e57 - tokio_serial_pacing::tests::check_write_pacing::{{closure}}::haff53bf5503dda24 [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:115:34 [INFO] [stdout] 42: 0x58216e8a0226 - core::ops::function::FnOnce::call_once::h29693c098fa46002 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 43: 0x58216e910c0b - core::ops::function::FnOnce::call_once::h651e3187cb632f8b [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 44: 0x58216e910c0b - test::__rust_begin_short_backtrace::hf087c08482082584 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/test/src/lib.rs:632:18 [INFO] [stdout] 45: 0x58216e910519 - test::run_test_in_process::{{closure}}::h028b11125eb38b18 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/test/src/lib.rs:655:60 [INFO] [stdout] 46: 0x58216e910519 - as core::ops::function::FnOnce<()>>::call_once::h8a69fc59e5c0ffcd [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 47: 0x58216e910519 - std::panicking::try::do_call::h53d2549af1773521 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:573:40 [INFO] [stdout] 48: 0x58216e910519 - std::panicking::try::h327579c208c8ae37 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:536:19 [INFO] [stdout] 49: 0x58216e910519 - std::panic::catch_unwind::hae7e4a4da155a27e [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panic.rs:358:14 [INFO] [stdout] 50: 0x58216e910519 - test::run_test_in_process::hef0a7b0ac1ee3437 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/test/src/lib.rs:655:27 [INFO] [stdout] 51: 0x58216e910519 - test::run_test::{{closure}}::h007633ec4ae045b1 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/test/src/lib.rs:576:43 [INFO] [stdout] 52: 0x58216e8d328a - test::run_test::{{closure}}::hf3a8c9852b545b46 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/test/src/lib.rs:606:41 [INFO] [stdout] 53: 0x58216e8d328a - std::sys::backtrace::__rust_begin_short_backtrace::ha442d5d7942f6ee9 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 54: 0x58216e8d6cf6 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hc8fd461cdc84b676 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/thread/mod.rs:561:17 [INFO] [stdout] 55: 0x58216e8d6cf6 - as core::ops::function::FnOnce<()>>::call_once::h5a459cc955f063ed [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 56: 0x58216e8d6cf6 - std::panicking::try::do_call::hc249aed3a6c9c972 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:573:40 [INFO] [stdout] 57: 0x58216e8d6cf6 - std::panicking::try::h649add41232b7ab3 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panicking.rs:536:19 [INFO] [stdout] 58: 0x58216e8d6cf6 - std::panic::catch_unwind::h2fd522623ccd57b0 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/panic.rs:358:14 [INFO] [stdout] 59: 0x58216e8d6cf6 - std::thread::Builder::spawn_unchecked_::{{closure}}::h685de412d0d20b6b [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/thread/mod.rs:559:30 [INFO] [stdout] 60: 0x58216e8d6cf6 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hf3391e711cf5434d [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 61: 0x58216e99bf4b - as core::ops::function::FnOnce>::call_once::hc98bb0f9729b604d [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/alloc/src/boxed.rs:1970:9 [INFO] [stdout] 62: 0x58216e99bf4b - as core::ops::function::FnOnce>::call_once::h3b479d8e9f1fef9f [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/alloc/src/boxed.rs:1970:9 [INFO] [stdout] 63: 0x58216e99bf4b - std::sys::pal::unix::thread::Thread::new::thread_start::he3d5da9652362070 [INFO] [stdout] at /rustc/ed7f3d77595b4831fdf085f2529aa13b5b51ff7d/library/std/src/sys/pal/unix/thread.rs:105:17 [INFO] [stdout] 64: 0x76786a92dac3 - [INFO] [stdout] 65: 0x76786a9bea04 - clone [INFO] [stdout] 66: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::check_write_pacing [INFO] [stdout] [INFO] [stdout] test result: FAILED. 3 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "5dcdb8032934eed9bb6d331febbcf9c596eb96e9c430e8b1a039dc0529929c0f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5dcdb8032934eed9bb6d331febbcf9c596eb96e9c430e8b1a039dc0529929c0f", kill_on_drop: false }` [INFO] [stdout] 5dcdb8032934eed9bb6d331febbcf9c596eb96e9c430e8b1a039dc0529929c0f