Dec 05 17:51:39.745 INFO testing kevinastone/httpbox against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 17:51:39.745 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 17:51:40.312 INFO [stdout] 8feec0f25ea2370eeaba4e3a3966ce0dc9f4e6fefcdc0385736d7d4ae961731c
Dec 05 17:51:40.314 INFO running `"docker" "start" "-a" "8feec0f25ea2370eeaba4e3a3966ce0dc9f4e6fefcdc0385736d7d4ae961731c"`
Dec 05 17:51:41.847 INFO [stderr] usermod: no changes
Dec 05 17:51:42.188 INFO [stderr]    Compiling term_size v0.2.3
Dec 05 17:51:42.188 INFO [stderr]    Compiling futures-timer v0.1.1
Dec 05 17:51:42.188 INFO [stderr]    Compiling rand v0.5.4
Dec 05 17:51:42.188 INFO [stderr]    Compiling want v0.0.4
Dec 05 17:51:42.188 INFO [stderr]    Compiling mio v0.6.15
Dec 05 17:51:42.188 INFO [stderr]    Compiling tempdir v0.3.7
Dec 05 17:51:42.188 INFO [stderr]    Compiling rand v0.3.22
Dec 05 17:51:42.223 INFO [stderr]    Compiling cookie v0.10.1
Dec 05 17:51:43.789 INFO [stderr]    Compiling syn v0.14.7
Dec 05 17:51:44.304 INFO [stderr]    Compiling tokio-io v0.1.7
Dec 05 17:51:44.319 INFO [stderr]    Compiling clap v2.16.4
Dec 05 17:51:48.895 INFO [stderr]    Compiling bincode v1.0.1
Dec 05 17:51:48.924 INFO [stderr]    Compiling gotham_derive v0.2.1
Dec 05 17:51:48.980 INFO [stderr]    Compiling regex v0.2.11
Dec 05 17:51:52.792 INFO [stderr]    Compiling error-chain v0.11.0
Dec 05 17:51:56.380 INFO [stderr]    Compiling tokio-threadpool v0.1.5
Dec 05 17:51:56.404 INFO [stderr]    Compiling tokio-codec v0.1.0
Dec 05 17:51:56.676 INFO [stderr]    Compiling tokio-reactor v0.1.2
Dec 05 17:52:09.752 INFO [stderr]    Compiling tokio-tcp v0.1.0
Dec 05 17:52:10.144 INFO [stderr]    Compiling tokio-udp v0.1.1
Dec 05 17:52:14.144 INFO [stderr]    Compiling serde_derive v1.0.70
Dec 05 17:52:14.917 INFO [stderr]    Compiling tokio-fs v0.1.2
Dec 05 17:52:17.414 INFO [stderr]    Compiling tokio v0.1.7
Dec 05 17:52:20.672 INFO [stderr]    Compiling tokio-core v0.1.17
Dec 05 17:52:24.640 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 05 17:52:28.906 INFO [stderr]    Compiling hyper v0.11.27
Dec 05 17:52:29.068 INFO [stderr]    Compiling cargo_metadata v0.5.8
Dec 05 17:52:32.088 INFO [stderr]    Compiling skeptic v0.13.3
Dec 05 17:52:36.320 INFO [stderr]    Compiling borrow-bag v1.0.0
Dec 05 17:52:39.452 INFO [stderr]    Compiling gotham v0.2.1
Dec 05 17:52:47.008 INFO [stderr]    Compiling httpbox v0.2.0 (/source)
Dec 05 17:52:58.516 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 16s
Dec 05 17:52:58.533 INFO [stderr] su: No module specific data is present
Dec 05 17:52:59.399 INFO running `"docker" "inspect" "8feec0f25ea2370eeaba4e3a3966ce0dc9f4e6fefcdc0385736d7d4ae961731c"`
Dec 05 17:52:59.752 INFO running `"docker" "rm" "-f" "8feec0f25ea2370eeaba4e3a3966ce0dc9f4e6fefcdc0385736d7d4ae961731c"`
Dec 05 17:53:00.153 INFO [stdout] 8feec0f25ea2370eeaba4e3a3966ce0dc9f4e6fefcdc0385736d7d4ae961731c
Dec 05 17:53:00.158 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 17:53:00.632 INFO [stdout] f9d191775657f9b5486657455f7c1a8ff284f134395ddad6475b564c9f8b9d5c
Dec 05 17:53:00.634 INFO running `"docker" "start" "-a" "f9d191775657f9b5486657455f7c1a8ff284f134395ddad6475b564c9f8b9d5c"`
Dec 05 17:53:02.008 INFO [stderr] usermod: no changes
Dec 05 17:53:02.248 INFO [stderr]    Compiling httpbox v0.2.0 (/source)
Dec 05 17:53:15.762 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 13.71s
Dec 05 17:53:15.780 INFO [stderr] su: No module specific data is present
Dec 05 17:53:16.744 INFO running `"docker" "inspect" "f9d191775657f9b5486657455f7c1a8ff284f134395ddad6475b564c9f8b9d5c"`
Dec 05 17:53:17.118 INFO running `"docker" "rm" "-f" "f9d191775657f9b5486657455f7c1a8ff284f134395ddad6475b564c9f8b9d5c"`
Dec 05 17:53:17.476 INFO [stdout] f9d191775657f9b5486657455f7c1a8ff284f134395ddad6475b564c9f8b9d5c
Dec 05 17:53:17.478 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 17:53:17.940 INFO [stdout] 13d101601cd8b247d04126aa3a426e8c262e165d206f41b033aa908ead58d24d
Dec 05 17:53:17.942 INFO running `"docker" "start" "-a" "13d101601cd8b247d04126aa3a426e8c262e165d206f41b033aa908ead58d24d"`
Dec 05 17:53:19.445 INFO [stderr] usermod: no changes
Dec 05 17:53:19.726 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Dec 05 17:53:19.735 INFO [stderr]      Running /target/debug/deps/httpbox-f2b922364777131f
Dec 05 17:53:19.758 INFO [stdout] 
Dec 05 17:53:19.758 INFO [stdout] running 52 tests
Dec 05 17:53:19.770 INFO [stdout] test app::auth::header::test::test_parse_err_www_authenticate ... ok
Dec 05 17:53:19.770 INFO [stdout] test app::auth::header::test::test_parse_err_basic_realm ... ok
Dec 05 17:53:19.770 INFO [stdout] test app::auth::header::test::test_format_basic_realm ... ok
Dec 05 17:53:19.776 INFO [stdout] test app::auth::header::test::test_parse_www_authenticate ... ok
Dec 05 17:53:19.776 INFO [stdout] test app::auth::header::test::test_parse_basic_realm ... ok
Dec 05 17:53:19.817 INFO [stdout] test app::auth::test::test_basic_unauthorized ... ok
Dec 05 17:53:19.817 INFO [stdout] test app::bytes::test::test_bytes ... ok
Dec 05 17:53:19.818 INFO [stdout] test app::auth::test::test_basic_authorized ... ok
Dec 05 17:53:19.818 INFO [stdout] test app::bytes::test::test_stream_bytes ... ok
Dec 05 17:53:19.818 INFO [stdout] test app::auth::test::test_basic_no_authorization ... ok
Dec 05 17:53:19.819 INFO [stdout] test app::auth::test::test_bearer_unauthorized ... ok
Dec 05 17:53:19.839 INFO [stdout] test app::cache::test::test_cache_if_none_match ... ok
Dec 05 17:53:19.850 INFO [stdout] test app::auth::test::test_bearer_authorized ... ok
Dec 05 17:53:19.854 INFO [stdout] test app::auth::test::test_bearer_no_authorization ... ok
Dec 05 17:53:19.875 INFO [stdout] test app::cache::test::test_set_cache ... ok
Dec 05 17:53:19.875 INFO [stdout] test app::cookies::test::test_cookies ... ok
Dec 05 17:53:19.892 INFO [stdout] test app::cache::test::test_cache_if_modified_since ... ok
Dec 05 17:53:19.900 INFO [stdout] test app::delay::test::test_sleep ... ok
Dec 05 17:53:19.904 INFO [stdout] test app::cache::test::test_cache_no_headers ... ok
Dec 05 17:53:19.908 INFO [stdout] test app::bytes::test::test_stream_bytes_with_chunk_size ... ok
Dec 05 17:53:19.920 INFO [stdout] test app::method::test::test_delete ... ok
Dec 05 17:53:19.924 INFO [stdout] test app::cookies::test::test_set_cookies ... ok
Dec 05 17:53:19.930 INFO [stdout] test app::cookies::test::test_no_cookies ... ok
Dec 05 17:53:19.936 INFO [stdout] test app::headers::test::test_headers ... ok
Dec 05 17:53:19.964 INFO [stdout] test app::delay::test::test_sleep_too_long ... ok
Dec 05 17:53:19.964 INFO [stdout] test app::ip::test::test_ip ... ok
Dec 05 17:53:19.964 INFO [stdout] test app::headers::test::test_response_headers ... ok
Dec 05 17:53:19.974 INFO [stdout] test app::method::test::test_multi_post ... ok
Dec 05 17:53:19.981 INFO [stdout] test app::method::test::test_get ... ok
Dec 05 17:53:19.991 INFO [stdout] test app::ip::test::test_ip_from_header ... ok
Dec 05 17:53:19.991 INFO [stdout] test app::method::test::test_put ... ok
Dec 05 17:53:19.991 INFO [stdout] test app::random::tests::rng_no_seed ... ok
Dec 05 17:53:20.007 INFO [stdout] test app::method::test::test_multi_get ... ok
Dec 05 17:53:20.007 INFO [stdout] test app::method::test::test_multi_patch ... ok
Dec 05 17:53:20.020 INFO [stdout] test app::random::tests::rng_seed_consistent ... ok
Dec 05 17:53:20.023 INFO [stdout] test app::method::test::test_post ... ok
Dec 05 17:53:20.028 INFO [stdout] test app::method::test::test_patch ... ok
Dec 05 17:53:20.028 INFO [stdout] test app::redirect::test::test_absolute_redirect_last ... ok
Dec 05 17:53:20.028 INFO [stdout] test app::redirect::test::test_absolute_redirect ... ok
Dec 05 17:53:20.052 INFO [stdout] test app::redirect::uri::test::test_absolute_uri_with_port ... ok
Dec 05 17:53:20.052 INFO [stdout] test app::redirect::uri::test::test_absolute_uri ... ok
Dec 05 17:53:20.060 INFO [stdout] test app::redirect::test::test_redirect_last ... ok
Dec 05 17:53:20.068 INFO [stdout] test app::redirect::test::test_redirect ... ok
Dec 05 17:53:20.076 INFO [stdout] test app::method::test::test_multi_put ... ok
Dec 05 17:53:20.080 INFO [stdout] test app::redirect::test::test_relative_redirect_last ... ok
Dec 05 17:53:20.082 INFO [stdout] test app::redirect::test::test_redirect_to ... ok
Dec 05 17:53:20.084 INFO [stdout] test app::redirect::uri::test::test_join_url ... ok
Dec 05 17:53:20.100 INFO [stdout] test app::redirect::test::test_relative_redirect ... ok
Dec 05 17:53:20.120 INFO [stdout] test app::status_code::test::test_status_code ... ok
Dec 05 17:53:20.126 INFO [stdout] test app::status_code::test::test_bad_status_code ... ok
Dec 05 17:53:20.136 INFO [stdout] test app::user_agent::test::test_user_agent ... ok
Dec 05 17:53:20.136 INFO [stdout] test app::user_agent::test::test_user_agent_custom ... ok
Dec 05 17:53:20.136 INFO [stdout] 
Dec 05 17:53:20.136 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 17:53:20.136 INFO [stdout] 
Dec 05 17:53:20.148 INFO [stderr] su: No module specific data is present
Dec 05 17:53:20.843 INFO running `"docker" "inspect" "13d101601cd8b247d04126aa3a426e8c262e165d206f41b033aa908ead58d24d"`
Dec 05 17:53:21.116 INFO running `"docker" "rm" "-f" "13d101601cd8b247d04126aa3a426e8c262e165d206f41b033aa908ead58d24d"`
Dec 05 17:53:21.506 INFO [stdout] 13d101601cd8b247d04126aa3a426e8c262e165d206f41b033aa908ead58d24d