[INFO] fetching crate tehuti-mock 0.22.1... [INFO] testing tehuti-mock-0.22.1 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2 [INFO] extracting crate tehuti-mock 0.22.1 into /workspace/builds/worker-5-tc1/source [INFO] started tweaking crates.io crate tehuti-mock 0.22.1 [INFO] finished tweaking crates.io crate tehuti-mock 0.22.1 [INFO] tweaked toml for crates.io crate tehuti-mock 0.22.1 written to /workspace/builds/worker-5-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate tehuti-mock 0.22.1 on toolchain 562dee4820c458d823175268e41601d4c060588a [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate tehuti-mock 0.22.1 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded typid v1.1.2 [INFO] [stderr] Downloaded toml_edit v0.25.10+spec-1.1.0 [INFO] [stderr] Downloaded tehuti v0.22.1 [INFO] [stderr] Downloaded flume v0.12.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] b4004a122cd197e43756af4e0bd94eca1ce0288051c96d40f4d4af7fef6e0879 [INFO] running `Command { std: "docker" "start" "-a" "b4004a122cd197e43756af4e0bd94eca1ce0288051c96d40f4d4af7fef6e0879", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "b4004a122cd197e43756af4e0bd94eca1ce0288051c96d40f4d4af7fef6e0879", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "b4004a122cd197e43756af4e0bd94eca1ce0288051c96d40f4d4af7fef6e0879", kill_on_drop: false }` [INFO] [stdout] b4004a122cd197e43756af4e0bd94eca1ce0288051c96d40f4d4af7fef6e0879 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e5a54749f7502a32bceef01d95be776c4e1892d76878d45c12151fd2e3a9e50a [INFO] running `Command { std: "docker" "start" "-a" "e5a54749f7502a32bceef01d95be776c4e1892d76878d45c12151fd2e3a9e50a", kill_on_drop: false }` [INFO] [stderr] Compiling syn v2.0.117 [INFO] [stderr] Compiling thiserror v2.0.18 [INFO] [stderr] Compiling rust_decimal v1.41.0 [INFO] [stderr] Compiling futures-core v0.3.32 [INFO] [stderr] Compiling tracing-core v0.1.36 [INFO] [stderr] Compiling arrayvec v0.7.6 [INFO] [stderr] Compiling futures-sink v0.3.32 [INFO] [stderr] Compiling heapless v0.7.17 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling leb128 v0.2.5 [INFO] [stderr] Compiling getrandom v0.4.2 [INFO] [stderr] Compiling smawk v0.3.2 [INFO] [stderr] Compiling unicode-linebreak v0.1.5 [INFO] [stderr] Compiling flume v0.12.0 [INFO] [stderr] Compiling uuid v1.22.0 [INFO] [stderr] Compiling rand v0.10.0 [INFO] [stderr] Compiling textwrap v0.16.2 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling thiserror-impl v2.0.18 [INFO] [stderr] Compiling tracing-attributes v0.1.31 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling cobs v0.3.0 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling typid v1.1.2 [INFO] [stderr] Compiling tracing-subscriber v0.3.23 [INFO] [stderr] Compiling postcard v1.1.3 [INFO] [stderr] Compiling tehuti v0.22.1 [INFO] [stderr] Compiling tehuti-mock v0.22.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 20.34s [INFO] running `Command { std: "docker" "inspect" "e5a54749f7502a32bceef01d95be776c4e1892d76878d45c12151fd2e3a9e50a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e5a54749f7502a32bceef01d95be776c4e1892d76878d45c12151fd2e3a9e50a", kill_on_drop: false }` [INFO] [stdout] e5a54749f7502a32bceef01d95be776c4e1892d76878d45c12151fd2e3a9e50a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 63f5fc83112b203758478bf30fbc0f55bcb46c6d82de641db0cbe7d27adc2319 [INFO] running `Command { std: "docker" "start" "-a" "63f5fc83112b203758478bf30fbc0f55bcb46c6d82de641db0cbe7d27adc2319", kill_on_drop: false }` [INFO] [stderr] Compiling tehuti-mock v0.22.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.09s [INFO] running `Command { std: "docker" "inspect" "63f5fc83112b203758478bf30fbc0f55bcb46c6d82de641db0cbe7d27adc2319", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "63f5fc83112b203758478bf30fbc0f55bcb46c6d82de641db0cbe7d27adc2319", kill_on_drop: false }` [INFO] [stdout] 63f5fc83112b203758478bf30fbc0f55bcb46c6d82de641db0cbe7d27adc2319 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 5463a58e2ab20ba4316fc676285ef104ae31216fe8c6d2f9181c81ee3ac889f6 [INFO] running `Command { std: "docker" "start" "-a" "5463a58e2ab20ba4316fc676285ef104ae31216fe8c6d2f9181c81ee3ac889f6", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.16s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tehuti_mock-30323a09b9550df7) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] 2026-04-20T00:41:50.767668Z TRACE tehuti::peer: Registering Peer Role id PeerRoleId(0) [INFO] [stdout] 2026-04-20T00:41:50.769129Z TRACE tehuti::mock::network: Mock network started in thread ThreadId(3) [INFO] [stdout] 2026-04-20T00:41:50.769228Z TRACE tehuti::mock::network: Mock network port 'a' created [INFO] [stdout] 2026-04-20T00:41:50.769439Z TRACE tehuti::mock::machine: Mock machine started in thread ThreadId(4) [INFO] [stdout] 2026-04-20T00:41:50.771270Z TRACE tehuti::mock::meeting: Mock meeting 1 started in thread ThreadId(5) [INFO] [stdout] 2026-04-20T00:41:50.771347Z TRACE tehuti::meeting: Meeting opened: 1-ThreadId(5) [INFO] [stdout] 2026-04-20T00:41:50.772067Z TRACE tehuti::mock::network: Mock network port 'b' created [INFO] [stdout] 2026-04-20T00:41:50.772312Z TRACE tehuti::mock::machine: Mock machine started in thread ThreadId(6) [INFO] [stdout] 2026-04-20T00:41:50.772523Z TRACE tehuti::mock::meeting: Mock meeting 1 started in thread ThreadId(7) [INFO] [stdout] 2026-04-20T00:41:50.772563Z TRACE tehuti::meeting: Meeting opened: 1-ThreadId(7) [INFO] [stdout] 2026-04-20T00:41:50.772661Z TRACE tehuti::meeting: Meeting 1-ThreadId(5) handle user event: PeerCreate(PeerId(0), PeerRoleId(0)) [INFO] [stdout] 2026-04-20T00:41:50.772763Z TRACE tehuti::meeting: Meeting 1-ThreadId(5) peer created: PeerInfo { peer_id: PeerId(0), role_id: PeerRoleId(0), remote: false } [INFO] [stdout] 2026-04-20T00:41:50.772831Z TRACE tehuti::mock::meeting: Mock meeting 1 created peer PeerId(0) in thread ThreadId(5) [INFO] [stdout] 2026-04-20T00:41:50.772845Z TRACE tehuti::peer: Peer PeerId(0) drop without destroying [INFO] [stdout] 2026-04-20T00:41:50.772894Z TRACE tehuti::mock::network: Mock network received frame Control(CreatePeer(PeerId(0), PeerRoleId(0))) from node 'a' [INFO] [stdout] 2026-04-20T00:41:50.772928Z TRACE tehuti::mock::network: Mock network send frame Control(CreatePeer(PeerId(0), PeerRoleId(0))) to node 'b' [INFO] [stdout] 2026-04-20T00:41:50.772964Z TRACE tehuti::meeting: Meeting 1-ThreadId(7) handle engine event: PeerJoined(EngineId(0), PeerId(0), PeerRoleId(0)) [INFO] [stdout] 2026-04-20T00:41:50.773051Z TRACE tehuti::meeting: Meeting 1-ThreadId(7) peer joined: PeerInfo { peer_id: PeerId(0), role_id: PeerRoleId(0), remote: true } [INFO] [stdout] 2026-04-20T00:41:50.773103Z TRACE tehuti::mock::meeting: Mock meeting 1 created peer PeerId(0) in thread ThreadId(7) [INFO] [stdout] 2026-04-20T00:41:50.773104Z TRACE tehuti::peer: Peer PeerId(0) drop without destroying [INFO] [stdout] 2026-04-20T00:41:50.773142Z TRACE tehuti::mock::network: Mock network received frame Packet(ProtocolPacketFrame { peer_id: PeerId(0), channel_id: ChannelId(0), data: ProtocolPacketData { data (size): 28, recepients: [], sender: None } }) from node 'a' [INFO] [stdout] 2026-04-20T00:41:50.773183Z TRACE tehuti::mock::network: Mock network send frame Packet(ProtocolPacketFrame { peer_id: PeerId(0), channel_id: ChannelId(0), data: ProtocolPacketData { data (size): 28, recepients: [], sender: None } }) to node 'b' [INFO] [stdout] 2026-04-20T00:41:50.773251Z TRACE tehuti::mock::machine: Mock machine terminating in thread ThreadId(4) [INFO] [stdout] 2026-04-20T00:41:50.773273Z TRACE tehuti::mock::machine: Mock machine stopped in thread ThreadId(4) [INFO] [stdout] 2026-04-20T00:41:50.773298Z TRACE tehuti::mock::meeting: Mock meeting 1 terminating in thread ThreadId(5) [INFO] [stdout] 2026-04-20T00:41:50.773319Z TRACE tehuti::mock::meeting: Mock meeting 1 stopped in thread ThreadId(5) [INFO] [stdout] 2026-04-20T00:41:50.773353Z TRACE tehuti::meeting: Meeting closed: 1-ThreadId(5) [INFO] [stdout] 2026-04-20T00:41:50.773589Z TRACE tehuti::mock::machine: Mock machine terminating in thread ThreadId(6) [INFO] [stdout] 2026-04-20T00:41:50.773611Z TRACE tehuti::mock::machine: Mock machine stopped in thread ThreadId(6) [INFO] [stdout] 2026-04-20T00:41:50.773632Z TRACE tehuti::mock::meeting: Mock meeting 1 terminating in thread ThreadId(7) [INFO] [stdout] 2026-04-20T00:41:50.773653Z TRACE tehuti::mock::meeting: Mock meeting 1 stopped in thread ThreadId(7) [INFO] [stdout] 2026-04-20T00:41:50.773684Z TRACE tehuti::meeting: Meeting closed: 1-ThreadId(7) [INFO] [stdout] 2026-04-20T00:41:50.773857Z TRACE tehuti::mock::network: Mock network terminating in thread ThreadId(3) [INFO] [stdout] 2026-04-20T00:41:50.773890Z TRACE tehuti::mock::network: Mock network stopped in thread ThreadId(3) [INFO] [stdout] test tests::test_mock ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Doc-tests tehuti_mock [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "5463a58e2ab20ba4316fc676285ef104ae31216fe8c6d2f9181c81ee3ac889f6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "5463a58e2ab20ba4316fc676285ef104ae31216fe8c6d2f9181c81ee3ac889f6", kill_on_drop: false }` [INFO] [stdout] 5463a58e2ab20ba4316fc676285ef104ae31216fe8c6d2f9181c81ee3ac889f6