[INFO] fetching crate rumq-core 0.1.0-alpha.10...
[INFO] testing rumq-core-0.1.0-alpha.10 against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041
[INFO] extracting crate rumq-core 0.1.0-alpha.10 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate rumq-core 0.1.0-alpha.10 on toolchain 432e145bd5a974c5b6f4dd9b352891bd7502b69d
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate rumq-core 0.1.0-alpha.10
[INFO] finished tweaking crates.io crate rumq-core 0.1.0-alpha.10
[INFO] tweaked toml for crates.io crate rumq-core 0.1.0-alpha.10 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 956a998e35e4f54126477b51223ca8fdae1f36b88ef45b692aae2e22f7e08192
[INFO] running `Command { std: "docker" "start" "-a" "956a998e35e4f54126477b51223ca8fdae1f36b88ef45b692aae2e22f7e08192", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "956a998e35e4f54126477b51223ca8fdae1f36b88ef45b692aae2e22f7e08192", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "956a998e35e4f54126477b51223ca8fdae1f36b88ef45b692aae2e22f7e08192", kill_on_drop: false }`
[INFO] [stdout] 956a998e35e4f54126477b51223ca8fdae1f36b88ef45b692aae2e22f7e08192
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a2c23d7e4fa8247aeb4745a868a7c5bec11e254bdfa52a3e35fee73e2c03c8a8
[INFO] running `Command { std: "docker" "start" "-a" "a2c23d7e4fa8247aeb4745a868a7c5bec11e254bdfa52a3e35fee73e2c03c8a8", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling libc v0.2.98
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling bytes v0.5.6
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling pin-project-lite v0.1.12
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling tokio-macros v0.2.6
[INFO] [stderr]    Compiling net2 v0.2.37
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling signal-hook-registry v1.4.0
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling mio v0.6.23
[INFO] [stderr]    Compiling mio-uds v0.6.8
[INFO] [stderr]    Compiling tokio v0.2.25
[INFO] [stderr]    Compiling tokio-util v0.3.1
[INFO] [stderr]    Compiling rumq-core v0.1.0-alpha.10 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.28s
[INFO] running `Command { std: "docker" "inspect" "a2c23d7e4fa8247aeb4745a868a7c5bec11e254bdfa52a3e35fee73e2c03c8a8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a2c23d7e4fa8247aeb4745a868a7c5bec11e254bdfa52a3e35fee73e2c03c8a8", kill_on_drop: false }`
[INFO] [stdout] a2c23d7e4fa8247aeb4745a868a7c5bec11e254bdfa52a3e35fee73e2c03c8a8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] da7fd80b1c8677069cabc206e0f7cb3d8edbb8fde3fda4a83bbf73f8216bad62
[INFO] running `Command { std: "docker" "start" "-a" "da7fd80b1c8677069cabc206e0f7cb3d8edbb8fde3fda4a83bbf73f8216bad62", kill_on_drop: false }`
[INFO] [stderr]    Compiling bencher v0.1.5
[INFO] [stderr]    Compiling rumq-core v0.1.0-alpha.10 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 5.05s
[INFO] running `Command { std: "docker" "inspect" "da7fd80b1c8677069cabc206e0f7cb3d8edbb8fde3fda4a83bbf73f8216bad62", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "da7fd80b1c8677069cabc206e0f7cb3d8edbb8fde3fda4a83bbf73f8216bad62", kill_on_drop: false }`
[INFO] [stdout] da7fd80b1c8677069cabc206e0f7cb3d8edbb8fde3fda4a83bbf73f8216bad62
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7e72903cecc351f32b07b513c970adadf0f96e01a04425bea354b5f89dc58993
[INFO] running `Command { std: "docker" "start" "-a" "7e72903cecc351f32b07b513c970adadf0f96e01a04425bea354b5f89dc58993", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/rumq_core-e6c1d09b71014d09)
[INFO] [stdout] 
[INFO] [stdout] running 32 tests
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_connack_works ... ok
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_suback_works ... ok
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_subscribe_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_connack_works ... ok
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_unsubscribe_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_connect_mqtt_protocol ... ok
[INFO] [stdout] test mqtt4::asyncserialize::test::write_packet_subscribe_works ... ok
[INFO] [stdout] test mqtt4::asyncserialize::test::write_packet_connack_works ... ok
[INFO] [stdout] test mqtt4::asyncserialize::test::write_packet_publish_at_most_once_works ... ok
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_publish_qos0_works ... ok
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_publish_qos1_works ... ok
[INFO] [stdout] test mqtt4::asyncserialize::test::write_packet_connect_mqtt_protocol_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_puback_works ... ok
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_connect_mqtt_protocol ... ok
[INFO] [stdout] test mqtt4::asyncserialize::test::write_packet_publish_at_least_once_works ... ok
[INFO] [stdout] test mqtt4::topic::test::wildcards_are_detected_correctly ... ok
[INFO] [stdout] test mqtt4::topic::test::topics_match_with_filters_as_expected ... ok
[INFO] [stdout] test mqtt4::serialize::test::write_packet_publish_at_least_once_works ... ok
[INFO] [stdout] test mqtt4::serialize::test::write_packet_connect_mqtt_protocol_works ... ok
[INFO] [stdout] test mqtt4::topic::test::zero_len_subscriptions_are_not_allowed ... ok
[INFO] [stdout] test mqtt4::serialize::test::write_packet_connack_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_publish_qos1_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_publish_qos0_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_suback_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_subscribe_works ... ok
[INFO] [stdout] test mqtt4::asyncdeserialize::test::read_packet_puback_works ... ok
[INFO] [stdout] test mqtt4::serialize::test::write_packet_subscribe_works ... ok
[INFO] [stdout] test mqtt4::topic::test::dollar_subscriptions_doesnt_match_dollar_topic ... ok
[INFO] [stdout] test mqtt4::topic::test::filters_are_validated_correctly ... ok
[INFO] [stdout] test mqtt4::topic::test::topics_are_validated_correctly ... ok
[INFO] [stdout] test mqtt4::serialize::test::write_packet_publish_at_most_once_works ... ok
[INFO] [stdout] test mqtt4::deserialize::test::read_packet_unsubscribe_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rumq-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] running `Command { std: "docker" "inspect" "7e72903cecc351f32b07b513c970adadf0f96e01a04425bea354b5f89dc58993", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7e72903cecc351f32b07b513c970adadf0f96e01a04425bea354b5f89dc58993", kill_on_drop: false }`
[INFO] [stdout] 7e72903cecc351f32b07b513c970adadf0f96e01a04425bea354b5f89dc58993