[INFO] fetching crate mqttest 0.2.0...
[INFO] testing mqttest-0.2.0 against 1.76.0 for beta-1.77-1
[INFO] extracting crate mqttest 0.2.0 into /workspace/builds/worker-5-tc1/source
[INFO] validating manifest of crates.io crate mqttest 0.2.0 on toolchain 1.76.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.76.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate mqttest 0.2.0
[INFO] finished tweaking crates.io crate mqttest 0.2.0
[INFO] tweaked toml for crates.io crate mqttest 0.2.0 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] crate crates.io crate mqttest 0.2.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" "+1.76.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded hermit-abi v0.1.10
[INFO] [stderr]   Downloaded time-macros-impl v0.1.0
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.60
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.60
[INFO] [stderr]   Downloaded standback v0.2.2
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.60
[INFO] [stderr]   Downloaded wasm-bindgen-backend v0.2.60
[INFO] [stderr]   Downloaded time v0.2.9
[INFO] [stderr]   Downloaded bumpalo v3.2.1
[INFO] [stderr]   Downloaded regex v1.3.6
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.60
[INFO] [stderr]   Downloaded mqttrs v0.3.0
[INFO] [stderr]   Downloaded tokio v0.2.16
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.76.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a95d0833ea40ccf6dd7b064d61e7b9c3573618730536f1626e14f6137c4c4ca3
[INFO] running `Command { std: "docker" "start" "-a" "a95d0833ea40ccf6dd7b064d61e7b9c3573618730536f1626e14f6137c4c4ca3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a95d0833ea40ccf6dd7b064d61e7b9c3573618730536f1626e14f6137c4c4ca3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a95d0833ea40ccf6dd7b064d61e7b9c3573618730536f1626e14f6137c4c4ca3", kill_on_drop: false }`
[INFO] [stdout] a95d0833ea40ccf6dd7b064d61e7b9c3573618730536f1626e14f6137c4c4ca3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.76.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5d1ca33af2bbb86b6c5b46a3ff037bd285d5f000d5765ed60801f810dc90c4b1
[INFO] running `Command { std: "docker" "start" "-a" "5d1ca33af2bbb86b6c5b46a3ff037bd285d5f000d5765ed60801f810dc90c4b1", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.10
[INFO] [stderr]    Compiling syn v1.0.17
[INFO] [stderr]    Compiling proc-macro-hack v0.5.15
[INFO] [stderr]    Compiling proc-macro-error-attr v0.4.12
[INFO] [stderr]    Compiling rustversion v1.0.2
[INFO] [stderr]    Compiling proc-macro-error v0.4.12
[INFO] [stderr]    Compiling serde v1.0.106
[INFO] [stderr]    Compiling standback v0.2.2
[INFO] [stderr]    Compiling regex v1.3.6
[INFO] [stderr]    Compiling quote v1.0.3
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling syn-mid v0.5.0
[INFO] [stderr]    Compiling serde_derive v1.0.106
[INFO] [stderr]    Compiling futures-macro v0.3.4
[INFO] [stderr]    Compiling tokio-macros v0.2.5
[INFO] [stderr]    Compiling time-macros-impl v0.1.0
[INFO] [stderr]    Compiling tokio v0.2.16
[INFO] [stderr]    Compiling time-macros v0.1.0
[INFO] [stderr]    Compiling structopt-derive v0.4.5
[INFO] [stderr]    Compiling time v0.2.9
[INFO] [stderr]    Compiling futures-util v0.3.4
[INFO] [stderr]    Compiling structopt v0.3.12
[INFO] [stderr]    Compiling futures-executor v0.3.4
[INFO] [stderr]    Compiling futures v0.3.4
[INFO] [stderr]    Compiling tokio-util v0.3.1
[INFO] [stderr]    Compiling mqttrs v0.3.0
[INFO] [stderr]    Compiling serde_json v1.0.51
[INFO] [stderr]    Compiling mqttest v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.91s
[INFO] running `Command { std: "docker" "inspect" "5d1ca33af2bbb86b6c5b46a3ff037bd285d5f000d5765ed60801f810dc90c4b1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5d1ca33af2bbb86b6c5b46a3ff037bd285d5f000d5765ed60801f810dc90c4b1", kill_on_drop: false }`
[INFO] [stdout] 5d1ca33af2bbb86b6c5b46a3ff037bd285d5f000d5765ed60801f810dc90c4b1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.76.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6823c0406d72b85f2b8387b498cb64e16a9155c633014cafd04c620ff0e22cec
[INFO] running `Command { std: "docker" "start" "-a" "6823c0406d72b85f2b8387b498cb64e16a9155c633014cafd04c620ff0e22cec", kill_on_drop: false }`
[INFO] [stderr]    Compiling mqttest v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.69s
[INFO] running `Command { std: "docker" "inspect" "6823c0406d72b85f2b8387b498cb64e16a9155c633014cafd04c620ff0e22cec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6823c0406d72b85f2b8387b498cb64e16a9155c633014cafd04c620ff0e22cec", kill_on_drop: false }`
[INFO] [stdout] 6823c0406d72b85f2b8387b498cb64e16a9155c633014cafd04c620ff0e22cec
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.76.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 04b9c4a2fca35292ce949d5d9e24f05d3e02fd39c820ab3071dbf392b6f76a4f
[INFO] running `Command { std: "docker" "start" "-a" "04b9c4a2fca35292ce949d5d9e24f05d3e02fd39c820ab3071dbf392b6f76a4f", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mqttest-5d35fc10f9aa0b21)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test::connect ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test::connect stdout ----
[INFO] [stdout] [2024-02-13T08:01:08Z DEBUG mqttest] Start Conf { ports: 1883..=2000, ack_timeouts: (Some(5s), None), ack_delay: 0ns, dump_files: [], dump_prefix: "", dump_decode: None, strict: false, idprefix: "", userpass: None, max_connect: 1, max_pkt: [None], max_pkt_delay: None, max_time: [None], sess_expire: [None] }
[INFO] [stdout] thread 'test::connect' panicked at src/test.rs:43:46:
[INFO] [stdout] Failed listen: Custom { kind: Other, error: "Listen failed on 127.0.0.1::1883..=2000 (raise log level for details)" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a33fdd23a6 - std::backtrace_rs::backtrace::libunwind::trace::hbee8a7973eeb6c93
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a33fdd23a6 - std::backtrace_rs::backtrace::trace_unsynchronized::hc8ac75eea3aa6899
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a33fdd23a6 - std::sys_common::backtrace::_print_fmt::hc7f3e3b5298b1083
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a33fdd23a6 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hbb235daedd7c6190
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a33fdfe720 - core::fmt::rt::Argument::fmt::h76c38a80d925a410
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a33fdfe720 - core::fmt::write::h3ed6aeaa977c8e45
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a33fdcef0f - std::io::Write::write_fmt::h1299aa7741865f2b
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a33fdd2184 - std::sys_common::backtrace::_print::h5d645a07e0fcfdbb
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a33fdd2184 - std::sys_common::backtrace::print::h85035a511aafe7a8
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a33fdd3ef7 - std::panicking::default_hook::{{closure}}::hcce8cea212785a25
[INFO] [stdout]   10:     0x55a33fdd3bdd - std::panicking::default_hook::hf5fcb0f213fe709a
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a33fc9e9b7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h60265c2dfa87ee34
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a33fc9e9b7 - test::test_main::{{closure}}::h77865bd3127078c6
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a33fdd4516 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hbc5ccf4eb663e1e5
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a33fdd4516 - std::panicking::rust_panic_with_hook::h095fccf1dc9379ee
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a33fdd4262 - std::panicking::begin_panic_handler::{{closure}}::h032ba12139b353db
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55a33fdd28a6 - std::sys_common::backtrace::__rust_end_short_backtrace::h9259bc2ff8fd0f76
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a33fdd3fc0 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a33fa57425 - core::panicking::panic_fmt::h784f20a50eaab275
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a33fa57a03 - core::result::unwrap_failed::h03d8a5018196e1cd
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x55a33fadeee3 - core::result::Result<T,E>::expect::hfe7872f50c6ec931
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/result.rs:1030:23
[INFO] [stdout]   21:     0x55a33fae485f - mqttest::test::connect::{{closure}}::ha961002d602a2f20
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:43:19
[INFO] [stdout]   22:     0x55a33fa775e3 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::hd4a878e135a80b86
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x55a33faf8fee - tokio::coop::budget::{{closure}}::hfaa12805f0ab171e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/coop.rs:97:9
[INFO] [stdout]   24:     0x55a33fae6445 - std::thread::local::LocalKey<T>::try_with::h7c7eba01b723ffd3
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/thread/local.rs:270:16
[INFO] [stdout]   25:     0x55a33fae5ea7 - std::thread::local::LocalKey<T>::with::hc0039ed151ab1bf1
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/thread/local.rs:246:9
[INFO] [stdout]   26:     0x55a33fa77071 - tokio::coop::budget::h231f9ce955ad1875
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/coop.rs:79:5
[INFO] [stdout]   27:     0x55a33fa77071 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::hc970d59f922d2ac9
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   28:     0x55a33fa779eb - tokio::runtime::basic_scheduler::enter::{{closure}}::h6cf0dc8668e796d6
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   29:     0x55a33facff50 - tokio::macros::scoped_tls::ScopedKey<T>::set::hecac0ab55ead0b95
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/macros/scoped_tls.rs:64:9
[INFO] [stdout]   30:     0x55a33fa77921 - tokio::runtime::basic_scheduler::enter::h56969ee443a388c2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   31:     0x55a33fa76e3c - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h4e1eb82c09262fe3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   32:     0x55a33fa9bc3d - tokio::runtime::Runtime::block_on::{{closure}}::haf876a10096423ff
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/mod.rs:418:34
[INFO] [stdout]   33:     0x55a33fa7fa15 - tokio::runtime::context::enter::h6341fdbe46918984
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/context.rs:72:5
[INFO] [stdout]   34:     0x55a33fa839a5 - tokio::runtime::handle::Handle::enter::h1ff19612b9f6a241
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/handle.rs:39:9
[INFO] [stdout]   35:     0x55a33fa9bb42 - tokio::runtime::Runtime::block_on::h1da860e3b43ea1e9
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/mod.rs:415:9
[INFO] [stdout]   36:     0x55a33fae43e1 - mqttest::test::block_on::he18f18b094c1e202
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:34:5
[INFO] [stdout]   37:     0x55a33fae44c0 - mqttest::test::connect::hbc4ca06e9d2dda63
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:39:32
[INFO] [stdout]   38:     0x55a33fae4487 - mqttest::test::connect::{{closure}}::h49e3d6161ea675d3
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:38:13
[INFO] [stdout]   39:     0x55a33fa9e3f6 - core::ops::function::FnOnce::call_once::hd0a343d64de863ba
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x55a33fca428f - core::ops::function::FnOnce::call_once::h8dc6907944022cf6
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x55a33fca428f - test::__rust_begin_short_backtrace::haae1a87433f1efb3
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/test/src/lib.rs:627:18
[INFO] [stdout]   42:     0x55a33fca3011 - test::run_test_in_process::{{closure}}::h8c7decfa7c14e152
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/test/src/lib.rs:650:60
[INFO] [stdout]   43:     0x55a33fca3011 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h19e6ff056d9d21e9
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x55a33fca3011 - std::panicking::try::do_call::h89c848fcaa37c035
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:552:40
[INFO] [stdout]   45:     0x55a33fca3011 - std::panicking::try::h57ab3dc74e2839b8
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:516:19
[INFO] [stdout]   46:     0x55a33fca3011 - std::panic::catch_unwind::hfb6a1b1abc120fb9
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panic.rs:142:14
[INFO] [stdout]   47:     0x55a33fca3011 - test::run_test_in_process::h5ae2f9875edd562d
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/test/src/lib.rs:650:27
[INFO] [stdout]   48:     0x55a33fca3011 - test::run_test::{{closure}}::h35d7300d8928a067
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/test/src/lib.rs:573:43
[INFO] [stdout]   49:     0x55a33fc6a346 - test::run_test::{{closure}}::h7525ced405d23d1b
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/test/src/lib.rs:601:41
[INFO] [stdout]   50:     0x55a33fc6a346 - std::sys_common::backtrace::__rust_begin_short_backtrace::h4e7db78ce05afad8
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   51:     0x55a33fc6f3a7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hcfbcb64f1a1b3482
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   52:     0x55a33fc6f3a7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9d89c5c4108bd689
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x55a33fc6f3a7 - std::panicking::try::do_call::h8a4869bc94ec50c9
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:552:40
[INFO] [stdout]   54:     0x55a33fc6f3a7 - std::panicking::try::h9a576f20ff81ac30
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panicking.rs:516:19
[INFO] [stdout]   55:     0x55a33fc6f3a7 - std::panic::catch_unwind::hbcb4e3f860ef9830
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/panic.rs:142:14
[INFO] [stdout]   56:     0x55a33fc6f3a7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h93c79a6be1505948
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   57:     0x55a33fc6f3a7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h426d96740c81bdaf
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x55a33fdd90c5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h12de4fc57affb195
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   59:     0x55a33fdd90c5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h3c619f45059d5cf1
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x55a33fdd90c5 - std::sys::unix::thread::Thread::new::thread_start::hbac657605e4b7389
[INFO] [stdout]                                at /rustc/07dca489ac2d933c78d3c5158e3f43beefeb02ce/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   61:     0x7f7d3ef5bac3 - <unknown>
[INFO] [stdout]   62:     0x7f7d3efecbf4 - __clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test::connect
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "04b9c4a2fca35292ce949d5d9e24f05d3e02fd39c820ab3071dbf392b6f76a4f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "04b9c4a2fca35292ce949d5d9e24f05d3e02fd39c820ab3071dbf392b6f76a4f", kill_on_drop: false }`
[INFO] [stdout] 04b9c4a2fca35292ce949d5d9e24f05d3e02fd39c820ab3071dbf392b6f76a4f
[INFO] testing mqttest-0.2.0 against beta-2024-02-10 for beta-1.77-1
[INFO] extracting crate mqttest 0.2.0 into /workspace/builds/worker-5-tc2/source
[INFO] validating manifest of crates.io crate mqttest 0.2.0 on toolchain beta-2024-02-10
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-02-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate mqttest 0.2.0
[INFO] finished tweaking crates.io crate mqttest 0.2.0
[INFO] tweaked toml for crates.io crate mqttest 0.2.0 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] crate crates.io crate mqttest 0.2.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" "+beta-2024-02-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-02-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 95bc8c63f93089d6472457b098c3a987f56c14fb628f16164a8a241023a4cfa8
[INFO] running `Command { std: "docker" "start" "-a" "95bc8c63f93089d6472457b098c3a987f56c14fb628f16164a8a241023a4cfa8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "95bc8c63f93089d6472457b098c3a987f56c14fb628f16164a8a241023a4cfa8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "95bc8c63f93089d6472457b098c3a987f56c14fb628f16164a8a241023a4cfa8", kill_on_drop: false }`
[INFO] [stdout] 95bc8c63f93089d6472457b098c3a987f56c14fb628f16164a8a241023a4cfa8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-02-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1a0d54d9821141575791b7dc6e92308b180a494ed35519ce4780cec2b16f7013
[INFO] running `Command { std: "docker" "start" "-a" "1a0d54d9821141575791b7dc6e92308b180a494ed35519ce4780cec2b16f7013", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.10
[INFO] [stderr]    Compiling syn v1.0.17
[INFO] [stderr]    Compiling proc-macro-hack v0.5.15
[INFO] [stderr]    Compiling proc-macro-error-attr v0.4.12
[INFO] [stderr]    Compiling rustversion v1.0.2
[INFO] [stderr]    Compiling proc-macro-error v0.4.12
[INFO] [stderr]    Compiling serde v1.0.106
[INFO] [stderr]    Compiling standback v0.2.2
[INFO] [stderr]    Compiling regex v1.3.6
[INFO] [stderr]    Compiling quote v1.0.3
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling syn-mid v0.5.0
[INFO] [stderr]    Compiling serde_derive v1.0.106
[INFO] [stderr]    Compiling futures-macro v0.3.4
[INFO] [stderr]    Compiling tokio-macros v0.2.5
[INFO] [stderr]    Compiling time-macros-impl v0.1.0
[INFO] [stderr]    Compiling tokio v0.2.16
[INFO] [stderr]    Compiling time-macros v0.1.0
[INFO] [stderr]    Compiling structopt-derive v0.4.5
[INFO] [stderr]    Compiling time v0.2.9
[INFO] [stderr]    Compiling futures-util v0.3.4
[INFO] [stderr]    Compiling structopt v0.3.12
[INFO] [stderr]    Compiling futures-executor v0.3.4
[INFO] [stderr]    Compiling futures v0.3.4
[INFO] [stderr]    Compiling tokio-util v0.3.1
[INFO] [stderr]    Compiling serde_json v1.0.51
[INFO] [stderr]    Compiling mqttrs v0.3.0
[INFO] [stderr]    Compiling mqttest v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.53s
[INFO] running `Command { std: "docker" "inspect" "1a0d54d9821141575791b7dc6e92308b180a494ed35519ce4780cec2b16f7013", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1a0d54d9821141575791b7dc6e92308b180a494ed35519ce4780cec2b16f7013", kill_on_drop: false }`
[INFO] [stdout] 1a0d54d9821141575791b7dc6e92308b180a494ed35519ce4780cec2b16f7013
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-02-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d20077c4d14b5379008216e736f1aae491b3a7940cf844bbe5ccd7c8c17cfc74
[INFO] running `Command { std: "docker" "start" "-a" "d20077c4d14b5379008216e736f1aae491b3a7940cf844bbe5ccd7c8c17cfc74", kill_on_drop: false }`
[INFO] [stderr]    Compiling mqttest v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.67s
[INFO] running `Command { std: "docker" "inspect" "d20077c4d14b5379008216e736f1aae491b3a7940cf844bbe5ccd7c8c17cfc74", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d20077c4d14b5379008216e736f1aae491b3a7940cf844bbe5ccd7c8c17cfc74", kill_on_drop: false }`
[INFO] [stdout] d20077c4d14b5379008216e736f1aae491b3a7940cf844bbe5ccd7c8c17cfc74
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-02-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3f5f1668f5706118098fd32b51d453e9959adea57d651b2e4347ad6bb43a05e8
[INFO] running `Command { std: "docker" "start" "-a" "3f5f1668f5706118098fd32b51d453e9959adea57d651b2e4347ad6bb43a05e8", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mqttest-b84da357430bb499)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test::connect ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test::connect stdout ----
[INFO] [stdout] [2024-02-13T08:01:21Z DEBUG mqttest] Start Conf { ports: 1883..=2000, ack_timeouts: (Some(5s), None), ack_delay: 0ns, dump_files: [], dump_prefix: "", dump_decode: None, strict: false, idprefix: "", userpass: None, max_connect: 1, max_pkt: [None], max_pkt_delay: None, max_time: [None], sess_expire: [None] }
[INFO] [stdout] thread 'test::connect' panicked at src/test.rs:43:46:
[INFO] [stdout] Failed listen: Custom { kind: Other, error: "Listen failed on 127.0.0.1::1883..=2000 (raise log level for details)" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x559d07190566 - std::backtrace_rs::backtrace::libunwind::trace::h140b6deb6a45c671
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x559d07190566 - std::backtrace_rs::backtrace::trace_unsynchronized::h8450d7e4e9219aed
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x559d07190566 - std::sys_common::backtrace::_print_fmt::hbd28e5e6c6fc3a3f
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x559d07190566 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hb058f285768cf98e
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x559d071bc920 - core::fmt::rt::Argument::fmt::h87dec7a95127da24
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x559d071bc920 - core::fmt::write::h873f89a91a4832db
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x559d0718cdff - std::io::Write::write_fmt::h90f651e9e694a4bb
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/io/mod.rs:1846:15
[INFO] [stdout]    7:     0x559d07190344 - std::sys_common::backtrace::_print::h7719d1529d9a9e13
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x559d07190344 - std::sys_common::backtrace::print::haa3afbd0e7947108
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x559d071920b7 - std::panicking::default_hook::{{closure}}::h10e3de2ec0eaff22
[INFO] [stdout]   10:     0x559d07191d9d - std::panicking::default_hook::hbdc1b1b7fe073dab
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x559d0705d1a7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h20f7887d7cd0a330
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x559d0705d1a7 - test::test_main::{{closure}}::hc125a615957b5cb1
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x559d071926d6 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h8c19e0590f8443c4
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x559d071926d6 - std::panicking::rust_panic_with_hook::hb81692602460473d
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:785:13
[INFO] [stdout]   15:     0x559d07192422 - std::panicking::begin_panic_handler::{{closure}}::h2470593aa2678e9c
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:659:13
[INFO] [stdout]   16:     0x559d07190a66 - std::sys_common::backtrace::__rust_end_short_backtrace::h560bb50225b0562b
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x559d07192174 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:647:5
[INFO] [stdout]   18:     0x559d06e17eb5 - core::panicking::panic_fmt::h29b6f262f6458dc3
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x559d06e18493 - core::result::unwrap_failed::h12bc80647957bcdb
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/result.rs:1649:5
[INFO] [stdout]   20:     0x559d06e4a4b3 - core::result::Result<T,E>::expect::hbcd96f33b52d6d1d
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/result.rs:1030:23
[INFO] [stdout]   21:     0x559d06e9dd17 - mqttest::test::connect::{{closure}}::h600000983eaa3a12
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:43:19
[INFO] [stdout]   22:     0x559d06e4c933 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::h39a020626bee1a62
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   23:     0x559d06eb9d8e - tokio::coop::budget::{{closure}}::ha604fe2b24dbf556
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/coop.rs:97:9
[INFO] [stdout]   24:     0x559d06e4903d - std::thread::local::LocalKey<T>::try_with::h792e4bd3a3ada17c
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/thread/local.rs:286:16
[INFO] [stdout]   25:     0x559d06e48cc7 - std::thread::local::LocalKey<T>::with::h9193be0f375083ca
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/thread/local.rs:262:9
[INFO] [stdout]   26:     0x559d06e4c491 - tokio::coop::budget::h6020eba865efe05a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/coop.rs:79:5
[INFO] [stdout]   27:     0x559d06e4c491 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h2ebd48c7c4fd826b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   28:     0x559d06e4ce3b - tokio::runtime::basic_scheduler::enter::{{closure}}::hd2907daad7185064
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   29:     0x559d06e949f0 - tokio::macros::scoped_tls::ScopedKey<T>::set::h1e8911c0c709247f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/macros/scoped_tls.rs:64:9
[INFO] [stdout]   30:     0x559d06e4cd70 - tokio::runtime::basic_scheduler::enter::h431b210d4a41d536
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   31:     0x559d06e4c25c - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h4385d611cdcbaccc
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   32:     0x559d06e83fbd - tokio::runtime::Runtime::block_on::{{closure}}::h4505affb385b4b69
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/mod.rs:418:34
[INFO] [stdout]   33:     0x559d06eb9ea5 - tokio::runtime::context::enter::hef4c66c713290926
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/context.rs:72:5
[INFO] [stdout]   34:     0x559d06e83e25 - tokio::runtime::handle::Handle::enter::hd8ffaf9e1e3eab46
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/handle.rs:39:9
[INFO] [stdout]   35:     0x559d06e83ec2 - tokio::runtime::Runtime::block_on::habcaa5d0a124e7d3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/tokio-0.2.16/src/runtime/mod.rs:415:9
[INFO] [stdout]   36:     0x559d06e9d869 - mqttest::test::block_on::hea82925fcc506dfa
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:34:5
[INFO] [stdout]   37:     0x559d06e9d940 - mqttest::test::connect::haa728f0b6146029f
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:39:32
[INFO] [stdout]   38:     0x559d06e9d907 - mqttest::test::connect::{{closure}}::h6a755719cca804d2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/test.rs:38:13
[INFO] [stdout]   39:     0x559d06eb1196 - core::ops::function::FnOnce::call_once::h313d2b8d40e96bea
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x559d07062d9f - core::ops::function::FnOnce::call_once::h692fe6f34484199f
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   41:     0x559d07062d9f - test::__rust_begin_short_backtrace::h48b62e76bd60e2de
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/test/src/lib.rs:621:18
[INFO] [stdout]   42:     0x559d07061bc1 - test::run_test_in_process::{{closure}}::h1c68597526ef43db
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/test/src/lib.rs:644:60
[INFO] [stdout]   43:     0x559d07061bc1 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hcae98092997f976b
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   44:     0x559d07061bc1 - std::panicking::try::do_call::h8d1548c2f5bb535a
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:554:40
[INFO] [stdout]   45:     0x559d07061bc1 - std::panicking::try::hbb7a2054f484688e
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:518:19
[INFO] [stdout]   46:     0x559d07061bc1 - std::panic::catch_unwind::h696d12d9d80497c2
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panic.rs:142:14
[INFO] [stdout]   47:     0x559d07061bc1 - test::run_test_in_process::h053367a7217c825b
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/test/src/lib.rs:644:27
[INFO] [stdout]   48:     0x559d07061bc1 - test::run_test::{{closure}}::hfa524e9fabcba78e
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/test/src/lib.rs:567:43
[INFO] [stdout]   49:     0x559d07029026 - test::run_test::{{closure}}::h2c4d0bb741ef7f9f
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/test/src/lib.rs:595:41
[INFO] [stdout]   50:     0x559d07029026 - std::sys_common::backtrace::__rust_begin_short_backtrace::h0d2c708415550075
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   51:     0x559d0702dfe7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h76e2635840d7293f
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   52:     0x559d0702dfe7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::haa640b67a810a214
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   53:     0x559d0702dfe7 - std::panicking::try::do_call::h41892e3bc2807ab5
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:554:40
[INFO] [stdout]   54:     0x559d0702dfe7 - std::panicking::try::h861a16d180681c80
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panicking.rs:518:19
[INFO] [stdout]   55:     0x559d0702dfe7 - std::panic::catch_unwind::h8195f9064b1509fa
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/panic.rs:142:14
[INFO] [stdout]   56:     0x559d0702dfe7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h73cc419da1217371
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   57:     0x559d0702dfe7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h79dc6499ff073b09
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   58:     0x559d07196b75 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::ha718e8cdc51a5182
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   59:     0x559d07196b75 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h86072abc877c5474
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   60:     0x559d07196b75 - std::sys::pal::unix::thread::Thread::new::thread_start::hac4056197c365894
[INFO] [stdout]                                at /rustc/f2048098a1ca42a520e7bed68e321a66edc0a1b1/library/std/src/sys/pal/unix/thread.rs:108:17
[INFO] [stdout]   61:     0x7f4e98adeac3 - <unknown>
[INFO] [stdout]   62:     0x7f4e98b6fbf4 - __clone
[INFO] [stdout]   63:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test::connect
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "3f5f1668f5706118098fd32b51d453e9959adea57d651b2e4347ad6bb43a05e8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3f5f1668f5706118098fd32b51d453e9959adea57d651b2e4347ad6bb43a05e8", kill_on_drop: false }`
[INFO] [stdout] 3f5f1668f5706118098fd32b51d453e9959adea57d651b2e4347ad6bb43a05e8
