[INFO] updating cached repository klausi/rustnish
[INFO] running `"git" "fetch" "--all"`
[INFO] [stdout] Fetching origin
[INFO] [stderr] From git://github.com/klausi/rustnish
[INFO] [stderr]  * branch            HEAD       -> FETCH_HEAD
[INFO] running `"git" "clone" "work/cache/sources/gh/klausi/rustnish" "work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/gh/klausi/rustnish"`
[INFO] [stderr] Cloning into 'work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/gh/klausi/rustnish'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/klausi/rustnish" "work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/gh/klausi/rustnish"`
[INFO] [stderr] Cloning into 'work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/gh/klausi/rustnish'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 2bc2d93eb3d61f4aa3fa3961301cd9b62e173d6c
[INFO] sha for GitHub repo klausi/rustnish: 2bc2d93eb3d61f4aa3fa3961301cd9b62e173d6c
[INFO] validating manifest of klausi/rustnish on toolchain master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of klausi/rustnish on toolchain try#7fea0229842e79db1159ea58ad9a653b288efee9
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing klausi/rustnish
[INFO] finished frobbing klausi/rustnish
[INFO] frobbed toml for klausi/rustnish written to work/ex/pr-57967/sources/master#c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54/gh/klausi/rustnish/Cargo.toml
[INFO] started frobbing klausi/rustnish
[INFO] finished frobbing klausi/rustnish
[INFO] frobbed toml for klausi/rustnish written to work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/gh/klausi/rustnish/Cargo.toml
[INFO] crate klausi/rustnish has a lockfile. skipping
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c1c3c4e95b69dfeaca5c5db6c622d7f90ad30a54-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing klausi/rustnish against try#7fea0229842e79db1159ea58ad9a653b288efee9 for pr-57967
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-3/try#7fea0229842e79db1159ea58ad9a653b288efee9:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/gh/klausi/rustnish:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "build" "--frozen"`
[INFO] [stdout] be9bbbf5a76e0ee801f2fa5dbc749a2d871d72a9763056fd4bd629166c7f3018
[INFO] running `"docker" "start" "-a" "be9bbbf5a76e0ee801f2fa5dbc749a2d871d72a9763056fd4bd629166c7f3018"`
[INFO] [stderr]    Compiling want v0.0.6
[INFO] [stderr]    Compiling tokio-io v0.1.9
[INFO] [stderr]    Compiling error-chain v0.12.0
[INFO] [stderr]    Compiling tokio-threadpool v0.1.7
[INFO] [stderr]    Compiling tokio-codec v0.1.1
[INFO] [stderr]    Compiling tokio-reactor v0.1.6
[INFO] [stderr]    Compiling h2 v0.1.12
[INFO] [stderr]    Compiling tokio-fs v0.1.3
[INFO] [stderr]    Compiling tokio-uds v0.2.2
[INFO] [stderr]    Compiling tokio-udp v0.1.2
[INFO] [stderr]    Compiling tokio-tcp v0.1.2
[INFO] [stderr]    Compiling tokio v0.1.11
[INFO] [stderr]    Compiling hyper v0.12.11
[INFO] [stderr]    Compiling rustnish v0.0.1 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 33.12s
[INFO] running `"docker" "inspect" "be9bbbf5a76e0ee801f2fa5dbc749a2d871d72a9763056fd4bd629166c7f3018"`
[INFO] running `"docker" "rm" "-f" "be9bbbf5a76e0ee801f2fa5dbc749a2d871d72a9763056fd4bd629166c7f3018"`
[INFO] [stdout] be9bbbf5a76e0ee801f2fa5dbc749a2d871d72a9763056fd4bd629166c7f3018
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-3/try#7fea0229842e79db1159ea58ad9a653b288efee9:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/gh/klausi/rustnish:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 464d48a7cc8821d170c3786fc3b9b99bdb893ca9397479619ebd153c97a9f313
[INFO] running `"docker" "start" "-a" "464d48a7cc8821d170c3786fc3b9b99bdb893ca9397479619ebd153c97a9f313"`
[INFO] [stderr]    Compiling tokio-core v0.1.17
[INFO] [stderr]    Compiling rustnish v0.0.1 (/opt/crater/workdir)
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]   --> tests/common/mod.rs:11:48
[INFO] [stderr]    |
[INFO] [stderr] 11 | use std::sync::atomic::{AtomicUsize, Ordering, ATOMIC_USIZE_INIT};
[INFO] [stderr]    |                                                ^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]   --> tests/common/mod.rs:76:35
[INFO] [stderr]    |
[INFO] [stderr] 76 |     static PORT_NR: AtomicUsize = ATOMIC_USIZE_INIT;
[INFO] [stderr]    |                                   ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]   --> tests/common/mod.rs:11:48
[INFO] [stderr]    |
[INFO] [stderr] 11 | use std::sync::atomic::{AtomicUsize, Ordering, ATOMIC_USIZE_INIT};
[INFO] [stderr]    |                                                ^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'std::sync::atomic::ATOMIC_USIZE_INIT': the `new` function is now preferred
[INFO] [stderr]   --> tests/common/mod.rs:76:35
[INFO] [stderr]    |
[INFO] [stderr] 76 |     static PORT_NR: AtomicUsize = ATOMIC_USIZE_INIT;
[INFO] [stderr]    |                                   ^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.89s
[INFO] running `"docker" "inspect" "464d48a7cc8821d170c3786fc3b9b99bdb893ca9397479619ebd153c97a9f313"`
[INFO] running `"docker" "rm" "-f" "464d48a7cc8821d170c3786fc3b9b99bdb893ca9397479619ebd153c97a9f313"`
[INFO] [stdout] 464d48a7cc8821d170c3786fc3b9b99bdb893ca9397479619ebd153c97a9f313
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-57967/worker-3/try#7fea0229842e79db1159ea58ad9a653b288efee9:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-57967/sources/try#7fea0229842e79db1159ea58ad9a653b288efee9/gh/klausi/rustnish:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+7fea0229842e79db1159ea58ad9a653b288efee9-alt" "test" "--frozen"`
[INFO] [stdout] 3faed71d4cd4a69ba88896710b2408b206efc7a2603197cb37660420a2e8fcca
[INFO] running `"docker" "start" "-a" "3faed71d4cd4a69ba88896710b2408b206efc7a2603197cb37660420a2e8fcca"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/rustnish-09b3714841274d27
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/rustnish-38a93476274cf60c
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/cache-d650a5ca6537fa82
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test no_max_age_means_uncachable ... ok
[INFO] [stdout] test session_cookie_bypass ... ok
[INFO] [stdout] test upstream_down_cache ... ok
[INFO] [stdout] test max_age_expired ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/response_and_headers-e2c1a69529468e1c
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test port_occupied ... ok
[INFO] [stdout] test invalid_host ... ok
[INFO] [stdout] test upstream_down ... ok
[INFO] [stdout] test query_parameters ... ok
[INFO] [stdout] test x_forwarded_for_added ... ok
[INFO] [stdout] test server_header_present ... ok
[INFO] [stdout] test via_header_added ... ok
[INFO] [stdout] test post_request ... ok
[INFO] [stdout] test pass_through ... test pass_through has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `"docker" "inspect" "3faed71d4cd4a69ba88896710b2408b206efc7a2603197cb37660420a2e8fcca"`
[INFO] running `"docker" "rm" "-f" "3faed71d4cd4a69ba88896710b2408b206efc7a2603197cb37660420a2e8fcca"`
[INFO] [stdout] 3faed71d4cd4a69ba88896710b2408b206efc7a2603197cb37660420a2e8fcca