Nov 16 11:25:00.990 INFO testing tcsc/asyncho against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 11:25:00.991 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 16 11:25:01.604 INFO [stdout] 27d442f0bd1b417463f2040cdf2864dccf2bc0f5d7401e6ce9afeb338e57f52f
Nov 16 11:25:01.607 INFO running `"docker" "start" "-a" "27d442f0bd1b417463f2040cdf2864dccf2bc0f5d7401e6ce9afeb338e57f52f"`
Nov 16 11:25:03.183 INFO [stderr] usermod: no changes
Nov 16 11:25:03.335 INFO [stderr]    Compiling memchr v1.0.1
Nov 16 11:25:03.335 INFO [stderr]    Compiling thread-id v3.0.0
Nov 16 11:25:03.347 INFO [stderr]    Compiling net2 v0.2.27
Nov 16 11:25:03.842 INFO [stderr]    Compiling thread_local v0.3.3
Nov 16 11:25:04.327 INFO [stderr]    Compiling aho-corasick v0.6.3
Nov 16 11:25:05.651 INFO [stderr]    Compiling mio v0.6.6
Nov 16 11:25:06.649 INFO [stderr]    Compiling regex v0.2.1
Nov 16 11:25:10.311 INFO [stderr]    Compiling tokio-core v0.1.6
Nov 16 11:25:20.298 INFO [stderr]    Compiling env_logger v0.4.2
Nov 16 11:25:21.275 INFO [stderr]    Compiling asyncho v0.1.0 (/source)
Nov 16 11:25:21.751 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 11:25:21.751 INFO [stderr]    --> src/service.rs:124:17
Nov 16 11:25:21.751 INFO [stderr]     |
Nov 16 11:25:21.751 INFO [stderr] 124 |                 self.spawn_connection(conn).map_err(erase);
Nov 16 11:25:21.751 INFO [stderr]     |                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 11:25:21.751 INFO [stderr]     |
Nov 16 11:25:21.751 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 16 11:25:21.751 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 11:25:21.751 INFO [stderr] 
Nov 16 11:25:23.986 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.76s
Nov 16 11:25:23.986 INFO [stderr] su: No module specific data is present
Nov 16 11:25:24.854 INFO running `"docker" "inspect" "27d442f0bd1b417463f2040cdf2864dccf2bc0f5d7401e6ce9afeb338e57f52f"`
Nov 16 11:25:25.091 INFO running `"docker" "rm" "-f" "27d442f0bd1b417463f2040cdf2864dccf2bc0f5d7401e6ce9afeb338e57f52f"`
Nov 16 11:25:25.407 INFO [stdout] 27d442f0bd1b417463f2040cdf2864dccf2bc0f5d7401e6ce9afeb338e57f52f
Nov 16 11:25:25.410 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 16 11:25:25.854 INFO [stdout] 35f9530c9d57afa9a5c317511c76badd9e5ab579021a9cbf2ce9829ecd7cb157
Nov 16 11:25:25.857 INFO running `"docker" "start" "-a" "35f9530c9d57afa9a5c317511c76badd9e5ab579021a9cbf2ce9829ecd7cb157"`
Nov 16 11:25:27.223 INFO [stderr] usermod: no changes
Nov 16 11:25:27.323 INFO [stderr]    Compiling asyncho v0.1.0 (/source)
Nov 16 11:25:27.899 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 11:25:27.900 INFO [stderr]    --> src/service.rs:124:17
Nov 16 11:25:27.900 INFO [stderr]     |
Nov 16 11:25:27.900 INFO [stderr] 124 |                 self.spawn_connection(conn).map_err(erase);
Nov 16 11:25:27.900 INFO [stderr]     |                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 11:25:27.901 INFO [stderr]     |
Nov 16 11:25:27.901 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 16 11:25:27.901 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 11:25:27.902 INFO [stderr] 
Nov 16 11:25:28.879 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.63s
Nov 16 11:25:28.887 INFO [stderr] su: No module specific data is present
Nov 16 11:25:29.805 INFO running `"docker" "inspect" "35f9530c9d57afa9a5c317511c76badd9e5ab579021a9cbf2ce9829ecd7cb157"`
Nov 16 11:25:30.003 INFO running `"docker" "rm" "-f" "35f9530c9d57afa9a5c317511c76badd9e5ab579021a9cbf2ce9829ecd7cb157"`
Nov 16 11:25:30.215 INFO [stdout] 35f9530c9d57afa9a5c317511c76badd9e5ab579021a9cbf2ce9829ecd7cb157
Nov 16 11:25:30.217 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 16 11:25:30.661 INFO [stdout] 04d3ffa766d226a02215e11d2ada70d4788ff5cffc66f98973997b645751dd6d
Nov 16 11:25:30.663 INFO running `"docker" "start" "-a" "04d3ffa766d226a02215e11d2ada70d4788ff5cffc66f98973997b645751dd6d"`
Nov 16 11:25:31.648 INFO [stderr] usermod: no changes
Nov 16 11:25:31.776 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Nov 16 11:25:31.787 INFO [stderr]      Running /target/debug/deps/asyncho-ee5794ea8000b80a
Nov 16 11:25:31.807 INFO [stdout] 
Nov 16 11:25:31.811 INFO [stdout] running 8 tests
Nov 16 11:25:31.813 INFO [stdout] test lines::test::encoder_handles_empty_frame ... ok
Nov 16 11:25:31.813 INFO [stdout] test lines::test::encoder_encodes_message ... ok
Nov 16 11:25:31.819 INFO [stdout] test lines::test::encoder_handles_multiple_frames ... ok
Nov 16 11:25:31.819 INFO [stderr] su: No module specific data is present
Nov 16 11:25:31.820 INFO [stdout] test lines::test::decoder_handles_zero_length_frame ... ok
Nov 16 11:25:31.820 INFO [stdout] test lines::test::decoder_handles_empty_buffer ... ok
Nov 16 11:25:31.821 INFO [stdout] test lines::test::decoder_extracts_message ... ok
Nov 16 11:25:31.821 INFO [stdout] test lines::test::decoder_returns_error_on_invalid_utf8 ... ok
Nov 16 11:25:31.821 INFO [stdout] test lines::test::decoder_handles_incomplete_frames ... ok
Nov 16 11:25:31.822 INFO [stdout] 
Nov 16 11:25:31.822 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:25:31.822 INFO [stdout] 
Nov 16 11:25:32.449 INFO running `"docker" "inspect" "04d3ffa766d226a02215e11d2ada70d4788ff5cffc66f98973997b645751dd6d"`
Nov 16 11:25:32.685 INFO running `"docker" "rm" "-f" "04d3ffa766d226a02215e11d2ada70d4788ff5cffc66f98973997b645751dd6d"`
Nov 16 11:25:32.863 INFO [stdout] 04d3ffa766d226a02215e11d2ada70d4788ff5cffc66f98973997b645751dd6d