Dec 04 23:56:31.830 INFO testing zklapow/duplex against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 04 23:56:31.831 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 04 23:56:32.377 INFO [stdout] 766503c3e7bb7e86650910cfc461c9cab3a635c4bb7ef8c58820b53dd56b1cf7
Dec 04 23:56:32.382 INFO running `"docker" "start" "-a" "766503c3e7bb7e86650910cfc461c9cab3a635c4bb7ef8c58820b53dd56b1cf7"`
Dec 04 23:56:33.288 INFO [stderr] usermod: no changes
Dec 04 23:56:33.456 INFO [stderr]    Compiling winapi-build v0.1.1
Dec 04 23:56:33.456 INFO [stderr]    Compiling libc v0.2.22
Dec 04 23:56:33.456 INFO [stderr]    Compiling byteorder v1.0.0
Dec 04 23:56:33.456 INFO [stderr]    Compiling cfg-if v0.1.0
Dec 04 23:56:33.456 INFO [stderr]    Compiling num-traits v0.1.37
Dec 04 23:56:33.456 INFO [stderr]    Compiling log v0.3.7
Dec 04 23:56:33.460 INFO [stderr]    Compiling slab v0.3.0
Dec 04 23:56:33.464 INFO [stderr]    Compiling lazycell v0.4.0
Dec 04 23:56:34.152 INFO [stderr]    Compiling futures v0.1.13
Dec 04 23:56:34.184 INFO [stderr]    Compiling scoped-tls v0.1.0
Dec 04 23:56:35.848 INFO [stderr]    Compiling utf8-ranges v0.1.3
Dec 04 23:56:35.884 INFO [stderr]    Compiling regex-syntax v0.3.9
Dec 04 23:56:35.928 INFO [stderr]    Compiling vec_map v0.7.0
Dec 04 23:56:35.936 INFO [stderr]    Compiling smallvec v0.2.1
Dec 04 23:56:36.493 INFO [stderr]    Compiling bitflags v0.8.2
Dec 04 23:56:36.493 INFO [stderr]    Compiling unicode-width v0.1.4
Dec 04 23:56:36.648 INFO [stderr]    Compiling unicode-segmentation v1.1.0
Dec 04 23:56:36.692 INFO [stderr]    Compiling take v0.1.0
Dec 04 23:56:37.120 INFO [stderr]    Compiling strsim v0.6.0
Dec 04 23:56:37.698 INFO [stderr]    Compiling ansi_term v0.9.0
Dec 04 23:56:37.698 INFO [stderr]    Compiling iovec v0.1.0
Dec 04 23:56:37.736 INFO [stderr]    Compiling memchr v0.1.11
Dec 04 23:56:38.180 INFO [stderr]    Compiling net2 v0.2.27
Dec 04 23:56:39.271 INFO [stderr]    Compiling term_size v0.3.0
Dec 04 23:56:39.292 INFO [stderr]    Compiling atty v0.2.2
Dec 04 23:56:40.336 INFO [stderr]    Compiling rand v0.3.15
Dec 04 23:56:40.627 INFO [stderr]    Compiling time v0.1.37
Dec 04 23:56:40.627 INFO [stderr]    Compiling kernel32-sys v0.2.2
Dec 04 23:56:40.687 INFO [stderr]    Compiling num-integer v0.1.34
Dec 04 23:56:42.756 INFO [stderr]    Compiling bytes v0.4.3
Dec 04 23:56:43.446 INFO [stderr]    Compiling aho-corasick v0.5.3
Dec 04 23:56:44.492 INFO [stderr]    Compiling mio v0.6.7
Dec 04 23:56:44.496 INFO [stderr]    Compiling num-iter v0.1.33
Dec 04 23:56:46.522 INFO [stderr]    Compiling clap v2.23.3
Dec 04 23:56:51.989 INFO [stderr]    Compiling num v0.1.37
Dec 04 23:56:52.036 INFO [stderr]    Compiling thread-id v2.0.0
Dec 04 23:56:52.384 INFO [stderr]    Compiling chrono v0.3.1
Dec 04 23:56:53.056 INFO [stderr]    Compiling thread_local v0.2.7
Dec 04 23:56:54.336 INFO [stderr]    Compiling tokio-io v0.1.1
Dec 04 23:56:57.888 INFO [stderr]    Compiling tokio-service v0.1.0
Dec 04 23:56:58.013 INFO [stderr]    Compiling regex v0.1.80
Dec 04 23:56:58.236 INFO [stderr]    Compiling tokio-core v0.1.6
Dec 04 23:57:03.148 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 04 23:57:11.592 INFO [stderr]    Compiling env_logger v0.3.5
Dec 04 23:57:24.236 INFO [stderr]    Compiling duplex v0.1.0 (/source)
Dec 04 23:57:24.440 INFO [stderr] warning: unused import: `std::cell::RefCell`
Dec 04 23:57:24.440 INFO [stderr]  --> src/proxy.rs:4:5
Dec 04 23:57:24.440 INFO [stderr]   |
Dec 04 23:57:24.440 INFO [stderr] 4 | use std::cell::RefCell;
Dec 04 23:57:24.440 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^
Dec 04 23:57:24.440 INFO [stderr]   |
Dec 04 23:57:24.440 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 04 23:57:24.440 INFO [stderr] 
Dec 04 23:57:24.440 INFO [stderr] warning: unused import: `Shutdown`
Dec 04 23:57:24.440 INFO [stderr]  --> src/proxy.rs:5:16
Dec 04 23:57:24.440 INFO [stderr]   |
Dec 04 23:57:24.440 INFO [stderr] 5 | use std::net::{Shutdown, SocketAddr};
Dec 04 23:57:24.440 INFO [stderr]   |                ^^^^^^^^
Dec 04 23:57:24.440 INFO [stderr] 
Dec 04 23:57:24.440 INFO [stderr] warning: unused import: `AsyncWrite`
Dec 04 23:57:24.440 INFO [stderr]  --> src/proxy.rs:9:27
Dec 04 23:57:24.440 INFO [stderr]   |
Dec 04 23:57:24.441 INFO [stderr] 9 | use tokio_io::{AsyncRead, AsyncWrite};
Dec 04 23:57:24.441 INFO [stderr]   |                           ^^^^^^^^^^
Dec 04 23:57:24.441 INFO [stderr] 
Dec 04 23:57:24.441 INFO [stderr] warning: unused import: `shutdown`
Dec 04 23:57:24.441 INFO [stderr]   --> src/proxy.rs:10:26
Dec 04 23:57:24.441 INFO [stderr]    |
Dec 04 23:57:24.441 INFO [stderr] 10 | use tokio_io::io::{copy, shutdown};
Dec 04 23:57:24.441 INFO [stderr]    |                          ^^^^^^^^
Dec 04 23:57:24.441 INFO [stderr] 
Dec 04 23:57:24.456 INFO [stderr] warning: unused import: `std::io`
Dec 04 23:57:24.456 INFO [stderr]   --> src/main.rs:16:5
Dec 04 23:57:24.456 INFO [stderr]    |
Dec 04 23:57:24.456 INFO [stderr] 16 | use std::io;
Dec 04 23:57:24.456 INFO [stderr]    |     ^^^^^^^
Dec 04 23:57:24.456 INFO [stderr] 
Dec 04 23:57:24.550 INFO [stderr] warning: unused variable: `res`
Dec 04 23:57:24.550 INFO [stderr]   --> src/main.rs:43:9
Dec 04 23:57:24.550 INFO [stderr]    |
Dec 04 23:57:24.550 INFO [stderr] 43 |     let res = match matches.subcommand() {
Dec 04 23:57:24.550 INFO [stderr]    |         ^^^ help: consider using `_res` instead
Dec 04 23:57:24.550 INFO [stderr]    |
Dec 04 23:57:24.550 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 04 23:57:24.550 INFO [stderr] 
Dec 04 23:57:27.293 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 53.97s
Dec 04 23:57:27.305 INFO [stderr] su: No module specific data is present
Dec 04 23:57:28.971 INFO running `"docker" "inspect" "766503c3e7bb7e86650910cfc461c9cab3a635c4bb7ef8c58820b53dd56b1cf7"`
Dec 04 23:57:29.332 INFO running `"docker" "rm" "-f" "766503c3e7bb7e86650910cfc461c9cab3a635c4bb7ef8c58820b53dd56b1cf7"`
Dec 04 23:57:29.696 INFO [stdout] 766503c3e7bb7e86650910cfc461c9cab3a635c4bb7ef8c58820b53dd56b1cf7
Dec 04 23:57:29.704 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 04 23:57:30.143 INFO [stdout] 22a0a982df72226820626ffb25cbef24b6d37fc33a59d964060f7d7dc5c36d97
Dec 04 23:57:30.145 INFO running `"docker" "start" "-a" "22a0a982df72226820626ffb25cbef24b6d37fc33a59d964060f7d7dc5c36d97"`
Dec 04 23:57:33.156 INFO [stderr] usermod: no changes
Dec 04 23:57:33.332 INFO [stderr]    Compiling duplex v0.1.0 (/source)
Dec 04 23:57:33.575 INFO [stderr] warning: unused import: `std::cell::RefCell`
Dec 04 23:57:33.575 INFO [stderr]  --> src/proxy.rs:4:5
Dec 04 23:57:33.575 INFO [stderr]   |
Dec 04 23:57:33.575 INFO [stderr] 4 | use std::cell::RefCell;
Dec 04 23:57:33.575 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^
Dec 04 23:57:33.575 INFO [stderr]   |
Dec 04 23:57:33.575 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 04 23:57:33.575 INFO [stderr] 
Dec 04 23:57:33.575 INFO [stderr] warning: unused import: `Shutdown`
Dec 04 23:57:33.575 INFO [stderr]  --> src/proxy.rs:5:16
Dec 04 23:57:33.575 INFO [stderr]   |
Dec 04 23:57:33.575 INFO [stderr] 5 | use std::net::{Shutdown, SocketAddr};
Dec 04 23:57:33.575 INFO [stderr]   |                ^^^^^^^^
Dec 04 23:57:33.575 INFO [stderr] 
Dec 04 23:57:33.575 INFO [stderr] warning: unused import: `AsyncWrite`
Dec 04 23:57:33.575 INFO [stderr]  --> src/proxy.rs:9:27
Dec 04 23:57:33.575 INFO [stderr]   |
Dec 04 23:57:33.575 INFO [stderr] 9 | use tokio_io::{AsyncRead, AsyncWrite};
Dec 04 23:57:33.575 INFO [stderr]   |                           ^^^^^^^^^^
Dec 04 23:57:33.575 INFO [stderr] 
Dec 04 23:57:33.575 INFO [stderr] warning: unused import: `shutdown`
Dec 04 23:57:33.575 INFO [stderr]   --> src/proxy.rs:10:26
Dec 04 23:57:33.575 INFO [stderr]    |
Dec 04 23:57:33.575 INFO [stderr] 10 | use tokio_io::io::{copy, shutdown};
Dec 04 23:57:33.575 INFO [stderr]    |                          ^^^^^^^^
Dec 04 23:57:33.575 INFO [stderr] 
Dec 04 23:57:33.575 INFO [stderr] warning: unused import: `std::io`
Dec 04 23:57:33.575 INFO [stderr]   --> src/main.rs:16:5
Dec 04 23:57:33.576 INFO [stderr]    |
Dec 04 23:57:33.576 INFO [stderr] 16 | use std::io;
Dec 04 23:57:33.576 INFO [stderr]    |     ^^^^^^^
Dec 04 23:57:33.576 INFO [stderr] 
Dec 04 23:57:33.674 INFO [stderr] warning: unused variable: `res`
Dec 04 23:57:33.674 INFO [stderr]   --> src/main.rs:43:9
Dec 04 23:57:33.674 INFO [stderr]    |
Dec 04 23:57:33.675 INFO [stderr] 43 |     let res = match matches.subcommand() {
Dec 04 23:57:33.675 INFO [stderr]    |         ^^^ help: consider using `_res` instead
Dec 04 23:57:33.675 INFO [stderr]    |
Dec 04 23:57:33.676 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 04 23:57:33.676 INFO [stderr] 
Dec 04 23:57:34.227 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.04s
Dec 04 23:57:34.234 INFO [stderr] su: No module specific data is present
Dec 04 23:57:35.874 INFO running `"docker" "inspect" "22a0a982df72226820626ffb25cbef24b6d37fc33a59d964060f7d7dc5c36d97"`
Dec 04 23:57:36.288 INFO running `"docker" "rm" "-f" "22a0a982df72226820626ffb25cbef24b6d37fc33a59d964060f7d7dc5c36d97"`
Dec 04 23:57:36.672 INFO [stdout] 22a0a982df72226820626ffb25cbef24b6d37fc33a59d964060f7d7dc5c36d97
Dec 04 23:57:36.680 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 04 23:57:37.200 INFO [stdout] f3e185b432104dd206240450a7d8966f3cc6983ad4bb0107a891179cb21a5f4d
Dec 04 23:57:37.202 INFO running `"docker" "start" "-a" "f3e185b432104dd206240450a7d8966f3cc6983ad4bb0107a891179cb21a5f4d"`
Dec 04 23:57:39.652 INFO [stderr] usermod: no changes
Dec 04 23:57:39.820 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 04 23:57:39.828 INFO [stderr]      Running /target/debug/deps/duplex-31100e6f3a470357
Dec 04 23:57:39.834 INFO [stdout] 
Dec 04 23:57:39.834 INFO [stdout] running 0 tests
Dec 04 23:57:39.834 INFO [stdout] 
Dec 04 23:57:39.834 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 04 23:57:39.834 INFO [stdout] 
Dec 04 23:57:39.836 INFO [stderr] su: No module specific data is present
Dec 04 23:57:41.446 INFO running `"docker" "inspect" "f3e185b432104dd206240450a7d8966f3cc6983ad4bb0107a891179cb21a5f4d"`
Dec 04 23:57:41.824 INFO running `"docker" "rm" "-f" "f3e185b432104dd206240450a7d8966f3cc6983ad4bb0107a891179cb21a5f4d"`
Dec 04 23:57:42.048 INFO [stdout] f3e185b432104dd206240450a7d8966f3cc6983ad4bb0107a891179cb21a5f4d