[INFO] fetching crate uflow 0.7.1...
[INFO] testing uflow-0.7.1 against 1.69.0 for beta-1.70-1
[INFO] extracting crate uflow 0.7.1 into /workspace/builds/worker-7-tc1/source
[INFO] validating manifest of crates.io crate uflow 0.7.1 on toolchain 1.69.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "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-tc1/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" "+1.69.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] df2837dc2f6ecbcc04728aeef4f13214da96ed678e677246f8b50d34f18b3c6f
[INFO] running `Command { std: "docker" "start" "-a" "df2837dc2f6ecbcc04728aeef4f13214da96ed678e677246f8b50d34f18b3c6f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "df2837dc2f6ecbcc04728aeef4f13214da96ed678e677246f8b50d34f18b3c6f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "df2837dc2f6ecbcc04728aeef4f13214da96ed678e677246f8b50d34f18b3c6f", kill_on_drop: false }`
[INFO] [stdout] df2837dc2f6ecbcc04728aeef4f13214da96ed678e677246f8b50d34f18b3c6f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bdf59694baa1ce8d287d83258c5a046475e2d9cd7a408a31a3f924c8c10aab93
[INFO] running `Command { std: "docker" "start" "-a" "bdf59694baa1ce8d287d83258c5a046475e2d9cd7a408a31a3f924c8c10aab93", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.102
[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] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.85s
[INFO] running `Command { std: "docker" "inspect" "bdf59694baa1ce8d287d83258c5a046475e2d9cd7a408a31a3f924c8c10aab93", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bdf59694baa1ce8d287d83258c5a046475e2d9cd7a408a31a3f924c8c10aab93", kill_on_drop: false }`
[INFO] [stdout] bdf59694baa1ce8d287d83258c5a046475e2d9cd7a408a31a3f924c8c10aab93
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e0eed1990c2572be473eab7787c1afd4a88c2aff996fed2a941a906c39bae17c
[INFO] running `Command { std: "docker" "start" "-a" "e0eed1990c2572be473eab7787c1afd4a88c2aff996fed2a941a906c39bae17c", kill_on_drop: false }`
[INFO] [stderr]    Compiling md5 v0.7.0
[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: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.81s
[INFO] running `Command { std: "docker" "inspect" "e0eed1990c2572be473eab7787c1afd4a88c2aff996fed2a941a906c39bae17c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e0eed1990c2572be473eab7787c1afd4a88c2aff996fed2a941a906c39bae17c", kill_on_drop: false }`
[INFO] [stdout] e0eed1990c2572be473eab7787c1afd4a88c2aff996fed2a941a906c39bae17c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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=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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 34c05f4759272e34af78d427e43b00498a3742e74e4c4dc6d9575c92b5b36bfb
[INFO] running `Command { std: "docker" "start" "-a" "34c05f4759272e34af78d427e43b00498a3742e74e4c4dc6d9575c92b5b36bfb", kill_on_drop: false }`
[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 test) generated 1 warning (run `cargo fix --lib -p uflow --tests` to apply 1 suggestion)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/uflow-1dfb0b31d12248b2)
[INFO] [stdout] 
[INFO] [stdout] running 78 tests
[INFO] [stdout] test frame::serial::crc::tests::zero_nonzero_crc ... ok
[INFO] [stdout] test frame::serial::crc::tests::basic ... 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::ack_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 half_connection::emit::tests::ack_min_one ... ok
[INFO] [stdout] test half_connection::emit::tests::ack_max_frame_size ... ok
[INFO] [stdout] test frame::serial::tests::ack_empty ... ok
[INFO] [stdout] test frame::serial::tests::data_empty ... ok
[INFO] [stdout] test half_connection::emit::tests::ack_size_limited ... ok
[INFO] [stdout] test half_connection::emit::tests::data_max_frame_size ... ok
[INFO] [stdout] test half_connection::frame_queue::tests::feedback_generation ... ok
[INFO] [stdout] test frame::serial::tests::handshake_syn_ack_basic ... ok
[INFO] [stdout] test frame::serial::crc::tests::random ... ok
[INFO] [stdout] test frame::serial::tests::sync_basic ... ok
[INFO] [stdout] test half_connection::frame_queue::tests::max_loss ... ok
[INFO] [stdout] test half_connection::packet_receiver::assembly_window::fragment_buffer::tests::multiple_fragments ... ok
[INFO] [stdout] test frame::serial::tests::handshake_syn_basic ... ok
[INFO] [stdout] test frame::serial::tests::data_basic ... 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::tests::basic ... ok
[INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::single_packet_single_fragment ... ok
[INFO] [stdout] test half_connection::frame_queue::tests::max_forget_cull ... ok
[INFO] [stdout] test half_connection::packet_receiver::assembly_window::fragment_buffer::tests::multiple_fragments_nonmultiple ... ok
[INFO] [stdout] test half_connection::emit::tests::data_window_limited ... ok
[INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::inconsistent_datagrams ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::channel_skip_received ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::basic_stall ... 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::emit::tests::data_size_limited ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::channel_stall ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::basic_skip ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::channel_ignore_old ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::fill_window_n_times ... ok
[INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::single_packet_multi_fragment ... ok
[INFO] [stdout] test half_connection::packet_tests::max_packet_transfer ... ignored
[INFO] [stdout] test half_connection::packet_receiver::tests::partial_advancement ... ok
[INFO] [stdout] test half_connection::packet_sender::tests::parent_leads ... ok
[INFO] [stdout] test half_connection::packet_sender::tests::basic ... ok
[INFO] [stdout] test half_connection::packet_sender::tests::alloc_size_correct ... 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::reorder_buffer::tests::advance_1_ack ... 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::reorder_buffer::tests::ack_1_ack ... ok
[INFO] [stdout] test half_connection::reorder_buffer::tests::advance_0_acks ... ok
[INFO] [stdout] test half_connection::packet_sender::tests::parent_leads_acknowledgement ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::full_advancement ... ok
[INFO] [stdout] test half_connection::tests::basic_send ... ok
[INFO] [stdout] test half_connection::send_rate::tests::tcp_throughput_inverse ... ok
[INFO] [stdout] test half_connection::tests::keepalive_timing ... 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::sync_frame_and_packet_window ... ok
[INFO] [stdout] test half_connection::tests::max_frame_size ... ok
[INFO] [stdout] test half_connection::tests::no_resend_after_ack ... ok
[INFO] [stdout] test half_connection::tests::sync_response ... ok
[INFO] [stdout] test half_connection::reorder_buffer::tests::max_span ... ok
[INFO] [stdout] test half_connection::packet_receiver::tests::max_stall ... ok
[INFO] [stdout] test half_connection::tests::resend_timing ... ok
[INFO] [stdout] test half_connection::tests::no_resend_after_packet_skip ... ok
[INFO] [stdout] test half_connection::tests::sync_packet_window_only ... ok
[INFO] [stdout] test half_connection::tests::time_sensitive_drop ... ok
[INFO] [stdout] test half_connection::packet_receiver::assembly_window::tests::alloc_counter ... ok
[INFO] [stdout] test half_connection::frame_queue::tests::max_window_advance_cull ... 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 half_connection::tests::packet_unambiguity ... ok
[INFO] [stdout] test frame::serial::tests::data_random ... ok
[INFO] [stdout] test half_connection::packet_receiver::assembly_window::fragment_buffer::tests::max_fragments ... ok
[INFO] [stdout] test frame::serial::tests::crc_flips ... ok
[INFO] [stdout] test half_connection::packet_tests::single_packet_max_alloc ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 75 passed; 0 failed; 3 ignored; 0 measured; 0 filtered out; finished in 5.72s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/disconnect.rs (/opt/rustwide/target/debug/deps/disconnect-0ae60bd62a623250)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test server_disconnect_now ... ok
[INFO] [stdout] test client_disconnect_flush ... ok
[INFO] [stdout] test server_disconnect_flush ... ok
[INFO] [stdout] test client_disconnect_now ... ok
[INFO] [stderr]      Running tests/ideal_transfer.rs (/opt/rustwide/target/debug/deps/ideal_transfer-4a2ea8998b5f9327)
[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] [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.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/reliable_transfer.rs (/opt/rustwide/target/debug/deps/reliable_transfer-2e67ebffa1a7745e)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test reliable_transfer ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.14s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/timeouts.rs (/opt/rustwide/target/debug/deps/timeouts-a108523fe566d505)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test client_active_timeout ... ok
[INFO] [stdout] test server_active_timeout ... FAILED
[INFO] [stdout] test server_handshake_timeout ... ok
[INFO] [stdout] test client_handshake_timeout ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- server_active_timeout stdout ----
[INFO] [stdout] thread '<unnamed>' panicked at 'no timeout event received', tests/timeouts.rs:206:13
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x555d7248e35a - std::backtrace_rs::backtrace::libunwind::trace::ha9053a9a07ca49cb
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x555d7248e35a - std::backtrace_rs::backtrace::trace_unsynchronized::h9c2852a457ad564e
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x555d7248e35a - std::sys_common::backtrace::_print_fmt::h457936fbfaa0070f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:65:5
[INFO] [stdout]    3:     0x555d7248e35a - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h5779d7bf7f70cb0c
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x555d724b4efe - core::fmt::write::h5a4baaff1bcd3eb5
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/fmt/mod.rs:1232:17
[INFO] [stdout]    5:     0x555d7248b1f5 - std::io::Write::write_fmt::h478f79c628ef31d1
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/io/mod.rs:1684:15
[INFO] [stdout]    6:     0x555d7248e125 - std::sys_common::backtrace::_print::h5fcdc36060f177e8
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    7:     0x555d7248e125 - std::sys_common::backtrace::print::h54ca9458b876c8bf
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    8:     0x555d7248feef - std::panicking::default_hook::{{closure}}::hbe471161c7664ed6
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:271:22
[INFO] [stdout]    9:     0x555d7248fbaf - std::panicking::default_hook::ha3500da57aa4ac4f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:287:9
[INFO] [stdout]   10:     0x555d72462077 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hdf1b89dd137ece34
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:2001:9
[INFO] [stdout]   11:     0x555d72462077 - test::test_main::{{closure}}::h9081a79f20e75698
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:135:21
[INFO] [stdout]   12:     0x555d7249061d - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6507bddc3eebb4a5
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:2001:9
[INFO] [stdout]   13:     0x555d7249061d - std::panicking::rust_panic_with_hook::h50c09d000dc561d2
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:696:13
[INFO] [stdout]   14:     0x555d723eba7a - std::panicking::begin_panic::{{closure}}::h401889cb721d7932
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:612:9
[INFO] [stdout]   15:     0x555d723b948a - std::sys_common::backtrace::__rust_end_short_backtrace::h9b95aa85ff13146a
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:150:18
[INFO] [stdout]   16:     0x555d723eb9c0 - std::panicking::begin_panic::hd452d6d26c006a58
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:611:12
[INFO] [stdout]   17:     0x555d7239dcf7 - timeouts::server_active_timeout::{{closure}}::h80184b12e76bbe56
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/timeouts.rs:206:13
[INFO] [stdout]   18:     0x555d7239f099 - std::sys_common::backtrace::__rust_begin_short_backtrace::h8443ecc58f0c4a29
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:134:18
[INFO] [stdout]   19:     0x555d72395c66 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::he9ee7003de2f8db1
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/thread/mod.rs:560:17
[INFO] [stdout]   20:     0x555d72398689 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h682f82b74364ec92
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   21:     0x555d7239b60a - std::panicking::try::do_call::h9f2ee39440a088b2
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:487:40
[INFO] [stdout]   22:     0x555d7239b94b - __rust_try
[INFO] [stdout]   23:     0x555d7239b3a6 - std::panicking::try::h991751793592acbf
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:451:19
[INFO] [stdout]   24:     0x555d72398736 - std::panic::catch_unwind::hb158b175293dd7c9
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panic.rs:140:14
[INFO] [stdout]   25:     0x555d72395a97 - std::thread::Builder::spawn_unchecked_::{{closure}}::hf5d01330dfefaa78
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   26:     0x555d72396dae - core::ops::function::FnOnce::call_once{{vtable.shim}}::h53e1ca63de772f40
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x555d72494b23 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h39990b24eedef2ab
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   28:     0x555d72494b23 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h01a027258444143b
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   29:     0x555d72494b23 - std::sys::unix::thread::Thread::new::thread_start::ha4f1cdd9c25884ba
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   30:     0x7f0cc251cb43 - <unknown>
[INFO] [stdout]   31:     0x7f0cc25adbb4 - __clone
[INFO] [stdout]   32:                0x0 - <unknown>
[INFO] [stdout] thread 'server_active_timeout' panicked at 'called `Result::unwrap()` on an `Err` value: Any { .. }', tests/timeouts.rs:210:19
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x555d7248e35a - std::backtrace_rs::backtrace::libunwind::trace::ha9053a9a07ca49cb
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x555d7248e35a - std::backtrace_rs::backtrace::trace_unsynchronized::h9c2852a457ad564e
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x555d7248e35a - std::sys_common::backtrace::_print_fmt::h457936fbfaa0070f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:65:5
[INFO] [stdout]    3:     0x555d7248e35a - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h5779d7bf7f70cb0c
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x555d724b4efe - core::fmt::write::h5a4baaff1bcd3eb5
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/fmt/mod.rs:1232:17
[INFO] [stdout]    5:     0x555d7248b1f5 - std::io::Write::write_fmt::h478f79c628ef31d1
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/io/mod.rs:1684:15
[INFO] [stdout]    6:     0x555d7248e125 - std::sys_common::backtrace::_print::h5fcdc36060f177e8
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    7:     0x555d7248e125 - std::sys_common::backtrace::print::h54ca9458b876c8bf
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    8:     0x555d7248feef - std::panicking::default_hook::{{closure}}::hbe471161c7664ed6
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:271:22
[INFO] [stdout]    9:     0x555d7248fbaf - std::panicking::default_hook::ha3500da57aa4ac4f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:287:9
[INFO] [stdout]   10:     0x555d72462077 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hdf1b89dd137ece34
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:2001:9
[INFO] [stdout]   11:     0x555d72462077 - test::test_main::{{closure}}::h9081a79f20e75698
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:135:21
[INFO] [stdout]   12:     0x555d7249061d - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6507bddc3eebb4a5
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:2001:9
[INFO] [stdout]   13:     0x555d7249061d - std::panicking::rust_panic_with_hook::h50c09d000dc561d2
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:696:13
[INFO] [stdout]   14:     0x555d72490399 - std::panicking::begin_panic_handler::{{closure}}::h9e2b2176e00e0d9c
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:583:13
[INFO] [stdout]   15:     0x555d7248e7c6 - std::sys_common::backtrace::__rust_end_short_backtrace::h5739b8e512c09d02
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:150:18
[INFO] [stdout]   16:     0x555d724900a2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:579:5
[INFO] [stdout]   17:     0x555d72391153 - core::panicking::panic_fmt::hf33a1475b4dc5c3e
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panicking.rs:64:14
[INFO] [stdout]   18:     0x555d723915a3 - core::result::unwrap_failed::hdff5465d74574b44
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/result.rs:1750:5
[INFO] [stdout]   19:     0x555d72397ddc - core::result::Result<T,E>::unwrap::h54541ff9a3188bf8
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/result.rs:1090:23
[INFO] [stdout]   20:     0x555d7239d2a8 - timeouts::server_active_timeout::hbfc73bf7cfaedee7
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/timeouts.rs:210:5
[INFO] [stdout]   21:     0x555d7239d237 - timeouts::server_active_timeout::{{closure}}::h5f89ef00104fb806
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/timeouts.rs:146:28
[INFO] [stdout]   22:     0x555d72396f45 - core::ops::function::FnOnce::call_once::h99f659eb7d972301
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x555d7246745f - core::ops::function::FnOnce::call_once::h7d969581be7d0075
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x555d7246745f - test::__rust_begin_short_backtrace::hca25a52684e56655
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:656:18
[INFO] [stdout]   25:     0x555d72438a7c - test::run_test::{{closure}}::ha8ac744c4af1a4bb
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:647:30
[INFO] [stdout]   26:     0x555d72438a7c - core::ops::function::FnOnce::call_once{{vtable.shim}}::h7b411a9ed45bdecf
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x555d72466426 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hd05328869a8ed200
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   28:     0x555d72466426 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0c601ce20bd5b2be
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   29:     0x555d72466426 - std::panicking::try::do_call::ha4be5c164fe30854
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:487:40
[INFO] [stdout]   30:     0x555d72466426 - std::panicking::try::h604546f3609af05f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:451:19
[INFO] [stdout]   31:     0x555d72466426 - std::panic::catch_unwind::h5bfa8afe44c9c2f9
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panic.rs:140:14
[INFO] [stdout]   32:     0x555d72466426 - test::run_test_in_process::hd50dee55dd63e6aa
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:679:27
[INFO] [stdout]   33:     0x555d72466426 - test::run_test::run_test_inner::{{closure}}::h4aa0f433aa85cea8
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:573:39
[INFO] [stdout]   34:     0x555d724330f1 - test::run_test::run_test_inner::{{closure}}::had56431adf24b4d6
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:600:37
[INFO] [stdout]   35:     0x555d724330f1 - std::sys_common::backtrace::__rust_begin_short_backtrace::ha8d9890e0c73bf13
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:134:18
[INFO] [stdout]   36:     0x555d72438b0b - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h251832bcb4a95327
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/thread/mod.rs:560:17
[INFO] [stdout]   37:     0x555d72438b0b - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h8fdff598fa414831
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   38:     0x555d72438b0b - std::panicking::try::do_call::h455dd2f7764a950f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:487:40
[INFO] [stdout]   39:     0x555d72438b0b - std::panicking::try::had6f23b7b73ae72a
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:451:19
[INFO] [stdout]   40:     0x555d72438b0b - std::panic::catch_unwind::ha6a5ca3915b4dad0
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panic.rs:140:14
[INFO] [stdout]   41:     0x555d72438b0b - std::thread::Builder::spawn_unchecked_::{{closure}}::h883b72ef75da6231
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   42:     0x555d72438b0b - core::ops::function::FnOnce::call_once{{vtable.shim}}::hb7dff73dc8bd2ccb
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x555d72494b23 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h39990b24eedef2ab
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   44:     0x555d72494b23 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h01a027258444143b
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   45:     0x555d72494b23 - std::sys::unix::thread::Thread::new::thread_start::ha4f1cdd9c25884ba
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   46:     0x7f0cc251cb43 - <unknown>
[INFO] [stdout]   47:     0x7f0cc25adbb4 - __clone
[INFO] [stdout]   48:                0x0 - <unknown>
[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.03s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test timeouts`
[INFO] running `Command { std: "docker" "inspect" "34c05f4759272e34af78d427e43b00498a3742e74e4c4dc6d9575c92b5b36bfb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "34c05f4759272e34af78d427e43b00498a3742e74e4c4dc6d9575c92b5b36bfb", kill_on_drop: false }`
[INFO] [stdout] 34c05f4759272e34af78d427e43b00498a3742e74e4c4dc6d9575c92b5b36bfb
