Nov 18 02:15:32.652 INFO testing redis-protocol-0.1.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 02:15:32.652 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 02:15:32.967 INFO [stdout] 4288a157fb1a3b9f1415357dc457ea4b535c0fd9094a45980dacbf139f12edbd
Nov 18 02:15:32.970 INFO running `"docker" "start" "-a" "4288a157fb1a3b9f1415357dc457ea4b535c0fd9094a45980dacbf139f12edbd"`
Nov 18 02:15:33.746 INFO [stderr] usermod: no changes
Nov 18 02:15:33.895 INFO [stderr]    Compiling crc16 v0.3.4
Nov 18 02:15:35.444 INFO [stderr]    Compiling redis-protocol v0.1.1 (/source)
Nov 18 02:15:38.423 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.64s
Nov 18 02:15:38.431 INFO [stderr] su: No module specific data is present
Nov 18 02:15:38.985 INFO running `"docker" "inspect" "4288a157fb1a3b9f1415357dc457ea4b535c0fd9094a45980dacbf139f12edbd"`
Nov 18 02:15:39.202 INFO running `"docker" "rm" "-f" "4288a157fb1a3b9f1415357dc457ea4b535c0fd9094a45980dacbf139f12edbd"`
Nov 18 02:15:39.481 INFO [stdout] 4288a157fb1a3b9f1415357dc457ea4b535c0fd9094a45980dacbf139f12edbd
Nov 18 02:15:39.488 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 02:15:39.815 INFO [stdout] c8797a99bb2d96b089a97486c6c06a6b51ec67931a7397d80eaf834dd6eb1126
Nov 18 02:15:39.818 INFO running `"docker" "start" "-a" "c8797a99bb2d96b089a97486c6c06a6b51ec67931a7397d80eaf834dd6eb1126"`
Nov 18 02:15:40.630 INFO [stderr] usermod: no changes
Nov 18 02:15:40.775 INFO [stderr]    Compiling redis-protocol v0.1.1 (/source)
Nov 18 02:15:42.453 INFO [stderr] warning: unused import: `::types::*`
Nov 18 02:15:42.453 INFO [stderr]    --> src/encode.rs:111:7
Nov 18 02:15:42.454 INFO [stderr]     |
Nov 18 02:15:42.454 INFO [stderr] 111 |   use ::types::*;
Nov 18 02:15:42.454 INFO [stderr]     |       ^^^^^^^^^^
Nov 18 02:15:42.454 INFO [stderr]     |
Nov 18 02:15:42.454 INFO [stderr]     = note: #[warn(unused_imports)] on by default
Nov 18 02:15:42.455 INFO [stderr] 
Nov 18 02:15:42.455 INFO [stderr] warning: unused import: `::utils`
Nov 18 02:15:42.455 INFO [stderr]    --> src/decode.rs:143:7
Nov 18 02:15:42.455 INFO [stderr]     |
Nov 18 02:15:42.455 INFO [stderr] 143 |   use ::utils;
Nov 18 02:15:42.455 INFO [stderr]     |       ^^^^^^^
Nov 18 02:15:42.456 INFO [stderr] 
Nov 18 02:15:42.456 INFO [stderr] warning: unused import: `::types::*`
Nov 18 02:15:42.456 INFO [stderr]    --> src/decode.rs:144:7
Nov 18 02:15:42.456 INFO [stderr]     |
Nov 18 02:15:42.456 INFO [stderr] 144 |   use ::types::*;
Nov 18 02:15:42.457 INFO [stderr]     |       ^^^^^^^^^^
Nov 18 02:15:42.457 INFO [stderr] 
Nov 18 02:15:42.458 INFO [stderr] warning: unused import: `std::fmt`
Nov 18 02:15:42.458 INFO [stderr]    --> src/decode.rs:146:7
Nov 18 02:15:42.458 INFO [stderr]     |
Nov 18 02:15:42.458 INFO [stderr] 146 |   use std::fmt;
Nov 18 02:15:42.459 INFO [stderr]     |       ^^^^^^^^
Nov 18 02:15:42.459 INFO [stderr] 
Nov 18 02:15:42.459 INFO [stderr] warning: unused import: `nom::Err as NomError`
Nov 18 02:15:42.460 INFO [stderr]    --> src/decode.rs:149:7
Nov 18 02:15:42.460 INFO [stderr]     |
Nov 18 02:15:42.460 INFO [stderr] 149 |   use nom::Err as NomError;
Nov 18 02:15:42.460 INFO [stderr]     |       ^^^^^^^^^^^^^^^^^^^^
Nov 18 02:15:42.461 INFO [stderr] 
Nov 18 02:15:42.461 INFO [stderr] warning: unused import: `nom::simple_errors::Context`
Nov 18 02:15:42.461 INFO [stderr]    --> src/decode.rs:150:7
Nov 18 02:15:42.462 INFO [stderr]     |
Nov 18 02:15:42.462 INFO [stderr] 150 |   use nom::simple_errors::Context;
Nov 18 02:15:42.462 INFO [stderr]     |       ^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 18 02:15:42.462 INFO [stderr] 
Nov 18 02:15:42.932 INFO [stderr] warning: unused variable: `s`
Nov 18 02:15:42.933 INFO [stderr]    --> src/types.rs:360:9
Nov 18 02:15:42.933 INFO [stderr]     |
Nov 18 02:15:42.933 INFO [stderr] 360 |     let s = e.to_string();
Nov 18 02:15:42.933 INFO [stderr]     |         ^ help: consider using `_s` instead
Nov 18 02:15:42.933 INFO [stderr]     |
Nov 18 02:15:42.933 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Nov 18 02:15:42.933 INFO [stderr] 
Nov 18 02:15:42.933 INFO [stderr] warning: unused variable: `s`
Nov 18 02:15:42.933 INFO [stderr]    --> src/types.rs:370:9
Nov 18 02:15:42.933 INFO [stderr]     |
Nov 18 02:15:42.933 INFO [stderr] 370 |     let s = e.to_string();
Nov 18 02:15:42.933 INFO [stderr]     |         ^ help: consider using `_s` instead
Nov 18 02:15:42.933 INFO [stderr] 
Nov 18 02:15:42.933 INFO [stderr] warning: unused variable: `s`
Nov 18 02:15:42.933 INFO [stderr]    --> src/types.rs:380:9
Nov 18 02:15:42.933 INFO [stderr]     |
Nov 18 02:15:42.933 INFO [stderr] 380 |     let s = e.to_string();
Nov 18 02:15:42.933 INFO [stderr]     |         ^ help: consider using `_s` instead
Nov 18 02:15:42.933 INFO [stderr] 
Nov 18 02:15:42.933 INFO [stderr] warning: unused variable: `s`
Nov 18 02:15:42.933 INFO [stderr]    --> src/types.rs:390:9
Nov 18 02:15:42.933 INFO [stderr]     |
Nov 18 02:15:42.933 INFO [stderr] 390 |     let s = e.to_string();
Nov 18 02:15:42.933 INFO [stderr]     |         ^ help: consider using `_s` instead
Nov 18 02:15:42.933 INFO [stderr] 
Nov 18 02:15:43.121 INFO [stderr] warning: variable does not need to be mutable
Nov 18 02:15:43.121 INFO [stderr]    --> src/decode.rs:297:9
Nov 18 02:15:43.121 INFO [stderr]     |
Nov 18 02:15:43.121 INFO [stderr] 297 |     let mut bytes: BytesMut = "foobarbazwibblewobble".into();
Nov 18 02:15:43.122 INFO [stderr]     |         ----^^^^^
Nov 18 02:15:43.122 INFO [stderr]     |         |
Nov 18 02:15:43.122 INFO [stderr]     |         help: remove this `mut`
Nov 18 02:15:43.122 INFO [stderr]     |
Nov 18 02:15:43.122 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Nov 18 02:15:43.122 INFO [stderr] 
Nov 18 02:15:43.159 INFO [stderr] warning: function is never used: `to_bytes`
Nov 18 02:15:43.159 INFO [stderr]    --> src/encode.rs:119:3
Nov 18 02:15:43.159 INFO [stderr]     |
Nov 18 02:15:43.159 INFO [stderr] 119 |   fn to_bytes(s: &str) -> BytesMut {
Nov 18 02:15:43.159 INFO [stderr]     |   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 18 02:15:43.159 INFO [stderr]     |
Nov 18 02:15:43.159 INFO [stderr]     = note: #[warn(dead_code)] on by default
Nov 18 02:15:43.159 INFO [stderr] 
Nov 18 02:15:43.159 INFO [stderr] warning: function is never used: `to_bytes`
Nov 18 02:15:43.159 INFO [stderr]    --> src/decode.rs:158:3
Nov 18 02:15:43.159 INFO [stderr]     |
Nov 18 02:15:43.159 INFO [stderr] 158 |   fn to_bytes(s: &str) -> BytesMut {
Nov 18 02:15:43.159 INFO [stderr]     |   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 18 02:15:43.159 INFO [stderr] 
Nov 18 02:15:43.159 INFO [stderr] warning: function is never used: `empty_bytes`
Nov 18 02:15:43.159 INFO [stderr]    --> src/decode.rs:162:3
Nov 18 02:15:43.159 INFO [stderr]     |
Nov 18 02:15:43.160 INFO [stderr] 162 |   fn empty_bytes() -> BytesMut {
Nov 18 02:15:43.160 INFO [stderr]     |   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 18 02:15:43.160 INFO [stderr] 
Nov 18 02:15:45.201 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.54s
Nov 18 02:15:45.208 INFO [stderr] su: No module specific data is present
Nov 18 02:15:46.031 INFO running `"docker" "inspect" "c8797a99bb2d96b089a97486c6c06a6b51ec67931a7397d80eaf834dd6eb1126"`
Nov 18 02:15:46.287 INFO running `"docker" "rm" "-f" "c8797a99bb2d96b089a97486c6c06a6b51ec67931a7397d80eaf834dd6eb1126"`
Nov 18 02:15:46.518 INFO [stdout] c8797a99bb2d96b089a97486c6c06a6b51ec67931a7397d80eaf834dd6eb1126
Nov 18 02:15:46.522 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 02:15:46.885 INFO [stdout] 0b20cd165c4cf621720af3070def755a941a2a5c2ce9b39c55ed9f66d684ac3e
Nov 18 02:15:46.887 INFO running `"docker" "start" "-a" "0b20cd165c4cf621720af3070def755a941a2a5c2ce9b39c55ed9f66d684ac3e"`
Nov 18 02:15:47.670 INFO [stderr] usermod: no changes
Nov 18 02:15:47.793 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Nov 18 02:15:47.794 INFO [stderr]      Running /target/debug/deps/redis_protocol-874f85ec71d96e23
Nov 18 02:15:47.796 INFO [stdout] 
Nov 18 02:15:47.796 INFO [stdout] running 40 tests
Nov 18 02:15:47.797 INFO [stdout] test decode::tests::should_decode_array_no_nulls ... ok
Nov 18 02:15:47.798 INFO [stdout] test decode::tests::should_decode_array_nulls ... ok
Nov 18 02:15:47.798 INFO [stdout] test decode::tests::should_decode_bulk_string ... ok
Nov 18 02:15:47.799 INFO [stdout] test encode::tests::should_encode_array_bulk_string_test ... ok
Nov 18 02:15:47.799 INFO [stdout] test decode::tests::should_decode_simple_string ... ok
Nov 18 02:15:47.799 INFO [stdout] test encode::tests::should_encode_bitcount_req_example ... ok
Nov 18 02:15:47.803 INFO [stdout] test decode::tests::should_decode_moved_error ... ok
Nov 18 02:15:47.803 INFO [stdout] test encode::tests::should_encode_array_null_test ... ok
Nov 18 02:15:47.807 INFO [stdout] test decode::tests::should_decode_ask_error ... ok
Nov 18 02:15:47.808 INFO [stdout] test decode::tests::should_decode_normal_error ... ok
Nov 18 02:15:47.809 INFO [stdout] test encode::tests::should_encode_raw_array_bulk_string_test ... ok
Nov 18 02:15:47.809 INFO [stdout] test encode::tests::should_encode_incr_req_example ... ok
Nov 18 02:15:47.809 INFO [stdout] test decode::tests::should_decode_incomplete ... ok
Nov 18 02:15:47.810 INFO [stdout] test encode::tests::should_encode_llen_req_example ... ok
Nov 18 02:15:47.810 INFO [stdout] test decode::tests::should_decode_llen_res_example ... ok
Nov 18 02:15:47.814 INFO [stdout] test encode::tests::should_encode_raw_incr_req_example ... ok
Nov 18 02:15:47.814 INFO [stdout] test encode::tests::should_encode_raw_llen_req_example ... ok
Nov 18 02:15:47.814 INFO [stdout] test types::tests::should_cast_from_nom_error ... ok
Nov 18 02:15:47.814 INFO [stdout] test types::tests::should_cast_from_gen_error ... ok
Nov 18 02:15:47.815 INFO [stdout] test encode::tests::should_encode_raw_array_null_test ... ok
Nov 18 02:15:47.815 INFO [stdout] test encode::tests::should_encode_raw_bitcount_req_example ... ok
Nov 18 02:15:47.831 INFO [stdout] test types::tests::should_create_encode_error ... ok
Nov 18 02:15:47.831 INFO [stdout] test types::tests::should_check_frame_types ... ok
Nov 18 02:15:47.831 INFO [stdout] test types::tests::should_create_buf_too_small_error ... ok
Nov 18 02:15:47.832 INFO [stdout] test types::tests::should_create_empty_error ... ok
Nov 18 02:15:47.832 INFO [stdout] test types::tests::should_create_decode_error ... ok
Nov 18 02:15:47.832 INFO [stdout] test types::tests::should_cast_from_nom_incomplete ... ok
Nov 18 02:15:47.832 INFO [stdout] test types::tests::should_decode_frame_kind_byte ... ok
Nov 18 02:15:47.833 INFO [stdout] test types::tests::should_encode_frame_kind_byte ... ok
Nov 18 02:15:47.833 INFO [stdout] test types::tests::should_parse_pubsub_message ... ok
Nov 18 02:15:47.833 INFO [stdout] test types::tests::should_print_error_kinds ... ok
Nov 18 02:15:47.833 INFO [stdout] test utils::tests::should_crc16_with_brackets ... ok
Nov 18 02:15:47.834 INFO [stdout] test utils::tests::should_crc16_with_brackets_no_padding ... ok
Nov 18 02:15:47.834 INFO [stdout] test utils::tests::should_crc16_123456789 ... ok
Nov 18 02:15:47.834 INFO [stdout] test utils::tests::should_crc16_with_invalid_brackets_rhs ... ok
Nov 18 02:15:47.834 INFO [stdout] test utils::tests::should_crc16_with_random_string ... ok
Nov 18 02:15:47.835 INFO [stdout] test utils::tests::should_crc16_with_invalid_brackets_lhs ... ok
Nov 18 02:15:47.835 INFO [stdout] test types::tests::should_cast_from_nom_failure ... ok
Nov 18 02:15:47.999 INFO [stdout] test decode::tests::should_error_on_junk ... ok
Nov 18 02:15:48.005 INFO [stdout] test types::tests::should_fail_parsing_non_pubsub_message ... ok
Nov 18 02:15:48.006 INFO [stdout] 
Nov 18 02:15:48.006 INFO [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:15:48.006 INFO [stdout] 
Nov 18 02:15:48.008 INFO [stderr]    Doc-tests redis_protocol
Nov 18 02:15:50.903 INFO [stdout] 
Nov 18 02:15:50.903 INFO [stdout] running 1 test
Nov 18 02:15:55.600 INFO [stdout] test src/lib.rs -  (line 8) ... ok
Nov 18 02:15:55.600 INFO [stdout] 
Nov 18 02:15:55.600 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 02:15:55.600 INFO [stdout] 
Nov 18 02:15:55.613 INFO [stderr] su: No module specific data is present
Nov 18 02:15:56.515 INFO running `"docker" "inspect" "0b20cd165c4cf621720af3070def755a941a2a5c2ce9b39c55ed9f66d684ac3e"`
Nov 18 02:15:56.888 INFO running `"docker" "rm" "-f" "0b20cd165c4cf621720af3070def755a941a2a5c2ce9b39c55ed9f66d684ac3e"`
Nov 18 02:15:57.195 INFO [stdout] 0b20cd165c4cf621720af3070def755a941a2a5c2ce9b39c55ed9f66d684ac3e