[INFO] fetching crate rumqttc-dev-patched 0.25.1-ack-notify...
[INFO] testing rumqttc-dev-patched-0.25.1-ack-notify against beta-2026-01-20 for beta-1.94-1
[INFO] extracting crate rumqttc-dev-patched 0.25.1-ack-notify into /workspace/builds/worker-2-tc2/source
[INFO] started tweaking crates.io crate rumqttc-dev-patched 0.25.1-ack-notify
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rumqttc-dev-patched 0.25.1-ack-notify
[INFO] tweaked toml for crates.io crate rumqttc-dev-patched 0.25.1-ack-notify written to /workspace/builds/worker-2-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rumqttc-dev-patched 0.25.1-ack-notify on toolchain beta-2026-01-20
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-01-20" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rumqttc-dev-patched 0.25.1-ack-notify 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-2026-01-20" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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" "+beta-2026-01-20" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8d12b5d944d460832f08979baa8def7fedccbf6205960565fd2c07a55c456ef1
[INFO] running `Command { std: "docker" "start" "-a" "8d12b5d944d460832f08979baa8def7fedccbf6205960565fd2c07a55c456ef1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8d12b5d944d460832f08979baa8def7fedccbf6205960565fd2c07a55c456ef1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d12b5d944d460832f08979baa8def7fedccbf6205960565fd2c07a55c456ef1", kill_on_drop: false }`
[INFO] [stdout] 8d12b5d944d460832f08979baa8def7fedccbf6205960565fd2c07a55c456ef1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] cb1d8815718f66d13542343a8de3b638052d7b6dee0508c16cb3ad171967f127
[INFO] running `Command { std: "docker" "start" "-a" "cb1d8815718f66d13542343a8de3b638052d7b6dee0508c16cb3ad171967f127", kill_on_drop: false }`
[INFO] [stderr]    Compiling aws-lc-rs v1.15.0
[INFO] [stderr]    Compiling rustls v0.23.35
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling fixedbitset v0.5.7
[INFO] [stderr]    Compiling cc v1.2.47
[INFO] [stderr]    Compiling syn v2.0.110
[INFO] [stderr]    Compiling flume v0.11.1
[INFO] [stderr]    Compiling cmake v0.1.54
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling aws-lc-sys v0.33.0
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling tokio v1.48.0
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling rustls-webpki v0.102.8
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling tokio-util v0.7.17
[INFO] [stderr]    Compiling rustls-webpki v0.103.8
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling rumqttc-dev-patched v0.25.1-ack-notify (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 34.93s
[INFO] running `Command { std: "docker" "inspect" "cb1d8815718f66d13542343a8de3b638052d7b6dee0508c16cb3ad171967f127", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cb1d8815718f66d13542343a8de3b638052d7b6dee0508c16cb3ad171967f127", kill_on_drop: false }`
[INFO] [stdout] cb1d8815718f66d13542343a8de3b638052d7b6dee0508c16cb3ad171967f127
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5db864752c635f4ec9c373aac3d273014a245e568aa232bc7a7ed8d7021df85f
[INFO] running `Command { std: "docker" "start" "-a" "5db864752c635f4ec9c373aac3d273014a245e568aa232bc7a7ed8d7021df85f", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling rustls v0.23.35
[INFO] [stderr]    Compiling backtrace v0.3.76
[INFO] [stderr]    Compiling matches v0.1.10
[INFO] [stderr]    Compiling pretty_env_logger v0.5.0
[INFO] [stderr]    Compiling color-backtrace v0.6.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling rumqttc-dev-patched v0.25.1-ack-notify (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 24.26s
[INFO] running `Command { std: "docker" "inspect" "5db864752c635f4ec9c373aac3d273014a245e568aa232bc7a7ed8d7021df85f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5db864752c635f4ec9c373aac3d273014a245e568aa232bc7a7ed8d7021df85f", kill_on_drop: false }`
[INFO] [stdout] 5db864752c635f4ec9c373aac3d273014a245e568aa232bc7a7ed8d7021df85f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:98afbf2d16093dec2546ff8915fddc74e65664aa03fc460b3712b1c2c54a33e4" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2026-01-20" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] daf6ebcf8a5da5825eb31ea6c11a86f5820571469eaf9d0931ff75dbc5cb6b84
[INFO] running `Command { std: "docker" "start" "-a" "daf6ebcf8a5da5825eb31ea6c11a86f5820571469eaf9d0931ff75dbc5cb6b84", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.20s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rumqttc_dev_patched-e78f4ea3b9f77e2f)
[INFO] [stdout] 
[INFO] [stdout] running 73 tests
[INFO] [stdout] test mqttbytes::topic::test::dollar_subscriptions_doesnt_match_dollar_topic ... ok
[INFO] [stdout] test mqttbytes::topic::test::filters_are_validated_correctly ... ok
[INFO] [stdout] test client::test::should_be_able_to_build_test_client_from_channel ... ok
[INFO] [stdout] test mqttbytes::topic::test::topics_match_with_filters_as_expected ... ok
[INFO] [stdout] test mqttbytes::topic::test::wildcards_are_detected_correctly ... ok
[INFO] [stdout] test mqttbytes::v4::codec::tests::outgoing_max_packet_size_check ... ok
[INFO] [stdout] test mqttbytes::v4::connack::test::connack_encoding_works ... ok
[INFO] [stdout] test mqttbytes::v4::connack::test::connack_parsing_works ... ok
[INFO] [stdout] test mqttbytes::v4::connect::test::connect_encoding_works ... ok
[INFO] [stdout] test mqttbytes::v4::connect::test::connect_parsing_works ... ok
[INFO] [stdout] test mqttbytes::v4::puback::test::puback_encoding_works ... ok
[INFO] [stdout] test mqttbytes::v4::publish::test::qos0_publish_encoding_works ... ok
[INFO] [stdout] test mqttbytes::v4::publish::test::qos0_publish_parsing_works ... ok
[INFO] [stdout] test mqttbytes::v4::publish::test::qos1_publish_encoding_works ... ok
[INFO] [stdout] test mqttbytes::v4::publish::test::qos1_publish_parsing_works ... ok
[INFO] [stdout] test mqttbytes::topic::test::topics_are_validated_correctly ... ok
[INFO] [stdout] test mqttbytes::v4::subscribe::test::subscribe_encoding_works ... ok
[INFO] [stdout] test mqttbytes::v4::subscribe::test::subscribe_parsing_works ... ok
[INFO] [stdout] test state::test::incoming_puback_with_pkid_greater_than_max_inflight_should_be_handled_gracefully ... ok
[INFO] [stdout] test state::test::incoming_pubcomp_should_release_correct_pkid_from_release_queue ... ok
[INFO] [stdout] test state::test::incoming_publish_should_be_added_to_queue_correctly ... ok
[INFO] [stdout] test state::test::incoming_publish_should_not_be_acked_with_manual_acks ... ok
[INFO] [stdout] test state::test::incoming_pubrec_should_release_publish_from_queue_and_add_relid_to_rel_queue ... ok
[INFO] [stdout] test state::test::next_pkid_increments_as_expected ... ok
[INFO] [stdout] test state::test::incoming_qos2_publish_should_send_rec_to_network_and_publish_to_user ... ok
[INFO] [stdout] test state::test::outgoing_ping_handle_should_succeed_if_pingresp_is_received ... ok
[INFO] [stdout] test state::test::outgoing_publish_should_set_pkid_and_add_publish_to_queue ... ok
[INFO] [stdout] test mqttbytes::v4::suback::test::suback_parsing_works ... ok
[INFO] [stdout] test state::test::outgoing_ping_handle_should_throw_errors_for_no_pingresp ... ok
[INFO] [stdout] test state::test::incoming_publish_should_be_acked ... ok
[INFO] [stdout] test state::test::incoming_pubrel_should_send_comp_to_network_and_nothing_to_user ... ok
[INFO] [stdout] test test::accept_empty_client_id ... ok
[INFO] [stdout] test v5::client::test::should_be_able_to_build_test_client_from_channel ... ok
[INFO] [stdout] test state::test::clean_is_calculating_pending_correctly ... ok
[INFO] [stdout] test client::test::calling_iter_twice_on_connection_shouldnt_panic ... ok
[INFO] [stdout] test test::set_clean_session_when_client_id_present ... ok
[INFO] [stdout] test v5::mqttbytes::v5::codec::tests::outgoing_max_packet_size_check ... ok
[INFO] [stdout] test state::test::incoming_pubrec_should_send_release_to_network_and_nothing_to_user ... ok
[INFO] [stdout] test v5::mqttbytes::v5::connack::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::connect::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::disconnect::test::disconnect1_encoding_works ... ok
[INFO] [stdout] test v5::mqttbytes::v5::disconnect::test::disconnect2_encoding_works ... ok
[INFO] [stdout] test v5::mqttbytes::v5::disconnect::test::disconnect2_parsing_works ... ok
[INFO] [stdout] test v5::mqttbytes::v5::disconnect::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::puback::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::pubcomp::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::publish::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::pubrec::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::disconnect::test::disconnect1_parsing_works ... ok
[INFO] [stdout] test v5::mqttbytes::v5::pubrel::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::suback::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::unsuback::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::subscribe::test::length_calculation ... ok
[INFO] [stdout] test v5::mqttbytes::v5::unsubscribe::test::length_calculation ... ok
[INFO] [stdout] test v5::client::test::calling_iter_twice_on_connection_shouldnt_panic ... ok
[INFO] [stdout] test mqttbytes::topic::test::zero_len_subscriptions_are_not_allowed ... ok
[INFO] [stdout] test v5::state::test::outgoing_publish_with_max_inflight_is_ok ... ok
[INFO] [stdout] test v5::test::allow_empty_client_id ... ok
[INFO] [stdout] test v5::state::test::incoming_publish_should_be_acked ... ok
[INFO] [stdout] test state::test::incoming_puback_should_remove_correct_publish_from_queue ... ok
[INFO] [stdout] test v5::state::test::incoming_pubrec_should_send_release_to_network_and_nothing_to_user ... ok
[INFO] [stdout] test v5::state::test::incoming_qos2_publish_should_send_rec_to_network_and_publish_to_user ... ok
[INFO] [stdout] test v5::state::test::incoming_puback_with_pkid_greater_than_max_inflight_should_be_handled_gracefully ... ok
[INFO] [stdout] test v5::state::test::incoming_puback_should_remove_correct_publish_from_queue ... ok
[INFO] [stdout] test v5::state::test::incoming_publish_should_not_be_acked_with_manual_acks ... ok
[INFO] [stdout] test v5::state::test::incoming_publish_should_be_added_to_queue_correctly ... ok
[INFO] [stdout] test v5::state::test::outgoing_publish_should_set_pkid_and_add_publish_to_queue ... ok
[INFO] [stdout] test v5::state::test::incoming_pubrel_should_send_comp_to_network_and_nothing_to_user ... ok
[INFO] [stdout] test v5::state::test::outgoing_ping_handle_should_succeed_if_pingresp_is_received ... ok
[INFO] [stdout] test v5::state::test::incoming_pubrec_should_release_publish_from_queue_and_add_relid_to_rel_queue ... ok
[INFO] [stdout] test v5::state::test::incoming_pubcomp_should_release_correct_pkid_from_release_queue ... ok
[INFO] [stdout] test v5::state::test::outgoing_ping_handle_should_throw_errors_for_no_pingresp ... ok
[INFO] [stdout] test v5::state::test::next_pkid_increments_as_expected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 73 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/broker.rs (/opt/rustwide/target/debug/deps/broker-e36f911f77fd2102)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/reliability.rs (/opt/rustwide/target/debug/deps/reliability-2ab018b065bc1cab)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test packet_id_collisions_are_detected_and_flow_control_is_applied ... ignored
[INFO] [stdout] test resolve_on_qos0_before_write_to_tcp_buffer ... ok
[INFO] [stdout] test resolve_on_sub_ack_from_broker ... FAILED
[INFO] [stdout] test test_valid_keep_alive_values ... ok
[INFO] [stdout] test test_zero_keep_alive_values ... ok
[INFO] [stdout] test resolve_on_unsub_ack_from_broker ... FAILED
[INFO] [stdout] test test_invalid_keep_alive_value - should panic ... ok
[INFO] [stdout] test next_poll_after_connect_failure_reconnects ... ok
[INFO] [stdout] test resolve_on_qos1_ack_from_broker ... ok
[INFO] [stdout] test idle_connection_triggers_pings_on_time ... ok
[INFO] [stdout] test resolve_on_qos2_ack_from_broker ... ok
[INFO] [stdout] test state_is_being_cleaned_properly_and_pending_request_calculated_properly ... ok
[INFO] [stdout] test connection_should_timeout_on_time ... ok
[INFO] [stdout] test requests_are_recovered_after_inflight_queue_size_falls_below_max ... ok
[INFO] [stdout] test reconnection_resumes_from_the_previous_state ... ok
[INFO] [stdout] test reconnection_resends_unacked_packets_from_the_previous_connection_first ... ok
[INFO] [stdout] test detects_halfopen_connections_in_the_second_ping_request ... ok
[INFO] [stdout] test requests_are_blocked_after_max_inflight_queue_size ... ok
[INFO] [stdout] test some_incoming_and_no_outgoing_should_trigger_pings_on_time ... ok
[INFO] [stdout] test some_outgoing_and_no_incoming_should_trigger_pings_on_time ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- resolve_on_sub_ack_from_broker stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'resolve_on_sub_ack_from_broker' (111) panicked at tests/broker.rs:56:55:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 98, kind: AddrInUse, message: "Address already in use" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5ebe5d2d7592 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5ebe5d2d7592 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5ebe5d2d7592 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5ebe5d2d7592 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5ebe5d2e83ea - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5ebe5d2e83ea - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5ebe5d2a5046 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5ebe5d2a5046 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5ebe5d2b65b9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5ebe5d2b65b9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5ebe5d2b6451 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5ebe5ce03c2e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5ebe5ce03c2e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5ebe5d2b68e2 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5ebe5d2b68e2 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5ebe5d2b6678 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5ebe5d2b1879 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5ebe5d299bbd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5ebe5d2f0ddc - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5ebe5d2f0552 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5ebe5cdc08e2 - core::result::Result<T,E>::unwrap::hea072e2421aa32a4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5ebe5cdc08e2 - reliability::broker::Broker::new::{{closure}}::h031cc6bae2edf2c1
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/broker.rs:56:55
[INFO] [stdout]   22:     0x5ebe5cd64527 - reliability::resolve_on_sub_ack_from_broker::{{closure}}::hb8e46586036b4e7c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/reliability.rs:806:50
[INFO] [stdout]   23:     0x5ebe5cd86052 - <core::pin::Pin<P> as core::future::future::Future>::poll::h68c372f055695026
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/future/future.rs:133:9
[INFO] [stdout]   24:     0x5ebe5cd862cd - <core::pin::Pin<P> as core::future::future::Future>::poll::haf62af5dd4bc0099
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/future/future.rs:133:9
[INFO] [stdout]   25:     0x5ebe5cd9303d - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h1ecd3dc888935b9f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:742:70
[INFO] [stdout]   26:     0x5ebe5cd92dab - tokio::task::coop::with_budget::h6835d8b4a62f8bee
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   27:     0x5ebe5cd92dab - tokio::task::coop::budget::h9f05d0ebb46abefb
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   28:     0x5ebe5cd92dab - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h8bedc9d77dd6c775
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:742:25
[INFO] [stdout]   29:     0x5ebe5cd90380 - tokio::runtime::scheduler::current_thread::Context::enter::heb0874571d71fd49
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:432:19
[INFO] [stdout]   30:     0x5ebe5cd919bd - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h0337e6a1c2ca8c3f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:741:44
[INFO] [stdout]   31:     0x5ebe5cd91624 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h6906870eb7f7691c
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:829:68
[INFO] [stdout]   32:     0x5ebe5cd9d66b - tokio::runtime::context::scoped::Scoped<T>::set::h6f7fc63fbd80e344
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   33:     0x5ebe5cdbd759 - tokio::runtime::context::set_scheduler::{{closure}}::he750a2822d92481b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context.rs:176:38
[INFO] [stdout]   34:     0x5ebe5cdda7c2 - std::thread::local::LocalKey<T>::try_with::h9fc80c8fcd635d83
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/local.rs:513:12
[INFO] [stdout]   35:     0x5ebe5cdd76de - std::thread::local::LocalKey<T>::with::h0745a9ee2d34744d
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/local.rs:477:20
[INFO] [stdout]   36:     0x5ebe5cdbd6cd - tokio::runtime::context::set_scheduler::hc237c0071f2c66e0
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context.rs:176:17
[INFO] [stdout]   37:     0x5ebe5cd913d0 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h80179bba7debb8a5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:829:27
[INFO] [stdout]   38:     0x5ebe5cd91687 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h35dee134233e83a4
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:729:24
[INFO] [stdout]   39:     0x5ebe5cd875b6 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h5fe1696e03484383
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:200:33
[INFO] [stdout]   40:     0x5ebe5cdb1985 - tokio::runtime::context::runtime::enter_runtime::h5ca3eb416a8d4dd8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   41:     0x5ebe5cd86fb1 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h7e027427a2fc1e9a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:188:9
[INFO] [stdout]   42:     0x5ebe5cde268a - tokio::runtime::runtime::Runtime::block_on_inner::h82fbfdff2c1978ab
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/runtime.rs:368:52
[INFO] [stdout]   43:     0x5ebe5cde284c - tokio::runtime::runtime::Runtime::block_on::hdad44140d8e969a5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   44:     0x5ebe5cd640d3 - reliability::resolve_on_sub_ack_from_broker::hd2050cbdcbf99f81
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/reliability.rs:847:6
[INFO] [stdout]   45:     0x5ebe5cd64167 - reliability::resolve_on_sub_ack_from_broker::{{closure}}::h62d65f8ef60647ed
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/reliability.rs:787:42
[INFO] [stdout]   46:     0x5ebe5cd4ae16 - core::ops::function::FnOnce::call_once::hbbb21c30b24eeb4f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   47:     0x5ebe5ce03a2b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   48:     0x5ebe5ce03a2b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   49:     0x5ebe5ce173fa - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   50:     0x5ebe5ce173fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   51:     0x5ebe5ce173fa - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   52:     0x5ebe5ce173fa - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   53:     0x5ebe5ce173fa - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   54:     0x5ebe5ce173fa - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   55:     0x5ebe5ce173fa - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   56:     0x5ebe5cdf1854 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   57:     0x5ebe5cdf1854 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   58:     0x5ebe5cdf5112 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   59:     0x5ebe5cdf5112 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   60:     0x5ebe5cdf5112 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   61:     0x5ebe5cdf5112 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   62:     0x5ebe5cdf5112 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   63:     0x5ebe5cdf5112 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   64:     0x5ebe5cdf5112 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   65:     0x5ebe5d2aca5f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   66:     0x5ebe5d2aca5f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   67:     0x70a5e5d32aa4 - <unknown>
[INFO] [stdout]   68:     0x70a5e5dbfa64 - clone
[INFO] [stdout]   69:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- resolve_on_unsub_ack_from_broker stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'resolve_on_unsub_ack_from_broker' (112) panicked at tests/broker.rs:56:55:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 98, kind: AddrInUse, message: "Address already in use" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5ebe5d2d7592 - std::backtrace_rs::backtrace::libunwind::trace::hf0bd46b30bc61685
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5ebe5d2d7592 - std::backtrace_rs::backtrace::trace_unsynchronized::h1d1fbb72ad89d7b7
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5ebe5d2d7592 - std::sys::backtrace::_print_fmt::he38b6f68ca847f47
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5ebe5d2d7592 - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::hb7e843cde1bc81a3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5ebe5d2e83ea - core::fmt::rt::Argument::fmt::hc1dd77ac64f2688c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5ebe5d2e83ea - core::fmt::write::h952c506e2dbe9cff
[INFO] [stdout]    6:     0x5ebe5d2a5046 - std::io::default_write_fmt::hd23bd8145c03a23a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x5ebe5d2a5046 - std::io::Write::write_fmt::hdd3314a2bd8a34bd
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x5ebe5d2b65b9 - std::sys::backtrace::BacktraceLock::print::h1079b82381c2c252
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5ebe5d2b65b9 - std::panicking::default_hook::{{closure}}::h85cb76b8462c00f2
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5ebe5d2b6451 - std::panicking::default_hook::h0134d220cc034c02
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5ebe5ce03c2e - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hb2e68dca3970e3ca
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   12:     0x5ebe5ce03c2e - test::test_main_with_exit_callback::{{closure}}::ha7ec2063a2565ec3
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x5ebe5d2b68e2 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::haebee478d0f56cf4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2220:9
[INFO] [stdout]   14:     0x5ebe5d2b68e2 - std::panicking::panic_with_hook::h8119b6db1fef734f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5ebe5d2b6678 - std::panicking::panic_handler::{{closure}}::h24f5360b91482c0e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5ebe5d2b1879 - std::sys::backtrace::__rust_end_short_backtrace::h4e60c5cbd1bd0108
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5ebe5d299bbd - __rustc[e4c6931bd8050421]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5ebe5d2f0ddc - core::panicking::panic_fmt::hb1614a3ff6840071
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5ebe5d2f0552 - core::result::unwrap_failed::h7d4c34940aded59c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5ebe5cdc08e2 - core::result::Result<T,E>::unwrap::hea072e2421aa32a4
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/result.rs:1233:23
[INFO] [stdout]   21:     0x5ebe5cdc08e2 - reliability::broker::Broker::new::{{closure}}::h031cc6bae2edf2c1
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/broker.rs:56:55
[INFO] [stdout]   22:     0x5ebe5cd69ae7 - reliability::resolve_on_unsub_ack_from_broker::{{closure}}::h54815fd9a50bf694
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/reliability.rs:870:50
[INFO] [stdout]   23:     0x5ebe5cd86052 - <core::pin::Pin<P> as core::future::future::Future>::poll::h68c372f055695026
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/future/future.rs:133:9
[INFO] [stdout]   24:     0x5ebe5cd862cd - <core::pin::Pin<P> as core::future::future::Future>::poll::haf62af5dd4bc0099
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/future/future.rs:133:9
[INFO] [stdout]   25:     0x5ebe5cd9303d - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h1ecd3dc888935b9f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:742:70
[INFO] [stdout]   26:     0x5ebe5cd92dab - tokio::task::coop::with_budget::h6835d8b4a62f8bee
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   27:     0x5ebe5cd92dab - tokio::task::coop::budget::h9f05d0ebb46abefb
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   28:     0x5ebe5cd92dab - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h8bedc9d77dd6c775
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:742:25
[INFO] [stdout]   29:     0x5ebe5cd90380 - tokio::runtime::scheduler::current_thread::Context::enter::heb0874571d71fd49
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:432:19
[INFO] [stdout]   30:     0x5ebe5cd919bd - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h0337e6a1c2ca8c3f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:741:44
[INFO] [stdout]   31:     0x5ebe5cd91624 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h6906870eb7f7691c
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:829:68
[INFO] [stdout]   32:     0x5ebe5cd9d66b - tokio::runtime::context::scoped::Scoped<T>::set::h6f7fc63fbd80e344
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   33:     0x5ebe5cdbd759 - tokio::runtime::context::set_scheduler::{{closure}}::he750a2822d92481b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context.rs:176:38
[INFO] [stdout]   34:     0x5ebe5cdda7c2 - std::thread::local::LocalKey<T>::try_with::h9fc80c8fcd635d83
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/local.rs:513:12
[INFO] [stdout]   35:     0x5ebe5cdd76de - std::thread::local::LocalKey<T>::with::h0745a9ee2d34744d
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/local.rs:477:20
[INFO] [stdout]   36:     0x5ebe5cdbd6cd - tokio::runtime::context::set_scheduler::hc237c0071f2c66e0
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context.rs:176:17
[INFO] [stdout]   37:     0x5ebe5cd913d0 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h80179bba7debb8a5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:829:27
[INFO] [stdout]   38:     0x5ebe5cd91687 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h35dee134233e83a4
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:729:24
[INFO] [stdout]   39:     0x5ebe5cd875b6 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h5fe1696e03484383
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:200:33
[INFO] [stdout]   40:     0x5ebe5cdb1985 - tokio::runtime::context::runtime::enter_runtime::h5ca3eb416a8d4dd8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   41:     0x5ebe5cd86fb1 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h7e027427a2fc1e9a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/scheduler/current_thread/mod.rs:188:9
[INFO] [stdout]   42:     0x5ebe5cde268a - tokio::runtime::runtime::Runtime::block_on_inner::h82fbfdff2c1978ab
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/runtime.rs:368:52
[INFO] [stdout]   43:     0x5ebe5cde284c - tokio::runtime::runtime::Runtime::block_on::hdad44140d8e969a5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.48.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   44:     0x5ebe5cd696c3 - reliability::resolve_on_unsub_ack_from_broker::h0fc394eeabe4ef45
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/reliability.rs:901:6
[INFO] [stdout]   45:     0x5ebe5cd6ac77 - reliability::resolve_on_unsub_ack_from_broker::{{closure}}::hdfe0051f24431705
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/reliability.rs:851:44
[INFO] [stdout]   46:     0x5ebe5cd4a856 - core::ops::function::FnOnce::call_once::h9f05e9eba3b5240d
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   47:     0x5ebe5ce03a2b - core::ops::function::FnOnce::call_once::hefaf63600cd43d2a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   48:     0x5ebe5ce03a2b - test::__rust_begin_short_backtrace::he30322a73a0e9ea6
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:663:18
[INFO] [stdout]   49:     0x5ebe5ce173fa - test::run_test_in_process::{{closure}}::hdea3ab8d0243ef36
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:74
[INFO] [stdout]   50:     0x5ebe5ce173fa - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h66d192f42498ffce
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   51:     0x5ebe5ce173fa - std::panicking::catch_unwind::do_call::h822e18e8d3a6bb65
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   52:     0x5ebe5ce173fa - std::panicking::catch_unwind::h54b1de7ceab578bf
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   53:     0x5ebe5ce173fa - std::panic::catch_unwind::h60c29b7a9d0246b1
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   54:     0x5ebe5ce173fa - test::run_test_in_process::h6099b5f871379b13
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:686:27
[INFO] [stdout]   55:     0x5ebe5ce173fa - test::run_test::{{closure}}::h926ce0a38281a4c8
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:607:43
[INFO] [stdout]   56:     0x5ebe5cdf1854 - test::run_test::{{closure}}::h508de21a9afc7140
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/test/src/lib.rs:637:41
[INFO] [stdout]   57:     0x5ebe5cdf1854 - std::sys::backtrace::__rust_begin_short_backtrace::h6e2f5c39ca00735a
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   58:     0x5ebe5cdf5112 - std::thread::lifecycle::spawn_unchecked::{{closure}}::{{closure}}::h133e44f0e5802c14
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   59:     0x5ebe5cdf5112 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h4718c1285283955c
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   60:     0x5ebe5cdf5112 - std::panicking::catch_unwind::do_call::h0bba3937b4892238
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:581:40
[INFO] [stdout]   61:     0x5ebe5cdf5112 - std::panicking::catch_unwind::h5b31cab5fb8c5d7f
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panicking.rs:544:19
[INFO] [stdout]   62:     0x5ebe5cdf5112 - std::panic::catch_unwind::hb2fa05d52ed0124e
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/panic.rs:359:14
[INFO] [stdout]   63:     0x5ebe5cdf5112 - std::thread::lifecycle::spawn_unchecked::{{closure}}::hf401cf5ff501bd29
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   64:     0x5ebe5cdf5112 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h160022e94ce3b0bb
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   65:     0x5ebe5d2aca5f - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf234e0d1d1d272ba
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/alloc/src/boxed.rs:2206:9
[INFO] [stdout]   66:     0x5ebe5d2aca5f - std::sys::thread::unix::Thread::new::thread_start::h106a295241840d3b
[INFO] [stdout]                                at /rustc/9b1f8ff42d110b0ca138116745be921df5dc97e7/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   67:     0x70a5e5d32aa4 - <unknown>
[INFO] [stdout]   68:     0x70a5e5dbfa64 - clone
[INFO] [stdout]   69:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     resolve_on_sub_ack_from_broker
[INFO] [stdout]     resolve_on_unsub_ack_from_broker
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 17 passed; 2 failed; 1 ignored; 0 measured; 0 filtered out; finished in 15.02s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test reliability`
[INFO] running `Command { std: "docker" "inspect" "daf6ebcf8a5da5825eb31ea6c11a86f5820571469eaf9d0931ff75dbc5cb6b84", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "daf6ebcf8a5da5825eb31ea6c11a86f5820571469eaf9d0931ff75dbc5cb6b84", kill_on_drop: false }`
[INFO] [stdout] daf6ebcf8a5da5825eb31ea6c11a86f5820571469eaf9d0931ff75dbc5cb6b84
