[INFO] updating cached repository https://github.com/jxs/gotham-middleware-example
[INFO] running `"git" "-c" "credential.helper=" "-c" "credential.helper=/big/crater/work/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune"`
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 081c90c776199e81ef187a0a00002e680e237773
[INFO] testing jxs/gotham-middleware-example against beta-2019-09-28 for beta-1.39-1
[INFO] running `"git" "clone" "work/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjxs%2Fgotham-middleware-example" "work/builds/worker-1/source"`
[INFO] [stderr] Cloning into 'work/builds/worker-1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/jxs/gotham-middleware-example on toolchain beta-2019-09-28
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking git repo https://github.com/jxs/gotham-middleware-example
[INFO] finished tweaking git repo https://github.com/jxs/gotham-middleware-example
[INFO] tweaked toml for git repo https://github.com/jxs/gotham-middleware-example written to work/builds/worker-1/source/Cargo.toml
[INFO] crate git repo https://github.com/jxs/gotham-middleware-example already has a lockfile, it will not be regenerated
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+beta-2019-09-28" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "build" "--frozen"`
[INFO] [stdout] b106d9e47fc216aa6fda423b56b38831ff9eb617c90c8ae427aac6fe1c426a80
[INFO] running `"docker" "start" "-a" "b106d9e47fc216aa6fda423b56b38831ff9eb617c90c8ae427aac6fe1c426a80"`
[INFO] [stderr]    Compiling tokio-executor v0.1.2
[INFO] [stderr]    Compiling tokio-service v0.1.0
[INFO] [stderr]    Compiling relay v0.1.1
[INFO] [stderr]    Compiling futures-cpupool v0.1.8
[INFO] [stderr]    Compiling want v0.0.4
[INFO] [stderr]    Compiling tokio-io v0.1.7
[INFO] [stderr]    Compiling serde_json v1.0.22
[INFO] [stderr]    Compiling gotham_derive v0.3.0-dev (https://github.com/gotham-rs/gotham.git#d0b35b16)
[INFO] [stderr]    Compiling error-chain v0.11.0
[INFO] [stderr]    Compiling tokio-threadpool v0.1.5
[INFO] [stderr]    Compiling tokio-timer v0.2.4
[INFO] [stderr]    Compiling tokio-reactor v0.1.2
[INFO] [stderr]    Compiling tokio-codec v0.1.0
[INFO] [stderr]    Compiling cargo_metadata v0.5.8
[INFO] [stderr]    Compiling tokio-udp v0.1.1
[INFO] [stderr]    Compiling tokio-tcp v0.1.0
[INFO] [stderr]    Compiling tokio-fs v0.1.1
[INFO] [stderr]    Compiling tokio v0.1.7
[INFO] [stderr]    Compiling skeptic v0.13.3
[INFO] [stderr]    Compiling tokio-core v0.1.17
[INFO] [stderr]    Compiling tokio-proto v0.1.1
[INFO] [stderr]    Compiling borrow-bag v1.0.0
[INFO] [stderr]    Compiling hyper v0.11.27
[INFO] [stderr]    Compiling gotham v0.3.0-dev (https://github.com/gotham-rs/gotham.git#d0b35b16)
[INFO] [stderr]    Compiling gotham_examples_middleware_introduction v0.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 45.48s
[INFO] running `"docker" "inspect" "b106d9e47fc216aa6fda423b56b38831ff9eb617c90c8ae427aac6fe1c426a80"`
[INFO] running `"docker" "rm" "-f" "b106d9e47fc216aa6fda423b56b38831ff9eb617c90c8ae427aac6fe1c426a80"`
[INFO] [stdout] b106d9e47fc216aa6fda423b56b38831ff9eb617c90c8ae427aac6fe1c426a80
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen" "--no-run"`
[INFO] [stdout] f2ca5a1fc1935f218ab1e53dd0adf5e093c6a454f651356daeb523e941dd4260
[INFO] running `"docker" "start" "-a" "f2ca5a1fc1935f218ab1e53dd0adf5e093c6a454f651356daeb523e941dd4260"`
[INFO] [stderr]    Compiling gotham_examples_middleware_introduction v0.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.62s
[INFO] running `"docker" "inspect" "f2ca5a1fc1935f218ab1e53dd0adf5e093c6a454f651356daeb523e941dd4260"`
[INFO] running `"docker" "rm" "-f" "f2ca5a1fc1935f218ab1e53dd0adf5e093c6a454f651356daeb523e941dd4260"`
[INFO] [stdout] f2ca5a1fc1935f218ab1e53dd0adf5e093c6a454f651356daeb523e941dd4260
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2019-09-28" "test" "--frozen"`
[INFO] [stdout] 0735c587ab1ff3b512434c0c6b053b0f9e0bc00e29353551a23e9fca4ac3e654
[INFO] running `"docker" "start" "-a" "0735c587ab1ff3b512434c0c6b053b0f9e0bc00e29353551a23e9fca4ac3e654"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/gotham_examples_middleware_introduction-d88929e3538d72af
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::ensure_middleware_and_handler_collaborate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "0735c587ab1ff3b512434c0c6b053b0f9e0bc00e29353551a23e9fca4ac3e654"`
[INFO] running `"docker" "rm" "-f" "0735c587ab1ff3b512434c0c6b053b0f9e0bc00e29353551a23e9fca4ac3e654"`
[INFO] [stdout] 0735c587ab1ff3b512434c0c6b053b0f9e0bc00e29353551a23e9fca4ac3e654