[INFO] cloning repository https://github.com/fluffysquirrels/mqtt-client
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/fluffysquirrels/mqtt-client" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffluffysquirrels%2Fmqtt-client", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffluffysquirrels%2Fmqtt-client'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] f967bc4bf996c444b14d8022c16a7cae94455e3a
[INFO] testing fluffysquirrels/mqtt-client against try#ce59db7a1b1b012fb2793c4641c1bdecad7a128b for pr-85530
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Ffluffysquirrels%2Fmqtt-client" "/workspace/builds/worker-10/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-10/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/fluffysquirrels/mqtt-client on toolchain ce59db7a1b1b012fb2793c4641c1bdecad7a128b
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/fluffysquirrels/mqtt-client
[INFO] finished tweaking git repo https://github.com/fluffysquirrels/mqtt-client
[INFO] tweaked toml for git repo https://github.com/fluffysquirrels/mqtt-client written to /workspace/builds/worker-10/source/Cargo.toml
[INFO] crate git repo https://github.com/fluffysquirrels/mqtt-client already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 549db38f9f6fe1031ef976b479d390495764dd766ec1e18064fa6424ac446604
[INFO] running `Command { std: "docker" "start" "-a" "549db38f9f6fe1031ef976b479d390495764dd766ec1e18064fa6424ac446604", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "549db38f9f6fe1031ef976b479d390495764dd766ec1e18064fa6424ac446604", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "549db38f9f6fe1031ef976b479d390495764dd766ec1e18064fa6424ac446604", kill_on_drop: false }`
[INFO] [stdout] 549db38f9f6fe1031ef976b479d390495764dd766ec1e18064fa6424ac446604
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bebc631a15cea246f4dab8b6c05e66d4789286796867dd8beb77b48474fd75ff
[INFO] running `Command { std: "docker" "start" "-a" "bebc631a15cea246f4dab8b6c05e66d4789286796867dd8beb77b48474fd75ff", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.86
[INFO] [stderr]    Compiling proc-macro2 v1.0.24
[INFO] [stderr]    Compiling unicode-xid v0.2.1
[INFO] [stderr]    Compiling syn v1.0.60
[INFO] [stderr]    Compiling once_cell v1.5.2
[INFO] [stderr]    Compiling cc v1.0.66
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling spin v0.5.2
[INFO] [stderr]    Compiling untrusted v0.7.1
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling proc-macro-hack v0.5.19
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling memchr v2.3.4
[INFO] [stderr]    Compiling byteorder v1.4.2
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling bytes v1.0.1
[INFO] [stderr]    Compiling slab v0.4.2
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling futures-task v0.3.12
[INFO] [stderr]    Compiling tokio v1.2.0
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling ring v0.16.20
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling mio v0.7.8
[INFO] [stderr]    Compiling bytes v0.4.12
[INFO] [stderr]    Compiling mqttrs v0.2.0
[INFO] [stderr]    Compiling sct v0.6.0
[INFO] [stderr]    Compiling webpki v0.21.4
[INFO] [stderr]    Compiling rustls v0.19.0
[INFO] [stderr]    Compiling tokio-macros v1.1.0
[INFO] [stderr]    Compiling futures-macro v0.3.12
[INFO] [stderr]    Compiling futures-util v0.3.12
[INFO] [stderr]    Compiling tokio-rustls v0.22.0
[INFO] [stderr]    Compiling mqtt-async-client v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 34.79s
[INFO] running `Command { std: "docker" "inspect" "bebc631a15cea246f4dab8b6c05e66d4789286796867dd8beb77b48474fd75ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bebc631a15cea246f4dab8b6c05e66d4789286796867dd8beb77b48474fd75ff", kill_on_drop: false }`
[INFO] [stdout] bebc631a15cea246f4dab8b6c05e66d4789286796867dd8beb77b48474fd75ff
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 507fa3f4bc93c3cb74beaf8d489eb20767f02126074444cf70a6a20d3d0af47f
[INFO] running `Command { std: "docker" "start" "-a" "507fa3f4bc93c3cb74beaf8d489eb20767f02126074444cf70a6a20d3d0af47f", kill_on_drop: false }`
[INFO] [stderr]    Compiling version_check v0.9.2
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling unicode-segmentation v1.7.1
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling regex-syntax v0.6.22
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling termcolor v1.1.2
[INFO] [stderr]    Compiling thread_local v1.1.3
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling aho-corasick v0.7.15
[INFO] [stderr]    Compiling webpki-roots v0.18.0
[INFO] [stderr]    Compiling humantime v1.3.0
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling heck v0.3.2
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling structopt-derive v0.4.14
[INFO] [stderr]    Compiling regex v1.4.3
[INFO] [stderr]    Compiling structopt v0.3.21
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling mqtt-async-client v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 23.80s
[INFO] running `Command { std: "docker" "inspect" "507fa3f4bc93c3cb74beaf8d489eb20767f02126074444cf70a6a20d3d0af47f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "507fa3f4bc93c3cb74beaf8d489eb20767f02126074444cf70a6a20d3d0af47f", kill_on_drop: false }`
[INFO] [stdout] 507fa3f4bc93c3cb74beaf8d489eb20767f02126074444cf70a6a20d3d0af47f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-10/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 12f406db45471c3ea8ef86c1c91f35db93ab15115b9144b80445e0b39cdb29f6
[INFO] running `Command { std: "docker" "start" "-a" "12f406db45471c3ea8ef86c1c91f35db93ab15115b9144b80445e0b39cdb29f6", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stdout] running 15 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/mqtt_async_client-f145b2b42d95d76e)
[INFO] [stdout] test util::free_pid_list::tests::free_case_merge_below ... ok
[INFO] [stdout] test util::free_pid_list::tests::free_case_new_range ... ok
[INFO] [stdout] test client::client::test::client_is_send ... ok
[INFO] [stdout] test util::free_pid_list::tests::double_free_upper_bound ... ok
[INFO] [stdout] test util::free_pid_list::tests::free_case_merge_above ... ok
[INFO] [stdout] test util::free_pid_list::tests::free_case_merge_above_and_below ... ok
[INFO] [stdout] test util::free_pid_list::tests::bounds_ex ... ok
[INFO] [stdout] test util::free_pid_list::tests::double_free_lower_bound ... ok
[INFO] [stdout] test util::free_pid_list::tests::clear ... ok
[INFO] [stdout] test util::free_pid_list::tests::ex_1 ... ok
[INFO] [stdout] test util::free_pid_list::tests::bad_bounds_zero ... ok
[INFO] [stdout] test util::free_pid_list::tests::bounds_bad_free_lb ... ok
[INFO] [stdout] test util::free_pid_list::tests::bounds_bad_free_ub ... ok
[INFO] [stdout] test util::free_pid_list::tests::bad_bounds_swapped ... ok
[INFO] [stdout] test util::free_pid_list::tests::empty ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-81fdb5bff3248b8e)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stderr] [2021-06-07T18:24:19Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:19Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:19Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:19Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:20Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:20Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:20Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:20Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:21Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:21Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:21Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:21Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:22Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:22Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:22Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:22Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:23Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:23Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:23Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:23Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:24Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:24Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:24Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:24Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:25Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:25Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:25Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:25Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:26Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:26Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:26Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:26Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:27Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:27Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:27Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:27Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:28Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:28Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:28Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:28Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:29Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:29Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:29Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:29Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:30Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:30Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:30Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:30Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:31Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:31Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:31Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:31Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:32Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:32Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:32Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:32Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:33Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:33Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:33Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:33Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:34Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:34Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:34Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:34Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:35Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:35Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:35Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:35Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:36Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:36Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:36Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:36Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:37Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:37Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:37Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:37Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:38Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:38Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:38Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] [2021-06-07T18:24:38Z ERROR mqtt_async_client::client::client] IoTask: Error connecting: Cannot assign requested address (os error 99)
[INFO] [stderr] error: test failed, to rerun pass '--test integration_test'
[INFO] [stdout] test retain ... FAILED
[INFO] [stdout] test pub_and_sub_tls ... FAILED
[INFO] [stdout] test pub_and_sub_plain ... FAILED
[INFO] [stdout] test unsubscribe ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- retain stdout ----
[INFO] [stdout] Error: String("Timeout writing publish after 20000ms")
[INFO] [stdout] thread 'retain' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `1`,
[INFO] [stdout]  right: `0`: the test returned a termination value with a non-zero status code (1) which indicates a failure', /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5580485a0de0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5580485a0de0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5580485c447c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55804859c125 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5580485a2fdb - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x5580485a2aec - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x5580485a3681 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x5580485a3187 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x5580485a12dc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x5580485a30e9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x5580480c3b91 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x5580485c28de - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x558048542a6a - core[ee1ca6415511a9c4]::panicking::assert_failed::<i32, i32>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x5580480e2709 - test[eeb9024d9ac7bc83]::assert_test_result::<core[ee1ca6415511a9c4]::result::Result<(), mqtt_async_client[d255cd16695999c5]::error::Error>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout]   18:     0x5580480e0ef9 - integration_test[84ef32e0c6556309]::retain::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:138:1
[INFO] [stdout]   19:     0x5580480d9c3e - <integration_test[84ef32e0c6556309]::retain::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5580482c2483 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x5580482c2483 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x5580482c0f4c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x5580482c0f4c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x5580482a0c12 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x5580482a0c12 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x5580482a14f8 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x5580485a8817 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7fc2f0550609 - start_thread
[INFO] [stdout]   42:     0x7fc2f0322293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- pub_and_sub_tls stdout ----
[INFO] [stdout] Error: String("Timeout waiting for Suback after 20000ms")
[INFO] [stdout] thread 'pub_and_sub_tls' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `1`,
[INFO] [stdout]  right: `0`: the test returned a termination value with a non-zero status code (1) which indicates a failure', /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5580485a0de0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5580485a0de0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5580485c447c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55804859c125 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5580485a2fdb - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x5580485a2aec - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x5580485a3681 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x5580485a3187 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x5580485a12dc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x5580485a30e9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x5580480c3b91 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x5580485c28de - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x558048542a6a - core[ee1ca6415511a9c4]::panicking::assert_failed::<i32, i32>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x5580480e2709 - test[eeb9024d9ac7bc83]::assert_test_result::<core[ee1ca6415511a9c4]::result::Result<(), mqtt_async_client[d255cd16695999c5]::error::Error>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout]   18:     0x5580480de0e9 - integration_test[84ef32e0c6556309]::pub_and_sub_tls::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:76:1
[INFO] [stdout]   19:     0x5580480d9bbe - <integration_test[84ef32e0c6556309]::pub_and_sub_tls::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5580482c2483 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x5580482c2483 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x5580482c0f4c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x5580482c0f4c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x5580482a0c12 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x5580482a0c12 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x5580482a14f8 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x5580485a8817 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7fc2f0550609 - start_thread
[INFO] [stdout]   42:     0x7fc2f0322293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- pub_and_sub_plain stdout ----
[INFO] [stdout] Error: String("Timeout waiting for Suback after 20000ms")
[INFO] [stdout] thread 'pub_and_sub_plain' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `1`,
[INFO] [stdout]  right: `0`: the test returned a termination value with a non-zero status code (1) which indicates a failure', /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5580485a0de0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5580485a0de0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5580485c447c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55804859c125 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5580485a2fdb - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x5580485a2aec - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x5580485a3681 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x5580485a3187 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x5580485a12dc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x5580485a30e9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x5580480c3b91 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x5580485c28de - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x558048542a6a - core[ee1ca6415511a9c4]::panicking::assert_failed::<i32, i32>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x5580480e2709 - test[eeb9024d9ac7bc83]::assert_test_result::<core[ee1ca6415511a9c4]::result::Result<(), mqtt_async_client[d255cd16695999c5]::error::Error>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout]   18:     0x5580480dca49 - integration_test[84ef32e0c6556309]::pub_and_sub_plain::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:46:1
[INFO] [stdout]   19:     0x5580480d9bfe - <integration_test[84ef32e0c6556309]::pub_and_sub_plain::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5580482c2483 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x5580482c2483 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x5580482c0f4c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x5580482c0f4c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x5580482a0c12 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x5580482a0c12 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x5580482a14f8 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x5580485a8817 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7fc2f0550609 - start_thread
[INFO] [stdout]   42:     0x7fc2f0322293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- unsubscribe stdout ----
[INFO] [stdout] Error: String("Timeout waiting for Suback after 20000ms")
[INFO] [stdout] thread 'unsubscribe' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `1`,
[INFO] [stdout]  right: `0`: the test returned a termination value with a non-zero status code (1) which indicates a failure', /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x5580485a0de0 - std[77c0456e0eb29f0c]::backtrace_rs::backtrace::trace_unsynchronized::<std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5580485a0de0 - std[77c0456e0eb29f0c]::sys_common::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5580485a0de0 - <std[77c0456e0eb29f0c]::sys_common::backtrace::_print::DisplayBacktrace as core[ee1ca6415511a9c4]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5580485c447c - core[ee1ca6415511a9c4]::fmt::write
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55804859c125 - <alloc[cda43b294bbfc5d0]::vec::Vec<u8> as std[77c0456e0eb29f0c]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/io/mod.rs:1584:15
[INFO] [stdout]    6:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::_print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5580485a2fdb - std[77c0456e0eb29f0c]::sys_common::backtrace::print
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5580485a2fdb - std[77c0456e0eb29f0c]::panicking::default_hook::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x5580485a2aec - std[77c0456e0eb29f0c]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x5580485a3681 - std[77c0456e0eb29f0c]::panicking::rust_panic_with_hook
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x5580485a3187 - std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x5580485a12dc - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_end_short_backtrace::<std[77c0456e0eb29f0c]::panicking::begin_panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x5580485a30e9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x5580480c3b91 - core[ee1ca6415511a9c4]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x5580485c28de - core[ee1ca6415511a9c4]::panicking::assert_failed_inner
[INFO] [stdout]   16:     0x558048542a6a - core[ee1ca6415511a9c4]::panicking::assert_failed::<i32, i32>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x5580480e2709 - test[eeb9024d9ac7bc83]::assert_test_result::<core[ee1ca6415511a9c4]::result::Result<(), mqtt_async_client[d255cd16695999c5]::error::Error>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:193:5
[INFO] [stdout]   18:     0x5580480df789 - integration_test[84ef32e0c6556309]::unsubscribe::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/integration_test.rs:105:1
[INFO] [stdout]   19:     0x5580480d9b7e - <integration_test[84ef32e0c6556309]::unsubscribe::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   20:     0x5580482c2483 - <fn() as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   21:     0x5580482c2483 - test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace::<fn()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577:5
[INFO] [stdout]   22:     0x5580482c0f4c - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   23:     0x5580482c0f4c - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   24:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   25:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   26:     0x5580482c0f4c - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()> + core[ee1ca6415511a9c4]::marker::Send>>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   27:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test_in_process
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600:18
[INFO] [stdout]   28:     0x5580482c0f4c - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492:39
[INFO] [stdout]   29:     0x5580482a0c12 - test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519:37
[INFO] [stdout]   30:     0x5580482a0c12 - std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   31:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   32:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346:9
[INFO] [stdout]   33:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::do_call::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401:40
[INFO] [stdout]   34:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365:19
[INFO] [stdout]   35:     0x5580482a14f8 - std[77c0456e0eb29f0c]::panic::catch_unwind::<std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433:14
[INFO] [stdout]   36:     0x5580482a14f8 - <std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked::<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   37:     0x5580482a14f8 - <<std[77c0456e0eb29f0c]::thread::Builder>::spawn_unchecked<test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1}, ()>::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   38:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   39:     0x5580485a8817 - <alloc[cda43b294bbfc5d0]::boxed::Box<alloc[cda43b294bbfc5d0]::boxed::Box<dyn core[ee1ca6415511a9c4]::ops::function::FnOnce<(), Output = ()>>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   40:     0x5580485a8817 - <std[77c0456e0eb29f0c]::sys::unix::thread::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   41:     0x7fc2f0550609 - start_thread
[INFO] [stdout]   42:     0x7fc2f0322293 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     pub_and_sub_plain
[INFO] [stdout]     pub_and_sub_tls
[INFO] [stdout]     retain
[INFO] [stdout]     unsubscribe
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out; finished in 20.04s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "12f406db45471c3ea8ef86c1c91f35db93ab15115b9144b80445e0b39cdb29f6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "12f406db45471c3ea8ef86c1c91f35db93ab15115b9144b80445e0b39cdb29f6", kill_on_drop: false }`
[INFO] [stdout] 12f406db45471c3ea8ef86c1c91f35db93ab15115b9144b80445e0b39cdb29f6