[INFO] cloning repository https://github.com/bbucko/raqqietka [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/bbucko/raqqietka" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbbucko%2Fraqqietka", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbbucko%2Fraqqietka'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 4b4a10f8470f5c6a4fc8a62aa704716626f4385e [INFO] testing bbucko/raqqietka against master#99e3aef02079e9c10583638520cd0c134dc3a01d for pr-85530 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fbbucko%2Fraqqietka" "/workspace/builds/worker-8/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-8/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/bbucko/raqqietka on toolchain 99e3aef02079e9c10583638520cd0c134dc3a01d [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/bbucko/raqqietka [INFO] finished tweaking git repo https://github.com/bbucko/raqqietka [INFO] tweaked toml for git repo https://github.com/bbucko/raqqietka written to /workspace/builds/worker-8/source/Cargo.toml [INFO] crate git repo https://github.com/bbucko/raqqietka already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] a82d6f778b863adf78a02945c2ea6e974e3d5636f8d12deb9014d1d05eba2ffb [INFO] running `Command { std: "docker" "start" "-a" "a82d6f778b863adf78a02945c2ea6e974e3d5636f8d12deb9014d1d05eba2ffb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "a82d6f778b863adf78a02945c2ea6e974e3d5636f8d12deb9014d1d05eba2ffb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a82d6f778b863adf78a02945c2ea6e974e3d5636f8d12deb9014d1d05eba2ffb", kill_on_drop: false }` [INFO] [stdout] a82d6f778b863adf78a02945c2ea6e974e3d5636f8d12deb9014d1d05eba2ffb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9d5a32533b639236532cef85cb4bb87f6f9b277165fed19e80e8d9088b420c42 [INFO] running `Command { std: "docker" "start" "-a" "9d5a32533b639236532cef85cb4bb87f6f9b277165fed19e80e8d9088b420c42", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling syn v1.0.72 [INFO] [stderr] Compiling pin-project-lite v0.2.6 [INFO] [stderr] Compiling futures-core v0.3.15 [INFO] [stderr] Compiling futures-sink v0.3.15 [INFO] [stderr] Compiling futures-channel v0.3.15 [INFO] [stderr] Compiling futures-task v0.3.15 [INFO] [stderr] Compiling futures-io v0.3.15 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling futures-macro v0.3.15 [INFO] [stderr] Compiling futures-util v0.3.15 [INFO] [stderr] Compiling tokio v1.6.0 [INFO] [stderr] Compiling tracing-core v0.1.18 [INFO] [stderr] Compiling sharded-slab v0.1.1 [INFO] [stderr] Compiling thread_local v1.1.3 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling syn v0.11.11 [INFO] [stderr] Compiling mio v0.7.11 [INFO] [stderr] Compiling regex-automata v0.1.9 [INFO] [stderr] Compiling tracing v0.1.26 [INFO] [stderr] Compiling core v0.1.0 (/opt/rustwide/workdir/core) [INFO] [stderr] Compiling broker v0.1.0 (/opt/rustwide/workdir/broker) [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling num-traits v0.1.43 [INFO] [stderr] Compiling enum-primitive-derive v0.1.2 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling tracing-subscriber v0.2.18 [INFO] [stderr] Compiling tokio-macros v1.2.0 [INFO] [stderr] Compiling serde_derive v1.0.126 [INFO] [stderr] Compiling pin-project-internal v1.0.7 [INFO] [stderr] Compiling pin-project v1.0.7 [INFO] [stderr] Compiling tracing-futures v0.2.5 [INFO] [stderr] Compiling futures-executor v0.3.15 [INFO] [stderr] Compiling futures v0.3.15 [INFO] [stderr] Compiling tokio-stream v0.1.6 [INFO] [stderr] Compiling tokio-util v0.6.7 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling mqttrs v0.3.1 (https://github.com/bbucko/mqttrs?branch=0.3.1#c3183f01) [INFO] [stderr] Compiling mqtt v0.1.0 (/opt/rustwide/workdir/mqtt) [INFO] [stdout] warning: unused variable: `sub_results` [INFO] [stdout] --> mqtt/src/client.rs:158:39 [INFO] [stdout] | [INFO] [stdout] 158 | Ack::Subscribe(packet_id, sub_results) => { [INFO] [stdout] | ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_sub_results` [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_variables)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Compiling raqqietka v0.1.0 (/opt/rustwide/workdir/raqqietka) [INFO] [stdout] warning: unused variable: `err` [INFO] [stdout] --> raqqietka/src/main.rs:73:23 [INFO] [stdout] | [INFO] [stdout] 73 | .map_err(|err| //FIXME improve error handling [INFO] [stdout] | ^^^ help: if this is intentional, prefix it with an underscore: `_err` [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_variables)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 48.83s [INFO] running `Command { std: "docker" "inspect" "9d5a32533b639236532cef85cb4bb87f6f9b277165fed19e80e8d9088b420c42", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9d5a32533b639236532cef85cb4bb87f6f9b277165fed19e80e8d9088b420c42", kill_on_drop: false }` [INFO] [stdout] 9d5a32533b639236532cef85cb4bb87f6f9b277165fed19e80e8d9088b420c42 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 0f0be6c7b0453d081c93f788ddb9c6ab6ca60a994ca2af9b8ee2dd6c2bc40804 [INFO] running `Command { std: "docker" "start" "-a" "0f0be6c7b0453d081c93f788ddb9c6ab6ca60a994ca2af9b8ee2dd6c2bc40804", kill_on_drop: false }` [INFO] [stderr] Compiling core v0.1.0 (/opt/rustwide/workdir/core) [INFO] [stdout] warning: unused variable: `sub_results` [INFO] [stdout] --> mqtt/src/client.rs:158:39 [INFO] [stdout] | [INFO] [stdout] 158 | Ack::Subscribe(packet_id, sub_results) => { [INFO] [stdout] | ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_sub_results` [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_variables)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Compiling mqtt v0.1.0 (/opt/rustwide/workdir/mqtt) [INFO] [stderr] Compiling broker v0.1.0 (/opt/rustwide/workdir/broker) [INFO] [stderr] Compiling raqqietka v0.1.0 (/opt/rustwide/workdir/raqqietka) [INFO] [stdout] warning: unused variable: `sub_results` [INFO] [stdout] --> mqtt/src/client.rs:158:39 [INFO] [stdout] | [INFO] [stdout] 158 | Ack::Subscribe(packet_id, sub_results) => { [INFO] [stdout] | ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_sub_results` [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_variables)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: unused variable: `err` [INFO] [stdout] --> raqqietka/src/main.rs:73:23 [INFO] [stdout] | [INFO] [stdout] 73 | .map_err(|err| //FIXME improve error handling [INFO] [stdout] | ^^^ help: if this is intentional, prefix it with an underscore: `_err` [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(unused_variables)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: 1 warning emitted [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 2.58s [INFO] running `Command { std: "docker" "inspect" "0f0be6c7b0453d081c93f788ddb9c6ab6ca60a994ca2af9b8ee2dd6c2bc40804", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0f0be6c7b0453d081c93f788ddb9c6ab6ca60a994ca2af9b8ee2dd6c2bc40804", kill_on_drop: false }` [INFO] [stdout] 0f0be6c7b0453d081c93f788ddb9c6ab6ca60a994ca2af9b8ee2dd6c2bc40804 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-8/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" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 8451b64e150013928fca97281058ef4588c7a25043c3de727873a630a826590c [INFO] running `Command { std: "docker" "start" "-a" "8451b64e150013928fca97281058ef4588c7a25043c3de727873a630a826590c", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] warning: unused variable: `sub_results` [INFO] [stderr] --> mqtt/src/client.rs:158:39 [INFO] [stderr] | [INFO] [stderr] 158 | Ack::Subscribe(packet_id, sub_results) => { [INFO] [stderr] | ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_sub_results` [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_variables)]` on by default [INFO] [stderr] [INFO] [stderr] warning: 1 warning emitted [INFO] [stderr] [INFO] [stderr] warning: unused variable: `sub_results` [INFO] [stderr] --> mqtt/src/client.rs:158:39 [INFO] [stderr] | [INFO] [stderr] 158 | Ack::Subscribe(packet_id, sub_results) => { [INFO] [stderr] | ^^^^^^^^^^^ help: if this is intentional, prefix it with an underscore: `_sub_results` [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_variables)]` on by default [INFO] [stderr] [INFO] [stderr] warning: 1 warning emitted [INFO] [stderr] [INFO] [stderr] warning: unused variable: `err` [INFO] [stderr] --> raqqietka/src/main.rs:73:23 [INFO] [stderr] | [INFO] [stderr] 73 | .map_err(|err| //FIXME improve error handling [INFO] [stderr] | ^^^ help: if this is intentional, prefix it with an underscore: `_err` [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(unused_variables)]` on by default [INFO] [stderr] [INFO] [stderr] warning: 1 warning emitted [INFO] [stderr] [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.07s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/broker-a9305607dd0ba7f1) [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] test tests::test_broker_connect ... ok [INFO] [stdout] test tests::test_broker_subscribe_with_wildcard_topics_multilevel ... ok [INFO] [stdout] test tests::test_broker_subscribe_with_wildcard_topics_single_level_last ... ok [INFO] [stdout] test validator::tests::test_publish_incorrect_topics ... ok [INFO] [stdout] test validator::tests::test_publish_correct_topics ... ok [INFO] [stdout] test tests::test_broker_publish_without_subscription ... ok [INFO] [stdout] test tests::test_broker_validate_topic_containing_wildcard ... ok [INFO] [stdout] test validator::tests::test_subscribe_correct_topics ... ok [INFO] [stdout] test tests::test_broker_subscribe_with_plain_topics ... ok [INFO] [stdout] test tests::test_broker_subscribe_with_incorrect_filter ... ok [INFO] [stdout] test tests::test_broker_subscribe_with_wildcard_topics_single_level_middle ... ok [INFO] [stdout] [INFO] [stderr] Running tests/integration_tests.rs (/opt/rustwide/target/debug/deps/integration_tests-5b03f236944d722e) [INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test test_clean_disconnect_with_lwt ... ok [INFO] [stdout] test test_register_with_existing_client ... ok [INFO] [stdout] test test_register ... ok [INFO] [stdout] test test_forced_disconnect_with_lwt ... ok [INFO] [stdout] test test_forced_disconnect_with_lwt_and_existing_client ... ok [INFO] [stdout] test test_broker_publish_with_wildcard_multilevel_at_the_end_subscription ... ok [INFO] [stdout] test test_broker_qos1_multiple_publish_with_plain_subscription ... ok [INFO] [stdout] test test_broker_qos0_publish_with_plain_subscription ... ok [INFO] [stdout] test test_broker_publish_increasing_counter ... ok [INFO] [stdout] test test_broker_publish_with_wildcard_one_level_subscription ... ok [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/core-1f05ab96022cedb0) [INFO] [stdout] test test_broker_qos1_publish_with_plain_subscription ... ok [INFO] [stdout] test test_broker_publish_with_wildcard_one_level_in_the_middle_subscription ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test util::tests::test_encoding_three_digits ... ok [INFO] [stdout] test util::tests::test_calculate_length ... ok [INFO] [stdout] test util::tests::test_encoding_four_digits ... ok [INFO] [stdout] test util::tests::test_encoding_two_digits ... ok [INFO] [stdout] test util::tests::test_encoding_one_digit ... ok [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/mqtt-912569243a8ea85c) [INFO] [stdout] test util::tests::test_calculate_length_short ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/raqqietka-448dc813799791fa) [INFO] [stdout] [INFO] [stderr] Doc-tests broker [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Doc-tests core [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Doc-tests mqtt [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "8451b64e150013928fca97281058ef4588c7a25043c3de727873a630a826590c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8451b64e150013928fca97281058ef4588c7a25043c3de727873a630a826590c", kill_on_drop: false }` [INFO] [stdout] 8451b64e150013928fca97281058ef4588c7a25043c3de727873a630a826590c