[INFO] fetching crate sctp-async 0.0.0... [INFO] testing sctp-async-0.0.0 against try#a7ee93192a766fb0dafa23def7154fc03cfcfc3e for pr-146989 [INFO] extracting crate sctp-async 0.0.0 into /workspace/builds/worker-3-tc2/source [INFO] started tweaking crates.io crate sctp-async 0.0.0 [INFO] removed 0 missing examples [INFO] finished tweaking crates.io crate sctp-async 0.0.0 [INFO] tweaked toml for crates.io crate sctp-async 0.0.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml [INFO] validating manifest of crates.io crate sctp-async 0.0.0 on toolchain a7ee93192a766fb0dafa23def7154fc03cfcfc3e [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate sctp-async 0.0.0 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" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 73b155e045767a14cb85d2e1e55c31ae2d66ffa9fedf33b7a18b5d2b8a2d1437 [INFO] running `Command { std: "docker" "start" "-a" "73b155e045767a14cb85d2e1e55c31ae2d66ffa9fedf33b7a18b5d2b8a2d1437", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "73b155e045767a14cb85d2e1e55c31ae2d66ffa9fedf33b7a18b5d2b8a2d1437", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "73b155e045767a14cb85d2e1e55c31ae2d66ffa9fedf33b7a18b5d2b8a2d1437", kill_on_drop: false }` [INFO] [stdout] 73b155e045767a14cb85d2e1e55c31ae2d66ffa9fedf33b7a18b5d2b8a2d1437 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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=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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7a70f793d73957968336cd6465d7ed13238871c585746c73067fd0e7028c62a1 [INFO] running `Command { std: "docker" "start" "-a" "7a70f793d73957968336cd6465d7ed13238871c585746c73067fd0e7028c62a1", kill_on_drop: false }` [INFO] [stderr] Compiling libc v0.2.107 [INFO] [stderr] Compiling proc-macro2 v1.0.32 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.81 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling parking_lot_core v0.8.5 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling instant v0.1.12 [INFO] [stderr] Compiling smallvec v1.7.0 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling lock_api v0.4.5 [INFO] [stderr] Compiling memoffset v0.6.4 [INFO] [stderr] Compiling tokio v1.13.0 [INFO] [stderr] Compiling async-trait v0.1.51 [INFO] [stderr] Compiling cc v1.0.72 [INFO] [stderr] Compiling ppv-lite86 v0.2.15 [INFO] [stderr] Compiling once_cell v1.8.0 [INFO] [stderr] Compiling pin-project-lite v0.2.7 [INFO] [stderr] Compiling crc-catalog v1.1.1 [INFO] [stderr] Compiling ipnet v2.3.1 [INFO] [stderr] Compiling crc v2.1.0 [INFO] [stderr] Compiling quote v1.0.10 [INFO] [stderr] Compiling webrtc-util v0.5.2 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling mio v0.7.14 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling nix v0.23.0 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling parking_lot v0.11.2 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling tokio-macros v1.5.1 [INFO] [stderr] Compiling thiserror-impl v1.0.30 [INFO] [stderr] Compiling thiserror v1.0.30 [INFO] [stderr] Compiling sctp-async v0.0.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 33.27s [INFO] running `Command { std: "docker" "inspect" "7a70f793d73957968336cd6465d7ed13238871c585746c73067fd0e7028c62a1", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7a70f793d73957968336cd6465d7ed13238871c585746c73067fd0e7028c62a1", kill_on_drop: false }` [INFO] [stdout] 7a70f793d73957968336cd6465d7ed13238871c585746c73067fd0e7028c62a1 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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=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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 340af29622db9372ef7832e279a03fc7b4df4d72da517b5061345d95b7038e0a [INFO] running `Command { std: "docker" "start" "-a" "340af29622db9372ef7832e279a03fc7b4df4d72da517b5061345d95b7038e0a", kill_on_drop: false }` [INFO] [stderr] Compiling futures-core v0.3.17 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling async-stream-impl v0.3.2 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling ansi_term v0.11.0 [INFO] [stderr] Compiling termcolor v1.1.2 [INFO] [stderr] Compiling tokio-stream v0.1.8 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling async-stream v0.3.2 [INFO] [stderr] Compiling tokio-test v0.4.2 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling env_logger v0.9.0 [INFO] [stderr] Compiling sctp-async v0.0.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 34.37s [INFO] running `Command { std: "docker" "inspect" "340af29622db9372ef7832e279a03fc7b4df4d72da517b5061345d95b7038e0a", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "340af29622db9372ef7832e279a03fc7b4df4d72da517b5061345d95b7038e0a", kill_on_drop: false }` [INFO] [stdout] 340af29622db9372ef7832e279a03fc7b4df4d72da517b5061345d95b7038e0a [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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=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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+a7ee93192a766fb0dafa23def7154fc03cfcfc3e" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 55b5a82b04d0f734b17296f4bd6ab2dfcaa39bd788d36c674f8dae37622236b8 [INFO] running `Command { std: "docker" "start" "-a" "55b5a82b04d0f734b17296f4bd6ab2dfcaa39bd788d36c674f8dae37622236b8", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.17s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sctp_async-035745dd50350c12) [INFO] [stdout] [INFO] [stdout] running 119 tests [INFO] [stdout] test association::association_internal::association_internal_test::test_assoc_handle_init ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_assoc_max_message_size_explicit ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_assoc_max_message_size_default ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_assoc_create_new_stream ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_create_forward_tsn_forward_one_abandoned ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_create_forward_tsn_forward_two_abandoned_with_the_same_si ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_handle_forward_tsn_dup_forward_tsn_chunk_should_generate_sack ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_handle_forward_tsn_forward_1for1_missing ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_handle_forward_tsn_forward_1for2_missing ... ok [INFO] [stdout] test association::association_internal::association_internal_test::test_handle_forward_tsn_forward_3unreceived_chunks ... ok [INFO] [stdout] test association::association_test::test_assoc_abort ... ok [INFO] [stdout] test association::association_test::test_assoc_reliable_ordered_reordered ... ok [INFO] [stdout] test association::association_test::test_assoc_reliable_ordered_fragmented_then_defragmented ... ok [INFO] [stdout] test association::association_test::test_assoc_reliable_short_buffer ... ok [INFO] [stdout] test association::association_test::test_assoc_reliable_unordered_fragmented_then_defragmented ... ok [INFO] [stdout] test association::association_test::test_assoc_reset_close_both_ways ... ok [INFO] [stdout] test association::association_test::test_assoc_reset_close_one_way ... ok [INFO] [stdout] test association::association_test::test_assoc_reliable_retransmission ... ok [INFO] [stdout] test association::association_test::test_assoc_reliable_simple ... ok [INFO] [stdout] test association::association_test::test_assoc_unreliable_rexmit_ordered_fragment ... ok [INFO] [stdout] test association::association_test::test_assoc_reliable_unordered_ordered ... ok [INFO] [stdout] test association::association_test::test_assoc_unreliable_rexmit_ordered_no_fragment ... ok [INFO] [stdout] test association::association_test::test_assoc_unreliable_rexmit_timed_ordered ... ok [INFO] [stdout] test association::association_test::test_assoc_unreliable_rexmit_timed_unordered ... ok [INFO] [stdout] test association::association_test::test_assoc_unreliable_rexmit_unordered_no_fragment ... ok [INFO] [stdout] test association::association_test::test_stats ... ok [INFO] [stdout] test chunk::chunk_test::test_abort_chunk_many_error_causes ... ok [INFO] [stdout] test chunk::chunk_test::test_abort_chunk_one_error_cause ... ok [INFO] [stdout] test chunk::chunk_test::test_chrome_chunk1_init ... ok [INFO] [stdout] test chunk::chunk_test::test_chrome_chunk2_init_ack ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_error_unrecognized_chunk_type_marshal ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_error_unrecognized_chunk_type_marshal_with_cause_value_being_nil ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_error_unrecognized_chunk_type_unmarshal ... ok [INFO] [stdout] test association::association_test::test_association_shutdown ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_forward_tsn_unmarshal_failure ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_reconfig_success ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_reconfig_unmarshal_failure ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_shutdown_ack_failure ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_shutdown_ack_success ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_shutdown_complete_failure ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_shutdown_complete_success ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_shutdown_failure ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_shutdown_success ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_type_string ... ok [INFO] [stdout] test chunk::chunk_test::test_forward_tsn_chunk ... ok [INFO] [stdout] test chunk::chunk_test::test_init_ack ... ok [INFO] [stdout] test chunk::chunk_test::test_init_chunk ... ok [INFO] [stdout] test chunk::chunk_test::test_chunk_forward_tsn_success ... ok [INFO] [stdout] test chunk::chunk_test::test_init_marshal_unmarshal ... ok [INFO] [stdout] test chunk::chunk_test::test_payload_data_marshal_unmarshal ... ok [INFO] [stdout] test chunk::chunk_test::test_reconfig_chunk ... ok [INFO] [stdout] test chunk::chunk_test::test_select_ack_chunk ... ok [INFO] [stdout] test chunk::chunk_type::test::test_chunk_type_string ... ok [INFO] [stdout] test packet::test::test_packet_marshal ... ok [INFO] [stdout] test packet::test::test_packet_unmarshal ... ok [INFO] [stdout] test param::param_test::test_build_param_failure ... ok [INFO] [stdout] test param::param_test::test_build_param_success ... ok [INFO] [stdout] test param::param_test::test_param_forward_tsn_supported_failure ... ok [INFO] [stdout] test param::param_test::test_param_forward_tsn_supported_success ... ok [INFO] [stdout] test param::param_test::test_param_header_success ... ok [INFO] [stdout] test param::param_test::test_param_header_unmarshal_failure ... ok [INFO] [stdout] test param::param_test::test_param_outgoing_reset_request_failure ... ok [INFO] [stdout] test chunk::chunk_test::test_select_ack_chunk_followed_by_a_payload_data_chunk ... ok [INFO] [stdout] test param::param_test::test_param_outgoing_reset_request_success ... ok [INFO] [stdout] test param::param_test::test_param_reconfig_response_failure ... ok [INFO] [stdout] test param::param_test::test_param_reconfig_response_success ... ok [INFO] [stdout] test param::param_test::test_parse_param_type_success ... ok [INFO] [stdout] test param::param_test::test_reconfig_result_stringer ... ok [INFO] [stdout] test queue::queue_test::test_chunk_set_empty_chunk_set ... ok [INFO] [stdout] test queue::queue_test::test_chunk_set_incomplete_chunk_set_no_beginning ... ok [INFO] [stdout] test queue::queue_test::test_chunk_set_incomplete_chunk_set_no_contiguous_tsn ... ok [INFO] [stdout] test queue::queue_test::test_chunk_set_push_dup_chunks_to_chunk_set ... ok [INFO] [stdout] test queue::queue_test::test_payload_queue_get_gap_ack_block ... ok [INFO] [stdout] test queue::queue_test::test_payload_queue_get_last_tsn_received ... ok [INFO] [stdout] test queue::queue_test::test_payload_queue_mark_all_to_retrasmit ... ok [INFO] [stdout] test queue::queue_test::test_payload_queue_reset_retransmit_flag_on_ack ... ok [INFO] [stdout] test queue::queue_test::test_payload_queue_push_no_check ... ok [INFO] [stdout] test queue::queue_test::test_pending_base_queue_out_of_bounce ... ok [INFO] [stdout] test queue::queue_test::test_pending_base_queue_push_and_pop ... ok [INFO] [stdout] test queue::queue_test::test_pending_queue_push_and_pop ... ok [INFO] [stdout] test queue::queue_test::test_pending_queue_selection_persistence ... ok [INFO] [stdout] test queue::queue_test::test_pending_queue_unordered_wins ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_detect_buffer_too_short ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_forward_tsn_for_ordered_framents ... ok [INFO] [stdout] test queue::queue_test::test_pending_queue_fragments ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_forward_tsn_for_unordered_framents ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_ignores_chunk_with_stale_ssn ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_ignores_chunk_with_wrong_si ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_ordered_and_unordered_fragments ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_ordered_fragments ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_should_fail_to_read_if_the_nex_ssn_is_not_ready ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_unordered_complete_skips_incomplete ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_unordered_fragments ... ok [INFO] [stdout] test stream::stream_test::test_stream_amount_on_buffered_amount_low ... ok [INFO] [stdout] test stream::stream_test::test_stream_buffered_amount ... ok [INFO] [stdout] test queue::queue_test::test_reassembly_queue_should_fail_to_read_incomplete_chunk ... ok [INFO] [stdout] test timer::timer_test::test_rto_manager::test_rto_manager_calculate_next_timeout ... ok [INFO] [stdout] test timer::timer_test::test_rto_manager::test_rto_manager_initial_values ... ok [INFO] [stdout] test timer::timer_test::test_rto_manager::test_rto_manager_reset ... ok [INFO] [stdout] test timer::timer_test::test_rto_manager::test_rto_manager_rto_calculation_large_rtt ... ok [INFO] [stdout] test timer::timer_test::test_rto_manager::test_rto_manager_rto_calculation_small_rtt ... ok [INFO] [stdout] test association::association_test::test_association_shutdown_during_write ... ok [INFO] [stdout] test timer::timer_test::test_ack_timer::test_ack_timer_start_and_stop ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_last_start_wins ... ok [INFO] [stdout] test association::association_test::test_assoc_congestion_control_fast_retransmission ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_closed_timer_wont_start ... ok [INFO] [stdout] test association::association_test::test_assoc_unreliable_rexmit_unordered_fragment ... FAILED [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_start_and_stop_in_atight_loop ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_start_stop_then_start ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_stop_timer_that_is_not_running_is_noop ... ok [INFO] [stdout] test util::test::test_serial_number_arithmetic16bit ... ok [INFO] [stdout] test util::test::test_serial_number_arithmetic32bit ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_stop_right_after_start ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_callback_interval ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_should_not_stop_if_max_retrans_is_zero ... ok [INFO] [stdout] test association::association_test::test_association_handle_packet_before_init ... ok [INFO] [stdout] test timer::timer_test::test_rtx_timer::test_rtx_timer_should_stop_after_rtx_failure ... ok [INFO] [stdout] test association::association_test::test_assoc_congestion_control_slow_reader ... ok [INFO] [stdout] test association::association_test::test_assoc_congestion_control_congestion_avoidance ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- association::association_test::test_assoc_unreliable_rexmit_unordered_fragment stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'association::association_test::test_assoc_unreliable_rexmit_unordered_fragment' (43) panicked at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/alloc/src/collections/vec_deque/mod.rs:1822:36: [INFO] [stdout] range end index 2 out of range for slice of length 0 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5585cd434732 - std[b14e17aa63033746]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5585cd434732 - std[b14e17aa63033746]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5585cd434732 - std[b14e17aa63033746]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5585cd434732 - <::print::DisplayBacktrace as core[7ebf52c056bd56a4]::fmt::Display>::fmt [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5585cd44b12a - ::fmt [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5585cd44b12a - core[7ebf52c056bd56a4]::fmt::write [INFO] [stdout] 6: 0x5585cd439856 - std[b14e17aa63033746]::io::default_write_fmt::> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5585cd439856 - as std[b14e17aa63033746]::io::Write>::write_fmt [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x5585cd4120df - ::print [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5585cd4120df - std[b14e17aa63033746]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5585cd42c639 - std[b14e17aa63033746]::panicking::default_hook [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5585cd2bacde - core[7ebf52c056bd56a4]::ops::function::Fn<(&'a std[b14e17aa63033746]::panic::PanicHookInfo<'b>,), Output = ()> + core[7ebf52c056bd56a4]::marker::Send + core[7ebf52c056bd56a4]::marker::Sync> as core[7ebf52c056bd56a4]::ops::function::Fn<(&std[b14e17aa63033746]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 12: 0x5585cd2bacde - test[3318909d72adbd73]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5585cd42c8a2 - core[7ebf52c056bd56a4]::ops::function::Fn<(&'a std[b14e17aa63033746]::panic::PanicHookInfo<'b>,), Output = ()> + core[7ebf52c056bd56a4]::marker::Send + core[7ebf52c056bd56a4]::marker::Sync> as core[7ebf52c056bd56a4]::ops::function::Fn<(&std[b14e17aa63033746]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 14: 0x5585cd42c8a2 - std[b14e17aa63033746]::panicking::panic_with_hook [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5585cd412198 - std[b14e17aa63033746]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5585cd409bc9 - std[b14e17aa63033746]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5585cd412fed - __rustc[f8abce35e9738d16]::rust_begin_unwind [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5585cd44b89c - core[7ebf52c056bd56a4]::panicking::panic_fmt [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5585cd44c398 - core[7ebf52c056bd56a4]::slice::index::slice_index_fail [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/panic.rs:177:9 [INFO] [stdout] 20: 0x5585cd363daa - core[7ebf52c056bd56a4]::slice::index::range::> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/slice/index.rs:919:52 [INFO] [stdout] 21: 0x5585cd237c4b - >::drain::> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/alloc/src/collections/vec_deque/mod.rs:1822:36 [INFO] [stdout] 22: 0x5585cd200d17 - ::drop_offset::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/webrtc-util-0.5.2/src/conn/conn_bridge.rs:164:15 [INFO] [stdout] 23: 0x5585cd0f6057 - sctp_async[7a50341ef0ed6092]::association::association_test::test_assoc_unreliable_rexmit_unordered_fragment::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/src/association/association_test.rs:1073:29 [INFO] [stdout] 24: 0x5585cd135ddb - as core[7ebf52c056bd56a4]::future::future::Future>::poll [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/future/future.rs:133:9 [INFO] [stdout] 25: 0x5585cd0a44db - >::block_on::>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/basic_scheduler.rs:228:78 [INFO] [stdout] 26: 0x5585cd1e9a4a - tokio[60ba2ad8eecc06b7]::coop::with_budget::>, >::block_on>::{closure#0}::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/coop.rs:106:9 [INFO] [stdout] 27: 0x5585cd0b5672 - >>::try_with::>, >::block_on>::{closure#0}::{closure#0}>::{closure#0}, core[7ebf52c056bd56a4]::task::poll::Poll>> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/thread/local.rs:513:12 [INFO] [stdout] 28: 0x5585cd0aaadc - >>::with::>, >::block_on>::{closure#0}::{closure#0}>::{closure#0}, core[7ebf52c056bd56a4]::task::poll::Poll>> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/thread/local.rs:477:20 [INFO] [stdout] 29: 0x5585cd085f7b - tokio[60ba2ad8eecc06b7]::coop::with_budget::>, >::block_on>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/coop.rs:99:13 [INFO] [stdout] 30: 0x5585cd085f7b - tokio[60ba2ad8eecc06b7]::coop::budget::>, >::block_on>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/coop.rs:76:5 [INFO] [stdout] 31: 0x5585cd085f7b - >::block_on::>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/basic_scheduler.rs:228:39 [INFO] [stdout] 32: 0x5585cd0a2a21 - tokio[60ba2ad8eecc06b7]::runtime::basic_scheduler::enter::<>::block_on>::{closure#0}, core[7ebf52c056bd56a4]::result::Result<(), sctp_async[7a50341ef0ed6092]::error::Error>, tokio[60ba2ad8eecc06b7]::runtime::driver::Driver>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/basic_scheduler.rs:337:29 [INFO] [stdout] 33: 0x5585cd2393ca - >::set::>::block_on>::{closure#0}, core[7ebf52c056bd56a4]::result::Result<(), sctp_async[7a50341ef0ed6092]::error::Error>, tokio[60ba2ad8eecc06b7]::runtime::driver::Driver>::{closure#0}, core[7ebf52c056bd56a4]::result::Result<(), sctp_async[7a50341ef0ed6092]::error::Error>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/macros/scoped_tls.rs:61:9 [INFO] [stdout] 34: 0x5585cd073645 - tokio[60ba2ad8eecc06b7]::runtime::basic_scheduler::enter::<>::block_on>::{closure#0}, core[7ebf52c056bd56a4]::result::Result<(), sctp_async[7a50341ef0ed6092]::error::Error>, tokio[60ba2ad8eecc06b7]::runtime::driver::Driver> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/basic_scheduler.rs:337:13 [INFO] [stdout] 35: 0x5585cd05d88a - >::block_on::> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/basic_scheduler.rs:218:9 [INFO] [stdout] 36: 0x5585cd06310d - >::block_on::> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/basic_scheduler.rs:489:38 [INFO] [stdout] 37: 0x5585cd0686ba - >::block_on:: [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/basic_scheduler.rs:178:30 [INFO] [stdout] 38: 0x5585cd1cae4f - ::block_on:: [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.13.0/src/runtime/mod.rs:461:51 [INFO] [stdout] 39: 0x5585cd109a5e - sctp_async[7a50341ef0ed6092]::association::association_test::test_assoc_unreliable_rexmit_unordered_fragment [INFO] [stdout] at /opt/rustwide/workdir/src/association/association_test.rs:1108:7 [INFO] [stdout] 40: 0x5585cd0cd8ed - sctp_async[7a50341ef0ed6092]::association::association_test::test_assoc_unreliable_rexmit_unordered_fragment::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/src/association/association_test.rs:1019:63 [INFO] [stdout] 41: 0x5585cd02df56 - >::call_once [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 42: 0x5585cd2af08b - core[7ebf52c056bd56a4]::result::Result<(), alloc[ed4a2d6a5f8966cc]::string::String> as core[7ebf52c056bd56a4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 43: 0x5585cd2af08b - test[3318909d72adbd73]::__rust_begin_short_backtrace::, fn() -> core[7ebf52c056bd56a4]::result::Result<(), alloc[ed4a2d6a5f8966cc]::string::String>> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/test/src/lib.rs:663:18 [INFO] [stdout] 44: 0x5585cd2bb8ea - test[3318909d72adbd73]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/test/src/lib.rs:686:74 [INFO] [stdout] 45: 0x5585cd2bb8ea - as core[7ebf52c056bd56a4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 46: 0x5585cd2bb8ea - std[b14e17aa63033746]::panicking::catch_unwind::do_call::, core[7ebf52c056bd56a4]::result::Result<(), alloc[ed4a2d6a5f8966cc]::string::String>> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:581:40 [INFO] [stdout] 47: 0x5585cd2bb8ea - std[b14e17aa63033746]::panicking::catch_unwind::, core[7ebf52c056bd56a4]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:544:19 [INFO] [stdout] 48: 0x5585cd2bb8ea - std[b14e17aa63033746]::panic::catch_unwind::, core[7ebf52c056bd56a4]::result::Result<(), alloc[ed4a2d6a5f8966cc]::string::String>> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panic.rs:359:14 [INFO] [stdout] 49: 0x5585cd2bb8ea - test[3318909d72adbd73]::run_test_in_process [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/test/src/lib.rs:686:27 [INFO] [stdout] 50: 0x5585cd2bb8ea - test[3318909d72adbd73]::run_test::{closure#0} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/test/src/lib.rs:607:43 [INFO] [stdout] 51: 0x5585cd2b6e94 - test[3318909d72adbd73]::run_test::{closure#1} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/test/src/lib.rs:637:41 [INFO] [stdout] 52: 0x5585cd2b6e94 - std[b14e17aa63033746]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 53: 0x5585cd2be3e2 - std[b14e17aa63033746]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 54: 0x5585cd2be3e2 - ::{closure#1}::{closure#0}> as core[7ebf52c056bd56a4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 55: 0x5585cd2be3e2 - std[b14e17aa63033746]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:581:40 [INFO] [stdout] 56: 0x5585cd2be3e2 - std[b14e17aa63033746]::panicking::catch_unwind::<(), core[7ebf52c056bd56a4]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panicking.rs:544:19 [INFO] [stdout] 57: 0x5585cd2be3e2 - std[b14e17aa63033746]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/panic.rs:359:14 [INFO] [stdout] 58: 0x5585cd2be3e2 - std[b14e17aa63033746]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 59: 0x5585cd2be3e2 - ::{closure#1} as core[7ebf52c056bd56a4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 60: 0x5585cd433edf - + core[7ebf52c056bd56a4]::marker::Send> as core[7ebf52c056bd56a4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/alloc/src/boxed.rs:2206:9 [INFO] [stdout] 61: 0x5585cd433edf - ::new::thread_start [INFO] [stdout] at /rustc/a7ee93192a766fb0dafa23def7154fc03cfcfc3e/library/std/src/sys/thread/unix.rs:127:17 [INFO] [stdout] 62: 0x7dfe9de66aa4 - [INFO] [stdout] 63: 0x7dfe9def3a64 - clone [INFO] [stdout] 64: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] association::association_test::test_assoc_unreliable_rexmit_unordered_fragment [INFO] [stdout] [INFO] [stdout] test result: FAILED. 118 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.68s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "55b5a82b04d0f734b17296f4bd6ab2dfcaa39bd788d36c674f8dae37622236b8", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "55b5a82b04d0f734b17296f4bd6ab2dfcaa39bd788d36c674f8dae37622236b8", kill_on_drop: false }` [INFO] [stdout] 55b5a82b04d0f734b17296f4bd6ab2dfcaa39bd788d36c674f8dae37622236b8