Oct 12 03:12:55.933 INFO testing chttp-0.2.2 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling
Oct 12 03:12:55.934 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 03:12:56.414 INFO blam! 6c8c832a414c128fee60093a6c3560af9dd481dcdb26160f44c49d62bb089353
Oct 12 03:12:56.415 INFO running `"docker" "start" "-a" "6c8c832a414c128fee60093a6c3560af9dd481dcdb26160f44c49d62bb089353"`
Oct 12 03:12:57.701 INFO kablam! usermod: no changes
Oct 12 03:12:58.052 INFO kablam!    Compiling futures-core-preview v0.2.3
Oct 12 03:12:58.052 INFO kablam!    Compiling libnghttp2-sys v0.1.0
Oct 12 03:12:58.060 INFO kablam!    Compiling curl-sys v0.4.13
Oct 12 03:12:58.080 INFO kablam!    Compiling withers_derive v0.2.0
Oct 12 03:12:58.081 INFO kablam!    Compiling crossbeam-channel v0.2.6
Oct 12 03:13:00.232 INFO kablam!    Compiling futures-channel-preview v0.2.2
Oct 12 03:13:00.232 INFO kablam!    Compiling futures-io-preview v0.2.2
Oct 12 03:13:03.571 INFO kablam!    Compiling futures-sink-preview v0.2.2
Oct 12 03:13:04.341 INFO kablam!    Compiling futures-util-preview v0.2.2
Oct 12 03:13:11.497 INFO kablam!    Compiling futures-executor-preview v0.2.2
Oct 12 03:13:14.080 INFO kablam!    Compiling futures-stable-preview v0.2.3
Oct 12 03:13:14.367 INFO kablam!    Compiling futures-async-runtime-preview v0.2.3
Oct 12 03:13:14.532 INFO kablam!    Compiling futures-preview v0.2.2
Oct 12 03:13:22.370 INFO kablam!    Compiling curl v0.4.18
Oct 12 03:13:25.212 INFO kablam!    Compiling chttp v0.2.2 (/source)
Oct 12 03:13:28.659 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 30.94s
Oct 12 03:13:28.680 INFO kablam! su: No module specific data is present
Oct 12 03:13:29.532 INFO running `"docker" "rm" "-f" "6c8c832a414c128fee60093a6c3560af9dd481dcdb26160f44c49d62bb089353"`
Oct 12 03:13:29.668 INFO blam! 6c8c832a414c128fee60093a6c3560af9dd481dcdb26160f44c49d62bb089353
Oct 12 03:13:29.676 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 03:13:30.010 INFO blam! 0fd582d40d1f8329dda103dfdeed6d9bea739a0c7bbe3e57ec6510a8935aede8
Oct 12 03:13:30.012 INFO running `"docker" "start" "-a" "0fd582d40d1f8329dda103dfdeed6d9bea739a0c7bbe3e57ec6510a8935aede8"`
Oct 12 03:13:30.600 INFO kablam! usermod: no changes
Oct 12 03:13:30.856 INFO kablam!    Compiling ascii v0.8.7
Oct 12 03:13:30.856 INFO kablam!    Compiling chunked_transfer v0.3.1
Oct 12 03:13:30.859 INFO kablam!    Compiling brotli-sys v0.3.2
Oct 12 03:13:30.864 INFO kablam!    Compiling filetime v0.2.1
Oct 12 03:13:30.872 INFO kablam!    Compiling futures-io-preview v0.2.2
Oct 12 03:13:30.872 INFO kablam!    Compiling threadpool v1.7.1
Oct 12 03:13:30.872 INFO kablam!    Compiling buf_redux v0.6.3
Oct 12 03:13:30.872 INFO kablam!    Compiling nix v0.11.0
Oct 12 03:13:31.633 INFO kablam!    Compiling twoway v0.1.8
Oct 12 03:13:33.424 INFO kablam!    Compiling curl-sys v0.4.13
Oct 12 03:13:33.424 INFO kablam!    Compiling gzip-header v0.2.0
Oct 12 03:13:33.432 INFO kablam!    Compiling futures-util-preview v0.2.2
Oct 12 03:13:33.456 INFO kablam!    Compiling parking_lot_core v0.3.1
Oct 12 03:13:33.536 INFO kablam!    Compiling tiny_http v0.6.0
Oct 12 03:13:33.536 INFO kablam!    Compiling multipart v0.13.6
Oct 12 03:13:34.821 INFO kablam!    Compiling curl v0.4.18
Oct 12 03:13:34.873 INFO kablam!    Compiling deflate v0.7.19
Oct 12 03:13:43.552 INFO kablam!    Compiling parking_lot v0.6.4
Oct 12 03:13:43.764 INFO kablam!    Compiling futures-executor-preview v0.2.2
Oct 12 03:13:46.693 INFO kablam!    Compiling crossbeam-channel v0.2.6
Oct 12 03:13:46.740 INFO kablam!    Compiling futures-stable-preview v0.2.3
Oct 12 03:13:47.088 INFO kablam!    Compiling futures-async-runtime-preview v0.2.3
Oct 12 03:13:47.412 INFO kablam!    Compiling futures-preview v0.2.2
Oct 12 03:13:51.432 INFO kablam!    Compiling brotli2 v0.3.2
Oct 12 03:13:52.736 INFO kablam!    Compiling rouille v2.2.0
Oct 12 03:13:53.364 INFO kablam!    Compiling chttp v0.2.2 (/source)
Oct 12 03:14:14.096 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 43.48s
Oct 12 03:14:14.116 INFO kablam! su: No module specific data is present
Oct 12 03:14:14.996 INFO running `"docker" "rm" "-f" "0fd582d40d1f8329dda103dfdeed6d9bea739a0c7bbe3e57ec6510a8935aede8"`
Oct 12 03:14:15.220 INFO blam! 0fd582d40d1f8329dda103dfdeed6d9bea739a0c7bbe3e57ec6510a8935aede8
Oct 12 03:14:15.222 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 03:14:15.620 INFO blam! 853a1e8fa9dd132361f6164ec999bdeb3c70df335bd0277fbf7e55c92462f2c7
Oct 12 03:14:15.620 INFO running `"docker" "start" "-a" "853a1e8fa9dd132361f6164ec999bdeb3c70df335bd0277fbf7e55c92462f2c7"`
Oct 12 03:14:16.412 INFO kablam! usermod: no changes
Oct 12 03:14:16.692 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Oct 12 03:14:16.708 INFO kablam!      Running /target/debug/deps/chttp-a2f71f600787e380
Oct 12 03:14:16.712 INFO blam! 
Oct 12 03:14:16.712 INFO blam! running 0 tests
Oct 12 03:14:16.712 INFO blam! 
Oct 12 03:14:16.712 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 03:14:16.712 INFO blam! 
Oct 12 03:14:16.712 INFO kablam!      Running /target/debug/deps/redirects-9cac2bfc659b5c5c
Oct 12 03:14:16.720 INFO blam! 
Oct 12 03:14:16.720 INFO blam! running 3 tests
Oct 12 03:14:16.801 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::agent: agent ready
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: received message from agent handle: BeginRequest(CurlRequest(Easy { handle: 0x7fab0064e000, handler: 0x7fab0064e000 }))
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request:   Trying 127.0.0.1...
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 43617 (#0)
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /a HTTP/1.1\r\nHost: 127.0.0.1:43617\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: received message from agent handle: BeginRequest(CurlRequest(Easy { handle: 0x7fab00851000, handler: 0x7fab00851000 }))
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: received message from agent handle: BeginRequest(CurlRequest(Easy { handle: 0x7fab00aa4000, handler: 0x7fab00aa4000 }))
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [serially]
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Server doesn't support multi-use (yet)
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request:   Trying 127.0.0.1...
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 45595 (#1)
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /a HTTP/1.1\r\nHost: 127.0.0.1:45595\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [serially]
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Server doesn't support multi-use (yet)
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request:   Trying 127.0.0.1...
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 38641 (#2)
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /0 HTTP/1.1\r\nHost: 127.0.0.1:38641\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:16.820 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.828 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /b\r\n
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.840 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::request: preparing for redirect to Some("/b")
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #1 to host 127.0.0.1 left intact
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Issue another request to this URL: 'http://127.0.0.1:45595/b'
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [can pipeline]
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Could pipeline, but not asked to!
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Re-using existing connection! (#1) with host 127.0.0.1
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 45595 (#1)
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /b HTTP/1.1\r\nHost: 127.0.0.1:45595\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.840 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /b\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #0 to host 127.0.0.1 left intact
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /1\r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.880 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::request: preparing for redirect to Some("/1")
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #2 to host 127.0.0.1 left intact
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Issue another request to this URL: 'http://127.0.0.1:38641/1'
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [can pipeline]
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Could pipeline, but not asked to!
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Re-using existing connection! (#2) with host 127.0.0.1
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 38641 (#2)
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /1 HTTP/1.1\r\nHost: 127.0.0.1:38641\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.880 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::agent: request with token 0 completed
Oct 12 03:14:16.880 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.892 INFO blam! test response_301_no_follow ... ok
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /2\r\n
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.900 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::request: preparing for redirect to Some("/2")
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #2 to host 127.0.0.1 left intact
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Issue another request to this URL: 'http://127.0.0.1:38641/2'
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [can pipeline]
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Could pipeline, but not asked to!
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Re-using existing connection! (#2) with host 127.0.0.1
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 38641 (#2)
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /2 HTTP/1.1\r\nHost: 127.0.0.1:38641\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.900 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 200 OK\r\n
Oct 12 03:14:16.936 INFO blam! test response_301_auto_follow ... ok
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Type: text/plain; charset=utf8\r\n
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 2\r\n
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: received read request for 32 bytes
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: buffer is empty, read is pending
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << ok
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: received 2 bytes of data
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: received read request for 32 bytes
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: read buffer contains 2 bytes, consuming 2 bytes
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: received read request for 30 bytes
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: buffer is empty, read is pending
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #1 to host 127.0.0.1 left intact
Oct 12 03:14:16.936 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::agent: request with token 1 completed
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: received read request for 30 bytes
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: request is closed, satisfying read request with EOF
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:16.936 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: received message from agent handle: UnpauseWrite(1)
Oct 12 03:14:16.937 INFO kablam!  WARN 2018-10-12T03:14:16Z: chttp::internal::agent: received unpause request for unknown request token: 1
Oct 12 03:14:16.937 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: received message from agent handle: UnpauseWrite(1)
Oct 12 03:14:16.937 INFO kablam!  WARN 2018-10-12T03:14:16Z: chttp::internal::agent: received unpause request for unknown request token: 1
Oct 12 03:14:16.937 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /3\r\n
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.940 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::request: preparing for redirect to Some("/3")
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #2 to host 127.0.0.1 left intact
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Issue another request to this URL: 'http://127.0.0.1:38641/3'
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [can pipeline]
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Could pipeline, but not asked to!
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Re-using existing connection! (#2) with host 127.0.0.1
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 38641 (#2)
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /3 HTTP/1.1\r\nHost: 127.0.0.1:38641\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.940 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /4\r\n
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.951 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::request: preparing for redirect to Some("/4")
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #2 to host 127.0.0.1 left intact
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Issue another request to this URL: 'http://127.0.0.1:38641/4'
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [can pipeline]
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Could pipeline, but not asked to!
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Re-using existing connection! (#2) with host 127.0.0.1
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 38641 (#2)
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /4 HTTP/1.1\r\nHost: 127.0.0.1:38641\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.951 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /5\r\n
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.964 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::request: preparing for redirect to Some("/5")
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #2 to host 127.0.0.1 left intact
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Issue another request to this URL: 'http://127.0.0.1:38641/5'
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7faafe25d060 [can pipeline]
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Could pipeline, but not asked to!
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Re-using existing connection! (#2) with host 127.0.0.1
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 38641 (#2)
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: >> GET /5 HTTP/1.1\r\nHost: 127.0.0.1:38641\r\nAccept: */*\r\n\r\n
Oct 12 03:14:16.964 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << HTTP/1.1 301 Moved Permanently\r\n
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:16 GMT\r\n
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Location: /6\r\n
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << Content-Length: 0\r\n
Oct 12 03:14:16.972 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::request: preparing for redirect to Some("/6")
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: << \r\n
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Connection #2 to host 127.0.0.1 left intact
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::request: Maximum (5) redirects followed
Oct 12 03:14:16.972 INFO kablam! DEBUG 2018-10-12T03:14:16Z: chttp::internal::agent: curl error: [47] Number of redirects hit maximum amount
Oct 12 03:14:16.972 INFO kablam! TRACE 2018-10-12T03:14:16Z: chttp::internal::agent: polling with timeout of 100ms
Oct 12 03:14:17.000 INFO blam! test redirect_limit_is_respected ... ok
Oct 12 03:14:17.000 INFO blam! 
Oct 12 03:14:17.000 INFO blam! test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 03:14:17.000 INFO blam! 
Oct 12 03:14:17.004 INFO kablam!      Running /target/debug/deps/response-63ad3e9177b68da9
Oct 12 03:14:17.015 INFO blam! 
Oct 12 03:14:17.015 INFO blam! running 2 tests
Oct 12 03:14:17.036 INFO kablam! DEBUG 2018-10-12T03:14:17Z: chttp::internal::agent: agent ready
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: received message from agent handle: BeginRequest(CurlRequest(Easy { handle: 0x7fe4f88a4000, handler: 0x7fe4f88a4000 }))
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request:   Trying 127.0.0.1...
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 34863 (#0)
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: >> GET / HTTP/1.1\r\nHost: 127.0.0.1:34863\r\nAccept: */*\r\n\r\n
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: received message from agent handle: BeginRequest(CurlRequest(Easy { handle: 0x7fe4f584e000, handler: 0x7fe4f584e000 }))
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: Found bundle for host 127.0.0.1: 0x7fe4f706c030 [serially]
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: Server doesn't support multi-use (yet)
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request:   Trying 127.0.0.1...
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 36023 (#1)
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: >> GET / HTTP/1.1\r\nHost: 127.0.0.1:36023\r\nAccept: */*\r\n\r\n
Oct 12 03:14:17.036 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.092 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << HTTP/1.1 200 OK\r\n
Oct 12 03:14:17.092 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:17 GMT\r\n
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Content-Type: text/plain; charset=utf8\r\n
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Content-Length: 13000\r\n
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 32 bytes
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: buffer is empty, read is pending
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << \r\n
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: received message from agent handle: UnpauseWrite(0)
Oct 12 03:14:17.093 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.095 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wo
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received 8192 bytes of data
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 32 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 8192 bytes, consuming 32 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 32 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 8160 bytes, consuming 32 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 64 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 8128 bytes, consuming 64 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 128 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 8064 bytes, consuming 128 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 256 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 7936 bytes, consuming 256 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 512 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 7680 bytes, consuming 512 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 1024 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 7168 bytes, consuming 1024 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 2048 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 6144 bytes, consuming 2048 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 4096 bytes
Oct 12 03:14:17.102 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 4096 bytes, consuming 4096 bytes
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 8192 bytes
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: buffer is empty, read is pending
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: received message from agent handle: UnpauseWrite(0)
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << w so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large wow so large 
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received 4808 bytes of data
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 8192 bytes
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 4808 bytes, consuming 4808 bytes
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 3384 bytes
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: buffer is empty, read is pending
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: Connection #0 to host 127.0.0.1 left intact
Oct 12 03:14:17.103 INFO kablam! DEBUG 2018-10-12T03:14:17Z: chttp::internal::agent: request with token 0 completed
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 3384 bytes
Oct 12 03:14:17.103 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: request is closed, satisfying read request with EOF
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.108 INFO blam! test large_response_body ... ok
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: received message from agent handle: UnpauseWrite(0)
Oct 12 03:14:17.108 INFO kablam!  WARN 2018-10-12T03:14:17Z: chttp::internal::agent: received unpause request for unknown request token: 0
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << HTTP/1.1 200 OK\r\n
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Server: tiny-http (Rust)\r\n
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Date: Fri, 12 Oct 2018 03:14:17 GMT\r\n
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Content-Type: text/plain; charset=utf8\r\n
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << Content-Length: 11\r\n
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << \r\n
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: << hello world
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received 11 bytes of data
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: Connection #1 to host 127.0.0.1 left intact
Oct 12 03:14:17.108 INFO blam! test simple_response_body ... ok
Oct 12 03:14:17.108 INFO kablam! DEBUG 2018-10-12T03:14:17Z: chttp::internal::agent: request with token 1 completed
Oct 12 03:14:17.108 INFO blam! 
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 100ms
Oct 12 03:14:17.108 INFO blam! test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 32 bytes
Oct 12 03:14:17.108 INFO blam! 
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: read buffer contains 11 bytes, consuming 11 bytes
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: received read request for 21 bytes
Oct 12 03:14:17.108 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: request is closed, satisfying read request with EOF
Oct 12 03:14:17.124 INFO kablam!      Running /target/debug/deps/timeouts-2419493d521c9304
Oct 12 03:14:17.127 INFO blam! 
Oct 12 03:14:17.127 INFO blam! running 1 test
Oct 12 03:14:17.172 INFO kablam! DEBUG 2018-10-12T03:14:17Z: chttp::internal::agent: agent ready
Oct 12 03:14:17.172 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: received message from agent handle: BeginRequest(CurlRequest(Easy { handle: 0x7f924c2a4000, handler: 0x7f924c2a4000 }))
Oct 12 03:14:17.172 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request:   Trying 127.0.0.1...
Oct 12 03:14:17.172 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: Connected to 127.0.0.1 (127.0.0.1) port 33063 (#0)
Oct 12 03:14:17.172 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::request: >> POST / HTTP/1.1\r\nHost: 127.0.0.1:33063\r\nAccept: */*\r\nContent-Length: 11\r\nExpect: 100-continue\r\n\r\n
Oct 12 03:14:17.172 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.172 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: woke up from notify fd
Oct 12 03:14:17.172 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.372 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.575 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.769 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:17.969 INFO kablam! TRACE 2018-10-12T03:14:17Z: chttp::internal::agent: polling with timeout of 200ms
Oct 12 03:14:18.170 INFO kablam! TRACE 2018-10-12T03:14:18Z: chttp::internal::request: Done waiting for 100-continue
Oct 12 03:14:18.170 INFO kablam! TRACE 2018-10-12T03:14:18Z: chttp::internal::agent: polling with timeout of 1s
Oct 12 03:14:18.170 INFO kablam! TRACE 2018-10-12T03:14:18Z: chttp::internal::request: >> hello world
Oct 12 03:14:18.170 INFO kablam! TRACE 2018-10-12T03:14:18Z: chttp::internal::request: We are completely uploaded and fine
Oct 12 03:14:18.170 INFO kablam! TRACE 2018-10-12T03:14:18Z: chttp::internal::agent: polling with timeout of 1s
Oct 12 03:14:19.180 INFO kablam! TRACE 2018-10-12T03:14:19Z: chttp::internal::request: Operation timed out after 2000 milliseconds with 0 bytes received
Oct 12 03:14:19.180 INFO blam! test request_errors_if_read_timeout_is_reached ... ok
Oct 12 03:14:19.180 INFO kablam! TRACE 2018-10-12T03:14:19Z: chttp::internal::request: Closing connection 0
Oct 12 03:14:19.180 INFO blam! 
Oct 12 03:14:19.180 INFO kablam! DEBUG 2018-10-12T03:14:19Z: chttp::internal::agent: curl error: [28] Timeout was reached
Oct 12 03:14:19.180 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 03:14:19.180 INFO kablam! TRACE 2018-10-12T03:14:19Z: chttp::internal::agent: polling with timeout of 100ms
Oct 12 03:14:19.180 INFO blam! 
Oct 12 03:14:19.180 INFO kablam!    Doc-tests chttp
Oct 12 03:14:20.056 INFO blam! 
Oct 12 03:14:20.056 INFO blam! running 6 tests
Oct 12 03:14:25.660 INFO blam! test src/client.rs - client::ClientBuilder (line 17) ... ok
Oct 12 03:14:26.345 INFO blam! test src/lib.rs -  (line 74) ... ok
Oct 12 03:14:26.702 INFO blam! test src/lib.rs -  (line 11) ... ok
Oct 12 03:14:26.730 INFO blam! test src/lib.rs -  (line 37) ... ok
Oct 12 03:14:26.763 INFO blam! test src/lib.rs -  (line 53) ... ok
Oct 12 03:14:26.763 INFO blam! test src/lib.rs -  (line 26) ... ok
Oct 12 03:14:26.763 INFO blam! 
Oct 12 03:14:26.763 INFO blam! test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 03:14:26.763 INFO blam! 
Oct 12 03:14:26.795 INFO kablam! su: No module specific data is present
Oct 12 03:14:27.510 INFO running `"docker" "rm" "-f" "853a1e8fa9dd132361f6164ec999bdeb3c70df335bd0277fbf7e55c92462f2c7"`
Oct 12 03:14:27.840 INFO blam! 853a1e8fa9dd132361f6164ec999bdeb3c70df335bd0277fbf7e55c92462f2c7