Nov 18 05:53:40.338 INFO testing mqtt311-0.1.4 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 05:53:40.339 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 05:53:40.792 INFO [stdout] c98f388e54f5ad6dc1a836c3c9b6fbfb4ac83ecb2b65afb90438e0b45370f3b6
Nov 18 05:53:40.794 INFO running `"docker" "start" "-a" "c98f388e54f5ad6dc1a836c3c9b6fbfb4ac83ecb2b65afb90438e0b45370f3b6"`
Nov 18 05:53:42.477 INFO [stderr] usermod: no changes
Nov 18 05:53:42.563 INFO [stderr]    Compiling mqtt311 v0.1.4 (/source)
Nov 18 05:53:44.664 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.14s
Nov 18 05:53:44.668 INFO [stderr] su: No module specific data is present
Nov 18 05:53:45.971 INFO running `"docker" "inspect" "c98f388e54f5ad6dc1a836c3c9b6fbfb4ac83ecb2b65afb90438e0b45370f3b6"`
Nov 18 05:53:46.329 INFO running `"docker" "rm" "-f" "c98f388e54f5ad6dc1a836c3c9b6fbfb4ac83ecb2b65afb90438e0b45370f3b6"`
Nov 18 05:53:46.615 INFO [stdout] c98f388e54f5ad6dc1a836c3c9b6fbfb4ac83ecb2b65afb90438e0b45370f3b6
Nov 18 05:53:46.620 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 05:53:47.162 INFO [stdout] f263959ce3c3916803c31e461caa3099f92f23ac3be49141e35cc30dba02904e
Nov 18 05:53:47.166 INFO running `"docker" "start" "-a" "f263959ce3c3916803c31e461caa3099f92f23ac3be49141e35cc30dba02904e"`
Nov 18 05:53:48.300 INFO [stderr] usermod: no changes
Nov 18 05:53:48.363 INFO [stderr]    Compiling mqtt311 v0.1.4 (/source)
Nov 18 05:53:51.172 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.82s
Nov 18 05:53:51.175 INFO [stderr] su: No module specific data is present
Nov 18 05:53:52.117 INFO running `"docker" "inspect" "f263959ce3c3916803c31e461caa3099f92f23ac3be49141e35cc30dba02904e"`
Nov 18 05:53:52.435 INFO running `"docker" "rm" "-f" "f263959ce3c3916803c31e461caa3099f92f23ac3be49141e35cc30dba02904e"`
Nov 18 05:53:52.746 INFO [stdout] f263959ce3c3916803c31e461caa3099f92f23ac3be49141e35cc30dba02904e
Nov 18 05:53:52.749 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 05:53:53.125 INFO [stdout] e4c5f2221ca0f41262ca6570d3ec02a8985fdaadc366ab64b5ef505ed8b72d71
Nov 18 05:53:53.131 INFO running `"docker" "start" "-a" "e4c5f2221ca0f41262ca6570d3ec02a8985fdaadc366ab64b5ef505ed8b72d71"`
Nov 18 05:53:54.410 INFO [stderr] usermod: no changes
Nov 18 05:53:54.472 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Nov 18 05:53:54.472 INFO [stderr]      Running /target/debug/deps/mqtt311-7b36c4483b20eed5
Nov 18 05:53:54.496 INFO [stdout] 
Nov 18 05:53:54.496 INFO [stdout] running 24 tests
Nov 18 05:53:54.496 INFO [stdout] test msg::test::to_topic_name_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test msg::test::message_from_pub_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test read::test::read_packet_connack_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test read::test::read_packet_publish_qos1_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test read::test::read_packet_puback_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test read::test::read_packet_connect_mqtt_protocol_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test read::test::read_packet_unsubscribe_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test test::packet_identifier_test ... ok
Nov 18 05:53:54.496 INFO [stdout] test test::protocol_test ... ok
Nov 18 05:53:54.515 INFO [stdout] test test::qos_min_test ... ok
Nov 18 05:53:54.515 INFO [stderr]    Doc-tests mqtt311
Nov 18 05:53:54.516 INFO [stdout] test topic::test::topic_is_not_valid_test ... ok
Nov 18 05:53:54.516 INFO [stdout] test topic::test::topic_path_test ... ok
Nov 18 05:53:54.516 INFO [stdout] test topic::test::wildcards_test ... ok
Nov 18 05:53:54.516 INFO [stdout] test write::test::write_packet_connack_test ... ok
Nov 18 05:53:54.517 INFO [stdout] test write::test::write_packet_connect_mqisdp_protocol_test ... ok
Nov 18 05:53:54.517 INFO [stdout] test write::test::write_packet_connect_mqtt_protocol_test ... ok
Nov 18 05:53:54.517 INFO [stdout] test write::test::write_packet_publish_at_least_once_test ... ok
Nov 18 05:53:54.517 INFO [stdout] test write::test::write_packet_publish_at_most_once_test ... ok
Nov 18 05:53:54.518 INFO [stdout] test write::test::write_packet_subscribe_test ... ok
Nov 18 05:53:54.518 INFO [stdout] test msg::test::message_to_pub_test ... ok
Nov 18 05:53:54.518 INFO [stdout] test read::test::read_packet_publish_qos0_test ... ok
Nov 18 05:53:54.519 INFO [stdout] test read::test::read_packet_connect_mqisdp_protocol_test ... ok
Nov 18 05:53:54.519 INFO [stdout] test read::test::read_packet_subscribe_test ... ok
Nov 18 05:53:54.519 INFO [stdout] test read::test::read_packet_suback_test ... ok
Nov 18 05:53:54.519 INFO [stdout] 
Nov 18 05:53:54.520 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 05:53:54.520 INFO [stdout] 
Nov 18 05:53:55.291 INFO [stdout] 
Nov 18 05:53:55.292 INFO [stdout] running 0 tests
Nov 18 05:53:55.292 INFO [stdout] 
Nov 18 05:53:55.292 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 05:53:55.292 INFO [stdout] 
Nov 18 05:53:55.294 INFO [stderr] su: No module specific data is present
Nov 18 05:53:55.971 INFO running `"docker" "inspect" "e4c5f2221ca0f41262ca6570d3ec02a8985fdaadc366ab64b5ef505ed8b72d71"`
Nov 18 05:53:56.365 INFO running `"docker" "rm" "-f" "e4c5f2221ca0f41262ca6570d3ec02a8985fdaadc366ab64b5ef505ed8b72d71"`
Nov 18 05:53:56.727 INFO [stdout] e4c5f2221ca0f41262ca6570d3ec02a8985fdaadc366ab64b5ef505ed8b72d71