[INFO] fetching crate uflow 0.7.1... [INFO] testing uflow-0.7.1 against beta-2025-01-12 for beta-1.85-1 [INFO] extracting crate uflow 0.7.1 into /workspace/builds/worker-7-tc2/source [INFO] validating manifest of crates.io crate uflow 0.7.1 on toolchain beta-2025-01-12 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2025-01-12" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate uflow 0.7.1 [INFO] finished tweaking crates.io crate uflow 0.7.1 [INFO] tweaked toml for crates.io crate uflow 0.7.1 written to /workspace/builds/worker-7-tc2/source/Cargo.toml [INFO] crate crates.io crate uflow 0.7.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" "+beta-2025-01-12" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 9a111e95f89ea623ef4dd72a7572ce7c9bb134eb4c0afb1e487e6ac2787c705f [INFO] running `Command { std: "docker" "start" "-a" "9a111e95f89ea623ef4dd72a7572ce7c9bb134eb4c0afb1e487e6ac2787c705f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "9a111e95f89ea623ef4dd72a7572ce7c9bb134eb4c0afb1e487e6ac2787c705f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9a111e95f89ea623ef4dd72a7572ce7c9bb134eb4c0afb1e487e6ac2787c705f", kill_on_drop: false }` [INFO] [stdout] 9a111e95f89ea623ef4dd72a7572ce7c9bb134eb4c0afb1e487e6ac2787c705f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 062f3266626d2cb8c0c534714e0533bd70a39820da3c6075b7545f61461417ab [INFO] running `Command { std: "docker" "start" "-a" "062f3266626d2cb8c0c534714e0533bd70a39820da3c6075b7545f61461417ab", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.102 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling uflow v0.7.1 (/opt/rustwide/workdir) [INFO] [stdout] warning: this method call resolves to `<&Box<[T]> as IntoIterator>::into_iter` (due to backwards compatibility), but will resolve to ` as IntoIterator>::into_iter` in Rust 2024 [INFO] [stdout] --> src/half_connection/frame_queue.rs:333:55 [INFO] [stdout] | [INFO] [stdout] 333 | for fragment_ref in fragment_refs.into_iter() { [INFO] [stdout] | ^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = warning: this changes meaning in Rust 2024 [INFO] [stdout] = note: for more information, see [INFO] [stdout] = note: `#[warn(boxed_slice_into_iter)]` on by default [INFO] [stdout] help: use `.iter()` instead of `.into_iter()` to avoid ambiguity [INFO] [stdout] | [INFO] [stdout] 333 | for fragment_ref in fragment_refs.iter() { [INFO] [stdout] | ~~~~ [INFO] [stdout] help: or remove `.into_iter()` to iterate by value [INFO] [stdout] | [INFO] [stdout] 333 - for fragment_ref in fragment_refs.into_iter() { [INFO] [stdout] 333 + for fragment_ref in fragment_refs { [INFO] [stdout] | [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.24s [INFO] running `Command { std: "docker" "inspect" "062f3266626d2cb8c0c534714e0533bd70a39820da3c6075b7545f61461417ab", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "062f3266626d2cb8c0c534714e0533bd70a39820da3c6075b7545f61461417ab", kill_on_drop: false }` [INFO] [stdout] 062f3266626d2cb8c0c534714e0533bd70a39820da3c6075b7545f61461417ab [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 223f80df6b4d437056b68487763902ff23b4a3ca559e9368c789b2b8118093ea [INFO] running `Command { std: "docker" "start" "-a" "223f80df6b4d437056b68487763902ff23b4a3ca559e9368c789b2b8118093ea", kill_on_drop: false }` [INFO] [stderr] Compiling md5 v0.7.0 [INFO] [stdout] warning: this method call resolves to `<&Box<[T]> as IntoIterator>::into_iter` (due to backwards compatibility), but will resolve to ` as IntoIterator>::into_iter` in Rust 2024 [INFO] [stdout] --> src/half_connection/frame_queue.rs:333:55 [INFO] [stdout] | [INFO] [stdout] 333 | for fragment_ref in fragment_refs.into_iter() { [INFO] [stdout] | ^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = warning: this changes meaning in Rust 2024 [INFO] [stdout] = note: for more information, see [INFO] [stdout] = note: `#[warn(boxed_slice_into_iter)]` on by default [INFO] [stdout] help: use `.iter()` instead of `.into_iter()` to avoid ambiguity [INFO] [stdout] | [INFO] [stdout] 333 | for fragment_ref in fragment_refs.iter() { [INFO] [stdout] | ~~~~ [INFO] [stdout] help: or remove `.into_iter()` to iterate by value [INFO] [stdout] | [INFO] [stdout] 333 - for fragment_ref in fragment_refs.into_iter() { [INFO] [stdout] 333 + for fragment_ref in fragment_refs { [INFO] [stdout] | [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Compiling uflow v0.7.1 (/opt/rustwide/workdir) [INFO] [stdout] warning: unused import: `super::*` [INFO] [stdout] --> src/half_connection/loss_rate.rs:114:9 [INFO] [stdout] | [INFO] [stdout] 114 | use super::*; [INFO] [stdout] | ^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_imports)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: this method call resolves to `<&Box<[T]> as IntoIterator>::into_iter` (due to backwards compatibility), but will resolve to ` as IntoIterator>::into_iter` in Rust 2024 [INFO] [stdout] --> src/half_connection/frame_queue.rs:333:55 [INFO] [stdout] | [INFO] [stdout] 333 | for fragment_ref in fragment_refs.into_iter() { [INFO] [stdout] | ^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = warning: this changes meaning in Rust 2024 [INFO] [stdout] = note: for more information, see [INFO] [stdout] = note: `#[warn(boxed_slice_into_iter)]` on by default [INFO] [stdout] help: use `.iter()` instead of `.into_iter()` to avoid ambiguity [INFO] [stdout] | [INFO] [stdout] 333 | for fragment_ref in fragment_refs.iter() { [INFO] [stdout] | ~~~~ [INFO] [stdout] help: or remove `.into_iter()` to iterate by value [INFO] [stdout] | [INFO] [stdout] 333 - for fragment_ref in fragment_refs.into_iter() { [INFO] [stdout] 333 + for fragment_ref in fragment_refs { [INFO] [stdout] | [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.35s [INFO] running `Command { std: "docker" "inspect" "223f80df6b4d437056b68487763902ff23b4a3ca559e9368c789b2b8118093ea", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "223f80df6b4d437056b68487763902ff23b4a3ca559e9368c789b2b8118093ea", kill_on_drop: false }` [INFO] [stdout] 223f80df6b4d437056b68487763902ff23b4a3ca559e9368c789b2b8118093ea [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 1e5bbff0c29a5ece8ec07d5cb11220d0653f6ca69fdcda2fdc8ca7a56e3b36c8 [INFO] running `Command { std: "docker" "start" "-a" "1e5bbff0c29a5ece8ec07d5cb11220d0653f6ca69fdcda2fdc8ca7a56e3b36c8", kill_on_drop: false }` [INFO] [stderr] warning: this method call resolves to `<&Box<[T]> as IntoIterator>::into_iter` (due to backwards compatibility), but will resolve to ` as IntoIterator>::into_iter` in Rust 2024 [INFO] [stderr] --> src/half_connection/frame_queue.rs:333:55 [INFO] [stderr] | [INFO] [stderr] 333 | for fragment_ref in fragment_refs.into_iter() { [INFO] [stderr] | ^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = warning: this changes meaning in Rust 2024 [INFO] [stderr] = note: for more information, see [INFO] [stderr] = note: `#[warn(boxed_slice_into_iter)]` on by default [INFO] [stderr] help: use `.iter()` instead of `.into_iter()` to avoid ambiguity [INFO] [stderr] | [INFO] [stderr] 333 | for fragment_ref in fragment_refs.iter() { [INFO] [stderr] | ~~~~ [INFO] [stderr] help: or remove `.into_iter()` to iterate by value [INFO] [stderr] | [INFO] [stderr] 333 - for fragment_ref in fragment_refs.into_iter() { [INFO] [stderr] 333 + for fragment_ref in fragment_refs { [INFO] [stderr] | [INFO] [stderr] [INFO] [stderr] warning: unused import: `super::*` [INFO] [stderr] --> src/half_connection/loss_rate.rs:114:9 [INFO] [stderr] | [INFO] [stderr] 114 | use super::*; [INFO] [stderr] | ^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_imports)]` on by default [INFO] [stderr] [INFO] [stderr] warning: `uflow` (lib) generated 1 warning (run `cargo fix --lib -p uflow` to apply 1 suggestion) [INFO] [stderr] warning: `uflow` (lib test) generated 2 warnings (1 duplicate) (run `cargo fix --lib -p uflow --tests` to apply 1 suggestion) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/uflow-bc9bfce0c3877b96) [INFO] [stdout] [INFO] [stdout] running 78 tests [INFO] [stdout] test frame::serial::crc::tests::basic ... ok [INFO] [stdout] test frame::serial::crc::tests::zero_nonzero_crc ... ok [INFO] [stdout] test frame::serial::tests::ack_basic ... ok [INFO] [stdout] test frame::serial::tests::ack_empty ... ok [INFO] [stdout] test frame::serial::tests::data_empty ... ok [INFO] [stdout] test frame::serial::tests::disconnect_ack_basic ... ok [INFO] [stdout] test frame::serial::tests::disconnect_basic ... ok [INFO] [stdout] test frame::serial::tests::handshake_ack_basic ... ok [INFO] [stdout] test frame::serial::tests::handshake_error_basic ... ok [INFO] [stdout] test frame::serial::tests::data_basic ... ok [INFO] [stdout] test frame::serial::tests::handshake_syn_ack_basic ... ok [INFO] [stdout] test half_connection::emit::tests::ack_min_one ... ok [INFO] [stdout] test frame::serial::tests::sync_basic ... ok [INFO] [stdout] test half_connection::emit::tests::ack_size_limited ... ok [INFO] [stdout] test half_connection::emit::tests::ack_max_frame_size ... ok [INFO] [stdout] test half_connection::emit::tests::data_max_frame_size ... ok [INFO] [stdout] test half_connection::emit::tests::data_size_limited ... ok [INFO] [stdout] test half_connection::emit::tests::data_window_limited ... ok [INFO] [stdout] test half_connection::frame_queue::tests::feedback_generation ... ok [INFO] [stdout] test frame::serial::tests::sync_random ... ok [INFO] [stdout] test half_connection::frame_queue::tests::window_advancement ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::fragment_buffer::tests::multiple_fragments_nonmultiple ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::inconsistent_datagrams ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::fragment_buffer::tests::single_fragment ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::alloc_exceeded ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::fragment_buffer::tests::multiple_fragments ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::basic_skip ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::basic_stall ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::channel_ignore_old ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::channel_skip_received ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::channel_stall ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::full_advancement ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::single_packet_multi_fragment ... ok [INFO] [stdout] test half_connection::packet_sender::tests::alloc_size_correct ... ok [INFO] [stdout] test frame::serial::tests::handshake_syn_basic ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::max_stall ... ok [INFO] [stdout] test half_connection::packet_sender::tests::basic ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::alloc_counter ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::basic ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::single_packet_single_fragment ... ok [INFO] [stdout] test half_connection::packet_tests::max_packet_transfer ... ignored [INFO] [stdout] test half_connection::packet_sender::tests::parent_leads ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::partial_advancement ... ok [INFO] [stdout] test half_connection::packet_receiver::tests::fill_window_n_times ... ok [INFO] [stdout] test half_connection::frame_queue::tests::max_loss ... ok [INFO] [stdout] test half_connection::frame_queue::tests::max_forget_cull ... ok [INFO] [stdout] test half_connection::reorder_buffer::tests::advance_0_acks ... ok [INFO] [stdout] test half_connection::reorder_buffer::tests::advance_2_acks ... ok [INFO] [stdout] test half_connection::reorder_buffer::tests::ack_2_acks ... ok [INFO] [stdout] test half_connection::send_rate::tests::tcp_throughput_inverse ... ok [INFO] [stdout] test half_connection::reorder_buffer::tests::max_span ... ok [INFO] [stdout] test half_connection::reorder_buffer::tests::advance_1_ack ... ok [INFO] [stdout] test half_connection::reorder_buffer::tests::ack_1_ack ... ok [INFO] [stdout] test half_connection::reorder_buffer::tests::ack_3_acks ... ok [INFO] [stdout] test half_connection::packet_tests::null_packet_transfer ... ok [INFO] [stdout] test half_connection::tests::basic_send ... ok [INFO] [stdout] test half_connection::frame_queue::tests::max_window_advance_cull ... ok [INFO] [stdout] test half_connection::tests::send_rate_1000k ... ignored [INFO] [stdout] test half_connection::tests::send_rate_100k ... ignored [INFO] [stdout] test half_connection::tests::max_frame_size ... ok [INFO] [stdout] test half_connection::tests::no_resend_after_packet_skip ... ok [INFO] [stdout] test half_connection::tests::no_resend_after_ack ... ok [INFO] [stdout] test half_connection::tests::keepalive_timing ... ok [INFO] [stdout] test half_connection::tests::resend_timing ... ok [INFO] [stdout] test half_connection::tests::time_sensitive_drop ... ok [INFO] [stdout] test half_connection::tests::sync_response ... ok [INFO] [stdout] test half_connection::tests::sync_frame_and_packet_window ... ok [INFO] [stdout] test half_connection::packet_sender::tests::parent_leads_acknowledgement ... ok [INFO] [stdout] test half_connection::tests::sync_packet_window_only ... ok [INFO] [stdout] test frame::serial::crc::tests::random ... ok [INFO] [stdout] test frame::serial::tests::ack_random ... ok [INFO] [stdout] test half_connection::tests::sync_frame_window_only ... ok [INFO] [stdout] test half_connection::packet_tests::random_transfer ... ok [INFO] [stdout] test frame::serial::tests::data_random ... ok [INFO] [stdout] test half_connection::tests::packet_unambiguity ... ok [INFO] [stdout] test half_connection::packet_receiver::assembly_window::fragment_buffer::tests::max_fragments ... ok [INFO] [stdout] test half_connection::packet_tests::single_packet_max_alloc ... ok [INFO] [stderr] Running tests/disconnect.rs (/opt/rustwide/target/debug/deps/disconnect-989e98d86d1e5bc9) [INFO] [stdout] test frame::serial::tests::crc_flips ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 75 passed; 0 failed; 3 ignored; 0 measured; 0 filtered out; finished in 5.74s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test client_disconnect_flush ... ok [INFO] [stdout] test client_disconnect_now ... ok [INFO] [stdout] test server_disconnect_now ... ok [INFO] [stdout] test server_disconnect_flush ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.06s [INFO] [stdout] [INFO] [stderr] Running tests/ideal_transfer.rs (/opt/rustwide/target/debug/deps/ideal_transfer-c857f6108665b9c1) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test ideal_transfer ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.14s [INFO] [stdout] [INFO] [stderr] Running tests/reliable_transfer.rs (/opt/rustwide/target/debug/deps/reliable_transfer-818292c68f26cc52) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] test reliable_transfer ... ok [INFO] [stderr] Running tests/timeouts.rs (/opt/rustwide/target/debug/deps/timeouts-b5467a4551650722) [INFO] [stdout] [INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.28s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test client_active_timeout ... ok [INFO] [stdout] test server_active_timeout ... FAILED [INFO] [stdout] test client_handshake_timeout ... ok [INFO] [stdout] test server_handshake_timeout ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- server_active_timeout stdout ---- [INFO] [stdout] [INFO] [stdout] thread '' panicked at tests/timeouts.rs:206:13: [INFO] [stdout] no timeout event received [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x599278dd157a - std::backtrace_rs::backtrace::libunwind::trace::ha13ab8a94fd3bb92 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x599278dd157a - std::backtrace_rs::backtrace::trace_unsynchronized::h2a4c556e569d314b [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x599278dd157a - std::sys::backtrace::_print_fmt::hf52186dec7bdf1bb [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x599278dd157a - ::fmt::hb5c3379828c15690 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x599278df9f73 - core::fmt::rt::Argument::fmt::h8220db795cd6f76c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x599278df9f73 - core::fmt::write::hd20c41beeec2e8c0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/mod.rs:1440:21 [INFO] [stdout] 6: 0x599278dcdff3 - std::io::Write::write_fmt::hf276ec928345bea3 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/io/mod.rs:1887:15 [INFO] [stdout] 7: 0x599278dd13c2 - std::sys::backtrace::BacktraceLock::print::h4fa77b65bb5ed2ec [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x599278dd2ab0 - std::panicking::default_hook::{{closure}}::hd3560f93167cf51e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x599278dd284d - std::panicking::default_hook::h361b8e3c5cbb2501 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:319:9 [INFO] [stdout] 10: 0x599278d9bda3 - as core::ops::function::Fn>::call::h52b4c42c9dce8b0e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 11: 0x599278d9bda3 - test::test_main::{{closure}}::h1a9dc25180417899 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:134:21 [INFO] [stdout] 12: 0x599278dd32e3 - as core::ops::function::Fn>::call::h080867abcafb687f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 13: 0x599278dd32e3 - std::panicking::rust_panic_with_hook::h7e187ba6ef3a8505 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:836:13 [INFO] [stdout] 14: 0x599278dd30ec - std::panicking::begin_panic::{{closure}}::h8b740c69600621de [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:765:9 [INFO] [stdout] 15: 0x599278dd1a89 - std::sys::backtrace::__rust_end_short_backtrace::h5e05677270f92ab5 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x599278cdc190 - std::panicking::begin_panic::h783c7c13a860d163 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:764:5 [INFO] [stdout] 17: 0x599278cea544 - timeouts::server_active_timeout::{{closure}}::h6937cfea8f5ddeb2 [INFO] [stdout] at /opt/rustwide/workdir/tests/timeouts.rs:206:13 [INFO] [stdout] 18: 0x599278ceaf86 - std::sys::backtrace::__rust_begin_short_backtrace::h7520e53b253e6b47 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 19: 0x599278ce4556 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::haef570936720d787 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:564:17 [INFO] [stdout] 20: 0x599278ce53c1 - as core::ops::function::FnOnce<()>>::call_once::hab6802382f25a8be [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 21: 0x599278ceb1a0 - std::panicking::try::do_call::hdb627610df57ea94 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:584:40 [INFO] [stdout] 22: 0x599278ce4e3b - __rust_try [INFO] [stdout] 23: 0x599278ce260d - std::panicking::try::h6c6090321719e836 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:547:19 [INFO] [stdout] 24: 0x599278ce260d - std::panic::catch_unwind::h1bc82010b8d9aecc [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panic.rs:358:14 [INFO] [stdout] 25: 0x599278ce260d - std::thread::Builder::spawn_unchecked_::{{closure}}::h2fcc83bbe91d211f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:562:30 [INFO] [stdout] 26: 0x599278ce601e - core::ops::function::FnOnce::call_once{{vtable.shim}}::hd4850ab5d9f61d36 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 27: 0x599278dd72cb - as core::ops::function::FnOnce>::call_once::hcc221cc1d8cbbdc7 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 28: 0x599278dd72cb - as core::ops::function::FnOnce>::call_once::he5e5264a0dcd6e5f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 29: 0x599278dd72cb - std::sys::pal::unix::thread::Thread::new::thread_start::h307a072356a0dfca [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/pal/unix/thread.rs:106:17 [INFO] [stdout] 30: 0x798be9ecfac3 - [INFO] [stdout] 31: 0x798be9f60a04 - clone [INFO] [stdout] 32: 0x0 - [INFO] [stdout] [INFO] [stdout] thread 'server_active_timeout' panicked at tests/timeouts.rs:210:19: [INFO] [stdout] called `Result::unwrap()` on an `Err` value: Any { .. } [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x599278dd157a - std::backtrace_rs::backtrace::libunwind::trace::ha13ab8a94fd3bb92 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x599278dd157a - std::backtrace_rs::backtrace::trace_unsynchronized::h2a4c556e569d314b [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x599278dd157a - std::sys::backtrace::_print_fmt::hf52186dec7bdf1bb [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x599278dd157a - ::fmt::hb5c3379828c15690 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x599278df9f73 - core::fmt::rt::Argument::fmt::h8220db795cd6f76c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x599278df9f73 - core::fmt::write::hd20c41beeec2e8c0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/mod.rs:1440:21 [INFO] [stdout] 6: 0x599278dcdff3 - std::io::Write::write_fmt::hf276ec928345bea3 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/io/mod.rs:1887:15 [INFO] [stdout] 7: 0x599278dd13c2 - std::sys::backtrace::BacktraceLock::print::h4fa77b65bb5ed2ec [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x599278dd2ab0 - std::panicking::default_hook::{{closure}}::hd3560f93167cf51e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x599278dd284d - std::panicking::default_hook::h361b8e3c5cbb2501 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:319:9 [INFO] [stdout] 10: 0x599278d9bda3 - as core::ops::function::Fn>::call::h52b4c42c9dce8b0e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 11: 0x599278d9bda3 - test::test_main::{{closure}}::h1a9dc25180417899 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:134:21 [INFO] [stdout] 12: 0x599278dd32e3 - as core::ops::function::Fn>::call::h080867abcafb687f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 13: 0x599278dd32e3 - std::panicking::rust_panic_with_hook::h7e187ba6ef3a8505 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:836:13 [INFO] [stdout] 14: 0x599278dd2fba - std::panicking::begin_panic_handler::{{closure}}::h2160aaedd30b4698 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:701:13 [INFO] [stdout] 15: 0x599278dd1a79 - std::sys::backtrace::__rust_end_short_backtrace::h2544fe16c7a2009f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x599278dd2c4d - rust_begin_unwind [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:692:5 [INFO] [stdout] 17: 0x599278cdd320 - core::panicking::panic_fmt::h55d7693adb8e1cee [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x599278cdd796 - core::result::unwrap_failed::h630dfdc7f21633d0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/result.rs:1704:5 [INFO] [stdout] 19: 0x599278ce9f02 - core::result::Result::unwrap::h9e70cbd5b53c1f69 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/result.rs:1109:23 [INFO] [stdout] 20: 0x599278ce9f02 - timeouts::server_active_timeout::he51710cded3fb22c [INFO] [stdout] at /opt/rustwide/workdir/tests/timeouts.rs:210:5 [INFO] [stdout] 21: 0x599278ce9e67 - timeouts::server_active_timeout::{{closure}}::h179c8d0b42c3ee2b [INFO] [stdout] at /opt/rustwide/workdir/tests/timeouts.rs:146:27 [INFO] [stdout] 22: 0x599278ce6126 - core::ops::function::FnOnce::call_once::h8850ec182f8e8733 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x599278da15fb - core::ops::function::FnOnce::call_once::h42df3dc9a56fb705 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x599278da15fb - test::__rust_begin_short_backtrace::hf2ff4d4d12dd75b0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:632:18 [INFO] [stdout] 25: 0x599278da0483 - test::run_test_in_process::{{closure}}::h8461a23c6c0ac10c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:655:60 [INFO] [stdout] 26: 0x599278da0483 - as core::ops::function::FnOnce<()>>::call_once::hefab1bfcb42baf2e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 27: 0x599278da0483 - std::panicking::try::do_call::h75c82cb1133d19f1 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:584:40 [INFO] [stdout] 28: 0x599278da0483 - std::panicking::try::h41d68fc63841231a [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:547:19 [INFO] [stdout] 29: 0x599278da0483 - std::panic::catch_unwind::h7a7ff6adf9e0c698 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panic.rs:358:14 [INFO] [stdout] 30: 0x599278da0483 - test::run_test_in_process::hcd527530689ec177 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:655:27 [INFO] [stdout] 31: 0x599278da0483 - test::run_test::{{closure}}::h51ba581aac56ca21 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:576:43 [INFO] [stdout] 32: 0x599278d64185 - test::run_test::{{closure}}::h9d0d2581742c4e6c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:606:41 [INFO] [stdout] 33: 0x599278d64185 - std::sys::backtrace::__rust_begin_short_backtrace::h94b953e0285eca69 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 34: 0x599278d67c16 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hac891bfe52f0501a [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:564:17 [INFO] [stdout] 35: 0x599278d67c16 - as core::ops::function::FnOnce<()>>::call_once::hd4f76b3ef0615394 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 36: 0x599278d67c16 - std::panicking::try::do_call::h31b1a419f4fa670c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:584:40 [INFO] [stdout] 37: 0x599278d67c16 - std::panicking::try::h277e348adef7f0af [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:547:19 [INFO] [stdout] 38: 0x599278d67c16 - std::panic::catch_unwind::h06db5059e51a109d [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panic.rs:358:14 [INFO] [stdout] 39: 0x599278d67c16 - std::thread::Builder::spawn_unchecked_::{{closure}}::h048aed1b5c822396 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:562:30 [INFO] [stdout] 40: 0x599278d67c16 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9f03098da71d0b51 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 41: 0x599278dd72cb - as core::ops::function::FnOnce>::call_once::hcc221cc1d8cbbdc7 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 42: 0x599278dd72cb - as core::ops::function::FnOnce>::call_once::he5e5264a0dcd6e5f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 43: 0x599278dd72cb - std::sys::pal::unix::thread::Thread::new::thread_start::h307a072356a0dfca [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/pal/unix/thread.rs:106:17 [INFO] [stdout] 44: 0x798be9ecfac3 - [INFO] [stdout] 45: 0x798be9f60a04 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] server_active_timeout [INFO] [stdout] [INFO] [stdout] test result: FAILED. 3 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 25.05s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test timeouts` [INFO] running `Command { std: "docker" "inspect" "1e5bbff0c29a5ece8ec07d5cb11220d0653f6ca69fdcda2fdc8ca7a56e3b36c8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1e5bbff0c29a5ece8ec07d5cb11220d0653f6ca69fdcda2fdc8ca7a56e3b36c8", kill_on_drop: false }` [INFO] [stdout] 1e5bbff0c29a5ece8ec07d5cb11220d0653f6ca69fdcda2fdc8ca7a56e3b36c8