[INFO] fetching crate rumqtt 0.31.0... [INFO] testing rumqtt-0.31.0 against try#1b74e096b9bfb06f84a3007193dcd2f059cbdf6a for pr-96025 [INFO] extracting crate rumqtt 0.31.0 into /workspace/builds/worker-107/source [INFO] validating manifest of crates.io crate rumqtt 0.31.0 on toolchain 1b74e096b9bfb06f84a3007193dcd2f059cbdf6a [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate rumqtt 0.31.0 [INFO] finished tweaking crates.io crate rumqtt 0.31.0 [INFO] tweaked toml for crates.io crate rumqtt 0.31.0 written to /workspace/builds/worker-107/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "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-107/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-107/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 114995f50cd6a702feeca4f3a602124cc8f70dc23295921fd988e25cbd5ec598 [INFO] running `Command { std: "docker" "start" "-a" "114995f50cd6a702feeca4f3a602124cc8f70dc23295921fd988e25cbd5ec598", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "114995f50cd6a702feeca4f3a602124cc8f70dc23295921fd988e25cbd5ec598", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "114995f50cd6a702feeca4f3a602124cc8f70dc23295921fd988e25cbd5ec598", kill_on_drop: false }` [INFO] [stdout] 114995f50cd6a702feeca4f3a602124cc8f70dc23295921fd988e25cbd5ec598 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-107/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-107/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 168766b47a3e27d38430685efb265f1504e1bd987dff14cd412196fc9d6e27a9 [INFO] running `Command { std: "docker" "start" "-a" "168766b47a3e27d38430685efb265f1504e1bd987dff14cd412196fc9d6e27a9", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling autocfg v1.1.0 [INFO] [stderr] Compiling libc v0.2.124 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling cc v1.0.73 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling maybe-uninit v2.0.0 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling semver-parser v0.7.0 [INFO] [stderr] Compiling futures v0.1.31 [INFO] [stderr] Compiling log v0.4.16 [INFO] [stderr] Compiling rand_core v0.4.2 [INFO] [stderr] Compiling proc-macro2 v1.0.37 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.91 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling memchr v2.4.1 [INFO] [stderr] Compiling slab v0.4.6 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling untrusted v0.6.2 [INFO] [stderr] Compiling proc-macro2 v0.4.30 [INFO] [stderr] Compiling unicode-xid v0.1.0 [INFO] [stderr] Compiling serde v1.0.136 [INFO] [stderr] Compiling gimli v0.26.1 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling syn v0.15.44 [INFO] [stderr] Compiling failure_derive v0.1.8 [INFO] [stderr] Compiling adler v1.0.2 [INFO] [stderr] Compiling serde_json v1.0.79 [INFO] [stderr] Compiling serde_derive v1.0.136 [INFO] [stderr] Compiling rustc-demangle v0.1.21 [INFO] [stderr] Compiling itoa v1.0.1 [INFO] [stderr] Compiling ryu v1.0.9 [INFO] [stderr] Compiling crossbeam-utils v0.6.6 [INFO] [stderr] Compiling lock_api v0.3.4 [INFO] [stderr] Compiling miniz_oxide v0.5.1 [INFO] [stderr] Compiling rand_core v0.3.1 [INFO] [stderr] Compiling rand_jitter v0.1.4 [INFO] [stderr] Compiling autocfg v0.1.8 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling rand_isaac v0.1.1 [INFO] [stderr] Compiling rand_hc v0.1.0 [INFO] [stderr] Compiling rand_xorshift v0.1.1 [INFO] [stderr] Compiling base64 v0.10.1 [INFO] [stderr] Compiling crossbeam-channel v0.3.9 [INFO] [stderr] Compiling crossbeam-utils v0.7.2 [INFO] [stderr] Compiling memoffset v0.5.6 [INFO] [stderr] Compiling crossbeam-epoch v0.8.2 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling rand_chacha v0.1.1 [INFO] [stderr] Compiling rand_pcg v0.1.2 [INFO] [stderr] Compiling rand v0.6.5 [INFO] [stderr] Compiling rustc_version v0.2.3 [INFO] [stderr] Compiling smallvec v0.6.14 [INFO] [stderr] Compiling parking_lot_core v0.6.2 [INFO] [stderr] Compiling parking_lot v0.9.0 [INFO] [stderr] Compiling object v0.28.3 [INFO] [stderr] Compiling quote v1.0.18 [INFO] [stderr] Compiling ring v0.14.6 [INFO] [stderr] Compiling backtrace v0.3.65 [INFO] [stderr] Compiling quote v0.6.13 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling num_cpus v1.13.1 [INFO] [stderr] Compiling net2 v0.2.37 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling rand_os v0.1.3 [INFO] [stderr] Compiling bytes v0.4.12 [INFO] [stderr] Compiling tokio-sync v0.1.8 [INFO] [stderr] Compiling tokio-executor v0.1.10 [INFO] [stderr] Compiling crossbeam-queue v0.2.3 [INFO] [stderr] Compiling mio v0.6.23 [INFO] [stderr] Compiling tokio-timer v0.2.13 [INFO] [stderr] Compiling tokio-current-thread v0.1.7 [INFO] [stderr] Compiling tokio-io v0.1.13 [INFO] [stderr] Compiling crossbeam-deque v0.7.4 [INFO] [stderr] Compiling tokio-threadpool v0.1.18 [INFO] [stderr] Compiling tokio-codec v0.1.2 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling tokio-reactor v0.1.12 [INFO] [stderr] Compiling tokio-tcp v0.1.4 [INFO] [stderr] Compiling webpki v0.19.1 [INFO] [stderr] Compiling sct v0.5.0 [INFO] [stderr] Compiling tokio v0.1.22 [INFO] [stderr] Compiling rustls v0.15.2 [INFO] [stderr] Compiling addr2line v0.17.0 [INFO] [stderr] Compiling synstructure v0.12.6 [INFO] [stderr] Compiling uuid v0.7.4 [INFO] [stderr] Compiling derive_more v0.13.0 [INFO] [stderr] Compiling tokio-rustls v0.9.4 [INFO] [stderr] Compiling failure v0.1.8 [INFO] [stderr] Compiling mqtt311 v0.2.0 [INFO] [stderr] Compiling jsonwebtoken v6.0.1 [INFO] [stderr] Compiling rumqtt v0.31.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 17.34s [INFO] running `Command { std: "docker" "inspect" "168766b47a3e27d38430685efb265f1504e1bd987dff14cd412196fc9d6e27a9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "168766b47a3e27d38430685efb265f1504e1bd987dff14cd412196fc9d6e27a9", kill_on_drop: false }` [INFO] [stdout] 168766b47a3e27d38430685efb265f1504e1bd987dff14cd412196fc9d6e27a9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-107/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-107/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f3dba316a7de7d10042e852ae3baf453fcb0a7de79a2c492592a274fe8ca39cd [INFO] running `Command { std: "docker" "start" "-a" "f3dba316a7de7d10042e852ae3baf453fcb0a7de79a2c492592a274fe8ca39cd", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling quick-error v1.2.3 [INFO] [stderr] Compiling termcolor v1.1.3 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling envy v0.3.3 [INFO] [stderr] Compiling humantime v1.3.0 [INFO] [stderr] Compiling regex v1.5.5 [INFO] [stderr] Compiling env_logger v0.6.2 [INFO] [stderr] Compiling pretty_env_logger v0.3.1 [INFO] [stderr] Compiling rumqtt v0.31.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 11.80s [INFO] [stderr] Executable unittests src/lib.rs (/opt/rustwide/target/debug/deps/rumqtt-5d63f6d6b39f8849) [INFO] running `Command { std: "docker" "inspect" "f3dba316a7de7d10042e852ae3baf453fcb0a7de79a2c492592a274fe8ca39cd", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f3dba316a7de7d10042e852ae3baf453fcb0a7de79a2c492592a274fe8ca39cd", kill_on_drop: false }` [INFO] [stdout] f3dba316a7de7d10042e852ae3baf453fcb0a7de79a2c492592a274fe8ca39cd [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-107/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-107/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1b74e096b9bfb06f84a3007193dcd2f059cbdf6a" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 7ec7c2a4ea7082e61da1191d85b00b92a384070042aa6bc037c04e450088b3a3 [INFO] running `Command { std: "docker" "start" "-a" "7ec7c2a4ea7082e61da1191d85b00b92a384070042aa6bc037c04e450088b3a3", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.20s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rumqtt-5d63f6d6b39f8849) [INFO] [stdout] [INFO] [stdout] running 30 tests [INFO] [stdout] test client::connection::test::connect_or_not_returns_dontreconnect_in_afterfirstsuccess_mode_during_first_failure ... ok [INFO] [stdout] test client::mqttstate::test::connack_handle_should_not_return_list_of_incomplete_messages_to_be_sent_in_clean_session ... ok [INFO] [stdout] test client::mqttstate::test::connack_handle_should_return_list_of_incomplete_messages_to_be_sent_in_persistent_session ... ok [INFO] [stdout] test client::mqttstate::test::connection_status_is_valid_while_handling_connect_and_connack_packets ... ok [INFO] [stdout] test client::mqttstate::test::connect_should_respect_options ... ok [INFO] [stdout] test client::mqttstate::test::incoming_publish_should_be_added_to_queue_correctly ... ok [INFO] [stdout] test client::mqttstate::test::incoming_puback_should_remove_correct_publish_from_queue ... ok [INFO] [stdout] test client::mqttstate::test::incoming_pubcomp_should_release_correct_pkid_from_release_queue ... ok [INFO] [stdout] test client::mqttstate::test::incoming_pubrec_should_release_correct_publish_from_queue_and_add_releaseid_to_rel_queue ... ok [INFO] [stdout] test client::mqttstate::test::incoming_pubrec_should_send_release_to_network_and_nothing_to_user ... ok [INFO] [stdout] test client::mqttstate::test::incoming_pubrel_should_send_comp_to_network_and_nothing_to_user ... ok [INFO] [stdout] test client::mqttstate::test::incoming_qos2_publish_should_send_rec_to_network_and_publish_to_user ... ok [INFO] [stdout] test client::mqttstate::test::outgoing_publish_handle_should_set_pkid_correctly_and_add_publish_to_queue_correctly ... ok [INFO] [stdout] test client::mqttstate::test::previous_session_handle_should_reset_everything_in_clean_session ... ok [INFO] [stdout] test client::mqttstate::test::previous_session_handle_should_reset_everything_except_queues_in_persistent_session ... ok [INFO] [stdout] test client::network::test::resolve ... ok [INFO] [stdout] test client::mqttstate::test::next_pkid_roll ... ok [INFO] [stdout] test client::connection::test::run_should_raise_connection_errors_based_on_reconnection_options ... ok [INFO] [stdout] test mqttoptions::test::client_id_startswith_space - should panic ... ok [INFO] [stdout] test mqttoptions::test::no_client_id - should panic ... ok [INFO] [stdout] test client::connection::test::reply_stream_results_in_an_error_when_notification_receiver_doesnt_catchup ... ok [INFO] [stdout] test client::connection::test::connect_or_not_returns_reconnect_in_afterfirstsuccess_mode_during_second_failure ... ok [INFO] [stdout] test client::connection::test::connect_or_not_returns_correct_reconnection_behaviour_in_always_reconnect_mode ... ok [INFO] [stdout] test client::connection::test::mqtt_io_returns_correct_reconnection_behaviour ... ok [INFO] [stdout] test client::connection::test::connection_success_and_disconnections_should_put_state_change_events_on_notifications ... ok [INFO] [stdout] test client::connection::test::reply_stream_triggers_pings_on_time ... ok [INFO] [stdout] test client::connection::test::requests_should_block_during_max_in_flight_messages ... ok [INFO] [stdout] test client::mqttstate::test::outgoing_ping_handle_should_succeed_if_pingresp_is_received ... ok [INFO] [stdout] test client::mqttstate::test::outgoing_ping_handle_should_throw_errors_for_no_pingresp ... ok [INFO] [stdout] test client::connection::test::throttled_stream_operates_at_specified_rate ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 20.21s [INFO] [stdout] [INFO] [stderr] Doc-tests rumqtt [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test src/lib.rs - (line 16) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 42) - compile ... ok [INFO] [stdout] test src/lib.rs - (line 78) - compile ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "7ec7c2a4ea7082e61da1191d85b00b92a384070042aa6bc037c04e450088b3a3", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7ec7c2a4ea7082e61da1191d85b00b92a384070042aa6bc037c04e450088b3a3", kill_on_drop: false }` [INFO] [stdout] 7ec7c2a4ea7082e61da1191d85b00b92a384070042aa6bc037c04e450088b3a3