[INFO] fetching crate metalmq-client 0.2.1...
[INFO] testing metalmq-client-0.2.1 against 1.54.0 for beta-1.55-1
[INFO] extracting crate metalmq-client 0.2.1 into /workspace/builds/worker-114/source
[INFO] validating manifest of crates.io crate metalmq-client 0.2.1 on toolchain 1.54.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate metalmq-client 0.2.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate metalmq-client 0.2.1
[INFO] tweaked toml for crates.io crate metalmq-client 0.2.1 written to /workspace/builds/worker-114/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5c61b409c01c2b273c715d677e64d35732df9c9e0130792e7b1277c405cd2f11
[INFO] running `Command { std: "docker" "start" "-a" "5c61b409c01c2b273c715d677e64d35732df9c9e0130792e7b1277c405cd2f11", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5c61b409c01c2b273c715d677e64d35732df9c9e0130792e7b1277c405cd2f11", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c61b409c01c2b273c715d677e64d35732df9c9e0130792e7b1277c405cd2f11", kill_on_drop: false }`
[INFO] [stdout] 5c61b409c01c2b273c715d677e64d35732df9c9e0130792e7b1277c405cd2f11
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9d4d2d1618a293dd2dc4236c91e8652550cf8a75455fe082fbd3fa118db15ca5
[INFO] running `Command { std: "docker" "start" "-a" "9d4d2d1618a293dd2dc4236c91e8652550cf8a75455fe082fbd3fa118db15ca5", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.28
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling syn v1.0.74
[INFO] [stderr]    Compiling memchr v2.4.0
[INFO] [stderr]    Compiling futures-core v0.3.16
[INFO] [stderr]    Compiling pin-project-lite v0.2.7
[INFO] [stderr]    Compiling futures-task v0.3.16
[INFO] [stderr]    Compiling futures-sink v0.3.16
[INFO] [stderr]    Compiling futures-channel v0.3.16
[INFO] [stderr]    Compiling slab v0.4.4
[INFO] [stderr]    Compiling futures-io v0.3.16
[INFO] [stderr]    Compiling anyhow v1.0.42
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling bytes v1.0.1
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling futures-macro v0.3.16
[INFO] [stderr]    Compiling futures-util v0.3.16
[INFO] [stderr]    Compiling tokio v1.9.0
[INFO] [stderr]    Compiling mio v0.7.13
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling env_logger v0.8.4
[INFO] [stderr]    Compiling tokio-macros v1.3.0
[INFO] [stderr]    Compiling tokio-stream v0.1.7
[INFO] [stderr]    Compiling tokio-util v0.6.7
[INFO] [stderr]    Compiling futures-executor v0.3.16
[INFO] [stderr]    Compiling futures v0.3.16
[INFO] [stderr]    Compiling metalmq-codec v0.2.1
[INFO] [stderr]    Compiling metalmq-client v0.2.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 27.52s
[INFO] running `Command { std: "docker" "inspect" "9d4d2d1618a293dd2dc4236c91e8652550cf8a75455fe082fbd3fa118db15ca5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9d4d2d1618a293dd2dc4236c91e8652550cf8a75455fe082fbd3fa118db15ca5", kill_on_drop: false }`
[INFO] [stdout] 9d4d2d1618a293dd2dc4236c91e8652550cf8a75455fe082fbd3fa118db15ca5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d5344cc70998ec29840d0bf74f36460fde9ca33b0219e5f8df244ea1b37667ab
[INFO] running `Command { std: "docker" "start" "-a" "d5344cc70998ec29840d0bf74f36460fde9ca33b0219e5f8df244ea1b37667ab", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling serde_derive v1.0.127
[INFO] [stderr]    Compiling serde v1.0.127
[INFO] [stderr]    Compiling ryu v1.0.5
[INFO] [stderr]    Compiling serde_json v1.0.66
[INFO] [stderr]    Compiling crossbeam-utils v0.8.5
[INFO] [stderr]    Compiling unicode-segmentation v1.8.0
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling itoa v0.4.7
[INFO] [stderr]    Compiling once_cell v1.8.0
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling peg-runtime v0.6.3
[INFO] [stderr]    Compiling async-trait v0.1.51
[INFO] [stderr]    Compiling vec_map v0.8.2
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling pathdiff v0.2.0
[INFO] [stderr]    Compiling futures-timer v3.0.2
[INFO] [stderr]    Compiling bstr v0.2.16
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling shh v1.0.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.26
[INFO] [stderr]    Compiling async-stream-impl v0.3.2
[INFO] [stderr]    Compiling typed-builder v0.7.1
[INFO] [stderr]    Compiling cute_custom_default v2.1.0
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling thread_local v1.1.3
[INFO] [stderr]    Compiling heck v0.3.3
[INFO] [stderr]    Compiling textwrap v0.12.1
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling globset v0.4.8
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling peg-macros v0.6.3
[INFO] [stderr]    Compiling ignore v0.4.18
[INFO] [stderr]    Compiling async-stream v0.3.2
[INFO] [stderr]    Compiling globwalk v0.8.1
[INFO] [stderr]    Compiling thiserror v1.0.26
[INFO] [stderr]    Compiling peg v0.6.3
[INFO] [stderr]    Compiling gherkin_rust v0.10.1
[INFO] [stderr]    Compiling cucumber_rust v0.8.4
[INFO] [stderr]    Compiling metalmq-client v0.2.1 (/opt/rustwide/workdir)
[INFO] [stdout] warning: field is never read: `receiver`
[INFO] [stdout]  --> tests/exchange.rs:7:5
[INFO] [stdout]   |
[INFO] [stdout] 7 |     receiver: metalmq_client::Client,
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field is never read: `last_result`
[INFO] [stdout]  --> tests/exchange.rs:8:5
[INFO] [stdout]   |
[INFO] [stdout] 8 |     last_result: Result<()>,
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field is never read: `channel`
[INFO] [stdout]  --> tests/acceptance.rs:7:5
[INFO] [stdout]   |
[INFO] [stdout] 7 |     channel: Option<metalmq_client::Channel>,
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 2 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 26.65s
[INFO] running `Command { std: "docker" "inspect" "d5344cc70998ec29840d0bf74f36460fde9ca33b0219e5f8df244ea1b37667ab", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d5344cc70998ec29840d0bf74f36460fde9ca33b0219e5f8df244ea1b37667ab", kill_on_drop: false }`
[INFO] [stdout] d5344cc70998ec29840d0bf74f36460fde9ca33b0219e5f8df244ea1b37667ab
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] f0ec6e9c6392a86fe5b61a4e0d9c7c42a7ad6f919bc9b351eb52c7c6d899426f
[INFO] running `Command { std: "docker" "start" "-a" "f0ec6e9c6392a86fe5b61a4e0d9c7c42a7ad6f919bc9b351eb52c7c6d899426f", kill_on_drop: false }`
[INFO] [stderr] warning: field is never read: `channel`
[INFO] [stderr]  --> tests/acceptance.rs:7:5
[INFO] [stderr]   |
[INFO] [stderr] 7 |     channel: Option<metalmq_client::Channel>,
[INFO] [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: 1 warning emitted
[INFO] [stderr] 
[INFO] [stderr] warning: field is never read: `receiver`
[INFO] [stderr]  --> tests/exchange.rs:7:5
[INFO] [stderr]   |
[INFO] [stderr] 7 |     receiver: metalmq_client::Client,
[INFO] [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: field is never read: `last_result`
[INFO] [stderr]  --> tests/exchange.rs:8:5
[INFO] [stderr]   |
[INFO] [stderr] 8 |     last_result: Result<()>,
[INFO] [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: 2 warnings emitted
[INFO] [stderr] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.19s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/metalmq_client-4a2e854e11697c87)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/acceptance.rs (/opt/rustwide/target/debug/deps/acceptance-94f0b246bb79223c)
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::send_client_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] [0m[1m[34m[Cucumber v0.8.4]
[INFO] [stdout] [0m[0m[1m[37mFeature: Connect as guest                         [0m[0m[37m features/connect.feature:1:1 
[INFO] [stdout] [0m
[INFO] [stdout] [0m[1m[37m Scenario: Connecting with plain password         [0m[0m[37m features/connect.feature:3:5 
[INFO] [stdout] [0m[0m[37m  Given a user                                    [0m[0m[37m features/connect.feature:4:9 
[INFO] [stdout] [0m[1A[2K[0m[32m  ✔ Given a user                                  [0m[0m[37m features/connect.feature:4:9 
[INFO] [stdout] [0m[0m[37m  When connects as guest/guest                    [0m[0m[37m features/connect.feature:5:9 
[INFO] [stdout] [0m[1A[2K[0m[32m  ✔ When connects as guest/guest                  [0m[0m[37m features/connect.feature:5:9 
[INFO] [stdout] [0m[0m[37m  Then it has been connected                      [0m[0m[37m features/connect.feature:6:9 
[INFO] [stdout] [0m[1A[2K[0m[31m  ✘ Then it has been connected                    [0m[0m[37m features/connect.feature:6:9 
[INFO] [stdout] [0m[0m[1m[31m———— [!] Step failed: ——————————————————————————————[0m[0m[37m  tests/acceptance.rs:66:21 
[INFO] [stdout] [0m[0m[31m  assertion failed: world.client.is_some()
[INFO] [stdout] [0m[0m[1m[31m———————— Captured stderr: ——————————————————————————————————————————————————————
[INFO] [stdout] [0m[0m[31m  2021-08-07T06:39:31.147Z - [[0m[1m[31mERROR[0m] tests/acceptance.rs:64 - Error
[INFO] [stdout]   Err(Connection error Os { code: 99, kind: AddrNotAvailable, message: "Cannot
[INFO] [stdout]   assign requested address" })
[INFO] [stdout] [0m[0m[1m[31m————————————————————————————————————————————————————————————————————————————————
[INFO] [stdout] [0m[0m[1m[37m Scenario: Connecting with wrong password         [0m[0m[37m features/connect.feature:8:5 
[INFO] [stdout] [0m[0m[37m  Given a user                                    [0m[0m[37m features/connect.feature:9:9 
[INFO] [stdout] [0m[1A[2K[0m[32m  ✔ Given a user                                  [0m[0m[37m features/connect.feature:9:9 
[INFO] [stdout] [0m[0m[37m  When connects as guest/pwd                     [0m[0m[37m features/connect.feature:10:9 
[INFO] [stdout] [0m[1A[2K[0m[32m  ✔ When connects as guest/pwd                   [0m[0m[37m features/connect.feature:10:9 
[INFO] [stdout] [0m[0m[37m  Then it gets connection closed error           [0m[0m[37m features/connect.feature:11:9 
[INFO] [stdout] [0m[1A[2K[0m[31m  ✘ Then it gets connection closed error         [0m[0m[37m features/connect.feature:11:9 
[INFO] [stdout] [0m[0m[1m[31m———— [!] Step failed: ——————————————————————————————[0m[0m[37m  tests/acceptance.rs:75:21 
[INFO] [stdout] [0m[0m[31m  assertion failed: maybe_err.is_some()
[INFO] [stdout] [0m
[INFO] [stdout] [0m[1m[37mFeature: Exchange                                [0m[0m[37m features/exchange.feature:1:1 
[INFO] [stdout] [0m
[INFO] [stdout] [0m[1m[37m Scenario: Send a message to an exchange         [0m[0m[37m features/exchange.feature:3:5 
[INFO] [stdout] [0m[0m[37m  Given an exchange declared as messages         [0m[0m[37m features/exchange.feature:4:9 
[INFO] [stdout] [0m[1A[2K[0m[36m  - Given an exchange declared as messages       [0m[0m[37m features/exchange.feature:4:9 
[INFO] [stdout] [0m[0m[33m    ⚡ [0mNot yet implemented (skipped)
[INFO] [stdout] 
[INFO] [stdout] [0m[1m[34m[Summary]
[INFO] [stdout] [0m[0m[1m[37m2 features
[INFO] [stdout] [0m[0m[1m[37m3 scenarios ([0m[0m[1m[31m2 failed[0m[0m[1m[37m, [0m[0m[1m[36m1 skipped[0m[0m[1m[37m, [0m[0m[1m[32m0 passed[0m[0m[1m[37m)
[INFO] [stdout] [0m[0m[1m[37m14 steps ([0m[0m[1m[31m2 failed[0m[0m[1m[37m, [0m[0m[1m[36m1 skipped[0m[0m[1m[37m, [0m[0m[1m[32m4 passed[0m[0m[1m[37m)
[INFO] [stdout] [0m
[INFO] [stdout] Finished in 0.23 seconds.
[INFO] [stderr] error: test failed, to rerun pass '--test acceptance'
[INFO] running `Command { std: "docker" "inspect" "f0ec6e9c6392a86fe5b61a4e0d9c7c42a7ad6f919bc9b351eb52c7c6d899426f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f0ec6e9c6392a86fe5b61a4e0d9c7c42a7ad6f919bc9b351eb52c7c6d899426f", kill_on_drop: false }`
[INFO] [stdout] f0ec6e9c6392a86fe5b61a4e0d9c7c42a7ad6f919bc9b351eb52c7c6d899426f
