[INFO] fetching crate crossfire 2.0.26... [INFO] testing crossfire-2.0.26 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-2 [INFO] extracting crate crossfire 2.0.26 into /workspace/builds/worker-3-tc1/source [INFO] started tweaking crates.io crate crossfire 2.0.26 [INFO] finished tweaking crates.io crate crossfire 2.0.26 [INFO] tweaked toml for crates.io crate crossfire 2.0.26 written to /workspace/builds/worker-3-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate crossfire 2.0.26 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate crossfire 2.0.26 already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded wasi v0.11.1+wasi-snapshot-preview1 [INFO] [stderr] Downloaded rustc_version v0.4.1 [INFO] [stderr] Downloaded wit-bindgen-rt v0.39.0 [INFO] [stderr] Downloaded android-tzdata v0.1.1 [INFO] [stderr] Downloaded parking_lot v0.12.4 [INFO] [stderr] Downloaded futures-lite v2.6.1 [INFO] [stderr] Downloaded winapi-util v0.1.10 [INFO] [stderr] Downloaded rand_chacha v0.9.0 [INFO] [stderr] Downloaded crossbeam v0.8.4 [INFO] [stderr] Downloaded blocking v1.6.2 [INFO] [stderr] Downloaded async-channel v2.5.0 [INFO] [stderr] Downloaded async-executor v1.13.3 [INFO] [stderr] Downloaded event-listener v5.4.1 [INFO] [stderr] Downloaded async-lock v3.4.1 [INFO] [stderr] Downloaded file-rotate v0.8.0 [INFO] [stderr] Downloaded zerocopy v0.8.26 [INFO] [stderr] Downloaded bumpalo v3.19.0 [INFO] [stderr] Downloaded winnow v0.7.13 [INFO] [stderr] Downloaded crossfire v2.0.24 [INFO] [stderr] Downloaded anes v0.2.1 [INFO] [stderr] Downloaded rayon-core v1.13.0 [INFO] [stderr] Downloaded num-traits v0.2.19 [INFO] [stderr] Downloaded criterion2 v3.0.2 [INFO] [stderr] Downloaded arc-swap v1.7.1 [INFO] [stderr] Downloaded async-std v1.13.2 [INFO] [stderr] Downloaded cc v1.2.34 [INFO] [stderr] Downloaded regex-automata v0.4.10 [INFO] [stderr] Downloaded rand v0.9.2 [INFO] [stderr] Downloaded toml_edit v0.22.27 [INFO] [stderr] Downloaded windows-interface v0.59.1 [INFO] [stderr] Downloaded nix v0.30.1 [INFO] [stderr] Downloaded rand_core v0.6.4 [INFO] [stderr] Downloaded windows_i686_msvc v0.53.0 [INFO] [stderr] Downloaded io-buffer v1.0.3 [INFO] [stderr] Downloaded windows_x86_64_gnu v0.53.0 [INFO] [stderr] Downloaded rayon v1.11.0 [INFO] [stderr] Downloaded windows_x86_64_gnullvm v0.53.0 [INFO] [stderr] Downloaded captains-log v0.8.6 [INFO] [stderr] Downloaded chrono v0.4.41 [INFO] [stderr] Downloaded bpaf v0.9.20 [INFO] [stderr] Downloaded serde_json v1.0.143 [INFO] [stderr] Downloaded cast v0.3.0 [INFO] [stderr] Downloaded half v2.6.0 [INFO] [stderr] Downloaded ciborium v0.2.2 [INFO] [stderr] Downloaded async-io v2.5.0 [INFO] [stderr] Downloaded exitcode v1.1.2 [INFO] [stderr] Downloaded core-foundation-sys v0.8.7 [INFO] [stderr] Downloaded windows-implement v0.60.0 [INFO] [stderr] Downloaded windows_i686_gnullvm v0.53.0 [INFO] [stderr] Downloaded windows_x86_64_msvc v0.53.0 [INFO] [stderr] Downloaded windows-result v0.3.4 [INFO] [stderr] Downloaded windows-core v0.61.2 [INFO] [stderr] Downloaded windows_i686_gnu v0.53.0 [INFO] [stderr] Downloaded iana-time-zone v0.1.63 [INFO] [stderr] Downloaded rand_chacha v0.3.1 [INFO] [stderr] Downloaded fail v0.5.1 [INFO] [stderr] Downloaded ring-file v0.1.2 [INFO] [stderr] Downloaded signal-hook-registry v1.4.6 [INFO] [stderr] Downloaded signal-hook v0.3.18 [INFO] [stderr] Downloaded ciborium-io v0.2.2 [INFO] [stderr] Downloaded crunchy v0.2.4 [INFO] [stderr] Downloaded ciborium-ll v0.2.2 [INFO] [stderr] Downloaded oorandom v11.1.5 [INFO] [stderr] Downloaded either v1.15.0 [INFO] [stderr] Downloaded enum_dispatch v0.3.13 [INFO] [stderr] Downloaded lock_api v0.4.13 [INFO] [stderr] Downloaded regex v1.11.2 [INFO] [stderr] Downloaded windows_aarch64_msvc v0.53.0 [INFO] [stderr] Downloaded hermit-abi v0.5.2 [INFO] [stderr] Downloaded captains-log-helper v0.3.1 [INFO] [stderr] Downloaded android_system_properties v0.1.5 [INFO] [stderr] Downloaded iana-time-zone-haiku v0.1.2 [INFO] [stderr] Downloaded windows-strings v0.4.2 [INFO] [stderr] Downloaded windows-link v0.1.3 [INFO] [stderr] Downloaded walkdir v2.5.0 [INFO] [stderr] Downloaded parking_lot_core v0.9.11 [INFO] [stderr] Downloaded wasi v0.14.2+wasi-0.2.4 [INFO] [stderr] Downloaded windows_aarch64_gnullvm v0.53.0 [INFO] [stderr] Downloaded rand_core v0.9.3 [INFO] [stderr] Downloaded regex-syntax v0.8.6 [INFO] [stderr] Downloaded polling v3.10.0 [INFO] [stderr] Downloaded windows-targets v0.53.3 [INFO] [stderr] Downloaded nanorand v0.7.0 [INFO] [stderr] Downloaded flume v0.11.1 [INFO] [stderr] Downloaded redox_syscall v0.5.17 [INFO] [stderr] Downloaded zerocopy-derive v0.8.26 [INFO] [stderr] Downloaded aho-corasick v1.1.3 [INFO] [stderr] Downloaded relative-path v1.9.3 [INFO] [stderr] Downloaded r-efi v5.3.0 [INFO] [stderr] Downloaded glob v0.3.3 [INFO] [stderr] Downloaded crossbeam-deque v0.8.6 [INFO] [stderr] Downloaded crossbeam-epoch v0.9.18 [INFO] [stderr] Downloaded crossbeam-queue v0.3.12 [INFO] [stderr] Downloaded rustversion v1.0.22 [INFO] [stderr] Downloaded spin v0.9.8 [INFO] [stderr] Downloaded autocfg v1.5.0 [INFO] [stderr] Downloaded toml_datetime v0.6.11 [INFO] [stderr] Downloaded rand v0.8.5 [INFO] [stderr] Downloaded kanal v0.1.1 [INFO] [stderr] Downloaded ppv-lite86 v0.2.21 [INFO] [stderr] Downloaded proc-macro-crate v3.3.0 [INFO] [stderr] Downloaded rstest_macros v0.26.1 [INFO] [stderr] Downloaded bitflags v2.9.3 [INFO] [stderr] Downloaded io-uring v0.7.10 [INFO] [stderr] Downloaded rstest v0.26.1 [INFO] [stderr] Downloaded backtrace v0.3.75 [INFO] [stderr] Downloaded semver v1.0.26 [INFO] [stderr] Downloaded rustc-demangle v0.1.26 [INFO] [stderr] Downloaded windows-sys v0.60.2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 3a49d4b8828f859a2722bc3a94c3a7a566ca3361f71b162ed7ceddda0fb06d7e [INFO] running `Command { std: "docker" "start" "-a" "3a49d4b8828f859a2722bc3a94c3a7a566ca3361f71b162ed7ceddda0fb06d7e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "3a49d4b8828f859a2722bc3a94c3a7a566ca3361f71b162ed7ceddda0fb06d7e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "3a49d4b8828f859a2722bc3a94c3a7a566ca3361f71b162ed7ceddda0fb06d7e", kill_on_drop: false }` [INFO] [stdout] 3a49d4b8828f859a2722bc3a94c3a7a566ca3361f71b162ed7ceddda0fb06d7e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 864e7d1546eab988ae5b02e0cc7f37b8d109c9babbec2101aac2e69c27670aef [INFO] running `Command { std: "docker" "start" "-a" "864e7d1546eab988ae5b02e0cc7f37b8d109c9babbec2101aac2e69c27670aef", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.101 [INFO] [stderr] Compiling unicode-ident v1.0.18 [INFO] [stderr] Compiling crossbeam-utils v0.8.21 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling libc v0.2.175 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling autocfg v1.5.0 [INFO] [stderr] Compiling memchr v2.7.5 [INFO] [stderr] Compiling slab v0.4.11 [INFO] [stderr] Compiling parking_lot_core v0.9.11 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling cfg-if v1.0.3 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling lock_api v0.4.13 [INFO] [stderr] Compiling crossbeam-epoch v0.9.18 [INFO] [stderr] Compiling crossbeam-queue v0.3.12 [INFO] [stderr] Compiling crossbeam-channel v0.5.15 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling syn v2.0.106 [INFO] [stderr] Compiling crossbeam-deque v0.8.6 [INFO] [stderr] Compiling crossbeam v0.8.4 [INFO] [stderr] Compiling parking_lot v0.12.4 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling enum_dispatch v0.3.13 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling crossfire v2.0.26 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 11.41s [INFO] running `Command { std: "docker" "inspect" "864e7d1546eab988ae5b02e0cc7f37b8d109c9babbec2101aac2e69c27670aef", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "864e7d1546eab988ae5b02e0cc7f37b8d109c9babbec2101aac2e69c27670aef", kill_on_drop: false }` [INFO] [stdout] 864e7d1546eab988ae5b02e0cc7f37b8d109c9babbec2101aac2e69c27670aef [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 06adcb9be2d82ab99b8d4040425ae1af411a2a49b0ea2e90dd7985c5c8ae088f [INFO] running `Command { std: "docker" "start" "-a" "06adcb9be2d82ab99b8d4040425ae1af411a2a49b0ea2e90dd7985c5c8ae088f", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.175 [INFO] [stderr] Compiling crossbeam-utils v0.8.21 [INFO] [stderr] Compiling zerocopy v0.8.26 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling getrandom v0.3.3 [INFO] [stderr] Compiling regex-syntax v0.8.6 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling semver v1.0.26 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling cfg_aliases v0.2.1 [INFO] [stderr] Compiling memchr v2.7.5 [INFO] [stderr] Compiling adler2 v2.0.1 [INFO] [stderr] Compiling hashbrown v0.15.5 [INFO] [stderr] Compiling syn v2.0.106 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling value-bag v1.11.1 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling nix v0.30.1 [INFO] [stderr] Compiling crc32fast v1.5.0 [INFO] [stderr] Compiling equivalent v1.0.2 [INFO] [stderr] Compiling indexmap v2.11.0 [INFO] [stderr] Compiling log v0.4.27 [INFO] [stderr] Compiling miniz_oxide v0.8.9 [INFO] [stderr] Compiling rayon-core v1.13.0 [INFO] [stderr] Compiling winnow v0.7.13 [INFO] [stderr] Compiling bitflags v2.9.3 [INFO] [stderr] Compiling toml_datetime v0.6.11 [INFO] [stderr] Compiling object v0.36.7 [INFO] [stderr] Compiling crossbeam-epoch v0.9.18 [INFO] [stderr] Compiling rustc_version v0.4.1 [INFO] [stderr] Compiling crossbeam-queue v0.3.12 [INFO] [stderr] Compiling crossbeam-channel v0.5.15 [INFO] [stderr] Compiling concurrent-queue v2.5.0 [INFO] [stderr] Compiling aho-corasick v1.1.3 [INFO] [stderr] Compiling crossbeam-deque v0.8.6 [INFO] [stderr] Compiling rstest_macros v0.26.1 [INFO] [stderr] Compiling half v2.6.0 [INFO] [stderr] Compiling serde_json v1.0.143 [INFO] [stderr] Compiling gimli v0.31.1 [INFO] [stderr] Compiling parking v2.2.1 [INFO] [stderr] Compiling ciborium-io v0.2.2 [INFO] [stderr] Compiling iana-time-zone v0.1.63 [INFO] [stderr] Compiling signal-hook v0.3.18 [INFO] [stderr] Compiling flate2 v1.1.2 [INFO] [stderr] Compiling event-listener v5.4.1 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling crossbeam v0.8.4 [INFO] [stderr] Compiling chrono v0.4.41 [INFO] [stderr] Compiling relative-path v1.9.3 [INFO] [stderr] Compiling rustc-demangle v0.1.26 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling ryu v1.0.20 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling itoa v1.0.15 [INFO] [stderr] Compiling glob v0.3.3 [INFO] [stderr] Compiling either v1.15.0 [INFO] [stderr] Compiling walkdir v2.5.0 [INFO] [stderr] Compiling event-listener-strategy v0.5.4 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling rayon v1.11.0 [INFO] [stderr] Compiling bpaf v0.9.20 [INFO] [stderr] Compiling regex-automata v0.4.10 [INFO] [stderr] Compiling futures-timer v3.0.3 [INFO] [stderr] Compiling exitcode v1.1.2 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling arc-swap v1.7.1 [INFO] [stderr] Compiling getrandom v0.2.16 [INFO] [stderr] Compiling parking_lot_core v0.9.11 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling parking_lot v0.12.4 [INFO] [stderr] Compiling rand_core v0.9.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling toml_edit v0.22.27 [INFO] [stderr] Compiling signal-hook-registry v1.4.6 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling rand v0.9.2 [INFO] [stderr] Compiling file-rotate v0.8.0 [INFO] [stderr] Compiling addr2line v0.24.2 [INFO] [stderr] Compiling nanorand v0.7.0 [INFO] [stderr] Compiling oorandom v11.1.5 [INFO] [stderr] Compiling anes v0.2.1 [INFO] [stderr] Compiling flume v0.11.1 [INFO] [stderr] Compiling fail v0.5.1 [INFO] [stderr] Compiling async-channel v2.5.0 [INFO] [stderr] Compiling kanal v0.1.1 [INFO] [stderr] Compiling io-buffer v1.0.3 [INFO] [stderr] Compiling ring-file v0.1.2 [INFO] [stderr] Compiling regex v1.11.2 [INFO] [stderr] Compiling proc-macro-crate v3.3.0 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling enum_dispatch v0.3.13 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling captains-log-helper v0.3.1 [INFO] [stderr] Compiling tokio v1.47.1 [INFO] [stderr] Compiling backtrace v0.3.75 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling rstest v0.26.1 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling crossfire v2.0.24 [INFO] [stderr] Compiling crossfire v2.0.26 (/opt/rustwide/workdir) [INFO] [stderr] Compiling captains-log v0.8.6 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling criterion2 v3.0.2 [INFO] [stdout] warning: struct `SpuriousTx` is never constructed [INFO] [stdout] --> src/tests/test_async.rs:945:8 [INFO] [stdout] | [INFO] [stdout] 945 | struct SpuriousTx { [INFO] [stdout] | ^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: struct `SpuriousRx` is never constructed [INFO] [stdout] --> src/tests/test_async.rs:976:8 [INFO] [stdout] | [INFO] [stdout] 976 | struct SpuriousRx { [INFO] [stdout] | ^^^^^^^^^^ [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 13s [INFO] running `Command { std: "docker" "inspect" "06adcb9be2d82ab99b8d4040425ae1af411a2a49b0ea2e90dd7985c5c8ae088f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "06adcb9be2d82ab99b8d4040425ae1af411a2a49b0ea2e90dd7985c5c8ae088f", kill_on_drop: false }` [INFO] [stdout] 06adcb9be2d82ab99b8d4040425ae1af411a2a49b0ea2e90dd7985c5c8ae088f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 63beda500f31bb6e6b41337e3a210a44232d9dd071b79cee213fd7b5de8a4bc0 [INFO] running `Command { std: "docker" "start" "-a" "63beda500f31bb6e6b41337e3a210a44232d9dd071b79cee213fd7b5de8a4bc0", kill_on_drop: false }` [INFO] [stderr] warning: struct `SpuriousTx` is never constructed [INFO] [stderr] --> src/tests/test_async.rs:945:8 [INFO] [stderr] | [INFO] [stderr] 945 | struct SpuriousTx { [INFO] [stderr] | ^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: struct `SpuriousRx` is never constructed [INFO] [stderr] --> src/tests/test_async.rs:976:8 [INFO] [stderr] | [INFO] [stderr] 976 | struct SpuriousRx { [INFO] [stderr] | ^^^^^^^^^^ [INFO] [stderr] [INFO] [stderr] warning: `crossfire` (lib test) generated 2 warnings [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.25s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/crossfire-57457c4b267ea3c2) [INFO] [stdout] [INFO] [stdout] running 280 tests [INFO] [stdout] test locked_waker::tests::test_waker ... ok [INFO] [stderr] [2025-09-03 12:54:05.601583][INFO][test_async.rs:221] <<< test_basic_bounded_1_thread (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.602455][INFO][test_async.rs:19] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.602918][INFO][test_async.rs:19] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.604603][INFO][test_async.rs:230] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.604607][INFO][test_async.rs:19] >>> test_basic_bounded_empty_full_drop_rx return () in 21.7µs >>> [INFO] [stderr] [2025-09-03 12:54:05.604607][INFO][test_async.rs:19] >>> test_basic_bounded_empty_full_drop_rx return () in 20.99µs >>> [INFO] [stderr] [2025-09-03 12:54:05.602266][INFO][test_async.rs:19] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.604671][INFO][test_async.rs:19] >>> test_basic_bounded_empty_full_drop_rx return () in 25.07µs >>> [INFO] [stderr] [2025-09-03 12:54:05.602815][INFO][test_async.rs:44] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.604712][INFO][test_async.rs:44] >>> test_basic_bounded_empty_full_drop_tx return () in 9.22µs >>> [INFO] [stderr] [2025-09-03 12:54:05.601712][INFO][test_async.rs:221] <<< test_basic_bounded_1_thread (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.602776][INFO][test_async.rs:44] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.604747][INFO][test_async.rs:230] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.601880][INFO][test_async.rs:221] <<< test_basic_bounded_1_thread (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.604754][INFO][test_async.rs:44] >>> test_basic_bounded_empty_full_drop_tx return () in 6.82µs >>> [INFO] [stderr] [2025-09-03 12:54:05.604770][INFO][test_async.rs:230] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.604667][INFO][test_async.rs:357] <<< test_basic_bounded_recv_after_sender_close (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.604837][INFO][test_async.rs:372] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.603255][INFO][test_async.rs:44] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.603289][INFO][test_async.rs:357] <<< test_basic_bounded_recv_after_sender_close (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.605219][INFO][test_async.rs:44] >>> test_basic_bounded_empty_full_drop_tx return () in 11.42µs >>> [INFO] [stderr] [2025-09-03 12:54:05.605264][INFO][test_async.rs:372] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.603662][INFO][test_async.rs:357] <<< test_basic_bounded_recv_after_sender_close (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.605498][INFO][test_async.rs:372] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.604036][INFO][test_async.rs:171] <<< test_basic_bounded_rx_drop (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.605779][INFO][test_async.rs:179] run with tokio multi thread [INFO] [stdout] test collections::tests::test_weak_cell ... ok [INFO] [stdout] test collections::tests::test_locked_queue ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_empty_full_drop_rx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:05.606487][INFO][test_async.rs:171] <<< test_basic_bounded_rx_drop (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.606603][INFO][test_async.rs:179] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_bounded_empty_full_drop_rx::case_1 ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_empty_full_drop_rx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:05.606790][INFO][test_async.rs:1088] <<< test_basic_into_stream_1_1 (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.606896][INFO][test_async.rs:1099] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.606252][INFO][test_async.rs:171] <<< test_basic_bounded_rx_drop (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.607221][INFO][test_async.rs:69] <<< test_basic_compile_bounded_empty_full () enter <<< [INFO] [stderr] [2025-09-03 12:54:05.607522][INFO][test_async.rs:179] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.607682][INFO][test_async.rs:69] >>> test_basic_compile_bounded_empty_full return () in 64.55µs >>> [INFO] [stdout] test tests::test_async::test_basic_bounded_empty_full_drop_tx::case_2 ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_empty_full_drop_tx::case_1 ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_empty_full_drop_tx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:05.609764][INFO][test_async.rs:1088] <<< test_basic_into_stream_1_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.609877][INFO][test_async.rs:1099] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.613170][INFO][test_async.rs:1088] <<< test_basic_into_stream_1_1 (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.613338][INFO][test_async.rs:1099] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.613979][INFO][test_async.rs:1088] <<< test_basic_into_stream_1_1 (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.614191][INFO][test_async.rs:1099] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.615246][INFO][test_async.rs:1088] <<< test_basic_into_stream_1_1 (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.615427][INFO][test_async.rs:1099] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_compile_bounded_empty_full ... ok [INFO] [stderr] [2025-09-03 12:54:05.619578][INFO][test_async.rs:1088] <<< test_basic_into_stream_1_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.620149][INFO][test_async.rs:1099] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.620430][INFO][test_async.rs:490] <<< test_basic_send_timeout_async (setup_log = (), _channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.620597][INFO][test_async.rs:490] >>> test_basic_send_timeout_async return () in 1.52µs >>> [INFO] [stdout] test tests::test_async::test_basic_send_timeout_async::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:05.655212][INFO][test_async.rs:490] <<< test_basic_send_timeout_async (setup_log = (), _channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.655405][INFO][test_async.rs:490] >>> test_basic_send_timeout_async return () in 1.31µs >>> [INFO] [stderr] [2025-09-03 12:54:05.655644][INFO][test_async.rs:490] <<< test_basic_send_timeout_async (setup_log = (), _channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.655748][INFO][test_async.rs:490] >>> test_basic_send_timeout_async return () in 891ns >>> [INFO] [stderr] [2025-09-03 12:54:05.656049][INFO][test_async.rs:422] <<< test_basic_timeout_recv_async_waker (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.656140][INFO][test_async.rs:422] >>> test_basic_timeout_recv_async_waker return () in 1.229µs >>> [INFO] [stderr] [2025-09-03 12:54:05.656581][INFO][test_async.rs:188] try to send after rx dropped [INFO] [stdout] test tests::test_async::test_basic_send_timeout_async::case_2 ... ok [INFO] [stdout] test tests::test_async::test_basic_send_timeout_async::case_3 ... ok [INFO] [stdout] test tests::test_async::test_basic_timeout_recv_async_waker::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:05.656821][INFO][test_async.rs:191] dropped tx [INFO] [stderr] [2025-09-03 12:54:05.689781][INFO][test_async.rs:357] >>> test_basic_bounded_recv_after_sender_close return () in 84.284843ms >>> [INFO] [stderr] [2025-09-03 12:54:05.692854][INFO][test_async.rs:171] >>> test_basic_bounded_rx_drop return () in 86.249783ms >>> [INFO] [stderr] [2025-09-03 12:54:05.691494][INFO][test_async.rs:188] try to send after rx dropped [INFO] [stderr] [2025-09-03 12:54:05.692934][INFO][test_async.rs:191] dropped tx [INFO] [stderr] [2025-09-03 12:54:05.693077][INFO][test_async.rs:422] <<< test_basic_timeout_recv_async_waker (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.693235][INFO][test_async.rs:422] >>> test_basic_timeout_recv_async_waker return () in 1.59µs >>> [INFO] [stdout] test tests::test_async::test_basic_bounded_recv_after_sender_close::case_2 ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_rx_drop::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:05.746475][INFO][test_async.rs:188] try to send after rx dropped [INFO] [stdout] test tests::test_async::test_basic_timeout_recv_async_waker::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:05.746566][INFO][test_async.rs:191] dropped tx [INFO] [stderr] [2025-09-03 12:54:05.747669][INFO][test_async.rs:1088] >>> test_basic_into_stream_1_1 return () in 134.326453ms >>> [INFO] [stderr] [2025-09-03 12:54:05.748218][INFO][test_async.rs:422] <<< test_basic_timeout_recv_async_waker (setup_log = (), channel = (MAsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.748964][INFO][test_async.rs:422] >>> test_basic_timeout_recv_async_waker return () in 1.88µs >>> [INFO] [stderr] [2025-09-03 12:54:05.750386][INFO][test_async.rs:171] >>> test_basic_bounded_rx_drop return () in 142.862592ms >>> [INFO] [stderr] [2025-09-03 12:54:05.751968][INFO][test_async.rs:1088] >>> test_basic_into_stream_1_1 return () in 145.070602ms >>> [INFO] [stdout] test tests::test_async::test_basic_into_stream_1_1::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:05.756804][INFO][test_async.rs:266] <<< test_basic_unbounded_1_thread (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stdout] test tests::test_async::test_basic_timeout_recv_async_waker::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:05.756973][INFO][test_async.rs:277] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_bounded_rx_drop::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:05.757266][INFO][test_async.rs:266] <<< test_basic_unbounded_1_thread (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stdout] test tests::test_async::test_basic_into_stream_1_1::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:05.757353][INFO][test_async.rs:277] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_bounded_rx_drop::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:05.758021][INFO][test_async.rs:266] <<< test_basic_unbounded_1_thread (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stdout] test tests::test_async::test_basic_into_stream_1_1::case_5 ... ok [INFO] [stderr] [2025-09-03 12:54:05.758114][INFO][test_async.rs:277] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.758086][INFO][test_async.rs:310] <<< test_basic_unbounded_idle_select (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.758213][INFO][test_async.rs:332] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.758191][INFO][test_async.rs:310] <<< test_basic_unbounded_idle_select (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.758386][INFO][test_async.rs:332] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.761214][INFO][test_async.rs:171] >>> test_basic_bounded_rx_drop return () in 155.431589ms >>> [INFO] [stderr] [2025-09-03 12:54:05.761496][INFO][test_async.rs:310] <<< test_basic_unbounded_idle_select (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.761627][INFO][test_async.rs:332] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.762135][INFO][test_async.rs:1088] >>> test_basic_into_stream_1_1 return () in 152.2585ms >>> [INFO] [stderr] [2025-09-03 12:54:05.763108][INFO][test_async.rs:357] >>> test_basic_bounded_recv_after_sender_close return () in 157.853288ms >>> [INFO] [stderr] [2025-09-03 12:54:05.763134][INFO][test_async.rs:389] <<< test_basic_unbounded_recv_after_sender_close (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.763440][INFO][test_async.rs:406] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.764741][INFO][test_async.rs:389] <<< test_basic_unbounded_recv_after_sender_close (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.765209][INFO][test_async.rs:1088] >>> test_basic_into_stream_1_1 return () in 151.01483ms >>> [INFO] [stderr] [2025-09-03 12:54:05.765290][INFO][test_async.rs:406] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.765964][INFO][test_async.rs:1088] >>> test_basic_into_stream_1_1 return () in 150.538291ms >>> [INFO] [stderr] [2025-09-03 12:54:05.766169][INFO][test_async.rs:1088] >>> test_basic_into_stream_1_1 return () in 146.024951ms >>> [INFO] [stderr] [2025-09-03 12:54:05.766411][INFO][test_async.rs:357] >>> test_basic_bounded_recv_after_sender_close return () in 161.590097ms >>> [INFO] [stderr] [2025-09-03 12:54:05.767295][INFO][test_async.rs:389] <<< test_basic_unbounded_recv_after_sender_close (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.767400][INFO][test_async.rs:456] <<< test_basic_unbounded_recv_timeout_async (setup_log = (), _channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.767532][INFO][test_async.rs:456] >>> test_basic_unbounded_recv_timeout_async return () in 1.48µs >>> [INFO] [stderr] [2025-09-03 12:54:05.767573][INFO][test_async.rs:406] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.768380][INFO][test_async.rs:456] <<< test_basic_unbounded_recv_timeout_async (setup_log = (), _channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.768470][INFO][test_async.rs:456] >>> test_basic_unbounded_recv_timeout_async return () in 1.15µs >>> [INFO] [stderr] [2025-09-03 12:54:05.768723][INFO][test_async.rs:456] <<< test_basic_unbounded_recv_timeout_async (setup_log = (), _channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.768829][INFO][test_async.rs:456] >>> test_basic_unbounded_recv_timeout_async return () in 1.08µs >>> [INFO] [stderr] [2025-09-03 12:54:05.768993][INFO][test_async.rs:196] <<< test_basic_unbounded_rx_drop (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.769097][INFO][test_async.rs:204] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.769553][INFO][test_async.rs:196] <<< test_basic_unbounded_rx_drop (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.769657][INFO][test_async.rs:204] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_bounded_recv_after_sender_close::case_1 ... ok [INFO] [stdout] test tests::test_async::test_basic_into_stream_1_1::case_4 ... ok [INFO] [stdout] test tests::test_async::test_basic_into_stream_1_1::case_2 ... ok [INFO] [stdout] test tests::test_async::test_basic_into_stream_1_1::case_6 ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_recv_after_sender_close::case_3 ... ok [INFO] [stdout] test tests::test_async::test_basic_unbounded_recv_timeout_async::case_2 ... ok [INFO] [stdout] test tests::test_async::test_basic_unbounded_recv_timeout_async::case_3 ... ok [INFO] [stdout] test tests::test_async::test_basic_unbounded_recv_timeout_async::case_1 ... ok [INFO] [stdout] test tests::test_async::test_conversion ... ok [INFO] [stderr] [2025-09-03 12:54:05.772547][INFO][test_async.rs:679] <<< test_pressure_bounded_async_1_1 (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.772715][INFO][test_async.rs:693] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.776107][INFO][test_async.rs:196] <<< test_basic_unbounded_rx_drop (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.776297][INFO][test_async.rs:204] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.785180][INFO][test_async.rs:213] try to send after rx dropped [INFO] [stderr] [2025-09-03 12:54:05.785282][INFO][test_async.rs:216] dropped tx [INFO] [stderr] [2025-09-03 12:54:05.788881][INFO][test_async.rs:196] >>> test_basic_unbounded_rx_drop return () in 19.784646ms >>> [INFO] [stderr] [2025-09-03 12:54:05.789891][INFO][test_async.rs:213] try to send after rx dropped [INFO] [stderr] [2025-09-03 12:54:05.789950][INFO][test_async.rs:216] dropped tx [INFO] [stderr] [2025-09-03 12:54:05.792173][INFO][test_async.rs:213] try to send after rx dropped [INFO] [stderr] [2025-09-03 12:54:05.792261][INFO][test_async.rs:216] dropped tx [INFO] [stderr] [2025-09-03 12:54:05.793568][INFO][test_async.rs:196] >>> test_basic_unbounded_rx_drop return () in 17.272137ms >>> [INFO] [stderr] [2025-09-03 12:54:05.793982][INFO][test_async.rs:679] <<< test_pressure_bounded_async_1_1 (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.794142][INFO][test_async.rs:693] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.815835][INFO][test_async.rs:679] >>> test_pressure_bounded_async_1_1 return () in 21.689196ms >>> [INFO] [stderr] [2025-09-03 12:54:05.816379][INFO][test_async.rs:679] <<< test_pressure_bounded_async_1_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.816614][INFO][test_async.rs:693] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_unbounded_rx_drop::case_1 ... ok [INFO] [stdout] test tests::test_async::test_basic_unbounded_rx_drop::case_3 ... ok [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_1_1::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:05.824048][INFO][test_async.rs:389] >>> test_basic_unbounded_recv_after_sender_close return () in 56.601139ms >>> [INFO] [stderr] [2025-09-03 12:54:05.824761][INFO][test_async.rs:679] <<< test_pressure_bounded_async_1_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.825095][INFO][test_async.rs:693] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_unbounded_recv_after_sender_close::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:05.826037][INFO][test_async.rs:389] >>> test_basic_unbounded_recv_after_sender_close return () in 62.738908ms >>> [INFO] [stderr] [2025-09-03 12:54:05.826810][INFO][test_async.rs:196] >>> test_basic_unbounded_rx_drop return () in 57.150959ms >>> [INFO] [stdout] test tests::test_async::test_basic_unbounded_recv_after_sender_close::case_1 ... ok [INFO] [stdout] test tests::test_async::test_basic_unbounded_rx_drop::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:05.828251][INFO][test_async.rs:679] <<< test_pressure_bounded_async_1_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.828458][INFO][test_async.rs:693] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.828583][INFO][test_async.rs:679] <<< test_pressure_bounded_async_1_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.828996][INFO][test_async.rs:693] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.853135][INFO][test_async.rs:679] >>> test_pressure_bounded_async_1_1 return () in 24.143895ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_1_1::case_6 ... ok [INFO] [stderr] [2025-09-03 12:54:05.854009][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 5, rx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.854182][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.859692][INFO][test_async.rs:679] <<< test_pressure_bounded_async_1_1 (setup_log = (), channel = (AsyncTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.859860][INFO][test_async.rs:693] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:05.860391][INFO][test_async.rs:389] >>> test_basic_unbounded_recv_after_sender_close return () in 95.306931ms >>> [INFO] [stdout] test tests::test_async::test_basic_unbounded_recv_after_sender_close::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:05.860814][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 100, rx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.860948][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_1_1::case_7 ... ok [INFO] [stderr] [2025-09-03 12:54:05.875328][INFO][test_async.rs:679] >>> test_pressure_bounded_async_1_1 return () in 46.871431ms >>> [INFO] [stderr] [2025-09-03 12:54:05.876128][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 10, rx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.876839][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_1_1::case_5 ... ok [INFO] [stderr] [2025-09-03 12:54:05.956621][INFO][test_async.rs:679] >>> test_pressure_bounded_async_1_1 return () in 131.525024ms >>> [INFO] [stderr] [2025-09-03 12:54:05.957245][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 300, rx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:05.957432][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_unbounded_idle_select::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:06.208249][INFO][test_async.rs:353] waker rx 0 [INFO] [stdout] test tests::test_async::test_basic_unbounded_idle_select::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:06.209864][INFO][test_async.rs:310] >>> test_basic_unbounded_idle_select return () in 451.47953ms >>> [INFO] [stderr] [2025-09-03 12:54:06.212700][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 5, rx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.212855][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.215445][INFO][test_async.rs:353] waker rx 0 [INFO] [stderr] [2025-09-03 12:54:06.243550][INFO][test_async.rs:310] >>> test_basic_unbounded_idle_select return () in 485.334664ms >>> [INFO] [stderr] [2025-09-03 12:54:06.290332][INFO][test_async.rs:353] waker rx 1 [INFO] [stderr] [2025-09-03 12:54:06.302064][INFO][test_async.rs:310] >>> test_basic_unbounded_idle_select return () in 540.433633ms >>> [INFO] [stdout] test tests::test_async::test_basic_unbounded_idle_select::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:06.308555][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 100, rx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.308879][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 10, rx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.309062][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.309277][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_05 ... ok [INFO] [stderr] [2025-09-03 12:54:06.319554][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 106.697399ms >>> [INFO] [stderr] [2025-09-03 12:54:06.353498][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 300, rx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.353706][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.533707][INFO][test_async.rs:679] >>> test_pressure_bounded_async_1_1 return () in 673.842636ms >>> [INFO] [stderr] [2025-09-03 12:54:06.536001][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 681.816784ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_01 ... ok [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_1_1::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:06.547528][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 5, rx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.547678][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.551435][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 100, rx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.551584][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.719424][INFO][test_async.rs:221] >>> test_basic_bounded_1_thread return () in 1.114649678s >>> [INFO] [stderr] [2025-09-03 12:54:06.720085][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 10, rx_count = 100) enter <<< [INFO] [stdout] test tests::test_async::test_basic_bounded_1_thread::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:06.720216][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_09 ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_1_thread::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:06.746504][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 198.82212ms >>> [INFO] [stderr] [2025-09-03 12:54:06.752449][INFO][test_async.rs:221] >>> test_basic_bounded_1_thread return () in 1.147701321s >>> [INFO] [stderr] [2025-09-03 12:54:06.752833][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.752944][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.766626][INFO][test_async.rs:782] <<< test_pressure_bounded_async_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 300, rx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.766776][INFO][test_async.rs:808] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.766911][INFO][test_async.rs:266] >>> test_basic_unbounded_1_thread return () in 1.009940779s >>> [INFO] [stdout] test tests::test_async::test_basic_unbounded_1_thread::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:06.790119][INFO][test_async.rs:266] >>> test_basic_unbounded_1_thread return () in 1.032001855s >>> [INFO] [stderr] [2025-09-03 12:54:06.790513][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 481.236253ms >>> [INFO] [stderr] [2025-09-03 12:54:06.796872][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.797029][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.801878][INFO][test_async.rs:221] >>> test_basic_bounded_1_thread return () in 1.197288671s >>> [INFO] [stderr] [2025-09-03 12:54:06.802230][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.802324][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.814789][INFO][test_async.rs:266] >>> test_basic_unbounded_1_thread return () in 1.057433329s >>> [INFO] [stderr] [2025-09-03 12:54:06.822347][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.822502][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.827555][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.827679][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:06.829228][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:06.829321][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_basic_unbounded_1_thread::case_3 ... ok [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_07 ... ok [INFO] [stdout] test tests::test_async::test_basic_bounded_1_thread::case_1 ... ok [INFO] [stdout] test tests::test_async::test_basic_unbounded_1_thread::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:07.270538][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 550.31839ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_11 ... ok [INFO] [stderr] [2025-09-03 12:54:07.272569][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:07.294634][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:07.327845][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 530.813784ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_04 ... ok [INFO] [stderr] [2025-09-03 12:54:07.328552][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 100) enter <<< [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_1_1::case_4 ... ok [INFO] [stderr] [2025-09-03 12:54:07.328726][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:07.361445][INFO][test_async.rs:679] >>> test_pressure_bounded_async_1_1 return () in 1.544829692s >>> [INFO] [stderr] [2025-09-03 12:54:07.369292][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, AsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:07.369458][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:07.483423][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 1.606580551s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_03 ... ok [INFO] [stderr] [2025-09-03 12:54:07.491049][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:07.573414][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:08.406267][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 2.545314662s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_02 ... ok [INFO] [stderr] [2025-09-03 12:54:08.407379][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:08.407688][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:08.619558][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 2.310493899s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_06 ... ok [INFO] [stderr] [2025-09-03 12:54:08.659141][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 1.364511778s >>> [INFO] [stderr] [2025-09-03 12:54:08.680502][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:08.683841][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:08.703121][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 5) enter <<< [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_07 ... ok [INFO] [stderr] [2025-09-03 12:54:08.703278][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:08.827483][INFO][test_async.rs:679] >>> test_pressure_bounded_async_1_1 return () in 3.054765741s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_1_1::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:08.859510][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:08.862403][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_10 ... ok [INFO] [stderr] [2025-09-03 12:54:09.000526][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 2.448938742s >>> [INFO] [stderr] [2025-09-03 12:54:09.003552][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:09.011052][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:09.584150][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 880.869595ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_13 ... ok [INFO] [stderr] [2025-09-03 12:54:09.584543][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:09.584664][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:09.777411][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 192.744261ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_16 ... ok [INFO] [stderr] [2025-09-03 12:54:09.823427][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:09.825470][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:10.016034][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 3.249254353s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_12 ... ok [INFO] [stderr] [2025-09-03 12:54:10.032802][INFO][test_async.rs:718] <<< test_pressure_bounded_async_multi_1 (setup_log = (), channel = (MAsyncTx, MAsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:10.032997][INFO][test_async.rs:749] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_08 ... ok [INFO] [stderr] [2025-09-03 12:54:10.593577][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 4.239869475s >>> [INFO] [stderr] [2025-09-03 12:54:10.605541][INFO][test_async.rs:853] <<< test_pressure_bounded_mixed_async_blocking_conversion (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:10.619214][INFO][test_async.rs:862] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:10.702426][INFO][test_async.rs:853] >>> test_pressure_bounded_mixed_async_blocking_conversion return () in 83.219144ms >>> [INFO] [stderr] [2025-09-03 12:54:10.707831][INFO][test_async.rs:853] <<< test_pressure_bounded_mixed_async_blocking_conversion (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stdout] test tests::test_async::test_pressure_bounded_mixed_async_blocking_conversion::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:10.707996][INFO][test_async.rs:862] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_10 ... ok [INFO] [stderr] [2025-09-03 12:54:10.760855][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 3.187446824s >>> [INFO] [stderr] [2025-09-03 12:54:10.761339][INFO][test_async.rs:853] <<< test_pressure_bounded_mixed_async_blocking_conversion (setup_log = (), channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:10.761533][INFO][test_async.rs:862] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:10.787586][INFO][test_async.rs:853] >>> test_pressure_bounded_mixed_async_blocking_conversion return () in 79.588154ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_mixed_async_blocking_conversion::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:10.787957][INFO][test_async.rs:550] <<< test_pressure_bounded_timeout_async (setup_log = (), _channel = (MAsyncTx, MAsyncRx)) enter <<< [INFO] [stdout] test tests::test_async::test_pressure_bounded_timeout_async::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:10.788073][INFO][test_async.rs:550] >>> test_pressure_bounded_timeout_async return () in 800ns >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi::case_04 ... ok [INFO] [stderr] [2025-09-03 12:54:10.788891][INFO][test_async.rs:782] >>> test_pressure_bounded_async_multi return () in 4.831460327s >>> [INFO] [stderr] [2025-09-03 12:54:10.789178][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 2) enter <<< [INFO] [stderr] [2025-09-03 12:54:10.789269][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:10.789909][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 4) enter <<< [INFO] [stderr] [2025-09-03 12:54:10.790012][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:10.867566][INFO][test_async.rs:853] >>> test_pressure_bounded_mixed_async_blocking_conversion return () in 106.031329ms >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_mixed_async_blocking_conversion::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:10.867910][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:10.868027][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:11.101456][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 4.348509803s >>> [INFO] [stderr] [2025-09-03 12:54:11.101824][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 3) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.101933][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:11.104211][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 314.198817ms >>> [INFO] [stderr] [2025-09-03 12:54:11.104478][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 30) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.104579][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_01 ... ok [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_2 ... ok [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_4 ... ok [INFO] [stderr] [2025-09-03 12:54:11.166562][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 64.623917ms >>> [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_6 ... ok [INFO] [stderr] [2025-09-03 12:54:11.166989][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 2) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.167118][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:11.189932][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 22.810476ms >>> [INFO] [stderr] [2025-09-03 12:54:11.190851][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 4) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.190972][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:11.219572][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 28.595535ms >>> [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_7 ... ok [INFO] [stderr] [2025-09-03 12:54:11.220583][INFO][test_async.rs:1120] <<< test_pressure_stream_multi (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 50) enter <<< [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_8 ... ok [INFO] [stderr] [2025-09-03 12:54:11.220694][INFO][test_async.rs:1140] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:11.281770][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 61.072437ms >>> [INFO] [stderr] [2025-09-03 12:54:11.282152][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 2) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.282264][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_5 ... ok [INFO] [stderr] [2025-09-03 12:54:11.363084][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 258.501848ms >>> [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:11.363455][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 4) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.363581][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:11.393693][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 525.662285ms >>> [INFO] [stderr] [2025-09-03 12:54:11.394076][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.394194][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:11.727620][INFO][test_async.rs:1120] >>> test_pressure_stream_multi return () in 938.348123ms >>> [INFO] [stdout] test tests::test_async::test_pressure_stream_multi::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:11.729778][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 3) enter <<< [INFO] [stderr] [2025-09-03 12:54:11.729922][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:13.145395][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 5.816665121s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_08 ... ok [INFO] [stderr] [2025-09-03 12:54:13.189733][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 30) enter <<< [INFO] [stderr] [2025-09-03 12:54:13.189913][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_5 ... ok [INFO] [stderr] [2025-09-03 12:54:14.707987][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 1.518071188s >>> [INFO] [stderr] [2025-09-03 12:54:14.708403][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 2) enter <<< [INFO] [stderr] [2025-09-03 12:54:14.709551][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:15.713957][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 4.319760209s >>> [INFO] [stderr] [2025-09-03 12:54:15.775551][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 4) enter <<< [INFO] [stderr] [2025-09-03 12:54:15.775750][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_17 ... ok [INFO] [stderr] [2025-09-03 12:54:17.322551][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 7.497079206s >>> [INFO] [stderr] [2025-09-03 12:54:17.330529][INFO][test_async.rs:1168] <<< test_pressure_stream_multi_idle (setup_log = (), channel = (MAsyncTx, MAsyncRx), rx_count = 50) enter <<< [INFO] [stderr] [2025-09-03 12:54:17.331427][INFO][test_async.rs:1188] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:17.670597][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 8.808195265s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_14 ... ok [INFO] [stdout] test tests::test_async::test_spurious_sink ... ok [INFO] [stderr] [2025-09-03 12:54:17.671992][INFO][test_async.rs:1006] <<< test_spurious_sink (setup_log = ()) enter <<< [INFO] [stdout] test tests::test_async::test_spurious_stream ... ok [INFO] [stderr] [2025-09-03 12:54:17.672115][INFO][test_async.rs:1006] >>> test_spurious_sink return () in 50ns >>> [INFO] [stderr] [2025-09-03 12:54:17.672310][INFO][test_async.rs:1047] <<< test_spurious_stream (setup_log = ()) enter <<< [INFO] [stderr] [2025-09-03 12:54:17.672418][INFO][test_async.rs:1047] >>> test_spurious_stream return () in 70ns >>> [INFO] [stderr] [2025-09-03 12:54:17.672604][INFO][test_async.rs:87] <<< test_sync () enter <<< [INFO] [stderr] [2025-09-03 12:54:17.672692][INFO][test_async.rs:91] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_8 ... ok [INFO] [stdout] test tests::test_async_blocking::test_basic_1_tx_async_1_rx_blocking::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:18.192380][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 860.931628ms >>> [INFO] [stderr] [2025-09-03 12:54:18.193685][INFO][test_async_blocking.rs:78] <<< test_basic_1_tx_async_1_rx_blocking (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:18.196071][INFO][test_async_blocking.rs:107] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:18.857725][INFO][test_async_blocking.rs:78] >>> test_basic_1_tx_async_1_rx_blocking return () in 663.837688ms >>> [INFO] [stderr] [2025-09-03 12:54:18.858049][INFO][test_async_blocking.rs:78] <<< test_basic_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:18.858218][INFO][test_async_blocking.rs:107] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:19.548801][INFO][test_async_blocking.rs:78] >>> test_basic_1_tx_async_1_rx_blocking return () in 690.623242ms >>> [INFO] [stdout] test tests::test_async_blocking::test_basic_1_tx_async_1_rx_blocking::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:19.549350][INFO][test_async_blocking.rs:78] <<< test_basic_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:19.549540][INFO][test_async_blocking.rs:107] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:20.359632][INFO][test_async_blocking.rs:78] >>> test_basic_1_tx_async_1_rx_blocking return () in 810.124228ms >>> [INFO] [stderr] [2025-09-03 12:54:20.362438][INFO][test_async_blocking.rs:14] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_basic_1_tx_async_1_rx_blocking::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:20.362567][INFO][test_async_blocking.rs:14] >>> test_basic_bounded_empty_full_drop_rx return () in 13.4µs >>> [INFO] [stdout] test tests::test_async_blocking::test_basic_bounded_empty_full_drop_rx::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:20.365555][INFO][test_async_blocking.rs:14] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_basic_bounded_empty_full_drop_rx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:20.365702][INFO][test_async_blocking.rs:14] >>> test_basic_bounded_empty_full_drop_rx return () in 14.12µs >>> [INFO] [stdout] test tests::test_async_blocking::test_basic_bounded_empty_full_drop_rx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:20.365854][INFO][test_async_blocking.rs:14] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_basic_bounded_empty_full_drop_tx::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:20.365951][INFO][test_async_blocking.rs:14] >>> test_basic_bounded_empty_full_drop_rx return () in 8.289µs >>> [INFO] [stdout] test tests::test_async_blocking::test_basic_bounded_empty_full_drop_tx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:20.366109][INFO][test_async_blocking.rs:37] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_basic_bounded_empty_full_drop_tx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:20.366189][INFO][test_async_blocking.rs:37] >>> test_basic_bounded_empty_full_drop_tx return () in 7.09µs >>> [INFO] [stdout] test tests::test_async_blocking::test_basic_compile_bounded_empty_full ... ok [INFO] [stderr] [2025-09-03 12:54:20.366342][INFO][test_async_blocking.rs:37] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:20.366441][INFO][test_async_blocking.rs:37] >>> test_basic_bounded_empty_full_drop_tx return () in 7.45µs >>> [INFO] [stderr] [2025-09-03 12:54:20.366586][INFO][test_async_blocking.rs:37] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:20.366664][INFO][test_async_blocking.rs:37] >>> test_basic_bounded_empty_full_drop_tx return () in 7.16µs >>> [INFO] [stderr] [2025-09-03 12:54:20.366799][INFO][test_async_blocking.rs:60] <<< test_basic_compile_bounded_empty_full () enter <<< [INFO] [stderr] [2025-09-03 12:54:20.366883][INFO][test_async_blocking.rs:60] >>> test_basic_compile_bounded_empty_full return () in 10.88µs >>> [INFO] [stderr] [2025-09-03 12:54:20.367048][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:20.367158][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:21.179351][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 14.377023235s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_05 ... ok [INFO] [stderr] [2025-09-03 12:54:21.179785][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 8) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:21.181207][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:21.260850][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 893.724912ms >>> [INFO] [stderr] [2025-09-03 12:54:21.261246][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:21.261438][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_18 ... ok [INFO] [stderr] [2025-09-03 12:54:21.589568][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 11.556568648s >>> [INFO] [stderr] [2025-09-03 12:54:21.589968][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 1000) enter <<< [INFO] [stderr] [2025-09-03 12:54:21.590122][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:21.906405][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 726.455906ms >>> [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:21.906766][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:21.906937][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:22.122534][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 861.130448ms >>> [INFO] [stderr] [2025-09-03 12:54:22.136695][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 8) enter <<< [INFO] [stderr] [2025-09-03 12:54:22.136909][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:22.225864][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 10.862279466s >>> [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:22.226518][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:22.226702][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_5 ... ok [INFO] [stderr] [2025-09-03 12:54:22.573623][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 666.728108ms >>> [INFO] [stderr] [2025-09-03 12:54:22.574175][INFO][test_async_blocking.rs:169] <<< test_basic_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 1000) enter <<< [INFO] [stderr] [2025-09-03 12:54:22.574442][INFO][test_async_blocking.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:22.693311][INFO][test_async.rs:87] >>> test_sync return () in 5.02061581s >>> [INFO] [stdout] test tests::test_async::test_sync ... ok [INFO] [stderr] [2025-09-03 12:54:22.693772][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:22.693954][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:22.865146][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 15.495684822s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_09 ... ok [INFO] [stderr] [2025-09-03 12:54:22.865893][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:22.866103][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_6 ... ok [INFO] [stderr] [2025-09-03 12:54:22.879933][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 743.072601ms >>> [INFO] [stderr] [2025-09-03 12:54:22.880436][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:22.880640][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:23.236284][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 1.009622999s >>> [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_7 ... ok [INFO] [stderr] [2025-09-03 12:54:23.236835][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:23.237649][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_04 ... ok [INFO] [stderr] [2025-09-03 12:54:24.406822][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 1.169792397s >>> [INFO] [stderr] [2025-09-03 12:54:24.408616][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:24.408834][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:24.501053][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 1.620458437s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_03 ... ok [INFO] [stderr] [2025-09-03 12:54:24.515612][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:24.515977][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_7 ... ok [INFO] [stderr] [2025-09-03 12:54:26.578572][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 10.802820467s >>> [INFO] [stderr] [2025-09-03 12:54:26.579200][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:26.579381][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:26.814735][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 15.084804284s >>> [INFO] [stderr] [2025-09-03 12:54:26.816764][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:26.817396][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_4 ... ok [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_02 ... ok [INFO] [stderr] [2025-09-03 12:54:26.915320][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 4.049253663s >>> [INFO] [stderr] [2025-09-03 12:54:26.917535][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:26.917749][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_4 ... ok [INFO] [stderr] [2025-09-03 12:54:27.261544][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 5.67145725s >>> [INFO] [stderr] [2025-09-03 12:54:27.262091][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:27.262295][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:27.926722][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 1.109511529s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_08 ... ok [INFO] [stderr] [2025-09-03 12:54:27.942561][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:27.942820][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_basic_multi_tx_async_1_rx_blocking::case_8 ... ok [INFO] [stderr] [2025-09-03 12:54:28.836397][INFO][test_async_blocking.rs:169] >>> test_basic_multi_tx_async_1_rx_blocking return () in 6.262050452s >>> [INFO] [stderr] [2025-09-03 12:54:28.836943][INFO][test_async_blocking.rs:242] <<< test_pressure_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:28.837137][INFO][test_async_blocking.rs:285] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:29.302804][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 2.723481588s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_07 ... ok [INFO] [stderr] [2025-09-03 12:54:29.303298][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:29.303520][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:29.328598][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 4.812701071s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_06 ... ok [INFO] [stderr] [2025-09-03 12:54:29.330469][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:29.331200][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:29.343427][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 1.400669372s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_11 ... ok [INFO] [stderr] [2025-09-03 12:54:29.377511][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:29.377745][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:29.754477][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 450.99137ms >>> [INFO] [stderr] [2025-09-03 12:54:29.755030][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx), tx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:54:29.755845][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:29.869002][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 1.031921915s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_12 ... ok [INFO] [stderr] [2025-09-03 12:54:29.871039][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:29.873459][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:29.903708][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 572.633206ms >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:29.904614][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:29.904780][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:30.125663][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 252.25838ms >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_5 ... ok [INFO] [stderr] [2025-09-03 12:54:30.126472][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:30.126647][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_7 ... ok [INFO] [stderr] [2025-09-03 12:54:31.552478][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 1.425873886s >>> [INFO] [stderr] [2025-09-03 12:54:31.552867][INFO][test_async_blocking.rs:298] <<< test_pressure_multi_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:54:31.553017][INFO][test_async_blocking.rs:335] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:32.167299][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 4.905060303s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_10 ... ok [INFO] [stderr] [2025-09-03 12:54:32.167783][INFO][test_async_blocking.rs:358] <<< test_pressure_multi_tx_async_multi_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 5, rx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:32.168100][INFO][test_async_blocking.rs:397] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_multi_rx_blocking::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:32.245014][INFO][test_async_blocking.rs:358] >>> test_pressure_multi_tx_async_multi_rx_blocking return () in 77.087534ms >>> [INFO] [stderr] [2025-09-03 12:54:32.245469][INFO][test_async_blocking.rs:358] <<< test_pressure_multi_tx_async_multi_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 100, rx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:32.281312][INFO][test_async_blocking.rs:397] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:32.835320][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 21.553052286s >>> [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:32.835814][INFO][test_async_blocking.rs:358] <<< test_pressure_multi_tx_async_multi_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 10, rx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:32.937973][INFO][test_async_blocking.rs:397] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:34.438743][INFO][test_async_blocking.rs:358] >>> test_pressure_multi_tx_async_multi_rx_blocking return () in 1.60272626s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_multi_rx_blocking::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:34.439353][INFO][test_async_blocking.rs:358] <<< test_pressure_multi_tx_async_multi_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx), tx_count = 300, rx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:34.569779][INFO][test_async_blocking.rs:397] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:34.901981][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 4.997234314s >>> [INFO] [stderr] [2025-09-03 12:54:34.902619][INFO][test_async_blocking.rs:120] <<< test_timeout_1_tx_async_1_rx_blocking (setup_log = (), channel = (AsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:34.902763][INFO][test_async_blocking.rs:153] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:34.907424][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 25.899662589s >>> [INFO] [stderr] [2025-09-03 12:54:34.907989][INFO][test_async_blocking.rs:120] <<< test_timeout_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:34.909130][INFO][test_async_blocking.rs:153] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:35.120557][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 5.742862235s >>> [INFO] [stderr] [2025-09-03 12:54:35.120990][INFO][test_async_blocking.rs:120] <<< test_timeout_1_tx_async_1_rx_blocking (setup_log = (), channel = (MAsyncTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:35.121144][INFO][test_async_blocking.rs:153] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_6 ... ok [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_15 ... ok [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:35.752415][INFO][test_async_blocking.rs:120] >>> test_timeout_1_tx_async_1_rx_blocking return () in 844.277671ms >>> [INFO] [stdout] test tests::test_async_blocking::test_timeout_1_tx_async_1_rx_blocking::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:35.752887][INFO][test_blocking_async.rs:99] <<< test_basic_1_tx_blocking_1_rx_async (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_timeout_1_tx_async_1_rx_blocking::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:35.753104][INFO][test_blocking_async.rs:124] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:35.756863][INFO][test_async_blocking.rs:120] >>> test_timeout_1_tx_async_1_rx_blocking return () in 854.137049ms >>> [INFO] [stderr] [2025-09-03 12:54:35.758799][INFO][test_blocking_async.rs:99] <<< test_basic_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:35.759764][INFO][test_blocking_async.rs:124] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_multi_rx_blocking::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:35.948908][INFO][test_async_blocking.rs:358] >>> test_pressure_multi_tx_async_multi_rx_blocking return () in 3.703314052s >>> [INFO] [stderr] [2025-09-03 12:54:35.949477][INFO][test_blocking_async.rs:99] <<< test_basic_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:35.949684][INFO][test_blocking_async.rs:124] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:36.006425][INFO][test_async_blocking.rs:120] >>> test_timeout_1_tx_async_1_rx_blocking return () in 885.310854ms >>> [INFO] [stdout] test tests::test_async_blocking::test_timeout_1_tx_async_1_rx_blocking::case_3 ... ok [INFO] [stdout] test tests::test_blocking_async::test_basic_bounded_empty_full_drop_rx::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:36.031340][INFO][test_blocking_async.rs:14] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.031962][INFO][test_blocking_async.rs:14] >>> test_basic_bounded_empty_full_drop_rx return () in 10.49µs >>> [INFO] [stderr] [2025-09-03 12:54:36.032388][INFO][test_blocking_async.rs:14] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.032557][INFO][test_blocking_async.rs:14] >>> test_basic_bounded_empty_full_drop_rx return () in 14.291µs >>> [INFO] [stdout] test tests::test_blocking_async::test_basic_bounded_empty_full_drop_rx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:36.033231][INFO][test_blocking_async.rs:14] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_basic_bounded_empty_full_drop_rx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:36.033342][INFO][test_blocking_async.rs:14] >>> test_basic_bounded_empty_full_drop_rx return () in 10.16µs >>> [INFO] [stdout] test tests::test_blocking_async::test_basic_bounded_empty_full_drop_tx::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:36.033997][INFO][test_blocking_async.rs:37] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_basic_bounded_empty_full_drop_tx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:36.034101][INFO][test_blocking_async.rs:37] >>> test_basic_bounded_empty_full_drop_tx return () in 7.63µs >>> [INFO] [stdout] test tests::test_blocking_async::test_basic_bounded_empty_full_drop_tx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:36.034809][INFO][test_blocking_async.rs:37] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_basic_compile_bounded_empty_full ... ok [INFO] [stderr] [2025-09-03 12:54:36.034905][INFO][test_blocking_async.rs:37] >>> test_basic_bounded_empty_full_drop_tx return () in 7.85µs >>> [INFO] [stdout] test tests::test_blocking_async::test_basic_unbounded_empty_drop_tx::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:36.035760][INFO][test_blocking_async.rs:37] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_basic_unbounded_empty_drop_tx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:36.035889][INFO][test_blocking_async.rs:37] >>> test_basic_bounded_empty_full_drop_tx return () in 12.1µs >>> [INFO] [stdout] test tests::test_blocking_async::test_basic_unbounded_empty_drop_tx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:36.036432][INFO][test_blocking_async.rs:81] <<< test_basic_compile_bounded_empty_full () enter <<< [INFO] [stderr] [2025-09-03 12:54:36.036543][INFO][test_blocking_async.rs:81] >>> test_basic_compile_bounded_empty_full return () in 13.22µs >>> [INFO] [stderr] [2025-09-03 12:54:36.037230][INFO][test_blocking_async.rs:60] <<< test_basic_unbounded_empty_drop_tx (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.037330][INFO][test_blocking_async.rs:60] >>> test_basic_unbounded_empty_drop_tx return () in 11.8µs >>> [INFO] [stderr] [2025-09-03 12:54:36.037891][INFO][test_blocking_async.rs:60] <<< test_basic_unbounded_empty_drop_tx (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.037987][INFO][test_blocking_async.rs:60] >>> test_basic_unbounded_empty_drop_tx return () in 8.749µs >>> [INFO] [stderr] [2025-09-03 12:54:36.040209][INFO][test_blocking_async.rs:60] <<< test_basic_unbounded_empty_drop_tx (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.040349][INFO][test_blocking_async.rs:60] >>> test_basic_unbounded_empty_drop_tx return () in 14.12µs >>> [INFO] [stderr] [2025-09-03 12:54:36.041321][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.041477][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_stream_multi_idle::case_6 ... ok [INFO] [stderr] [2025-09-03 12:54:36.559865][INFO][test_async.rs:1168] >>> test_pressure_stream_multi_idle return () in 21.850313606s >>> [INFO] [stderr] [2025-09-03 12:54:36.560521][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.560668][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:36.758079][INFO][test_blocking_async.rs:99] >>> test_basic_1_tx_blocking_1_rx_async return () in 1.00502945s >>> [INFO] [stdout] test tests::test_blocking_async::test_basic_1_tx_blocking_1_rx_async::case_1 ... ok [INFO] [stderr] [2025-09-03 12:54:36.758497][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.758638][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_basic_1_tx_blocking_1_rx_async::case_2 ... ok [INFO] [stderr] [2025-09-03 12:54:36.821770][INFO][test_blocking_async.rs:99] >>> test_basic_1_tx_blocking_1_rx_async return () in 1.062867498s >>> [INFO] [stderr] [2025-09-03 12:54:36.822157][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.822317][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_basic_1_tx_blocking_1_rx_async::case_3 ... ok [INFO] [stderr] [2025-09-03 12:54:36.954590][INFO][test_blocking_async.rs:99] >>> test_basic_1_tx_blocking_1_rx_async return () in 1.00496383s >>> [INFO] [stderr] [2025-09-03 12:54:36.955086][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:36.955337][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:37.860693][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 31.038188155s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_06 ... ok [INFO] [stderr] [2025-09-03 12:54:37.902127][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:37.903416][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_4 ... ok [INFO] [stderr] [2025-09-03 12:54:39.874474][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 3.052186812s >>> [INFO] [stderr] [2025-09-03 12:54:39.879641][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:39.879890][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:39.933987][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 2.978713376s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_5 ... ok [INFO] [stderr] [2025-09-03 12:54:39.934820][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:39.935077][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_6 ... ok [INFO] [stderr] [2025-09-03 12:54:41.700928][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 3.798614833s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_7 ... ok [INFO] [stderr] [2025-09-03 12:54:41.763221][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 1.883394054s >>> [INFO] [stderr] [2025-09-03 12:54:41.772629][INFO][test_blocking_async.rs:189] <<< test_pressure_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:54:41.777404][INFO][test_blocking_async.rs:218] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:41.795749][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:41.796233][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:42.228794][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 12.473602475s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_4 ... ok [INFO] [stderr] [2025-09-03 12:54:42.229206][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 100) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_8 ... ok [INFO] [stderr] [2025-09-03 12:54:42.246667][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_01 ... ok [INFO] [stderr] [2025-09-03 12:54:42.298666][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 2.363650679s >>> [INFO] [stderr] [2025-09-03 12:54:42.301517][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:54:42.390843][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:42.449332][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 653.4193ms >>> [INFO] [stderr] [2025-09-03 12:54:42.449854][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:54:42.450568][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:42.912496][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 462.267868ms >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_04 ... ok [INFO] [stderr] [2025-09-03 12:54:42.915531][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:42.950967][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_1_rx_blocking::case_8 ... ok [INFO] [stderr] [2025-09-03 12:54:42.986390][INFO][test_async_blocking.rs:298] >>> test_pressure_multi_tx_async_1_rx_blocking return () in 11.433405402s >>> [INFO] [stderr] [2025-09-03 12:54:42.992507][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:54:43.074455][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:43.832978][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 2.060213739s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_9 ... ok [INFO] [stderr] [2025-09-03 12:54:43.923477][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:43.928844][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_07 ... ok [INFO] [stderr] [2025-09-03 12:54:45.440606][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 1.515447428s >>> [INFO] [stderr] [2025-09-03 12:54:45.444072][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:45.490816][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_11 ... ok [INFO] [stderr] [2025-09-03 12:54:52.073074][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 43.665382859s >>> [INFO] [stderr] [2025-09-03 12:54:52.097439][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:52.288644][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:52.858072][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 9.942394349s >>> [INFO] [stderr] [2025-09-03 12:54:52.859614][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:52.865523][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_05 ... ok [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_10 ... ok [INFO] [stderr] [2025-09-03 12:54:52.983924][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 124.207596ms >>> [INFO] [stderr] [2025-09-03 12:54:53.013541][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:53.037187][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:54.369345][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 12.13998341s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_02 ... ok [INFO] [stderr] [2025-09-03 12:54:54.371621][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:54:54.450388][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_multi_tx_async_multi_rx_blocking::case_4 ... ok [INFO] [stderr] [2025-09-03 12:54:57.854800][INFO][test_async_blocking.rs:358] >>> test_pressure_multi_tx_async_multi_rx_blocking return () in 23.414977154s >>> [INFO] [stderr] [2025-09-03 12:54:57.860485][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:54:57.860758][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:58.116240][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 255.626879ms >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_13 ... ok [INFO] [stderr] [2025-09-03 12:54:58.116742][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:58.315404][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 5.301649383s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_11 ... ok [INFO] [stderr] [2025-09-03 12:54:58.323305][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx), tx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:54:58.587302][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:54:58.591493][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 13.14728206s >>> [INFO] [stderr] [2025-09-03 12:54:58.594983][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 6) enter <<< [INFO] [stderr] [2025-09-03 12:54:58.595346][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_08 ... ok [INFO] [stderr] [2025-09-03 12:54:58.816140][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 221.015296ms >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_16 ... ok [INFO] [stderr] [2025-09-03 12:54:58.816544][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100) enter <<< [INFO] [stderr] [2025-09-03 12:54:59.344740][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:00.754058][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 17.761356881s >>> [INFO] [stderr] [2025-09-03 12:55:00.764807][INFO][test_blocking_async.rs:235] <<< test_pressure_tx_multi_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 300) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_06 ... ok [INFO] [stderr] [2025-09-03 12:55:01.535045][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 3.418203499s >>> [INFO] [stderr] [2025-09-03 12:55:01.543444][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_14 ... ok [INFO] [stderr] [2025-09-03 12:55:01.550487][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 5, rx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:55:01.925982][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:03.283296][INFO][test_blocking_async.rs:283] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:04.675594][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 3.121348238s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_01 ... ok [INFO] [stderr] [2025-09-03 12:55:04.676028][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100, rx_count = 20) enter <<< [INFO] [stderr] [2025-09-03 12:55:04.691499][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_17 ... ok [INFO] [stderr] [2025-09-03 12:55:04.911058][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 6.094369656s >>> [INFO] [stderr] [2025-09-03 12:55:04.977538][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 300, rx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:55:05.237909][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_02 has been running for over 60 seconds [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_03 has been running for over 60 seconds [INFO] [stderr] [2025-09-03 12:55:06.976001][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 60.148318955s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_02 ... ok [INFO] [stderr] [2025-09-03 12:55:06.976353][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 10, rx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:55:06.976776][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_04 ... ok [INFO] [stderr] [2025-09-03 12:55:07.324139][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 347.637121ms >>> [INFO] [stderr] [2025-09-03 12:55:07.324595][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100, rx_count = 20) enter <<< [INFO] [stderr] [2025-09-03 12:55:07.348165][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:07.550994][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 6.786040648s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_18 ... ok [INFO] [stderr] [2025-09-03 12:55:07.562518][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 300, rx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:55:07.820116][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_12 has been running for over 60 seconds [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_15 ... ok [INFO] [stderr] [2025-09-03 12:55:15.064903][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 16.721340623s >>> [INFO] [stderr] [2025-09-03 12:55:15.065956][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 10, rx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:55:15.067287][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:15.902041][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 835.901926ms >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_07 ... ok [INFO] [stderr] [2025-09-03 12:55:15.904518][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100, rx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:55:15.964812][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:19.721080][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 3.816402805s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_08 ... ok [INFO] [stderr] [2025-09-03 12:55:19.722691][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 300, rx_count = 300) enter <<< [INFO] [stderr] [2025-09-03 12:55:20.398581][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:20.439476][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 13.114762525s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_05 ... ok [INFO] [stderr] [2025-09-03 12:55:20.440026][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 30, rx_count = 500) enter <<< [INFO] [stderr] [2025-09-03 12:55:20.445202][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_10 ... ok [INFO] [stderr] [2025-09-03 12:55:22.235994][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 1.795802243s >>> [INFO] [stderr] [2025-09-03 12:55:22.236499][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 5, rx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:55:22.236785][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_11 ... ok [INFO] [stderr] [2025-09-03 12:55:22.426484][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 189.86011ms >>> [INFO] [stderr] [2025-09-03 12:55:22.433524][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100, rx_count = 20) enter <<< [INFO] [stderr] [2025-09-03 12:55:22.665209][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_01 has been running for over 60 seconds [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_12 ... ok [INFO] [stderr] [2025-09-03 12:55:23.173752][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 737.825977ms >>> [INFO] [stderr] [2025-09-03 12:55:23.174662][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 300, rx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:55:23.744233][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:24.159805][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 19.483655172s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_02 ... ok [INFO] [stderr] [2025-09-03 12:55:24.176748][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 10, rx_count = 200) enter <<< [INFO] [stderr] [2025-09-03 12:55:24.177808][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:24.292884][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 115.726273ms >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_14 ... ok [INFO] [stderr] [2025-09-03 12:55:24.311716][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 100, rx_count = 200) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_05 has been running for over 60 seconds [INFO] [stderr] [2025-09-03 12:55:24.799741][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_15 ... ok [INFO] [stderr] [2025-09-03 12:55:25.203942][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 892.036839ms >>> [INFO] [stderr] [2025-09-03 12:55:25.216511][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 300, rx_count = 300) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_03 ... ok [INFO] [stderr] [2025-09-03 12:55:26.781317][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 44.479656067s >>> [INFO] [stderr] [2025-09-03 12:55:26.782169][INFO][test_blocking_async.rs:302] <<< test_pressure_tx_multi_blocking_multi_rx_async (setup_log = (), channel = (MTx, MAsyncRx), tx_count = 30, rx_count = 500) enter <<< [INFO] [stderr] [2025-09-03 12:55:26.782715][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:26.800729][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 3.625757206s >>> [INFO] [stderr] [2025-09-03 12:55:26.832519][INFO][test_blocking_async.rs:143] <<< test_timeout_1_tx_blocking_1_rx_async (setup_log = (), channel = (Tx, AsyncRx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_13 ... ok [INFO] [stderr] [2025-09-03 12:55:26.964934][INFO][test_blocking_async.rs:350] run with tokio multi thread [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_09 has been running for over 60 seconds [INFO] [stderr] [2025-09-03 12:55:27.182148][INFO][test_blocking_async.rs:168] run with tokio multi thread [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_17 ... ok [INFO] [stderr] [2025-09-03 12:55:27.422994][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 640.692938ms >>> [INFO] [stdout] test tests::test_blocking_async::test_timeout_1_tx_blocking_1_rx_async::case_1 ... ok [INFO] [stderr] [2025-09-03 12:55:27.423411][INFO][test_blocking_async.rs:143] <<< test_timeout_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, AsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:27.425911][INFO][test_blocking_async.rs:143] >>> test_timeout_1_tx_blocking_1_rx_async return () in 593.230803ms >>> [INFO] [stderr] [2025-09-03 12:55:27.426247][INFO][test_blocking_async.rs:143] <<< test_timeout_1_tx_blocking_1_rx_async (setup_log = (), channel = (MTx, MAsyncRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:27.523760][INFO][test_blocking_async.rs:168] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:27.526460][INFO][test_blocking_async.rs:168] run with tokio multi thread [INFO] [stderr] [2025-09-03 12:55:27.731078][INFO][test_blocking_async.rs:143] >>> test_timeout_1_tx_blocking_1_rx_async return () in 304.722224ms >>> [INFO] [stdout] test tests::test_blocking_async::test_timeout_1_tx_blocking_1_rx_async::case_3 ... ok [INFO] [stderr] [2025-09-03 12:55:27.735976][INFO][test_blocking_async.rs:143] >>> test_timeout_1_tx_blocking_1_rx_async return () in 312.443581ms >>> [INFO] [stdout] test tests::test_blocking_async::test_timeout_1_tx_blocking_1_rx_async::case_2 ... ok [INFO] [stderr] [2025-09-03 12:55:27.736400][INFO][test_blocking_context.rs:157] <<< test_basic_bounded_1_thread (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:27.802185][INFO][test_blocking_context.rs:157] <<< test_basic_bounded_1_thread (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_1_thread::case_2 ... ok [INFO] [stderr] [2025-09-03 12:55:28.737024][INFO][test_blocking_context.rs:157] >>> test_basic_bounded_1_thread return () in 1.000492364s >>> [INFO] [stderr] [2025-09-03 12:55:28.737384][INFO][test_blocking_context.rs:157] <<< test_basic_bounded_1_thread (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:28.820401][INFO][test_blocking_context.rs:157] >>> test_basic_bounded_1_thread return () in 1.01344852s >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_1_thread::case_1 ... ok [INFO] [stderr] [2025-09-03 12:55:28.845510][INFO][test_blocking_context.rs:16] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:28.845669][INFO][test_blocking_context.rs:16] >>> test_basic_bounded_empty_full_drop_rx return () in 14.79µs >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_empty_full_drop_rx::case_1 ... ok [INFO] [stderr] [2025-09-03 12:55:28.912503][INFO][test_blocking_context.rs:16] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:28.912681][INFO][test_blocking_context.rs:16] >>> test_basic_bounded_empty_full_drop_rx return () in 16.451µs >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_empty_full_drop_rx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:55:28.957605][INFO][test_blocking_context.rs:16] <<< test_basic_bounded_empty_full_drop_rx (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_empty_full_drop_rx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:55:28.981496][INFO][test_blocking_context.rs:16] >>> test_basic_bounded_empty_full_drop_rx return () in 14.57µs >>> [INFO] [stderr] [2025-09-03 12:55:28.986025][INFO][test_blocking_context.rs:53] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_empty_full_drop_tx::case_1 ... ok [INFO] [stderr] [2025-09-03 12:55:28.986168][INFO][test_blocking_context.rs:53] >>> test_basic_bounded_empty_full_drop_tx return () in 12.18µs >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_empty_full_drop_tx::case_2 ... ok [INFO] [stderr] [2025-09-03 12:55:28.990580][INFO][test_blocking_context.rs:53] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_empty_full_drop_tx::case_3 ... ok [INFO] [stderr] [2025-09-03 12:55:28.990712][INFO][test_blocking_context.rs:53] >>> test_basic_bounded_empty_full_drop_tx return () in 14.45µs >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_recv_after_sender_close::case_1 ... ok [INFO] [stderr] [2025-09-03 12:55:28.991845][INFO][test_blocking_context.rs:53] <<< test_basic_bounded_empty_full_drop_tx (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_recv_after_sender_close::case_2 ... ok [INFO] [stderr] [2025-09-03 12:55:28.991945][INFO][test_blocking_context.rs:53] >>> test_basic_bounded_empty_full_drop_tx return () in 16.41µs >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_recv_after_sender_close::case_3 ... ok [INFO] [stderr] [2025-09-03 12:55:28.992436][INFO][test_blocking_context.rs:246] <<< test_basic_recv_after_sender_close (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_recv_after_sender_close::case_4 ... ok [INFO] [stderr] [2025-09-03 12:55:28.992531][INFO][test_blocking_context.rs:246] >>> test_basic_recv_after_sender_close return () in 12.64µs >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_recv_after_sender_close::case_5 ... ok [INFO] [stderr] [2025-09-03 12:55:28.993176][INFO][test_blocking_context.rs:246] <<< test_basic_recv_after_sender_close (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_recv_after_sender_close::case_6 ... ok [INFO] [stderr] [2025-09-03 12:55:28.993274][INFO][test_blocking_context.rs:246] >>> test_basic_recv_after_sender_close return () in 9.85µs >>> [INFO] [stderr] [2025-09-03 12:55:28.993447][INFO][test_blocking_context.rs:246] <<< test_basic_recv_after_sender_close (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:28.993535][INFO][test_blocking_context.rs:246] >>> test_basic_recv_after_sender_close return () in 10.27µs >>> [INFO] [stderr] [2025-09-03 12:55:28.993954][INFO][test_blocking_context.rs:246] <<< test_basic_recv_after_sender_close (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:28.994045][INFO][test_blocking_context.rs:246] >>> test_basic_recv_after_sender_close return () in 12.86µs >>> [INFO] [stderr] [2025-09-03 12:55:28.994253][INFO][test_blocking_context.rs:246] <<< test_basic_recv_after_sender_close (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:28.994339][INFO][test_blocking_context.rs:246] >>> test_basic_recv_after_sender_close return () in 10.71µs >>> [INFO] [stderr] [2025-09-03 12:55:28.994655][INFO][test_blocking_context.rs:246] <<< test_basic_recv_after_sender_close (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:28.994793][INFO][test_blocking_context.rs:246] >>> test_basic_recv_after_sender_close return () in 11.16µs >>> [INFO] [stderr] [2025-09-03 12:55:28.995066][INFO][test_blocking_context.rs:203] <<< test_basic_unbounded_1_thread (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_16 ... ok [INFO] [stderr] [2025-09-03 12:55:29.272276][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 4.055602029s >>> [INFO] [stderr] [2025-09-03 12:55:29.274778][INFO][test_blocking_context.rs:203] <<< test_basic_unbounded_1_thread (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_03 ... ok [INFO] [stdout] test tests::test_blocking_context::test_basic_bounded_1_thread::case_3 ... ok [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_empty_drop_rx::case_1 ... ok [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_empty_drop_rx::case_2 ... ok [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_empty_drop_rx::case_3 ... ok [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_empty_drop_tx::case_1 ... ok [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_empty_drop_tx::case_2 ... ok [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_empty_drop_tx::case_3 ... ok [INFO] [stdout] test tests::test_blocking_context::test_conversion ... ok [INFO] [stderr] [2025-09-03 12:55:29.719960][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 24.738419678s >>> [INFO] [stderr] [2025-09-03 12:55:29.722020][INFO][test_blocking_context.rs:203] <<< test_basic_unbounded_1_thread (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.738287][INFO][test_blocking_context.rs:157] >>> test_basic_bounded_1_thread return () in 1.000780554s >>> [INFO] [stderr] [2025-09-03 12:55:29.759485][INFO][test_blocking_context.rs:90] <<< test_basic_unbounded_empty_drop_rx (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.759633][INFO][test_blocking_context.rs:90] >>> test_basic_unbounded_empty_drop_rx return () in 17.1µs >>> [INFO] [stderr] [2025-09-03 12:55:29.759806][INFO][test_blocking_context.rs:90] <<< test_basic_unbounded_empty_drop_rx (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.759890][INFO][test_blocking_context.rs:90] >>> test_basic_unbounded_empty_drop_rx return () in 9.63µs >>> [INFO] [stderr] [2025-09-03 12:55:29.760084][INFO][test_blocking_context.rs:90] <<< test_basic_unbounded_empty_drop_rx (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.760169][INFO][test_blocking_context.rs:90] >>> test_basic_unbounded_empty_drop_rx return () in 10.22µs >>> [INFO] [stderr] [2025-09-03 12:55:29.760322][INFO][test_blocking_context.rs:124] <<< test_basic_unbounded_empty_drop_tx (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.760433][INFO][test_blocking_context.rs:124] >>> test_basic_unbounded_empty_drop_tx return () in 12.12µs >>> [INFO] [stderr] [2025-09-03 12:55:29.760704][INFO][test_blocking_context.rs:124] <<< test_basic_unbounded_empty_drop_tx (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.760786][INFO][test_blocking_context.rs:124] >>> test_basic_unbounded_empty_drop_tx return () in 10.89µs >>> [INFO] [stderr] [2025-09-03 12:55:29.761052][INFO][test_blocking_context.rs:124] <<< test_basic_unbounded_empty_drop_tx (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.761133][INFO][test_blocking_context.rs:124] >>> test_basic_unbounded_empty_drop_tx return () in 10.03µs >>> [INFO] [stderr] [2025-09-03 12:55:29.761629][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:29.997529][INFO][test_blocking_context.rs:203] >>> test_basic_unbounded_1_thread return () in 1.002381064s >>> [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_1_thread::case_1 ... ok [INFO] [stderr] [2025-09-03 12:55:29.999554][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_01 ... ok [INFO] [stderr] [2025-09-03 12:55:30.049331][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 67.355428947s >>> [INFO] [stderr] [2025-09-03 12:55:30.053647][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_1_thread::case_2 ... ok [INFO] [stderr] [2025-09-03 12:55:30.357665][INFO][test_blocking_context.rs:203] >>> test_basic_unbounded_1_thread return () in 1.082756518s >>> [INFO] [stderr] [2025-09-03 12:55:30.358011][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (Tx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_basic_unbounded_1_thread::case_3 ... ok [INFO] [stderr] [2025-09-03 12:55:30.734808][INFO][test_blocking_context.rs:203] >>> test_basic_unbounded_1_thread return () in 1.01267182s >>> [INFO] [stderr] [2025-09-03 12:55:30.744742][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:35.903749][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 41.531991391s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_12 ... ok [INFO] [stderr] [2025-09-03 12:55:35.909189][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_1 has been running for over 60 seconds [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_2 has been running for over 60 seconds [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_3 has been running for over 60 seconds [INFO] [stderr] [2025-09-03 12:55:36.815516][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 6.457376961s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_04 ... ok [INFO] [stderr] [2025-09-03 12:55:36.815850][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_03 ... ok [INFO] [stderr] [2025-09-03 12:55:37.209984][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 7.156191481s >>> [INFO] [stderr] [2025-09-03 12:55:37.210623][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, Rx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:38.152138][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 30.58945584s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_06 ... ok [INFO] [stderr] [2025-09-03 12:55:38.183964][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_02 ... ok [INFO] [stderr] [2025-09-03 12:55:39.550074][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 9.550351844s >>> [INFO] [stderr] [2025-09-03 12:55:39.550964][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_multi_rx_async::case_09 ... ok [INFO] [stderr] [2025-09-03 12:55:39.783160][INFO][test_blocking_async.rs:302] >>> test_pressure_tx_multi_blocking_multi_rx_async return () in 20.060342156s >>> [INFO] [stderr] [2025-09-03 12:55:39.801515][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_08 ... ok [INFO] [stderr] [2025-09-03 12:55:40.115351][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 2.904607933s >>> [INFO] [stderr] [2025-09-03 12:55:40.118504][INFO][test_blocking_context.rs:282] <<< test_pressure_bounded_blocking_1_1 (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_07 ... ok [INFO] [stderr] [2025-09-03 12:55:40.251603][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 3.435638255s >>> [INFO] [stderr] [2025-09-03 12:55:40.256505][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 2, rx_count = 2) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_11 ... ok [INFO] [stderr] [2025-09-03 12:55:41.757951][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 1.956278422s >>> [INFO] [stderr] [2025-09-03 12:55:41.759606][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 16, rx_count = 2) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_12 ... ok [INFO] [stderr] [2025-09-03 12:55:42.071568][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 1.952932533s >>> [INFO] [stderr] [2025-09-03 12:55:42.081499][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 2, rx_count = 16) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_06 ... ok [INFO] [stderr] [2025-09-03 12:55:43.371387][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 7.462002494s >>> [INFO] [stderr] [2025-09-03 12:55:43.380625][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 2, rx_count = 2) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_01 ... ok [INFO] [stderr] [2025-09-03 12:55:43.950571][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 3.693912864s >>> [INFO] [stderr] [2025-09-03 12:55:43.955633][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 13, rx_count = 2) enter <<< [INFO] [stderr] [2025-09-03 12:55:44.192415][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 811.625264ms >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_04 ... ok [INFO] [stderr] [2025-09-03 12:55:44.202510][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 3, rx_count = 10) enter <<< [INFO] [stderr] [2025-09-03 12:55:44.240565][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 2.158927498s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_03 ... ok [INFO] [stderr] [2025-09-03 12:55:44.242165][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 3, rx_count = 3) enter <<< [INFO] [stderr] [2025-09-03 12:55:44.607540][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 365.243345ms >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_07 ... ok [INFO] [stderr] [2025-09-03 12:55:44.607843][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 8, rx_count = 3) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_06 ... ok [INFO] [stderr] [2025-09-03 12:55:45.229623][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 1.026896936s >>> [INFO] [stderr] [2025-09-03 12:55:45.230048][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 3, rx_count = 8) enter <<< [INFO] [stderr] [2025-09-03 12:55:45.461457][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 81.052670692s >>> [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_05 ... ok [INFO] [stderr] [2025-09-03 12:55:45.472631][INFO][test_blocking_context.rs:403] <<< test_pressure_bounded_blocking_multi (setup_log = (), _channel = (MTx, MRx), tx_count = 5, rx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:55:45.745583][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 1.789772885s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_05 ... ok [INFO] [stderr] [2025-09-03 12:55:45.776659][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 3) enter <<< [INFO] [stderr] [2025-09-03 12:55:45.794482][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 564.298212ms >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_09 ... ok [INFO] [stderr] [2025-09-03 12:55:45.795767][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 5) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_08 ... ok [INFO] [stderr] [2025-09-03 12:55:45.894160][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 1.286173464s >>> [INFO] [stderr] [2025-09-03 12:55:45.895475][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 10) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_10 ... ok [INFO] [stderr] [2025-09-03 12:55:45.982259][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 509.47424ms >>> [INFO] [stderr] [2025-09-03 12:55:45.982707][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 16) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi::case_02 ... ok [INFO] [stderr] [2025-09-03 12:55:46.534436][INFO][test_blocking_context.rs:403] >>> test_pressure_bounded_blocking_multi return () in 4.774679232s >>> [INFO] [stderr] [2025-09-03 12:55:46.535474][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 4) enter <<< [INFO] [stderr] [2025-09-03 12:55:47.422280][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 1.626384847s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_02 ... ok [INFO] [stderr] [2025-09-03 12:55:47.430214][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 7) enter <<< [INFO] [stderr] [2025-09-03 12:55:47.716001][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 1.939137398s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_01 ... ok [INFO] [stderr] [2025-09-03 12:55:47.719468][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 12) enter <<< [INFO] [stdout] test tests::test_async_blocking::test_pressure_1_tx_async_1_rx_blocking::case_09 ... ok [INFO] [stderr] [2025-09-03 12:55:47.723993][INFO][test_async_blocking.rs:242] >>> test_pressure_1_tx_async_1_rx_blocking return () in 80.806287827s >>> [INFO] [stderr] [2025-09-03 12:55:47.737494][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 3) enter <<< [INFO] [stderr] [2025-09-03 12:55:47.953553][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 523.105905ms >>> [INFO] [stderr] [2025-09-03 12:55:47.955052][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 9) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_06 ... ok [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_03 ... ok [INFO] [stderr] [2025-09-03 12:55:48.195050][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 2.294612005s >>> [INFO] [stderr] [2025-09-03 12:55:48.195509][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, Rx), tx_count = 13) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_08 ... ok [INFO] [stderr] [2025-09-03 12:55:48.475159][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 737.507457ms >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_04 ... ok [INFO] [stderr] [2025-09-03 12:55:48.475539][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 2) enter <<< [INFO] [stderr] [2025-09-03 12:55:48.521245][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 2.538413249s >>> [INFO] [stderr] [2025-09-03 12:55:48.530836][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 5) enter <<< [INFO] [stderr] [2025-09-03 12:55:49.475158][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 9.924049056s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_10 ... ok [INFO] [stderr] [2025-09-03 12:55:49.517510][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 15) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_05 ... ok [INFO] [stderr] [2025-09-03 12:55:49.561877][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 3.026282844s >>> [INFO] [stderr] [2025-09-03 12:55:49.562272][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 3) enter <<< [INFO] [stderr] [2025-09-03 12:55:49.606779][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 1.131124253s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_11 ... ok [INFO] [stderr] [2025-09-03 12:55:49.607239][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 7) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_09 ... ok [INFO] [stderr] [2025-09-03 12:55:50.090854][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 2.135651966s >>> [INFO] [stderr] [2025-09-03 12:55:50.094604][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 16) enter <<< [INFO] [stderr] [2025-09-03 12:55:50.517991][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 1.967521078s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_12 ... ok [INFO] [stderr] [2025-09-03 12:55:50.519707][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 2) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_17 ... ok [INFO] [stderr] [2025-09-03 12:55:51.424924][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 901.529736ms >>> [INFO] [stderr] [2025-09-03 12:55:51.425525][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 8) enter <<< [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_09 has been running for over 60 seconds [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_2 ... ok [INFO] [stderr] [2025-09-03 12:55:52.287509][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 75.726874968s >>> [INFO] [stderr] [2025-09-03 12:55:52.287957][INFO][test_blocking_context.rs:335] <<< test_pressure_bounded_blocking_multi_1 (setup_log = (), _channel = (MTx, MRx), tx_count = 16) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_15 ... ok [INFO] [stderr] [2025-09-03 12:55:53.299904][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 3.692540663s >>> [INFO] [stderr] [2025-09-03 12:55:53.300228][INFO][test_blocking_context.rs:479] <<< test_pressure_bounded_timeout_blocking (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_13 ... ok [INFO] [stderr] [2025-09-03 12:55:53.412543][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 3.89484762s >>> [INFO] [stderr] [2025-09-03 12:55:53.412935][INFO][test_blocking_context.rs:479] <<< test_pressure_bounded_timeout_blocking (setup_log = (), _channel = (MTx, MRx)) enter <<< [INFO] [stderr] [2025-09-03 12:55:53.841238][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 3.746432827s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_16 ... ok [INFO] [stderr] [2025-09-03 12:55:54.286310][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 6.090679857s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_10 ... ok [INFO] [stderr] [2025-09-03 12:55:54.437143][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 4.87473523s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_14 ... ok [INFO] [stderr] [2025-09-03 12:55:54.661722][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 3.236075828s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_18 ... ok [INFO] [stderr] [2025-09-03 12:55:54.748212][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 2.460128583s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_19 ... ok [INFO] [stderr] [2025-09-03 12:55:55.240576][INFO][test_blocking_context.rs:335] >>> test_pressure_bounded_blocking_multi_1 return () in 7.520982135s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_multi_1::case_07 ... ok [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_1 ... ok [INFO] [stderr] [2025-09-03 12:55:56.037259][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 79.99582086s >>> [INFO] [stderr] [2025-09-03 12:55:56.648495][INFO][test_blocking_async.rs:189] >>> test_pressure_1_tx_blocking_1_rx_async return () in 79.88989086s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_1_tx_blocking_1_rx_async::case_3 ... ok [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_05 ... ok [INFO] [stderr] [2025-09-03 12:56:06.651772][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 35.906875631s >>> [INFO] [stderr] [2025-09-03 12:56:11.060966][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 41.299250038s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_01 ... ok [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_blocking_1_1::case_09 ... ok [INFO] [stderr] [2025-09-03 12:56:13.620939][INFO][test_blocking_context.rs:282] >>> test_pressure_bounded_blocking_1_1 return () in 35.436806139s >>> [INFO] [stderr] [2025-09-03 12:56:15.664706][INFO][test_blocking_context.rs:479] >>> test_pressure_bounded_timeout_blocking return () in 22.364372577s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_timeout_blocking::case_1 ... ok [INFO] [stderr] [2025-09-03 12:56:16.399812][INFO][test_blocking_context.rs:479] >>> test_pressure_bounded_timeout_blocking return () in 22.986722031s >>> [INFO] [stdout] test tests::test_blocking_context::test_pressure_bounded_timeout_blocking::case_2 ... ok [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_12 ... ok [INFO] [stderr] [2025-09-03 12:56:27.237255][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 138.553416657s >>> [INFO] [stderr] [2025-09-03 12:56:35.629832][INFO][test_async.rs:718] >>> test_pressure_bounded_async_multi_1 return () in 148.800506377s >>> [INFO] [stdout] test tests::test_async::test_pressure_bounded_async_multi_1::case_03 ... ok [INFO] [stderr] [2025-09-03 12:57:12.699175][INFO][test_blocking_async.rs:235] >>> test_pressure_tx_multi_blocking_1_rx_async return () in 140.601552276s >>> [INFO] [stdout] test tests::test_blocking_async::test_pressure_tx_multi_blocking_1_rx_async::case_09 ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 280 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 187.10s [INFO] [stdout] [INFO] [stderr] Doc-tests crossfire [INFO] [stdout] [INFO] [stdout] running 13 tests [INFO] [stdout] test src/async_rx.rs - async_rx::AsyncRx (line 45) - compile fail ... ok [INFO] [stdout] test src/spsc.rs - spsc (line 25) - compile fail ... ok [INFO] [stdout] test src/blocking_tx.rs - blocking_tx::Tx (line 33) - compile fail ... ok [INFO] [stdout] test src/blocking_rx.rs - blocking_rx::Rx (line 33) - compile fail ... ok [INFO] [stdout] test src/mpsc.rs - mpsc (line 25) - compile fail ... ok [INFO] [stdout] test src/async_tx.rs - async_tx::AsyncTx (line 45) - compile fail ... ok [INFO] [stdout] test src/async_tx.rs - async_tx::AsyncTx (line 30) ... ok [INFO] [stdout] test src/spsc.rs - spsc (line 10) ... ok [INFO] [stdout] test src/async_rx.rs - async_rx::AsyncRx (line 30) ... ok [INFO] [stdout] test src/mpsc.rs - mpsc (line 10) ... ok [INFO] [stdout] test src/blocking_tx.rs - blocking_tx::Tx (line 20) ... ok [INFO] [stdout] test src/blocking_rx.rs - blocking_rx::Rx (line 20) ... ok [INFO] [stdout] test src/lib.rs - (line 139) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.17s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "63beda500f31bb6e6b41337e3a210a44232d9dd071b79cee213fd7b5de8a4bc0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "63beda500f31bb6e6b41337e3a210a44232d9dd071b79cee213fd7b5de8a4bc0", kill_on_drop: false }` [INFO] [stdout] 63beda500f31bb6e6b41337e3a210a44232d9dd071b79cee213fd7b5de8a4bc0