Class groovyx.net.http.ApacheHttpBuilderSpec

6

tests

0

failures

0

ignored

5.235s

duration

100%

successful

Tests

Test Duration Result
FromServer hasBody should return false when there is no content 0.124s passed
FromServer hasBody should return true when there is content 0.115s passed
Sending/Receiving JSON Data (POST) 0.413s passed
access to client implementation 0.113s passed
client customization 0.164s passed
client-specific configuration 4.306s passed

Standard output

06:24:07.652 [Test worker] DEBUG ersatz.jboss.logging - Logging Provider: ersatz.jboss.logging.Slf4jLoggerProvider
06:24:07.682 [Test worker] DEBUG ersatz.undertow - starting undertow server ersatz.undertow.Undertow@9d83e08
06:24:07.705 [Test worker] INFO ersatz.xnio - XNIO version 3.3.8.Final
06:24:07.767 [Test worker] INFO ersatz.xnio.nio - XNIO NIO Implementation Version 3.3.8.Final
06:24:07.942 [XNIO-1 I/O-1] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-1', selector sun.nio.ch.EPollSelectorImpl@5427f349
06:24:07.970 [XNIO-1 I/O-8] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-8', selector sun.nio.ch.EPollSelectorImpl@18bf2c41
06:24:07.978 [XNIO-1 Accept] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 Accept', selector sun.nio.ch.EPollSelectorImpl@38ccd640
06:24:07.952 [XNIO-1 I/O-7] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-7', selector sun.nio.ch.EPollSelectorImpl@254e452b
06:24:07.982 [Test worker] DEBUG ersatz.undertow - Configuring listener with protocol HTTP for interface localhost and port 0
06:24:07.946 [XNIO-1 I/O-3] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-3', selector sun.nio.ch.EPollSelectorImpl@5dfae79a
06:24:07.950 [XNIO-1 I/O-5] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-5', selector sun.nio.ch.EPollSelectorImpl@51f8443d
06:24:07.943 [XNIO-1 I/O-2] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-2', selector sun.nio.ch.EPollSelectorImpl@75d3e57e
06:24:07.946 [XNIO-1 I/O-4] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-4', selector sun.nio.ch.EPollSelectorImpl@41397748
06:24:07.951 [XNIO-1 I/O-6] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-1 I/O-6', selector sun.nio.ch.EPollSelectorImpl@128f6558
06:24:09.465 [Test worker] DEBUG org.apache.http.client.protocol.RequestAddCookies - CookieSpec selected: default
06:24:09.495 [Test worker] DEBUG org.apache.http.client.protocol.RequestAuthCache - Auth cache not set in the context
06:24:09.497 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Get connection for route {}->http://localhost:33689
06:24:09.527 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Opening connection {}->http://localhost:33689
06:24:09.531 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connecting to localhost/127.0.0.1:33689
06:24:09.563 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connection established 127.0.0.1:56138<->127.0.0.1:33689
06:24:09.563 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Executing request GET /foo HTTP/1.1
06:24:09.564 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Target auth state: UNCHALLENGED
06:24:09.565 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Proxy auth state: UNCHALLENGED
06:24:09.570 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 >> GET /foo HTTP/1.1
06:24:09.571 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 >> Host: localhost:33689
06:24:09.571 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 >> Connection: Keep-Alive
06:24:09.571 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 >> User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)
06:24:09.571 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 >> Accept-Encoding: gzip,deflate
06:24:09.572 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 >> "GET /foo HTTP/1.1[\r][\n]"
06:24:09.572 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 >> "Host: localhost:33689[\r][\n]"
06:24:09.572 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 >> "Connection: Keep-Alive[\r][\n]"
06:24:09.572 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 >> "User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)[\r][\n]"
06:24:09.572 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 >> "Accept-Encoding: gzip,deflate[\r][\n]"
06:24:09.573 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 >> "[\r][\n]"
06:24:09.790 [XNIO-1 task-1] DEBUG com.stehno.ersatz.ErsatzServer - Request: { GET /foo (query=[:], headers={Connection=[Keep-Alive], Accept-Encoding=[gzip,deflate], User-Agent=[Apache-HttpClient/4.5.2 (Java/1.8.0_131)], Host=[localhost:33689]}, cookies=[:]): <empty> }
06:24:10.026 [XNIO-1 task-1] DEBUG com.stehno.ersatz.ErsatzServer - Response({Content-Type=[text/plain]}): ok
06:24:10.125 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "HTTP/1.1 200 OK[\r][\n]"
06:24:10.126 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "Content-Encoding: gzip[\r][\n]"
06:24:10.127 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "Connection: keep-alive[\r][\n]"
06:24:10.127 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "Content-Type: text/plain[\r][\n]"
06:24:10.127 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "Content-Length: 22[\r][\n]"
06:24:10.127 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "Date: Mon, 20 Nov 2017 12:24:10 GMT[\r][\n]"
06:24:10.127 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "[\r][\n]"
06:24:10.127 [Test worker] DEBUG org.apache.http.wire - http-outgoing-0 << "[0x1f][0x8b][0x8][0x0][0x0][0x0][0x0][0x0][0x0][0x0][0xcb][0xcf][0x6][0x0]G[0xdd][0xdc]y[0x2][0x0][0x0][0x0]"
06:24:10.135 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 << HTTP/1.1 200 OK
06:24:10.136 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 << Content-Encoding: gzip
06:24:10.136 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 << Connection: keep-alive
06:24:10.137 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 << Content-Type: text/plain
06:24:10.137 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 << Content-Length: 22
06:24:10.137 [Test worker] DEBUG org.apache.http.headers - http-outgoing-0 << Date: Mon, 20 Nov 2017 12:24:10 GMT
06:24:10.159 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Connection can be kept alive indefinitely
06:24:10.627 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Releasing connection 127.0.0.1:56138<->127.0.0.1:33689
06:24:10.627 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Connection can be kept alive indefinitely
06:24:10.672 [Test worker] DEBUG ersatz.undertow - stopping undertow server ersatz.undertow.Undertow@9d83e08
06:24:10.696 [Test worker] DEBUG ersatz.undertow - starting undertow server ersatz.undertow.Undertow@65705969
06:24:10.718 [XNIO-2 I/O-1] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-1', selector sun.nio.ch.EPollSelectorImpl@45c82302
06:24:10.738 [XNIO-2 I/O-2] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-2', selector sun.nio.ch.EPollSelectorImpl@4216acaf
06:24:10.747 [XNIO-2 I/O-4] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-4', selector sun.nio.ch.EPollSelectorImpl@406adea4
06:24:10.754 [XNIO-2 I/O-5] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-5', selector sun.nio.ch.EPollSelectorImpl@27f3cbe
06:24:10.758 [XNIO-2 I/O-3] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-3', selector sun.nio.ch.EPollSelectorImpl@16368075
06:24:10.787 [XNIO-2 I/O-6] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-6', selector sun.nio.ch.EPollSelectorImpl@276b2a4c
06:24:10.789 [XNIO-2 I/O-8] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-8', selector sun.nio.ch.EPollSelectorImpl@4ec21d9d
06:24:10.790 [XNIO-2 I/O-7] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 I/O-7', selector sun.nio.ch.EPollSelectorImpl@27a8a31f
06:24:10.794 [Test worker] DEBUG ersatz.undertow - Configuring listener with protocol HTTP for interface localhost and port 0
06:24:10.802 [Test worker] DEBUG ersatz.undertow - stopping undertow server ersatz.undertow.Undertow@65705969
06:24:10.803 [XNIO-2 Accept] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-2 Accept', selector sun.nio.ch.EPollSelectorImpl@7b6c1f66
06:24:10.810 [Test worker] DEBUG ersatz.undertow - starting undertow server ersatz.undertow.Undertow@10d331f2
06:24:10.826 [XNIO-3 I/O-1] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-1', selector sun.nio.ch.EPollSelectorImpl@47e9b023
06:24:10.831 [XNIO-3 I/O-2] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-2', selector sun.nio.ch.EPollSelectorImpl@2a3cc3e
06:24:10.841 [XNIO-3 I/O-3] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-3', selector sun.nio.ch.EPollSelectorImpl@730e30bd
06:24:10.858 [XNIO-3 I/O-4] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-4', selector sun.nio.ch.EPollSelectorImpl@6ce261f3
06:24:10.866 [XNIO-3 I/O-5] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-5', selector sun.nio.ch.EPollSelectorImpl@29dcc01d
06:24:10.878 [XNIO-3 I/O-6] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-6', selector sun.nio.ch.EPollSelectorImpl@1c8fa12b
06:24:10.884 [XNIO-3 I/O-7] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-7', selector sun.nio.ch.EPollSelectorImpl@53c5aa7c
06:24:10.886 [XNIO-3 I/O-8] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 I/O-8', selector sun.nio.ch.EPollSelectorImpl@774c27c2
06:24:10.895 [Test worker] DEBUG ersatz.undertow - Configuring listener with protocol HTTP for interface localhost and port 0
06:24:10.896 [XNIO-3 Accept] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-3 Accept', selector sun.nio.ch.EPollSelectorImpl@445e041b
06:24:10.960 [Test worker] DEBUG ersatz.undertow - stopping undertow server ersatz.undertow.Undertow@10d331f2
06:24:10.972 [Test worker] DEBUG ersatz.undertow - starting undertow server ersatz.undertow.Undertow@24fbc62
06:24:10.983 [XNIO-4 I/O-1] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-1', selector sun.nio.ch.EPollSelectorImpl@20808151
06:24:10.988 [XNIO-4 I/O-7] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-7', selector sun.nio.ch.EPollSelectorImpl@36ee7348
06:24:10.983 [XNIO-4 I/O-3] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-3', selector sun.nio.ch.EPollSelectorImpl@7a20b894
06:24:10.984 [XNIO-4 I/O-6] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-6', selector sun.nio.ch.EPollSelectorImpl@2604898a
06:24:10.983 [XNIO-4 I/O-4] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-4', selector sun.nio.ch.EPollSelectorImpl@4985fc06
06:24:10.998 [Test worker] DEBUG ersatz.undertow - Configuring listener with protocol HTTP for interface localhost and port 0
06:24:10.983 [XNIO-4 I/O-2] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-2', selector sun.nio.ch.EPollSelectorImpl@26b642c0
06:24:10.998 [XNIO-4 Accept] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 Accept', selector sun.nio.ch.EPollSelectorImpl@755e647
06:24:10.983 [XNIO-4 I/O-5] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-5', selector sun.nio.ch.EPollSelectorImpl@736c1a0b
06:24:11.011 [XNIO-4 I/O-8] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-4 I/O-8', selector sun.nio.ch.EPollSelectorImpl@78a97c3c
06:24:11.078 [Test worker] DEBUG org.apache.http.client.protocol.RequestAddCookies - CookieSpec selected: default
06:24:11.078 [Test worker] DEBUG org.apache.http.client.protocol.RequestAuthCache - Auth cache not set in the context
06:24:11.080 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Get connection for route {}->http://localhost:38399
06:24:11.080 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Opening connection {}->http://localhost:38399
06:24:11.081 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connecting to localhost/127.0.0.1:38399
06:24:11.081 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connection established 127.0.0.1:33582<->127.0.0.1:38399
06:24:11.081 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Executing request POST /foo HTTP/1.1
06:24:11.081 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Target auth state: UNCHALLENGED
06:24:11.081 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Proxy auth state: UNCHALLENGED
06:24:11.082 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 >> POST /foo HTTP/1.1
06:24:11.082 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 >> Content-Length: 0
06:24:11.082 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 >> Host: localhost:38399
06:24:11.082 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 >> Connection: Keep-Alive
06:24:11.082 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 >> User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)
06:24:11.082 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 >> Accept-Encoding: gzip,deflate
06:24:11.083 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 >> "POST /foo HTTP/1.1[\r][\n]"
06:24:11.083 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 >> "Content-Length: 0[\r][\n]"
06:24:11.083 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 >> "Host: localhost:38399[\r][\n]"
06:24:11.083 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 >> "Connection: Keep-Alive[\r][\n]"
06:24:11.084 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 >> "User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)[\r][\n]"
06:24:11.084 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 >> "Accept-Encoding: gzip,deflate[\r][\n]"
06:24:11.084 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 >> "[\r][\n]"
06:24:11.086 [XNIO-4 task-1] DEBUG com.stehno.ersatz.ErsatzServer - Request: { POST /foo (query=[:], headers={Connection=[Keep-Alive], Accept-Encoding=[gzip,deflate], Content-Length=[0], User-Agent=[Apache-HttpClient/4.5.2 (Java/1.8.0_131)], Host=[localhost:38399]}, cookies=[:]): <empty> }
06:24:11.087 [XNIO-4 task-1] DEBUG com.stehno.ersatz.ErsatzServer - Response({}): <empty>
06:24:11.087 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 << "HTTP/1.1 200 OK[\r][\n]"
06:24:11.087 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 << "Connection: keep-alive[\r][\n]"
06:24:11.087 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 << "Content-Length: 0[\r][\n]"
06:24:11.087 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 << "Date: Mon, 20 Nov 2017 12:24:10 GMT[\r][\n]"
06:24:11.087 [Test worker] DEBUG org.apache.http.wire - http-outgoing-1 << "[\r][\n]"
06:24:11.088 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 << HTTP/1.1 200 OK
06:24:11.088 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 << Connection: keep-alive
06:24:11.088 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 << Content-Length: 0
06:24:11.088 [Test worker] DEBUG org.apache.http.headers - http-outgoing-1 << Date: Mon, 20 Nov 2017 12:24:10 GMT
06:24:11.088 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Connection can be kept alive indefinitely
06:24:11.088 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Releasing connection 127.0.0.1:33582<->127.0.0.1:38399
06:24:11.088 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Connection can be kept alive indefinitely
06:24:11.094 [Test worker] DEBUG ersatz.undertow - stopping undertow server ersatz.undertow.Undertow@24fbc62
06:24:11.098 [Test worker] DEBUG ersatz.undertow - starting undertow server ersatz.undertow.Undertow@1f59fc8e
06:24:11.102 [XNIO-5 I/O-3] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-3', selector sun.nio.ch.EPollSelectorImpl@13bcad8
06:24:11.102 [XNIO-5 I/O-2] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-2', selector sun.nio.ch.EPollSelectorImpl@1ef2795a
06:24:11.114 [XNIO-5 I/O-5] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-5', selector sun.nio.ch.EPollSelectorImpl@2358eebe
06:24:11.115 [XNIO-5 I/O-4] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-4', selector sun.nio.ch.EPollSelectorImpl@1784ed26
06:24:11.130 [Test worker] DEBUG ersatz.undertow - Configuring listener with protocol HTTP for interface localhost and port 0
06:24:11.164 [XNIO-5 I/O-7] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-7', selector sun.nio.ch.EPollSelectorImpl@f84a721
06:24:11.165 [Finalizer] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Shutting down connection
06:24:11.166 [Finalizer] DEBUG org.apache.http.impl.conn.DefaultManagedHttpClientConnection - http-outgoing-1: Shutdown connection
06:24:11.102 [XNIO-5 I/O-1] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-1', selector sun.nio.ch.EPollSelectorImpl@4e931cc
06:24:11.114 [XNIO-5 I/O-6] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-6', selector sun.nio.ch.EPollSelectorImpl@322d7ce6
06:24:11.173 [XNIO-5 Accept] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 Accept', selector sun.nio.ch.EPollSelectorImpl@7a6ea588
06:24:11.173 [XNIO-5 I/O-8] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-5 I/O-8', selector sun.nio.ch.EPollSelectorImpl@938eb3
06:24:11.194 [Test worker] DEBUG org.apache.http.client.protocol.RequestAddCookies - CookieSpec selected: default
06:24:11.194 [Test worker] DEBUG org.apache.http.client.protocol.RequestAuthCache - Auth cache not set in the context
06:24:11.194 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Get connection for route {}->http://localhost:44197
06:24:11.194 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Opening connection {}->http://localhost:44197
06:24:11.194 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connecting to localhost/127.0.0.1:44197
06:24:11.194 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connection established 127.0.0.1:37142<->127.0.0.1:44197
06:24:11.194 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Executing request POST /foo HTTP/1.1
06:24:11.194 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Target auth state: UNCHALLENGED
06:24:11.195 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Proxy auth state: UNCHALLENGED
06:24:11.195 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 >> POST /foo HTTP/1.1
06:24:11.195 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 >> Content-Length: 0
06:24:11.195 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 >> Host: localhost:44197
06:24:11.195 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 >> Connection: Keep-Alive
06:24:11.195 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 >> User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)
06:24:11.195 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 >> Accept-Encoding: gzip,deflate
06:24:11.195 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 >> "POST /foo HTTP/1.1[\r][\n]"
06:24:11.195 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 >> "Content-Length: 0[\r][\n]"
06:24:11.195 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 >> "Host: localhost:44197[\r][\n]"
06:24:11.195 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 >> "Connection: Keep-Alive[\r][\n]"
06:24:11.195 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 >> "User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)[\r][\n]"
06:24:11.195 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 >> "Accept-Encoding: gzip,deflate[\r][\n]"
06:24:11.195 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 >> "[\r][\n]"
06:24:11.198 [XNIO-5 task-1] DEBUG com.stehno.ersatz.ErsatzServer - Request: { POST /foo (query=[:], headers={Connection=[Keep-Alive], Accept-Encoding=[gzip,deflate], Content-Length=[0], User-Agent=[Apache-HttpClient/4.5.2 (Java/1.8.0_131)], Host=[localhost:44197]}, cookies=[:]): <empty> }
06:24:11.200 [XNIO-5 task-1] DEBUG com.stehno.ersatz.ErsatzServer - Response({Content-Type=[text/plain]}): OK
06:24:11.201 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "HTTP/1.1 200 OK[\r][\n]"
06:24:11.201 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "Content-Encoding: gzip[\r][\n]"
06:24:11.201 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "Connection: keep-alive[\r][\n]"
06:24:11.202 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "Content-Type: text/plain[\r][\n]"
06:24:11.202 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "Content-Length: 22[\r][\n]"
06:24:11.202 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "Date: Mon, 20 Nov 2017 12:24:10 GMT[\r][\n]"
06:24:11.202 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "[\r][\n]"
06:24:11.202 [Test worker] DEBUG org.apache.http.wire - http-outgoing-2 << "[0x1f][0x8b][0x8][0x0][0x0][0x0][0x0][0x0][0x0][0x0][0xf3][0xf7][0x6][0x0]-[0xd9]6[0xd7][0x2][0x0][0x0][0x0]"
06:24:11.202 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 << HTTP/1.1 200 OK
06:24:11.203 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 << Content-Encoding: gzip
06:24:11.203 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 << Connection: keep-alive
06:24:11.203 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 << Content-Type: text/plain
06:24:11.203 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 << Content-Length: 22
06:24:11.203 [Test worker] DEBUG org.apache.http.headers - http-outgoing-2 << Date: Mon, 20 Nov 2017 12:24:10 GMT
06:24:11.203 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Connection can be kept alive indefinitely
06:24:11.204 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Releasing connection 127.0.0.1:37142<->127.0.0.1:44197
06:24:11.204 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Connection can be kept alive indefinitely
06:24:11.205 [Test worker] DEBUG ersatz.undertow - stopping undertow server ersatz.undertow.Undertow@1f59fc8e
06:24:11.214 [Test worker] DEBUG ersatz.undertow - starting undertow server ersatz.undertow.Undertow@29c158f4
06:24:11.230 [XNIO-6 I/O-2] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-2', selector sun.nio.ch.EPollSelectorImpl@7cd0260a
06:24:11.234 [XNIO-6 I/O-3] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-3', selector sun.nio.ch.EPollSelectorImpl@1428bb9e
06:24:11.238 [XNIO-6 I/O-4] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-4', selector sun.nio.ch.EPollSelectorImpl@39c5cb01
06:24:11.251 [XNIO-6 I/O-5] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-5', selector sun.nio.ch.EPollSelectorImpl@11c027af
06:24:11.230 [XNIO-6 I/O-1] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-1', selector sun.nio.ch.EPollSelectorImpl@479d7923
06:24:11.262 [XNIO-6 I/O-6] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-6', selector sun.nio.ch.EPollSelectorImpl@648acd61
06:24:11.266 [XNIO-6 I/O-7] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-7', selector sun.nio.ch.EPollSelectorImpl@78770bff
06:24:11.279 [XNIO-6 I/O-8] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 I/O-8', selector sun.nio.ch.EPollSelectorImpl@27eb9248
06:24:11.282 [Test worker] DEBUG ersatz.undertow - Configuring listener with protocol HTTP for interface localhost and port 0
06:24:11.285 [XNIO-6 Accept] DEBUG ersatz.xnio.nio - Started channel thread 'XNIO-6 Accept', selector sun.nio.ch.EPollSelectorImpl@5611685f
06:24:11.392 [Test worker] DEBUG org.apache.http.client.protocol.RequestAddCookies - CookieSpec selected: default
06:24:11.392 [Test worker] DEBUG org.apache.http.client.protocol.RequestAuthCache - Auth cache not set in the context
06:24:11.392 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Get connection for route {}->http://httpbin.org:80
06:24:11.393 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Opening connection {}->http://httpbin.org:80
06:24:11.421 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connecting to httpbin.org/54.221.226.80:80
06:24:11.470 [Test worker] DEBUG org.apache.http.impl.conn.DefaultHttpClientConnectionOperator - Connection established 192.168.86.49:52968<->54.221.226.80:80
06:24:11.470 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Executing request POST /post HTTP/1.1
06:24:11.470 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Target auth state: UNCHALLENGED
06:24:11.470 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Proxy auth state: UNCHALLENGED
06:24:11.470 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 >> POST /post HTTP/1.1
06:24:11.470 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 >> Content-Type: application/json; charset=utf-8
06:24:11.470 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 >> Content-Length: 38
06:24:11.470 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 >> Host: httpbin.org
06:24:11.470 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 >> Connection: Keep-Alive
06:24:11.470 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 >> User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)
06:24:11.471 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 >> Accept-Encoding: gzip,deflate
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "POST /post HTTP/1.1[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "Content-Type: application/json; charset=utf-8[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "Content-Length: 38[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "Host: httpbin.org[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "Connection: Keep-Alive[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "User-Agent: Apache-HttpClient/4.5.2 (Java/1.8.0_131)[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "Accept-Encoding: gzip,deflate[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "[\r][\n]"
06:24:11.476 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 >> "{"item":"ASDFASEACV235","score":90786}"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "HTTP/1.1 200 OK[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Connection: keep-alive[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Server: meinheld/0.6.1[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Date: Mon, 20 Nov 2017 12:24:11 GMT[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Content-Type: application/json[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Access-Control-Allow-Origin: *[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Access-Control-Allow-Credentials: true[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "X-Powered-By: Flask[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "X-Processed-Time: 0.000859022140503[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Content-Length: 505[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "Via: 1.1 vegur[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "[\r][\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "{[\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "args": {}, [\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "data": "{\"item\":\"ASDFASEACV235\",\"score\":90786}", [\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "files": {}, [\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "form": {}, [\n]"
06:24:11.525 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "headers": {[\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "Accept-Encoding": "gzip,deflate", [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "Connection": "close", [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "Content-Length": "38", [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "Content-Type": "application/json; charset=utf-8", [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "Host": "httpbin.org", [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "User-Agent": "Apache-HttpClient/4.5.2 (Java/1.8.0_131)"[\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  }, [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "json": {[\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "item": "ASDFASEACV235", [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "    "score": 90786[\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  }, [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "origin": "76.186.120.225", [\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "  "url": "http://httpbin.org/post"[\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.wire - http-outgoing-3 << "}[\n]"
06:24:11.526 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << HTTP/1.1 200 OK
06:24:11.526 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Connection: keep-alive
06:24:11.526 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Server: meinheld/0.6.1
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Date: Mon, 20 Nov 2017 12:24:11 GMT
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Content-Type: application/json
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Access-Control-Allow-Origin: *
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Access-Control-Allow-Credentials: true
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << X-Powered-By: Flask
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << X-Processed-Time: 0.000859022140503
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Content-Length: 505
06:24:11.527 [Test worker] DEBUG org.apache.http.headers - http-outgoing-3 << Via: 1.1 vegur
06:24:11.527 [Test worker] DEBUG org.apache.http.impl.execchain.MainClientExec - Connection can be kept alive indefinitely
06:24:11.587 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Releasing connection 192.168.86.49:52968<->54.221.226.80:80
06:24:11.587 [Test worker] DEBUG org.apache.http.impl.conn.BasicHttpClientConnectionManager - Connection can be kept alive indefinitely
06:24:11.624 [Test worker] DEBUG ersatz.undertow - stopping undertow server ersatz.undertow.Undertow@29c158f4