Dec 05 17:50:48.250 INFO testing kevinastone/httpbox against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514 Dec 05 17:50:48.250 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 05 17:50:48.726 INFO [stdout] 37873ec8ea98282adeb28039d9c13b3d38cae2f5980772152345c555ac8c8cff Dec 05 17:50:48.728 INFO running `"docker" "start" "-a" "37873ec8ea98282adeb28039d9c13b3d38cae2f5980772152345c555ac8c8cff"` Dec 05 17:50:50.979 INFO [stderr] usermod: no changes Dec 05 17:50:51.341 INFO [stderr] Compiling term_size v0.2.3 Dec 05 17:50:51.351 INFO [stderr] Compiling futures-timer v0.1.1 Dec 05 17:50:51.365 INFO [stderr] Compiling rand v0.5.4 Dec 05 17:50:51.377 INFO [stderr] Compiling tempdir v0.3.7 Dec 05 17:50:51.393 INFO [stderr] Compiling cookie v0.10.1 Dec 05 17:50:51.409 INFO [stderr] Compiling bincode v1.0.1 Dec 05 17:50:51.412 INFO [stderr] Compiling tokio-reactor v0.1.2 Dec 05 17:50:51.413 INFO [stderr] Compiling serde_derive v1.0.70 Dec 05 17:50:53.366 INFO [stderr] Compiling regex v0.2.11 Dec 05 17:50:55.117 INFO [stderr] Compiling error-chain v0.11.0 Dec 05 17:51:00.602 INFO [stderr] Compiling clap v2.16.4 Dec 05 17:51:00.603 INFO [stderr] Compiling tokio-threadpool v0.1.5 Dec 05 17:51:00.637 INFO [stderr] Compiling tokio-tcp v0.1.0 Dec 05 17:51:00.640 INFO [stderr] Compiling tokio-udp v0.1.1 Dec 05 17:51:20.177 INFO [stderr] Compiling tokio-fs v0.1.2 Dec 05 17:51:22.983 INFO [stderr] Compiling tokio v0.1.7 Dec 05 17:51:38.804 INFO [stderr] Compiling tokio-core v0.1.17 Dec 05 17:51:39.094 INFO [stderr] Compiling cargo_metadata v0.5.8 Dec 05 17:51:43.504 INFO [stderr] Compiling tokio-proto v0.1.1 Dec 05 17:51:45.468 INFO [stderr] Compiling skeptic v0.13.3 Dec 05 17:51:48.795 INFO [stderr] Compiling hyper v0.11.27 Dec 05 17:51:52.052 INFO [stderr] Compiling borrow-bag v1.0.0 Dec 05 17:52:02.351 INFO [stderr] Compiling gotham v0.2.1 Dec 05 17:52:10.576 INFO [stderr] Compiling httpbox v0.2.0 (/source) Dec 05 17:52:22.637 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 31s Dec 05 17:52:22.655 INFO [stderr] su: No module specific data is present Dec 05 17:52:23.331 INFO running `"docker" "inspect" "37873ec8ea98282adeb28039d9c13b3d38cae2f5980772152345c555ac8c8cff"` Dec 05 17:52:23.584 INFO running `"docker" "rm" "-f" "37873ec8ea98282adeb28039d9c13b3d38cae2f5980772152345c555ac8c8cff"` Dec 05 17:52:23.992 INFO [stdout] 37873ec8ea98282adeb28039d9c13b3d38cae2f5980772152345c555ac8c8cff Dec 05 17:52:24.000 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 05 17:52:24.425 INFO [stdout] aa1970bcc72bc0c1e1b3c4ead9583846a13416419e8266b71a41e274af0321cf Dec 05 17:52:24.427 INFO running `"docker" "start" "-a" "aa1970bcc72bc0c1e1b3c4ead9583846a13416419e8266b71a41e274af0321cf"` Dec 05 17:52:26.112 INFO [stderr] usermod: no changes Dec 05 17:52:26.343 INFO [stderr] Compiling httpbox v0.2.0 (/source) Dec 05 17:52:38.052 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 11.92s Dec 05 17:52:38.071 INFO [stderr] su: No module specific data is present Dec 05 17:52:38.702 INFO running `"docker" "inspect" "aa1970bcc72bc0c1e1b3c4ead9583846a13416419e8266b71a41e274af0321cf"` Dec 05 17:52:38.952 INFO running `"docker" "rm" "-f" "aa1970bcc72bc0c1e1b3c4ead9583846a13416419e8266b71a41e274af0321cf"` Dec 05 17:52:39.167 INFO [stdout] aa1970bcc72bc0c1e1b3c4ead9583846a13416419e8266b71a41e274af0321cf Dec 05 17:52:39.174 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 05 17:52:39.640 INFO [stdout] 3f34ed4ab1a968a53d42d109b2350ff0f3ff6f55fd10c8926b95b0156f61b79f Dec 05 17:52:39.642 INFO running `"docker" "start" "-a" "3f34ed4ab1a968a53d42d109b2350ff0f3ff6f55fd10c8926b95b0156f61b79f"` Dec 05 17:52:41.103 INFO [stderr] usermod: no changes Dec 05 17:52:41.380 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.25s Dec 05 17:52:41.399 INFO [stderr] Running /target/debug/deps/httpbox-0978e8f4cba76dc4 Dec 05 17:52:41.402 INFO [stdout] Dec 05 17:52:41.402 INFO [stdout] running 52 tests Dec 05 17:52:41.403 INFO [stdout] test app::auth::header::test::test_format_basic_realm ... ok Dec 05 17:52:41.404 INFO [stdout] test app::auth::header::test::test_parse_err_basic_realm ... ok Dec 05 17:52:41.404 INFO [stdout] test app::auth::header::test::test_parse_basic_realm ... ok Dec 05 17:52:41.412 INFO [stdout] test app::auth::header::test::test_parse_err_www_authenticate ... ok Dec 05 17:52:41.416 INFO [stdout] test app::auth::header::test::test_parse_www_authenticate ... ok Dec 05 17:52:41.485 INFO [stdout] test app::bytes::test::test_stream_bytes ... ok Dec 05 17:52:41.485 INFO [stdout] test app::auth::test::test_bearer_unauthorized ... ok Dec 05 17:52:41.488 INFO [stdout] test app::auth::test::test_bearer_authorized ... ok Dec 05 17:52:41.496 INFO [stdout] test app::auth::test::test_bearer_no_authorization ... ok Dec 05 17:52:41.497 INFO [stdout] test app::auth::test::test_basic_no_authorization ... ok Dec 05 17:52:41.498 INFO [stdout] test app::auth::test::test_basic_unauthorized ... ok Dec 05 17:52:41.524 INFO [stdout] test app::auth::test::test_basic_authorized ... ok Dec 05 17:52:41.524 INFO [stdout] test app::bytes::test::test_bytes ... ok Dec 05 17:52:41.540 INFO [stdout] test app::bytes::test::test_stream_bytes_with_chunk_size ... ok Dec 05 17:52:41.552 INFO [stdout] test app::cache::test::test_cache_if_none_match ... ok Dec 05 17:52:41.564 INFO [stdout] test app::cookies::test::test_cookies ... ok Dec 05 17:52:41.584 INFO [stdout] test app::cache::test::test_cache_if_modified_since ... ok Dec 05 17:52:41.592 INFO [stdout] test app::cache::test::test_cache_no_headers ... ok Dec 05 17:52:41.593 INFO [stdout] test app::delay::test::test_sleep ... ok Dec 05 17:52:41.594 INFO [stdout] test app::cookies::test::test_no_cookies ... ok Dec 05 17:52:41.595 INFO [stdout] test app::cookies::test::test_set_cookies ... ok Dec 05 17:52:41.661 INFO [stdout] test app::cache::test::test_set_cache ... ok Dec 05 17:52:41.690 INFO [stdout] test app::headers::test::test_headers ... ok Dec 05 17:52:41.690 INFO [stdout] test app::delay::test::test_sleep_too_long ... ok Dec 05 17:52:41.690 INFO [stdout] test app::headers::test::test_response_headers ... ok Dec 05 17:52:41.693 INFO [stdout] test app::ip::test::test_ip_from_header ... ok Dec 05 17:52:41.700 INFO [stdout] test app::ip::test::test_ip ... ok Dec 05 17:52:41.713 INFO [stdout] test app::method::test::test_get ... ok Dec 05 17:52:41.728 INFO [stdout] test app::method::test::test_multi_get ... ok Dec 05 17:52:41.729 INFO [stdout] test app::method::test::test_delete ... ok Dec 05 17:52:41.740 INFO [stdout] test app::random::tests::rng_seed_consistent ... ok Dec 05 17:52:41.741 INFO [stdout] test app::method::test::test_post ... ok Dec 05 17:52:41.741 INFO [stdout] test app::random::tests::rng_no_seed ... ok Dec 05 17:52:41.742 INFO [stdout] test app::method::test::test_patch ... ok Dec 05 17:52:41.752 INFO [stdout] test app::method::test::test_multi_patch ... ok Dec 05 17:52:41.753 INFO [stdout] test app::method::test::test_multi_post ... ok Dec 05 17:52:41.780 INFO [stdout] test app::method::test::test_multi_put ... ok Dec 05 17:52:41.781 INFO [stdout] test app::method::test::test_put ... ok Dec 05 17:52:41.788 INFO [stdout] test app::redirect::uri::test::test_absolute_uri ... ok Dec 05 17:52:41.789 INFO [stdout] test app::redirect::test::test_absolute_redirect_last ... ok Dec 05 17:52:41.808 INFO [stdout] test app::redirect::uri::test::test_join_url ... ok Dec 05 17:52:41.809 INFO [stdout] test app::redirect::test::test_redirect ... ok Dec 05 17:52:41.809 INFO [stdout] test app::redirect::test::test_absolute_redirect ... ok Dec 05 17:52:41.809 INFO [stdout] test app::redirect::uri::test::test_absolute_uri_with_port ... ok Dec 05 17:52:41.809 INFO [stdout] test app::redirect::test::test_relative_redirect ... ok Dec 05 17:52:41.832 INFO [stdout] test app::redirect::test::test_relative_redirect_last ... ok Dec 05 17:52:41.835 INFO [stdout] test app::redirect::test::test_redirect_last ... ok Dec 05 17:52:41.836 INFO [stdout] test app::redirect::test::test_redirect_to ... ok Dec 05 17:52:41.856 INFO [stdout] test app::user_agent::test::test_user_agent ... ok Dec 05 17:52:41.857 INFO [stdout] test app::user_agent::test::test_user_agent_custom ... ok Dec 05 17:52:41.857 INFO [stdout] test app::status_code::test::test_bad_status_code ... ok Dec 05 17:52:41.857 INFO [stdout] test app::status_code::test::test_status_code ... ok Dec 05 17:52:41.857 INFO [stdout] Dec 05 17:52:41.858 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 05 17:52:41.858 INFO [stdout] Dec 05 17:52:41.862 INFO [stderr] su: No module specific data is present Dec 05 17:52:42.652 INFO running `"docker" "inspect" "3f34ed4ab1a968a53d42d109b2350ff0f3ff6f55fd10c8926b95b0156f61b79f"` Dec 05 17:52:42.918 INFO running `"docker" "rm" "-f" "3f34ed4ab1a968a53d42d109b2350ff0f3ff6f55fd10c8926b95b0156f61b79f"` Dec 05 17:52:43.184 INFO [stdout] 3f34ed4ab1a968a53d42d109b2350ff0f3ff6f55fd10c8926b95b0156f61b79f