[INFO] fetching crate links_blocking 0.2.12... [INFO] testing links_blocking-0.2.12 against master#350d0ef0ec0493e6d21cfb265cb8211a0e74d766 for pr-145330-1 [INFO] extracting crate links_blocking 0.2.12 into /workspace/builds/worker-0-tc1/source [INFO] started tweaking crates.io crate links_blocking 0.2.12 [INFO] finished tweaking crates.io crate links_blocking 0.2.12 [INFO] tweaked toml for crates.io crate links_blocking 0.2.12 written to /workspace/builds/worker-0-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate links_blocking 0.2.12 on toolchain 350d0ef0ec0493e6d21cfb265cb8211a0e74d766 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Locking 151 packages to latest compatible versions [INFO] [stderr] Adding criterion v0.5.1 (available: v0.7.0) [INFO] [stderr] Adding rand v0.8.5 (available: v0.9.2) [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded byteserde v0.6.2 [INFO] [stderr] Downloaded links_core v0.2.12 [INFO] [stderr] Downloaded byteserde_derive v0.6.2 [INFO] [stderr] Downloaded byteserde_types v0.6.2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] e6630599777f21a087ca04fa9f85ba75500ab68fbe632d562f681c473b42ec53 [INFO] running `Command { std: "docker" "start" "-a" "e6630599777f21a087ca04fa9f85ba75500ab68fbe632d562f681c473b42ec53", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "e6630599777f21a087ca04fa9f85ba75500ab68fbe632d562f681c473b42ec53", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e6630599777f21a087ca04fa9f85ba75500ab68fbe632d562f681c473b42ec53", kill_on_drop: false }` [INFO] [stdout] e6630599777f21a087ca04fa9f85ba75500ab68fbe632d562f681c473b42ec53 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4aff09a301a21fdd941a49540ff0cb7e545fcc36e9e8d05d600a69e1d7d36ab2 [INFO] running `Command { std: "docker" "start" "-a" "4aff09a301a21fdd941a49540ff0cb7e545fcc36e9e8d05d600a69e1d7d36ab2", kill_on_drop: false }` [INFO] [stderr] Compiling byteserde v0.6.2 [INFO] [stderr] Compiling links_core v0.2.12 [INFO] [stderr] Compiling links_blocking v0.2.12 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.05s [INFO] running `Command { std: "docker" "inspect" "4aff09a301a21fdd941a49540ff0cb7e545fcc36e9e8d05d600a69e1d7d36ab2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4aff09a301a21fdd941a49540ff0cb7e545fcc36e9e8d05d600a69e1d7d36ab2", kill_on_drop: false }` [INFO] [stdout] 4aff09a301a21fdd941a49540ff0cb7e545fcc36e9e8d05d600a69e1d7d36ab2 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8107f8f0c829a534fb5d5296cf47de471781a8f0054871f6947c3019d67d876e [INFO] running `Command { std: "docker" "start" "-a" "8107f8f0c829a534fb5d5296cf47de471781a8f0054871f6947c3019d67d876e", kill_on_drop: false }` [INFO] [stderr] Compiling regex-automata v0.4.11 [INFO] [stderr] Compiling anstyle-query v1.1.4 [INFO] [stderr] Compiling quote v1.0.41 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling serde_json v1.0.145 [INFO] [stderr] Compiling colored v2.2.0 [INFO] [stderr] Compiling num-format v0.4.4 [INFO] [stderr] Compiling tokio v1.47.1 [INFO] [stderr] Compiling anstream v0.6.20 [INFO] [stderr] Compiling syn v2.0.106 [INFO] [stderr] Compiling regex v1.11.3 [INFO] [stderr] Compiling env_filter v0.1.3 [INFO] [stderr] Compiling env_logger v0.11.8 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling byteserde_derive v0.6.2 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling byteserde_types v0.6.2 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling links_core v0.2.12 [INFO] [stderr] Compiling criterion v0.5.1 [INFO] [stderr] Compiling links_blocking v0.2.12 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 18.90s [INFO] running `Command { std: "docker" "inspect" "8107f8f0c829a534fb5d5296cf47de471781a8f0054871f6947c3019d67d876e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8107f8f0c829a534fb5d5296cf47de471781a8f0054871f6947c3019d67d876e", kill_on_drop: false }` [INFO] [stdout] 8107f8f0c829a534fb5d5296cf47de471781a8f0054871f6947c3019d67d876e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+350d0ef0ec0493e6d21cfb265cb8211a0e74d766" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 122acd74fe9d458e1abb653924826c08917d875abbc0fe3eec2316235cf2613f [INFO] running `Command { std: "docker" "start" "-a" "122acd74fe9d458e1abb653924826c08917d875abbc0fe3eec2316235cf2613f", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.19s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/links_blocking-c20650947e160111) [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stderr] 2025-10-02T03:08:03.109417708Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test svc: Svc, RoundRobinPool> [INFO] [stderr] 2025-10-02T03:08:03.109643297Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test #0, clt: Clt127.0.0.1:45224), CltTestMessenger, 128> [INFO] [stderr] 2025-10-02T03:08:03.109776288Z INFO (connect::svc::test::test_svc_not_connected ) links_blocking::connect::svc::test svc: Svc, RoundRobinPool> [INFO] [stderr] 2025-10-02T03:08:03.109814448Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test #1, clt: Clt127.0.0.1:45224), CltTestMessenger, 128> [INFO] [stderr] 2025-10-02T03:08:03.109790477Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test svc: Svc, RoundRobinPool> [INFO] [stderr] 2025-10-02T03:08:03.110126628Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test #2, clt: Clt127.0.0.1:45224), CltTestMessenger, 128> [INFO] [stderr] 2025-10-02T03:08:03.109976377Z INFO (core::framer::test::test_reader ) links_blocking::core::framer::test send_frame: [INFO] [stderr] 0000: 3a 67 38 cc 63 ce 89 a3 b5 48 ac 74 ae ad 94 b0 | : g 8 Ì c Î . £ µ H ¬ t ® ­ . ° [INFO] [stderr] 0001: 27 9e a8 7e 68 e2 f8 dc c7 46 bc 66 09 38 59 43 | ' . ¨ . h â ø Ü Ç F ¼ f . 8 Y C [INFO] [stderr] 0002: f1 f8 e3 64 e5 ca f0 6b 93 53 f2 44 bd 6d a1 eb | ñ ø ã d å Ê ð k . S ò D ½ m ¡ ë [INFO] [stderr] 0003: fc ea 0e 2b 5e cd 71 c4 83 f7 d0 49 13 e8 2f c7 | ü ê . + ^ Í q Ä . ÷ Ð I . è / Ç [INFO] [stderr] 0004: 3d 00 6f 33 9c f9 21 d1 7a 63 21 65 1d 1e 55 4a | = . o 3 . ù . Ñ z c . e . . U J [INFO] [stderr] 0005: 15 8f 71 09 20 5e 33 e4 e1 b8 28 3d 9d 34 4f 35 | . . q . . ^ 3 ä á ¸ ( = . 4 O 5 [INFO] [stderr] 0006: a4 c0 d2 79 d6 74 30 2f 64 b3 dd f5 cb bd 9e 06 | ¤ À Ò y Ö t 0 / d ³ Ý õ Ë ½ . . [INFO] [stderr] 0007: 4b ef 54 93 38 f8 98 3b 93 8f 08 2f 69 89 81 1a | K ï T . 8 ø . ; . . . / i . . . [INFO] [stderr] [INFO] [stdout] test connect::svc::test::test_svc_not_connected ... ok [INFO] [stderr] 2025-10-02T03:08:03.110248277Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test clt_pool_err: Custom { kind: OutOfMemory, error: "RoundRobinPool at max capacity: 2, element: Clt127.0.0.1:45224), CltTestMessenger, 128> will be dropped" } [INFO] [stderr] 2025-10-02T03:08:03.110247948Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test clt: Clt127.0.0.1:15138), CltTestMessenger, 128> [INFO] [stderr] 2025-10-02T03:08:03.110772277Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test svc_pool_err: Custom { kind: OutOfMemory, error: "RoundRobinPool at max capacity: 2, element: Clt will be dropped" } [INFO] [stderr] 2025-10-02T03:08:03.110805317Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test svc: Svc, RoundRobinPool]>> [INFO] [stderr] 2025-10-02T03:08:03.111000648Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test --------- PRE SPLIT --------- [INFO] [stderr] 2025-10-02T03:08:03.110958728Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test #3, clt: Clt127.0.0.1:45224), CltTestMessenger, 128> [INFO] [stderr] 2025-10-02T03:08:03.111131637Z INFO (connect::svc::test::test_svc_clt_connected ) links_core::callbacks::logger LoggerCallback::on_sent Initiator(unittest@127.0.0.1:43416->127.0.0.1:15138) Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stderr] 2025-10-02T03:08:03.111201177Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test clt_pool_err: Custom { kind: OutOfMemory, error: "RoundRobinPool at max capacity: 2, element: Clt127.0.0.1:45224), CltTestMessenger, 128> will be dropped" } [INFO] [stderr] 2025-10-02T03:08:03.111344637Z INFO (connect::svc::test::test_svc_clt_connected ) links_core::callbacks::logger LoggerCallback::on_recv Acceptor(unittest@127.0.0.1:15138<-127.0.0.1:43416) Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stderr] 2025-10-02T03:08:03.111569408Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test svc_pool_err: Custom { kind: OutOfMemory, error: "RoundRobinPool at max capacity: 2, element: Clt will be dropped" } [INFO] [stderr] 2025-10-02T03:08:03.111648617Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test --------- SVC SPLIT POOL --------- [INFO] [stderr] 2025-10-02T03:08:03.111903468Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test clt_pool: RoundRobinPool127.0.0.1:45224), CltTestMessenger, 128>,Clt127.0.0.1:45224), CltTestMessenger, 128>]> [INFO] [stderr] 2025-10-02T03:08:03.112041548Z INFO (connect::svc::test::test_svc_clt_connected ) links_core::callbacks::logger LoggerCallback::on_sent Initiator(unittest@127.0.0.1:43416->127.0.0.1:15138) Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stderr] 2025-10-02T03:08:03.112073588Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test svc_pool: RoundRobinPool,Clt]> [INFO] [stderr] 2025-10-02T03:08:03.112269668Z INFO (connect::svc::test::test_svc_clt_connected ) links_core::callbacks::logger LoggerCallback::on_recv Acceptor(unittest@127.0.0.1:15138<-127.0.0.1:43416) Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stderr] 2025-10-02T03:08:03.112461797Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test clt_msg: Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stderr] 2025-10-02T03:08:03.112720927Z INFO (connect::pool::test::test_svcpool_cltpool_connected) links_blocking::connect::pool::test svc_msg: Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stdout] test connect::pool::test::test_svcpool_cltpool_connected ... ok [INFO] [stderr] 2025-10-02T03:08:03.112534967Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test --------- CLT SPLIT DIRECT --------- [INFO] [stdout] test connect::svc::test::test_svc_clt_connected ... ok [INFO] [stderr] 2025-10-02T03:08:03.119053247Z INFO (connect::svc::test::test_svc_clt_connected ) links_core::callbacks::logger LoggerCallback::on_sent Initiator(unittest@127.0.0.1:43416->127.0.0.1:15138) Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stderr] 2025-10-02T03:08:03.119220257Z INFO (connect::svc::test::test_svc_clt_connected ) links_core::callbacks::logger LoggerCallback::on_recv Acceptor(unittest@127.0.0.1:15138<-127.0.0.1:43416) Dbg(CltTestMsgDebug { ty: ConstCharAscii<49>('1'), text: StringAsciiFixed<127, 32, true>(" Hello Frm Client Msg") }) [INFO] [stderr] 2025-10-02T03:08:03.119342307Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test --------- CLT DROP RANDOM HALF --------- [INFO] [stderr] 2025-10-02T03:08:03.119397397Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test dropping clt_send [INFO] [stderr] 2025-10-02T03:08:03.119463647Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test clt_recv opt: None [INFO] [stderr] 2025-10-02T03:08:03.119512187Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test --------- SVC RECV/SEND SHOULD FAIL CLT DROPS HALF --------- [INFO] [stderr] 2025-10-02T03:08:03.119590967Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::pool recver: CltRecver is dead and will be dropped, connection reset by peer. recvers: RoundRobinPool [INFO] [stderr] 2025-10-02T03:08:03.119703447Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test pool_recver opt: None [INFO] [stderr] 2025-10-02T03:08:03.119791687Z INFO (connect::svc::test::test_svc_clt_connected ) links_blocking::connect::svc::test pool_sender err: sender: CltSender is dead and will be dropped, senders: RoundRobinPool. error: (Acceptor(unittest@127.0.0.1:15138<-127.0.0.1:43416) FrameWriter::write_frame caused by: [Broken pipe (os error 32)]) [INFO] [stderr] 2025-10-02T03:08:03.162611337Z INFO (connect::clt::test::test_clt_not_connected ) links_blocking::connect::clt::test res: Err(Custom { kind: TimedOut, error: "Initiator { name: \"unittest\", local: None, peer: 127.0.0.1:10838 } connect timeout: 50ms" }) [INFO] [stdout] test connect::clt::test::test_clt_not_connected ... ok [INFO] [stderr] 2025-10-02T03:08:03.210369686Z INFO (core::messenger::test::test_messenger ) links_blocking::core::messenger::test Initiator(unittest@127.0.0.1:42314->127.0.0.1:50253) MessageSender connected [INFO] [stderr] 2025-10-02T03:08:03.210916786Z INFO (core::framer::test::test_reader ) links_blocking::core::framer::test clt: FrameWriter { Initiator(unittest@127.0.0.1:47696->127.0.0.1:47515), addr: connected, peer: connected, fd: 5 } [INFO] [stderr] 2025-10-02T03:08:03.210928646Z INFO (Thread-Svc ) links_blocking::core::messenger::test Acceptor(unittest@127.0.0.1:50253<-127.0.0.1:42314) MessageSender connected [INFO] [stderr] 2025-10-02T03:08:03.211922326Z INFO (Thread-Svc ) links_blocking::core::framer::test svc: reader: FrameReader> { Acceptor(unittest@127.0.0.1:47515<-127.0.0.1:47696), addr: connected, peer: connected, fd: 8 } [INFO] [stderr] 2025-10-02T03:08:03.418161252Z INFO (core::framer::test::test_reader ) links_blocking::core::framer::test dropping clt_writer [INFO] [stderr] 2025-10-02T03:08:03.418343882Z INFO (core::framer::test::test_reader ) links_blocking::core::framer::test clt_reader.read_frame() opt: None [INFO] [stderr] 2025-10-02T03:08:03.476711221Z INFO (Thread-Svc ) links_blocking::core::framer::test svc: read_frame is None, client closed connection [INFO] [stderr] 2025-10-02T03:08:03.478921321Z INFO (core::framer::test::test_reader ) links_blocking::core::framer::test frame_send_count: 100,000, frame_recv_count: 100,000 [INFO] [stderr] 2025-10-02T03:08:03.479011381Z INFO (core::framer::test::test_reader ) links_blocking::core::framer::test per send elapsed: 2.071µs, total elapsed: 207.107126ms [INFO] [stdout] test core::framer::test::test_reader ... ok [INFO] [stderr] 2025-10-02T03:08:06.481384349Z INFO (core::messenger::test::test_messenger ) links_blocking::core::messenger::test dropping clt_recver [INFO] [stderr] 2025-10-02T03:08:06.481675439Z INFO (Thread-Svc ) links_blocking::core::messenger::test Acceptor { name: "unittest", local: 127.0.0.1:50253, peer: Some(127.0.0.1:42314) } MessageRecver Connection Closed by Client [INFO] [stderr] 2025-10-02T03:08:06.481907179Z INFO (core::messenger::test::test_messenger ) links_blocking::core::messenger::test clt_sender.send(): Initiator(unittest@127.0.0.1:42314->127.0.0.1:50253) FrameWriter::write_frame caused by: [Broken pipe (os error 32)] [INFO] [stderr] 2025-10-02T03:08:06.482206789Z INFO (core::messenger::test::test_messenger ) links_blocking::core::messenger::test clt_msg_sent_count: 100,000, clt_msg_recv_count: 100,000 [INFO] [stderr] 2025-10-02T03:08:06.483907039Z INFO (core::messenger::test::test_messenger ) links_blocking::core::messenger::test svc_msg_sent_count: 100,000, svc_msg_recv_count: 100,000 [INFO] [stderr] 2025-10-02T03:08:06.484304229Z INFO (core::messenger::test::test_messenger ) links_blocking::core::messenger::test per round trip elapsed: 32.708µs, total elapsed: 3.270859173s [INFO] [stdout] test core::messenger::test::test_messenger ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.38s [INFO] [stdout] [INFO] [stderr] Doc-tests links_blocking [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test src/core/messenger.rs - core::messenger (line 8) - compile ... ok [INFO] [stdout] test src/connect/pool.rs - connect::pool::CltsPool (line 19) - compile ... ok [INFO] [stdout] test src/connect/pool.rs - connect::pool::PoolCltAcceptor (line 375) - compile ... ok [INFO] [stdout] test src/connect/pool.rs - connect::pool::CltSendersPool (line 268) ... ok [INFO] [stdout] test src/core/framer.rs - core::framer (line 8) ... ok [INFO] [stdout] test src/connect/pool.rs - connect::pool::CltRecversPool (line 156) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.07s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "122acd74fe9d458e1abb653924826c08917d875abbc0fe3eec2316235cf2613f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "122acd74fe9d458e1abb653924826c08917d875abbc0fe3eec2316235cf2613f", kill_on_drop: false }` [INFO] [stdout] 122acd74fe9d458e1abb653924826c08917d875abbc0fe3eec2316235cf2613f