Dec 06 20:47:23.241 INFO testing tarpc-bincode-transport-0.3.0 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 06 20:47:23.241 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 20:47:23.732 INFO [stdout] d2e96f85363948939a4c2f58b1aaf4aa82380a3af86e211ba7e047969f892c8e
Dec 06 20:47:23.734 INFO running `"docker" "start" "-a" "d2e96f85363948939a4c2f58b1aaf4aa82380a3af86e211ba7e047969f892c8e"`
Dec 06 20:47:24.897 INFO [stderr] usermod: no changes
Dec 06 20:47:24.936 INFO [stderr] warning: the cargo feature `rename-dependency` is now stable and is no longer necessary to be listed in the manifest
Dec 06 20:47:25.137 INFO [stderr]    Compiling byteorder v1.2.7
Dec 06 20:47:25.148 INFO [stderr]    Compiling futures-core-preview v0.3.0-alpha.10
Dec 06 20:47:25.152 INFO [stderr]    Compiling tarpc-trace v0.1.0
Dec 06 20:47:26.951 INFO [stderr]    Compiling futures-channel-preview v0.3.0-alpha.10
Dec 06 20:47:26.958 INFO [stderr]    Compiling futures-io-preview v0.3.0-alpha.10
Dec 06 20:47:28.302 INFO [stderr]    Compiling bytes v0.4.11
Dec 06 20:47:28.302 INFO [stderr]    Compiling bincode v1.0.1
Dec 06 20:47:30.186 INFO [stderr]    Compiling futures-sink-preview v0.3.0-alpha.10
Dec 06 20:47:31.812 INFO [stderr]    Compiling futures-util-preview v0.3.0-alpha.10
Dec 06 20:47:32.673 INFO [stderr]    Compiling tokio-io v0.1.10
Dec 06 20:47:35.184 INFO [stderr]    Compiling tokio-reactor v0.1.7
Dec 06 20:47:35.184 INFO [stderr]    Compiling tokio-codec v0.1.1
Dec 06 20:47:35.184 INFO [stderr]    Compiling tokio-fs v0.1.4
Dec 06 20:47:40.024 INFO [stderr]    Compiling futures-executor-preview v0.3.0-alpha.10
Dec 06 20:47:42.404 INFO [stderr]    Compiling tokio-tcp v0.1.2
Dec 06 20:47:42.404 INFO [stderr]    Compiling tokio-udp v0.1.3
Dec 06 20:47:42.404 INFO [stderr]    Compiling tokio-uds v0.2.4
Dec 06 20:47:47.834 INFO [stderr]    Compiling futures-preview v0.3.0-alpha.10
Dec 06 20:47:50.940 INFO [stderr]    Compiling tokio v0.1.13
Dec 06 20:47:51.064 INFO [stderr]    Compiling tarpc-lib v0.2.0
Dec 06 20:47:55.652 INFO [stderr]    Compiling async-bincode v0.4.9
Dec 06 20:47:59.499 INFO [stderr]    Compiling tarpc-bincode-transport v0.3.0 (/source)
Dec 06 20:48:03.700 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 38.78s
Dec 06 20:48:03.709 INFO [stderr] su: No module specific data is present
Dec 06 20:48:04.091 INFO running `"docker" "inspect" "d2e96f85363948939a4c2f58b1aaf4aa82380a3af86e211ba7e047969f892c8e"`
Dec 06 20:48:04.191 INFO running `"docker" "rm" "-f" "d2e96f85363948939a4c2f58b1aaf4aa82380a3af86e211ba7e047969f892c8e"`
Dec 06 20:48:04.344 INFO [stdout] d2e96f85363948939a4c2f58b1aaf4aa82380a3af86e211ba7e047969f892c8e
Dec 06 20:48:04.352 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 20:48:04.720 INFO [stdout] 9fc8b6a011812cac0bf55a775935eb1efc4aa1b166c4328bd0678f85a635c5d9
Dec 06 20:48:04.722 INFO running `"docker" "start" "-a" "9fc8b6a011812cac0bf55a775935eb1efc4aa1b166c4328bd0678f85a635c5d9"`
Dec 06 20:48:05.616 INFO [stderr] usermod: no changes
Dec 06 20:48:05.647 INFO [stderr] warning: the cargo feature `rename-dependency` is now stable and is no longer necessary to be listed in the manifest
Dec 06 20:48:05.778 INFO [stderr]    Compiling tokio-serde v0.2.0
Dec 06 20:48:06.510 INFO [stderr]    Compiling tarpc-bincode-transport v0.3.0 (/source)
Dec 06 20:48:25.283 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.64s
Dec 06 20:48:25.295 INFO [stderr] su: No module specific data is present
Dec 06 20:48:25.990 INFO running `"docker" "inspect" "9fc8b6a011812cac0bf55a775935eb1efc4aa1b166c4328bd0678f85a635c5d9"`
Dec 06 20:48:26.212 INFO running `"docker" "rm" "-f" "9fc8b6a011812cac0bf55a775935eb1efc4aa1b166c4328bd0678f85a635c5d9"`
Dec 06 20:48:26.455 INFO [stdout] 9fc8b6a011812cac0bf55a775935eb1efc4aa1b166c4328bd0678f85a635c5d9
Dec 06 20:48:26.458 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 06 20:48:26.817 INFO [stdout] f3d75b02933cdb2683a6dcd274b7f651b7227fc360f0f58adbe94dabcee368b4
Dec 06 20:48:26.819 INFO running `"docker" "start" "-a" "f3d75b02933cdb2683a6dcd274b7f651b7227fc360f0f58adbe94dabcee368b4"`
Dec 06 20:48:27.360 INFO [stderr] usermod: no changes
Dec 06 20:48:27.388 INFO [stderr] warning: the cargo feature `rename-dependency` is now stable and is no longer necessary to be listed in the manifest
Dec 06 20:48:27.559 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 06 20:48:27.566 INFO [stderr]      Running /target/debug/deps/tarpc_bincode_transport-c59e6448ebcf80eb
Dec 06 20:48:27.567 INFO [stdout] 
Dec 06 20:48:27.567 INFO [stdout] running 0 tests
Dec 06 20:48:27.567 INFO [stdout] 
Dec 06 20:48:27.567 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:48:27.567 INFO [stdout] 
Dec 06 20:48:27.569 INFO [stderr]      Running /target/debug/deps/bench-8facc3a2ff9dfe2a
Dec 06 20:48:27.584 INFO [stdout] 
Dec 06 20:48:27.584 INFO [stdout] running 1 test
Dec 06 20:48:40.023 INFO [stdout] Of 10000 runs:
Dec 06 20:48:40.023 INFO [stdout] 	Successful: 10000
Dec 06 20:48:40.023 INFO [stdout] 	Unsuccessful: 0
Dec 06 20:48:40.023 INFO [stdout] 	Mean: 1.242044ms
Dec 06 20:48:40.023 INFO [stdout] 	Median: 894.738µs
Dec 06 20:48:40.023 INFO [stdout] 	Std Dev: 1.476837ms
Dec 06 20:48:40.023 INFO [stdout] 	Min: 348.209µs
Dec 06 20:48:40.023 INFO [stdout] 	Max: 29.23098ms
Dec 06 20:48:40.023 INFO [stdout] 	Quartiles: (783.584µs, 894.738µs, 1.034813ms)
Dec 06 20:48:40.028 INFO [stdout] test bench_small_packet ... ok
Dec 06 20:48:40.028 INFO [stdout] 
Dec 06 20:48:40.028 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:48:40.028 INFO [stdout] 
Dec 06 20:48:40.033 INFO [stderr]      Running /target/debug/deps/cancel-b4c2c72c7e13b92e
Dec 06 20:48:40.036 INFO [stdout] 
Dec 06 20:48:40.036 INFO [stdout] running 1 test
Dec 06 20:48:40.112 INFO [stdout] test cancel_slower ... ok
Dec 06 20:48:40.112 INFO [stdout] 
Dec 06 20:48:40.112 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:48:40.112 INFO [stdout] 
Dec 06 20:48:40.114 INFO [stderr]      Running /target/debug/deps/pushback-032fcaa04f2469a0
Dec 06 20:48:40.122 INFO [stdout] 
Dec 06 20:48:40.122 INFO [stdout] running 1 test
Dec 06 20:48:40.178 INFO [stdout] done
Dec 06 20:48:50.001 INFO [stderr] ERROR 2018-12-06T20:48:50Z: pushback: [4d7fdb1cfffeb553c9] request error: TimedOut: Response did not complete before deadline of 2018-12-06T20:48:50Zs.
Dec 06 20:48:50.001 INFO [stderr] ERROR 2018-12-06T20:48:50Z: pushback: [32737f39f3ffdfbf27] request error: TimedOut: Response did not complete before deadline of 2018-12-06T20:48:50Zs.
Dec 06 20:48:50.001 INFO [stderr] ERROR 2018-12-06T20:48:50Z: pushback: [23fd39eb3fc6bebf76] request error: TimedOut: Response did not complete before deadline of 2018-12-06T20:48:50Zs.
Dec 06 20:48:50.001 INFO [stderr] ERROR 2018-12-06T20:48:50Z: pushback: [5be7fedc668fb9fe5b] request error: TimedOut: Response did not complete before deadline of 2018-12-06T20:48:50Zs.
Dec 06 20:48:50.008 INFO [stderr] ERROR 2018-12-06T20:48:50Z: pushback: [89dff52bff15ffd276] request error: TimedOut: Response did not complete before deadline of 2018-12-06T20:48:50Zs.
Dec 06 20:48:50.051 INFO [stdout] test ping_pong ... ok
Dec 06 20:48:50.051 INFO [stdout] 
Dec 06 20:48:50.051 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:48:50.051 INFO [stdout] 
Dec 06 20:48:50.052 INFO [stderr]    Doc-tests tarpc-bincode-transport
Dec 06 20:48:57.503 INFO [stdout] 
Dec 06 20:48:57.503 INFO [stdout] running 0 tests
Dec 06 20:48:57.503 INFO [stdout] 
Dec 06 20:48:57.503 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 20:48:57.503 INFO [stdout] 
Dec 06 20:48:57.512 INFO [stderr] su: No module specific data is present
Dec 06 20:48:57.828 INFO running `"docker" "inspect" "f3d75b02933cdb2683a6dcd274b7f651b7227fc360f0f58adbe94dabcee368b4"`
Dec 06 20:48:57.895 INFO running `"docker" "rm" "-f" "f3d75b02933cdb2683a6dcd274b7f651b7227fc360f0f58adbe94dabcee368b4"`
Dec 06 20:48:57.976 INFO [stdout] f3d75b02933cdb2683a6dcd274b7f651b7227fc360f0f58adbe94dabcee368b4