Dec 15 04:17:48.166 INFO testing mqtt3-0.1.4 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 04:17:48.166 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 04:17:48.540 INFO [stdout] 2baf4c38ef44207b4c9571865fb620d4577d415d0fb1d0683161240e9d8f4f09
Dec 15 04:17:48.547 INFO running `"docker" "start" "-a" "2baf4c38ef44207b4c9571865fb620d4577d415d0fb1d0683161240e9d8f4f09"`
Dec 15 04:17:50.586 INFO [stderr] usermod: no changes
Dec 15 04:17:50.651 INFO [stderr]    Compiling mqtt3 v0.1.4 (/source)
Dec 15 04:17:52.427 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.81s
Dec 15 04:17:52.430 INFO [stderr] su: No module specific data is present
Dec 15 04:17:53.129 INFO running `"docker" "inspect" "2baf4c38ef44207b4c9571865fb620d4577d415d0fb1d0683161240e9d8f4f09"`
Dec 15 04:17:53.421 INFO running `"docker" "rm" "-f" "2baf4c38ef44207b4c9571865fb620d4577d415d0fb1d0683161240e9d8f4f09"`
Dec 15 04:17:53.751 INFO [stdout] 2baf4c38ef44207b4c9571865fb620d4577d415d0fb1d0683161240e9d8f4f09
Dec 15 04:17:53.762 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 04:17:54.132 INFO [stdout] 10b387745af201a2d02baccd0a446ac049d5fc04e19710fdc351a24ab092edba
Dec 15 04:17:54.136 INFO running `"docker" "start" "-a" "10b387745af201a2d02baccd0a446ac049d5fc04e19710fdc351a24ab092edba"`
Dec 15 04:17:55.138 INFO [stderr] usermod: no changes
Dec 15 04:17:55.191 INFO [stderr]    Compiling mqtt3 v0.1.4 (/source)
Dec 15 04:17:57.808 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.60s
Dec 15 04:17:57.808 INFO [stderr] su: No module specific data is present
Dec 15 04:17:58.399 INFO running `"docker" "inspect" "10b387745af201a2d02baccd0a446ac049d5fc04e19710fdc351a24ab092edba"`
Dec 15 04:17:58.739 INFO running `"docker" "rm" "-f" "10b387745af201a2d02baccd0a446ac049d5fc04e19710fdc351a24ab092edba"`
Dec 15 04:17:59.081 INFO [stdout] 10b387745af201a2d02baccd0a446ac049d5fc04e19710fdc351a24ab092edba
Dec 15 04:17:59.082 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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"`
Dec 15 04:17:59.607 INFO [stdout] 355fcae3376887a2826f508c0b4523a961d5d5bf9c6edb78838bd6766381057f
Dec 15 04:17:59.615 INFO running `"docker" "start" "-a" "355fcae3376887a2826f508c0b4523a961d5d5bf9c6edb78838bd6766381057f"`
Dec 15 04:18:00.389 INFO [stderr] usermod: no changes
Dec 15 04:18:00.435 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Dec 15 04:18:00.436 INFO [stderr]      Running /target/debug/deps/mqtt3-c158e4592b2f94ad
Dec 15 04:18:00.443 INFO [stdout] 
Dec 15 04:18:00.443 INFO [stdout] running 24 tests
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_publish_qos0_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_connect_mqtt_protocol_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_connect_mqisdp_protocol_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_connack_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test msg::test::message_from_pub_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test msg::test::message_to_pub_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_publish_qos1_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_suback_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_subscribe_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test read::test::read_packet_unsubscribe_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test test::packet_identifier_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test test::protocol_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test test::qos_min_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test topic::test::topic_is_not_valid_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test topic::test::topic_path_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test topic::test::wildcards_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test write::test::write_packet_connack_test ... ok
Dec 15 04:18:00.443 INFO [stdout] test write::test::write_packet_connect_mqisdp_protocol_test ... ok
Dec 15 04:18:00.451 INFO [stdout] test read::test::read_packet_puback_test ... ok
Dec 15 04:18:00.455 INFO [stdout] test write::test::write_packet_publish_at_least_once_test ... ok
Dec 15 04:18:00.455 INFO [stdout] test write::test::write_packet_connect_mqtt_protocol_test ... ok
Dec 15 04:18:00.455 INFO [stdout] test msg::test::to_topic_name_test ... ok
Dec 15 04:18:00.455 INFO [stdout] test write::test::write_packet_publish_at_most_once_test ... ok
Dec 15 04:18:00.455 INFO [stdout] test write::test::write_packet_subscribe_test ... ok
Dec 15 04:18:00.455 INFO [stdout] 
Dec 15 04:18:00.455 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 04:18:00.455 INFO [stdout] 
Dec 15 04:18:00.455 INFO [stderr]    Doc-tests mqtt3
Dec 15 04:18:01.582 INFO [stdout] 
Dec 15 04:18:01.582 INFO [stdout] running 0 tests
Dec 15 04:18:01.582 INFO [stdout] 
Dec 15 04:18:01.582 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 04:18:01.582 INFO [stdout] 
Dec 15 04:18:01.611 INFO [stderr] su: No module specific data is present
Dec 15 04:18:02.823 INFO running `"docker" "inspect" "355fcae3376887a2826f508c0b4523a961d5d5bf9c6edb78838bd6766381057f"`
Dec 15 04:18:03.087 INFO running `"docker" "rm" "-f" "355fcae3376887a2826f508c0b4523a961d5d5bf9c6edb78838bd6766381057f"`
Dec 15 04:18:03.495 INFO [stdout] 355fcae3376887a2826f508c0b4523a961d5d5bf9c6edb78838bd6766381057f