[INFO] fetching crate penguin-mux 0.8.2... [INFO] testing penguin-mux-0.8.2 against master#c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 for pr-146098-8 [INFO] extracting crate penguin-mux 0.8.2 into /workspace/builds/worker-1-tc1/source [INFO] started tweaking crates.io crate penguin-mux 0.8.2 [INFO] finished tweaking crates.io crate penguin-mux 0.8.2 [INFO] tweaked toml for crates.io crate penguin-mux 0.8.2 written to /workspace/builds/worker-1-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate penguin-mux 0.8.2 on toolchain c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate penguin-mux 0.8.2 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" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded tokio-tungstenite v0.28.0 [INFO] [stderr] Downloaded generator v0.8.7 [INFO] [stderr] Downloaded tungstenite v0.28.0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 8aa73178814ce84f0912700de52acc3d36406ae552d22ec8901d18298c013094 [INFO] running `Command { std: "docker" "start" "-a" "8aa73178814ce84f0912700de52acc3d36406ae552d22ec8901d18298c013094", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "8aa73178814ce84f0912700de52acc3d36406ae552d22ec8901d18298c013094", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8aa73178814ce84f0912700de52acc3d36406ae552d22ec8901d18298c013094", kill_on_drop: false }` [INFO] [stdout] 8aa73178814ce84f0912700de52acc3d36406ae552d22ec8901d18298c013094 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 61ecee6a792d84c3a6ea92352aa849a17144d3295cec227f3f47a59b0b46eff4 [INFO] running `Command { std: "docker" "start" "-a" "61ecee6a792d84c3a6ea92352aa849a17144d3295cec227f3f47a59b0b46eff4", kill_on_drop: false }` [INFO] [stderr] Compiling unicode-ident v1.0.20 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling proc-macro2 v1.0.103 [INFO] [stderr] Compiling quote v1.0.41 [INFO] [stderr] Compiling syn v2.0.108 [INFO] [stderr] Compiling thiserror-impl v2.0.17 [INFO] [stderr] Compiling tokio-macros v2.6.0 [INFO] [stderr] Compiling tracing-attributes v0.1.30 [INFO] [stderr] Compiling tokio v1.48.0 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling thiserror v2.0.17 [INFO] [stderr] Compiling tungstenite v0.28.0 [INFO] [stderr] Compiling tokio-tungstenite v0.28.0 [INFO] [stderr] Compiling penguin-mux v0.8.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 13.69s [INFO] running `Command { std: "docker" "inspect" "61ecee6a792d84c3a6ea92352aa849a17144d3295cec227f3f47a59b0b46eff4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "61ecee6a792d84c3a6ea92352aa849a17144d3295cec227f3f47a59b0b46eff4", kill_on_drop: false }` [INFO] [stdout] 61ecee6a792d84c3a6ea92352aa849a17144d3295cec227f3f47a59b0b46eff4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 6d2879dcb5cd05e06a0fbc36147ca6c5a30e44b0513c146d12803af272da0993 [INFO] running `Command { std: "docker" "start" "-a" "6d2879dcb5cd05e06a0fbc36147ca6c5a30e44b0513c146d12803af272da0993", kill_on_drop: false }` [INFO] [stderr] Compiling rustix v1.1.2 [INFO] [stderr] Compiling regex-syntax v0.8.8 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling divan-macros v0.1.21 [INFO] [stderr] Compiling regex-lite v0.1.8 [INFO] [stderr] Compiling condtype v1.3.0 [INFO] [stderr] Compiling tungstenite v0.28.0 [INFO] [stderr] Compiling tokio v1.48.0 [INFO] [stderr] Compiling regex-automata v0.4.13 [INFO] [stderr] Compiling terminal_size v0.4.3 [INFO] [stderr] Compiling clap_builder v4.5.51 [INFO] [stderr] Compiling matchers v0.2.0 [INFO] [stderr] Compiling tracing-subscriber v0.3.20 [INFO] [stderr] Compiling clap v4.5.51 [INFO] [stderr] Compiling divan v0.1.21 [INFO] [stderr] Compiling tokio-tungstenite v0.28.0 [INFO] [stderr] Compiling penguin-mux v0.8.2 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 23.90s [INFO] running `Command { std: "docker" "inspect" "6d2879dcb5cd05e06a0fbc36147ca6c5a30e44b0513c146d12803af272da0993", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6d2879dcb5cd05e06a0fbc36147ca6c5a30e44b0513c146d12803af272da0993", kill_on_drop: false }` [INFO] [stdout] 6d2879dcb5cd05e06a0fbc36147ca6c5a30e44b0513c146d12803af272da0993 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:4848fb76d95f26979359cc7e45710b1dbc8f3acb7aeedee7c460d7702230f228" "/opt/rustwide/cargo-home/bin/cargo" "+c90bcb9571b7aab0d8beaa2ce8a998ffaf079d38" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 4bd5d9d7bb5165585c64277b40bf804028d1d080fb2b84cded9592a378279062 [INFO] running `Command { std: "docker" "start" "-a" "4bd5d9d7bb5165585c64277b40bf804028d1d080fb2b84cded9592a378279062", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/penguin_mux-02dabd484d58c1fe) [INFO] [stdout] [INFO] [stdout] running 46 tests [INFO] [stdout] test config::tests::test_options ... ok [INFO] [stdout] test frame::tests::test_cow_bytes_eq ... ok [INFO] [stdout] test frame::tests::test_cow_bytes ... ok [INFO] [stdout] test frame::tests::test_frame_repr_bind ... ok [INFO] [stdout] test frame::tests::test_frame_repr_connect ... ok [INFO] [stdout] test frame::tests::test_frame_repr_acknowledge ... ok [INFO] [stdout] test frame::tests::test_finalized_frame ... ok [INFO] [stdout] test frame::tests::test_frame_repr_reset ... ok [INFO] [stdout] test frame::tests::test_frame_repr_push ... ok [INFO] [stdout] test frame::tests::test_frame_repr_finish ... ok [INFO] [stdout] test frame::tests::test_frames ... ok [INFO] [stdout] test stream::tests::test_copy_bidirectional_normal ... ok [INFO] [stdout] test stream::tests::test_mux_stream_read ... ok [INFO] [stdout] test stream::tests::test_mux_stream_write ... ok [INFO] [stdout] test stream::tests::test_mux_stream_shutdown ... ok [INFO] [stdout] test stream::tests::test_flow_control ... ok [INFO] [stdout] test tests::connect_succeeds ... ok [INFO] [stdout] test tests::test_bind_request ... ok [INFO] [stdout] test frame::tests::test_frame_repr_datagram ... ok [INFO] [stdout] test tests::test_close_port_behaviour ... ok [INFO] [stdout] test tests::test_flow_id_contention_will_give_up ... ok [INFO] [stdout] test tests::test_datagram_reject_long_host ... ok [INFO] [stdout] test tests::test_shutdown_has_effect ... ok [INFO] [stdout] test tests::test_flow_id_contention_can_succeed ... ok [INFO] [stdout] test tests::test_several_channels ... ok [INFO] [stdout] test timing::tests::test_optional_duration ... ok [INFO] [stdout] test timing::tests::test_backoff ... ok [INFO] [stdout] test ws::tokio_tungstenite::tests::test_binary_message ... ok [INFO] [stdout] test tests::test_early_eof_detected ... ok [INFO] [stdout] test ws::tokio_tungstenite::tests::test_ping_message ... ok [INFO] [stdout] 2025-11-13T21:21:35.321721Z ERROR penguin_mux::ws::tokio_tungstenite: Received text message: Hello [INFO] [stdout] test ws::tokio_tungstenite::tests::test_text_message ... ok [INFO] [stdout] test ws::tokio_tungstenite::tests::test_close_message ... ok [INFO] [stdout] test frame::tests::test_finalized_frame_too_long - should panic ... ok [INFO] [stdout] test tests::connected_stream_passes_data ... ok [INFO] [stdout] 2025-11-13T21:21:37.265474Z ERROR penguin_mux::task: Multiplexor task exited with error: No keepalive pong received within the allowed time [INFO] [stdout] 2025-11-13T21:21:37.265647Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] 2025-11-13T21:21:37.265704Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] test tests::test_timeout_if_no_pong_1 ... ok [INFO] [stdout] 2025-11-13T21:21:38.270571Z ERROR penguin_mux::task: Multiplexor task exited with error: No keepalive pong received within the allowed time [INFO] [stdout] 2025-11-13T21:21:38.271590Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] 2025-11-13T21:21:38.272277Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] test tests::test_timeout_if_no_pong_2 ... ok [INFO] [stdout] test timing::tests::test_optional_interval ... ok [INFO] [stdout] test tests::datagram_channel_passes_data ... ok [INFO] [stdout] test tests::test_no_timeout_if_no_keepalive ... ok [INFO] [stdout] test tests::connected_stream_passes_data_tiny_mtu ... ok [INFO] [stdout] test tests::connected_stream_passes_data_tiny_mtu_rwndminusone ... ok [INFO] [stdout] 2025-11-13T21:21:47.527388Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] 2025-11-13T21:21:52.724525Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] test tests::test_contention ... ok [INFO] [stdout] test tests::connected_stream_passes_data_one_sided_lots ... ok [INFO] [stdout] 2025-11-13T21:21:54.983708Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] test tests::connected_stream_passes_data_tiny_mtu_with_keepalive ... ok [INFO] [stdout] 2025-11-13T21:21:58.393596Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] test tests::datagram_channel_passes_data_tiny_mtu ... ok [INFO] [stdout] 2025-11-13T21:22:04.902574Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] 2025-11-13T21:22:11.572453Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] 2025-11-13T21:22:22.081445Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] 2025-11-13T21:22:25.462637Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stdout] 2025-11-13T21:22:31.896648Z ERROR penguin_mux: Failed to inform task of dropped multiplexor [INFO] [stderr] Doc-tests penguin_mux [INFO] [stdout] test tests::test_with_tcpsocket ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 56.69s [INFO] [stdout] [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" "4bd5d9d7bb5165585c64277b40bf804028d1d080fb2b84cded9592a378279062", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4bd5d9d7bb5165585c64277b40bf804028d1d080fb2b84cded9592a378279062", kill_on_drop: false }` [INFO] [stdout] 4bd5d9d7bb5165585c64277b40bf804028d1d080fb2b84cded9592a378279062