Dec 14 17:37:17.025 INFO testing tarpc-bincode-transport-0.3.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 17:37:17.026 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 17:37:17.598 INFO [stdout] af10b074e0febb0981f75a3cb70d46fb55558786a0cf572585f987744950f37d
Dec 14 17:37:17.607 INFO running `"docker" "start" "-a" "af10b074e0febb0981f75a3cb70d46fb55558786a0cf572585f987744950f37d"`
Dec 14 17:37:18.911 INFO [stderr] usermod: no changes
Dec 14 17:37:18.959 INFO [stderr] warning: the cargo feature `rename-dependency` is now stable and is no longer necessary to be listed in the manifest
Dec 14 17:37:19.178 INFO [stderr]    Compiling pin-utils v0.1.0-alpha.3
Dec 14 17:37:19.178 INFO [stderr]    Compiling serde v1.0.82
Dec 14 17:37:19.187 INFO [stderr]    Compiling futures-core-preview v0.3.0-alpha.10
Dec 14 17:37:19.187 INFO [stderr]    Compiling bytes v0.4.11
Dec 14 17:37:21.141 INFO [stderr]    Compiling futures-channel-preview v0.3.0-alpha.10
Dec 14 17:37:21.141 INFO [stderr]    Compiling futures-io-preview v0.3.0-alpha.10
Dec 14 17:37:24.335 INFO [stderr]    Compiling tokio-io v0.1.10
Dec 14 17:37:24.619 INFO [stderr]    Compiling futures-sink-preview v0.3.0-alpha.10
Dec 14 17:37:26.191 INFO [stderr]    Compiling futures-util-preview v0.3.0-alpha.10
Dec 14 17:37:27.471 INFO [stderr]    Compiling tokio-reactor v0.1.7
Dec 14 17:37:27.471 INFO [stderr]    Compiling tokio-codec v0.1.1
Dec 14 17:37:27.471 INFO [stderr]    Compiling tokio-fs v0.1.4
Dec 14 17:37:38.068 INFO [stderr]    Compiling tokio-tcp v0.1.2
Dec 14 17:37:38.070 INFO [stderr]    Compiling tokio-udp v0.1.3
Dec 14 17:37:38.084 INFO [stderr]    Compiling tokio-uds v0.2.4
Dec 14 17:37:42.603 INFO [stderr]    Compiling futures-executor-preview v0.3.0-alpha.10
Dec 14 17:37:47.543 INFO [stderr]    Compiling tokio v0.1.13
Dec 14 17:37:48.199 INFO [stderr]    Compiling futures-preview v0.3.0-alpha.10
Dec 14 17:37:52.831 INFO [stderr]    Compiling tarpc-trace v0.1.0
Dec 14 17:37:52.831 INFO [stderr]    Compiling bincode v1.0.1
Dec 14 17:37:54.456 INFO [stderr]    Compiling tarpc-lib v0.2.0
Dec 14 17:37:54.643 INFO [stderr]    Compiling async-bincode v0.4.9
Dec 14 17:37:58.768 INFO [stderr]    Compiling tarpc-bincode-transport v0.3.0 (/source)
Dec 14 17:38:03.019 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 44.08s
Dec 14 17:38:03.030 INFO [stderr] su: No module specific data is present
Dec 14 17:38:03.333 INFO running `"docker" "inspect" "af10b074e0febb0981f75a3cb70d46fb55558786a0cf572585f987744950f37d"`
Dec 14 17:38:03.560 INFO running `"docker" "rm" "-f" "af10b074e0febb0981f75a3cb70d46fb55558786a0cf572585f987744950f37d"`
Dec 14 17:38:03.787 INFO [stdout] af10b074e0febb0981f75a3cb70d46fb55558786a0cf572585f987744950f37d
Dec 14 17:38:03.789 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 17:38:04.119 INFO [stdout] dd3d31b28fba110fa1af29437b8ec9a50a1445d61313036dc3ffd4cca9f6be32
Dec 14 17:38:04.122 INFO running `"docker" "start" "-a" "dd3d31b28fba110fa1af29437b8ec9a50a1445d61313036dc3ffd4cca9f6be32"`
Dec 14 17:38:05.111 INFO [stderr] usermod: no changes
Dec 14 17:38:05.167 INFO [stderr] warning: the cargo feature `rename-dependency` is now stable and is no longer necessary to be listed in the manifest
Dec 14 17:38:05.355 INFO [stderr]    Compiling tokio-serde v0.2.0
Dec 14 17:38:06.147 INFO [stderr]    Compiling tarpc-bincode-transport v0.3.0 (/source)
Dec 14 17:38:25.602 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.46s
Dec 14 17:38:25.614 INFO [stderr] su: No module specific data is present
Dec 14 17:38:25.975 INFO running `"docker" "inspect" "dd3d31b28fba110fa1af29437b8ec9a50a1445d61313036dc3ffd4cca9f6be32"`
Dec 14 17:38:26.287 INFO running `"docker" "rm" "-f" "dd3d31b28fba110fa1af29437b8ec9a50a1445d61313036dc3ffd4cca9f6be32"`
Dec 14 17:38:26.548 INFO [stdout] dd3d31b28fba110fa1af29437b8ec9a50a1445d61313036dc3ffd4cca9f6be32
Dec 14 17:38:26.553 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 14 17:38:26.907 INFO [stdout] 3d273c2794fab6ed125aa7095c91b88fe75eb6e924087c126b380fdc474d38ab
Dec 14 17:38:26.907 INFO running `"docker" "start" "-a" "3d273c2794fab6ed125aa7095c91b88fe75eb6e924087c126b380fdc474d38ab"`
Dec 14 17:38:27.991 INFO [stderr] usermod: no changes
Dec 14 17:38:28.047 INFO [stderr] warning: the cargo feature `rename-dependency` is now stable and is no longer necessary to be listed in the manifest
Dec 14 17:38:28.254 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.22s
Dec 14 17:38:28.275 INFO [stderr]      Running /target/debug/deps/tarpc_bincode_transport-11d958521c6e2443
Dec 14 17:38:28.275 INFO [stderr]      Running /target/debug/deps/bench-174bcf8af2f2aba6
Dec 14 17:38:28.275 INFO [stdout] 
Dec 14 17:38:28.275 INFO [stdout] running 0 tests
Dec 14 17:38:28.275 INFO [stdout] 
Dec 14 17:38:28.275 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 17:38:28.275 INFO [stdout] 
Dec 14 17:38:28.284 INFO [stdout] 
Dec 14 17:38:28.284 INFO [stdout] running 1 test
Dec 14 17:38:39.413 INFO [stdout] Of 10000 runs:
Dec 14 17:38:39.413 INFO [stdout] 	Successful: 10000
Dec 14 17:38:39.413 INFO [stdout] 	Unsuccessful: 0
Dec 14 17:38:39.413 INFO [stdout] 	Mean: 1.110825ms
Dec 14 17:38:39.413 INFO [stdout] 	Median: 829.011µs
Dec 14 17:38:39.413 INFO [stdout] 	Std Dev: 1.294717ms
Dec 14 17:38:39.413 INFO [stdout] 	Min: 280.535µs
Dec 14 17:38:39.413 INFO [stdout] 	Max: 20.12862ms
Dec 14 17:38:39.413 INFO [stdout] 	Quartiles: (712.468µs, 829.011µs, 955.213µs)
Dec 14 17:38:39.419 INFO [stdout] test bench_small_packet ... ok
Dec 14 17:38:39.419 INFO [stdout] 
Dec 14 17:38:39.419 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 17:38:39.419 INFO [stdout] 
Dec 14 17:38:39.421 INFO [stderr]      Running /target/debug/deps/cancel-f5b3eb4a573c86fb
Dec 14 17:38:39.425 INFO [stdout] 
Dec 14 17:38:39.425 INFO [stdout] running 1 test
Dec 14 17:38:39.486 INFO [stdout] test cancel_slower ... ok
Dec 14 17:38:39.487 INFO [stderr]      Running /target/debug/deps/pushback-a4407480c655d498
Dec 14 17:38:39.487 INFO [stdout] 
Dec 14 17:38:39.487 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 17:38:39.487 INFO [stdout] 
Dec 14 17:38:39.487 INFO [stdout] 
Dec 14 17:38:39.487 INFO [stdout] running 1 test
Dec 14 17:38:39.510 INFO [stdout] done
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [aa75fefed5bffbf713] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [593f35fafddf7fe24f] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [89dd3ffc54ffbffdc8] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [4bd9d3ffbef8ec7e71] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [edff76795edfbe5c37] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [40fbfbd7f5f3c97712] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [9857def3ff7dbbcc7d] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.007 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [97f795bba77ab7f163] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.008 INFO [stderr] ERROR 2018-12-14T17:38:49Z: pushback: [fcef97de6579675731] request error: TimedOut: Response did not complete before deadline of 2018-12-14T17:38:49Zs.
Dec 14 17:38:49.115 INFO [stderr]    Doc-tests tarpc-bincode-transport
Dec 14 17:38:49.115 INFO [stdout] test ping_pong ... ok
Dec 14 17:38:49.115 INFO [stdout] 
Dec 14 17:38:49.115 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 17:38:49.115 INFO [stdout] 
Dec 14 17:38:58.153 INFO [stdout] 
Dec 14 17:38:58.153 INFO [stdout] running 0 tests
Dec 14 17:38:58.153 INFO [stdout] 
Dec 14 17:38:58.153 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 17:38:58.153 INFO [stdout] 
Dec 14 17:38:58.164 INFO [stderr] su: No module specific data is present
Dec 14 17:38:58.595 INFO running `"docker" "inspect" "3d273c2794fab6ed125aa7095c91b88fe75eb6e924087c126b380fdc474d38ab"`
Dec 14 17:38:58.726 INFO running `"docker" "rm" "-f" "3d273c2794fab6ed125aa7095c91b88fe75eb6e924087c126b380fdc474d38ab"`
Dec 14 17:38:58.806 INFO [stdout] 3d273c2794fab6ed125aa7095c91b88fe75eb6e924087c126b380fdc474d38ab