Dec 13 04:11:44.716 INFO testing scottlamb/http-serve against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 04:11:44.716 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 04:11:45.127 INFO [stdout] f15512078ee405b7e8e0c40be4cfb72d7de047878e00b9bee8a0ebc3cdc6c4c1
Dec 13 04:11:45.135 INFO running `"docker" "start" "-a" "f15512078ee405b7e8e0c40be4cfb72d7de047878e00b9bee8a0ebc3cdc6c4c1"`
Dec 13 04:11:45.923 INFO [stderr] usermod: no changes
Dec 13 04:11:46.260 INFO [stderr]    Compiling mio v0.6.16
Dec 13 04:11:46.263 INFO [stderr]    Compiling tokio-io v0.1.10
Dec 13 04:11:46.263 INFO [stderr]    Compiling tokio-threadpool v0.1.8
Dec 13 04:11:48.795 INFO [stderr]    Compiling tokio-codec v0.1.1
Dec 13 04:11:48.795 INFO [stderr]    Compiling h2 v0.1.13
Dec 13 04:11:50.499 INFO [stderr]    Compiling mio-uds v0.6.7
Dec 13 04:11:50.499 INFO [stderr]    Compiling tokio-reactor v0.1.6
Dec 13 04:11:52.633 INFO [stderr]    Compiling tokio-fs v0.1.4
Dec 13 04:11:56.271 INFO [stderr]    Compiling tokio-udp v0.1.2
Dec 13 04:11:56.272 INFO [stderr]    Compiling tokio-tcp v0.1.2
Dec 13 04:11:56.272 INFO [stderr]    Compiling tokio-uds v0.2.3
Dec 13 04:11:59.375 INFO [stderr]    Compiling tokio v0.1.11
Dec 13 04:12:07.067 INFO [stderr]    Compiling hyper v0.12.13
Dec 13 04:12:14.883 INFO [stderr]    Compiling http-serve v0.1.2 (/source)
Dec 13 04:12:16.999 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 31.04s
Dec 13 04:12:17.025 INFO [stderr] su: No module specific data is present
Dec 13 04:12:17.867 INFO running `"docker" "inspect" "f15512078ee405b7e8e0c40be4cfb72d7de047878e00b9bee8a0ebc3cdc6c4c1"`
Dec 13 04:12:18.184 INFO running `"docker" "rm" "-f" "f15512078ee405b7e8e0c40be4cfb72d7de047878e00b9bee8a0ebc3cdc6c4c1"`
Dec 13 04:12:18.561 INFO [stdout] f15512078ee405b7e8e0c40be4cfb72d7de047878e00b9bee8a0ebc3cdc6c4c1
Dec 13 04:12:18.567 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 04:12:18.994 INFO [stdout] 244d5eda13321e372a9d6751ea400d6340d8403b878e5a0d8f11ef3df63da987
Dec 13 04:12:19.003 INFO running `"docker" "start" "-a" "244d5eda13321e372a9d6751ea400d6340d8403b878e5a0d8f11ef3df63da987"`
Dec 13 04:12:20.366 INFO [stderr] usermod: no changes
Dec 13 04:12:20.823 INFO [stderr]    Compiling cast v0.2.2
Dec 13 04:12:20.823 INFO [stderr]    Compiling thread-scoped v1.0.2
Dec 13 04:12:20.851 INFO [stderr]    Compiling regex-syntax v0.6.2
Dec 13 04:12:20.853 INFO [stderr]    Compiling itertools-num v0.1.2
Dec 13 04:12:20.875 INFO [stderr]    Compiling syn v0.15.16
Dec 13 04:12:20.876 INFO [stderr]    Compiling openssl v0.10.15
Dec 13 04:12:20.883 INFO [stderr]    Compiling simplelog v0.5.3
Dec 13 04:12:22.923 INFO [stderr]    Compiling criterion-plot v0.2.5
Dec 13 04:12:22.923 INFO [stderr]    Compiling criterion-stats v0.2.5
Dec 13 04:12:38.185 INFO [stderr]    Compiling native-tls v0.2.2
Dec 13 04:12:42.267 INFO [stderr]    Compiling hyper-tls v0.3.1
Dec 13 04:12:46.571 INFO [stderr]    Compiling regex v1.0.5
Dec 13 04:12:49.263 INFO [stderr]    Compiling reqwest v0.9.4
Dec 13 04:12:53.450 INFO [stderr]    Compiling synstructure v0.10.1
Dec 13 04:12:53.450 INFO [stderr]    Compiling serde_derive v1.0.80
Dec 13 04:13:11.620 INFO [stderr]    Compiling failure_derive v0.1.3
Dec 13 04:13:19.788 INFO [stderr]    Compiling handlebars v0.32.4
Dec 13 04:13:21.815 INFO [stderr]    Compiling env_logger v0.5.13
Dec 13 04:13:21.867 INFO [stderr]    Compiling failure v0.1.3
Dec 13 04:13:35.247 INFO [stderr]    Compiling criterion v0.2.5
Dec 13 04:13:43.033 INFO [stderr]    Compiling http-serve v0.1.2 (/source)
Dec 13 04:14:03.120 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 42s
Dec 13 04:14:03.140 INFO [stderr] su: No module specific data is present
Dec 13 04:14:03.409 INFO running `"docker" "inspect" "244d5eda13321e372a9d6751ea400d6340d8403b878e5a0d8f11ef3df63da987"`
Dec 13 04:14:03.487 INFO running `"docker" "rm" "-f" "244d5eda13321e372a9d6751ea400d6340d8403b878e5a0d8f11ef3df63da987"`
Dec 13 04:14:03.603 INFO [stdout] 244d5eda13321e372a9d6751ea400d6340d8403b878e5a0d8f11ef3df63da987
Dec 13 04:14:03.605 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 13 04:14:03.819 INFO [stdout] 71480b44d7fe11b1d83ba41974bd2f8621a0d1ab24cb9e736f0ce0f93f856da9
Dec 13 04:14:03.821 INFO running `"docker" "start" "-a" "71480b44d7fe11b1d83ba41974bd2f8621a0d1ab24cb9e736f0ce0f93f856da9"`
Dec 13 04:14:04.268 INFO [stderr] usermod: no changes
Dec 13 04:14:04.550 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.26s
Dec 13 04:14:04.562 INFO [stderr]      Running /target/debug/deps/http_serve-6996d572986467da
Dec 13 04:14:04.565 INFO [stdout] 
Dec 13 04:14:04.565 INFO [stdout] running 19 tests
Dec 13 04:14:04.565 INFO [stdout] test chunker::tests::chunk_double_write ... ok
Dec 13 04:14:04.565 INFO [stdout] test chunker::tests::abort ... ok
Dec 13 04:14:04.566 INFO [stdout] test chunker::tests::small_flush ... ok
Dec 13 04:14:04.566 INFO [stdout] test chunker::tests::chunk_write ... ok
Dec 13 04:14:04.566 INFO [stdout] test chunker::tests::large_write ... ok
Dec 13 04:14:04.566 INFO [stdout] test etag::tests::comma_in_etag ... ok
Dec 13 04:14:04.566 INFO [stdout] test etag::tests::corrupt_list ... ok
Dec 13 04:14:04.566 INFO [stdout] test chunker::tests::small_large_write ... ok
Dec 13 04:14:04.566 INFO [stdout] test etag::tests::empty_list ... ok
Dec 13 04:14:04.567 INFO [stdout] test etag::tests::strong_eq ... ok
Dec 13 04:14:04.567 INFO [stdout] test etag::tests::nonempty_list ... ok
Dec 13 04:14:04.567 INFO [stdout] test chunker::tests::small_no_flush ... ok
Dec 13 04:14:04.567 INFO [stdout] test range::tests::test_resolve_ranges_rfc ... ok
Dec 13 04:14:04.567 INFO [stdout] test range::tests::test_resolve_ranges_absent_or_invalid ... ok
Dec 13 04:14:04.567 INFO [stdout] test etag::tests::weak_eq ... ok
Dec 13 04:14:04.567 INFO [stdout] test range::tests::test_resolve_ranges_satisfiability ... ok
Dec 13 04:14:04.567 INFO [stdout] test tests::should_gzip ... ok
Dec 13 04:14:04.567 INFO [stdout] test file::tests::without_pool ... ok
Dec 13 04:14:04.567 INFO [stdout] test file::tests::with_pool ... ok
Dec 13 04:14:04.567 INFO [stdout] 
Dec 13 04:14:04.567 INFO [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 04:14:04.567 INFO [stdout] 
Dec 13 04:14:04.569 INFO [stderr]      Running /target/debug/deps/chunked_acceptance-2fced3d5ac91e97b
Dec 13 04:14:04.571 INFO [stdout] 
Dec 13 04:14:04.571 INFO [stdout] running 5 tests
Dec 13 04:14:04.638 INFO [stdout] test no_gzip_abort ... ok
Dec 13 04:14:04.643 INFO [stdout] test auto_gzip ... ok
Dec 13 04:14:04.643 INFO [stdout] test manual_gzip ... ok
Dec 13 04:14:04.646 INFO [stdout] test no_gzip ... ok
Dec 13 04:14:04.647 INFO [stdout] test auto_gzip_abort ... ok
Dec 13 04:14:04.647 INFO [stdout] 
Dec 13 04:14:04.647 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 04:14:04.647 INFO [stdout] 
Dec 13 04:14:04.649 INFO [stderr]      Running /target/debug/deps/entity_acceptance-5fa79439a8a3eac1
Dec 13 04:14:04.654 INFO [stdout] 
Dec 13 04:14:04.654 INFO [stdout] running 3 tests
Dec 13 04:14:04.708 INFO [stdout] test serve_with_weak_etag ... ok
Dec 13 04:14:04.712 INFO [stdout] test serve_with_strong_etag ... ok
Dec 13 04:14:04.724 INFO [stdout] test serve_without_etag ... ok
Dec 13 04:14:04.724 INFO [stdout] 
Dec 13 04:14:04.724 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 04:14:04.724 INFO [stdout] 
Dec 13 04:14:04.726 INFO [stderr]    Doc-tests http-serve
Dec 13 04:14:06.050 INFO [stdout] 
Dec 13 04:14:06.050 INFO [stdout] running 0 tests
Dec 13 04:14:06.050 INFO [stdout] 
Dec 13 04:14:06.050 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 04:14:06.050 INFO [stdout] 
Dec 13 04:14:06.061 INFO [stderr] su: No module specific data is present
Dec 13 04:14:06.320 INFO running `"docker" "inspect" "71480b44d7fe11b1d83ba41974bd2f8621a0d1ab24cb9e736f0ce0f93f856da9"`
Dec 13 04:14:06.400 INFO running `"docker" "rm" "-f" "71480b44d7fe11b1d83ba41974bd2f8621a0d1ab24cb9e736f0ce0f93f856da9"`
Dec 13 04:14:06.493 INFO [stdout] 71480b44d7fe11b1d83ba41974bd2f8621a0d1ab24cb9e736f0ce0f93f856da9