Dec 15 04:17:35.221 INFO testing mqtt311-0.1.4 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 04:17:35.221 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:35.413 INFO [stdout] d9989fb1e5702c3f632325a14dde533568bd38bc04d782a94e350490a6d01d12
Dec 15 04:17:35.420 INFO running `"docker" "start" "-a" "d9989fb1e5702c3f632325a14dde533568bd38bc04d782a94e350490a6d01d12"`
Dec 15 04:17:36.014 INFO [stderr] usermod: no changes
Dec 15 04:17:36.075 INFO [stderr]    Compiling mqtt311 v0.1.4 (/source)
Dec 15 04:17:37.887 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.84s
Dec 15 04:17:37.887 INFO [stderr] su: No module specific data is present
Dec 15 04:17:38.616 INFO running `"docker" "inspect" "d9989fb1e5702c3f632325a14dde533568bd38bc04d782a94e350490a6d01d12"`
Dec 15 04:17:38.881 INFO running `"docker" "rm" "-f" "d9989fb1e5702c3f632325a14dde533568bd38bc04d782a94e350490a6d01d12"`
Dec 15 04:17:39.340 INFO [stdout] d9989fb1e5702c3f632325a14dde533568bd38bc04d782a94e350490a6d01d12
Dec 15 04:17:39.344 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:39.619 INFO [stdout] 613736bc81ed0a90ac39fc4e6d303630bdaf34e83735fb15253bbdf578d83303
Dec 15 04:17:39.631 INFO running `"docker" "start" "-a" "613736bc81ed0a90ac39fc4e6d303630bdaf34e83735fb15253bbdf578d83303"`
Dec 15 04:17:40.300 INFO [stderr] usermod: no changes
Dec 15 04:17:40.338 INFO [stderr]    Compiling mqtt311 v0.1.4 (/source)
Dec 15 04:17:43.499 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.17s
Dec 15 04:17:43.499 INFO [stderr] su: No module specific data is present
Dec 15 04:17:44.245 INFO running `"docker" "inspect" "613736bc81ed0a90ac39fc4e6d303630bdaf34e83735fb15253bbdf578d83303"`
Dec 15 04:17:44.545 INFO running `"docker" "rm" "-f" "613736bc81ed0a90ac39fc4e6d303630bdaf34e83735fb15253bbdf578d83303"`
Dec 15 04:17:44.890 INFO [stdout] 613736bc81ed0a90ac39fc4e6d303630bdaf34e83735fb15253bbdf578d83303
Dec 15 04:17:44.901 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:45.301 INFO [stdout] cb1ac50fea296064ac228df6299ccc6dc124a2f2cdcb6d710d067864478b208a
Dec 15 04:17:45.304 INFO running `"docker" "start" "-a" "cb1ac50fea296064ac228df6299ccc6dc124a2f2cdcb6d710d067864478b208a"`
Dec 15 04:17:45.797 INFO [stderr] usermod: no changes
Dec 15 04:17:45.823 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Dec 15 04:17:45.824 INFO [stderr]      Running /target/debug/deps/mqtt311-c115919c2183045d
Dec 15 04:17:45.825 INFO [stdout] 
Dec 15 04:17:45.825 INFO [stdout] running 24 tests
Dec 15 04:17:45.826 INFO [stdout] test msg::test::message_from_pub_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test read::test::read_packet_connack_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test msg::test::to_topic_name_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test msg::test::message_to_pub_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test read::test::read_packet_publish_qos1_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test read::test::read_packet_suback_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test read::test::read_packet_subscribe_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test read::test::read_packet_connect_mqtt_protocol_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test test::qos_min_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test read::test::read_packet_publish_qos0_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test test::packet_identifier_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test topic::test::topic_is_not_valid_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test read::test::read_packet_unsubscribe_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test test::protocol_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test topic::test::topic_path_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test write::test::write_packet_connect_mqtt_protocol_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test write::test::write_packet_connack_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test write::test::write_packet_connect_mqisdp_protocol_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test write::test::write_packet_publish_at_most_once_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test write::test::write_packet_publish_at_least_once_test ... ok
Dec 15 04:17:45.826 INFO [stdout] test write::test::write_packet_subscribe_test ... ok
Dec 15 04:17:45.827 INFO [stdout] test topic::test::wildcards_test ... ok
Dec 15 04:17:45.831 INFO [stdout] test read::test::read_packet_connect_mqisdp_protocol_test ... ok
Dec 15 04:17:45.835 INFO [stdout] test read::test::read_packet_puback_test ... ok
Dec 15 04:17:45.835 INFO [stdout] 
Dec 15 04:17:45.835 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 04:17:45.835 INFO [stdout] 
Dec 15 04:17:45.839 INFO [stderr]    Doc-tests mqtt311
Dec 15 04:17:46.747 INFO [stdout] 
Dec 15 04:17:46.747 INFO [stdout] running 0 tests
Dec 15 04:17:46.747 INFO [stdout] 
Dec 15 04:17:46.747 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 04:17:46.747 INFO [stdout] 
Dec 15 04:17:46.753 INFO [stderr] su: No module specific data is present
Dec 15 04:17:47.387 INFO running `"docker" "inspect" "cb1ac50fea296064ac228df6299ccc6dc124a2f2cdcb6d710d067864478b208a"`
Dec 15 04:17:47.776 INFO running `"docker" "rm" "-f" "cb1ac50fea296064ac228df6299ccc6dc124a2f2cdcb6d710d067864478b208a"`
Dec 15 04:17:48.094 INFO [stdout] cb1ac50fea296064ac228df6299ccc6dc124a2f2cdcb6d710d067864478b208a