Hello.
I'm using httpclient-4.1.1 and i'm trying to authenticate with different
users on different realms but it seems to fail.
i create several AuthScope objects with the same host and port and a
different realm for each one.
If I pass schema as null then httpclient will attempt to send the username
and password for every WWW-Authenticate header?
When the first request is asked to authenticate it is authenticated for
'realmx' with the user 'userx' and a password and the authentication is
successful and when I perform another request to the same host and port but
for a different realm the method getCredentials() of the authState in the
updateAuthState method in
org.apache.http.impl.client.DefaultRequestDirector returns the credentials
for 'userx' (line 1215) and because it is not null the authentication
fails, the credentials are set to null and the method handleResponse
returns null causing the method 'execute' to exit without authenticating.
Either the AuthState should be invalidated or am I missing something else?
What is the correct execution path for multiple request to the same host
for different realms?
This is the log, you can see the first request succeeds but the second one
fails.
2014-03-24 17:32:31,604 INFO main mortbay.log (Slf4jLog.java:info(67)) -
Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
org.mortbay.log.Slf4jLog
2014-03-24 17:32:31,612 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container Server@4685d9a4 + org.mortbay.jetty.servlet.Context@7d93c227{/,null}
as handler
2014-03-24 17:32:31,612 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container SessionHandler@6fafced9 + ServletHandler@7f3541d7 as handler
2014-03-24 17:32:31,613 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container SessionHandler@6fafced9 +
org.mortbay.jetty.servlet.HashSessionManager@175cb80 as sessionManager
2014-03-24 17:32:31,613 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container org.mortbay.jetty.servlet.Context@7d93c227{/,null} +
SessionHandler@6fafced9 as handler
2014-03-24 17:32:31,622 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Checking Resource aliases
2014-03-24 17:32:31,637 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container ServletHandler@7f3541d7 +
org.apache.jasper.servlet.JspServlet-2007433549 as servlet
2014-03-24 17:32:31,638 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container ServletHandler@7f3541d7 +
(S=org.apache.jasper.servlet.JspServlet-2007433549,[*.jsp]) as
servletMapping
2014-03-24 17:32:31,647 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
filterNameMap=null
2014-03-24 17:32:31,647 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
pathFilters=null
2014-03-24 17:32:31,648 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
servletFilterMap=null
2014-03-24 17:32:31,648 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
servletPathMap={*.jsp=org.apache.jasper.servlet.JspServlet-2007433549}
2014-03-24 17:32:31,648 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
servletNameMap={org.apache.jasper.servlet.JspServlet-2007433549=org.apache.jasper.servlet.JspServlet-2007433549}
2014-03-24 17:32:32,407 INFO main httpclient.Http
(HttpBase.java:logConf(289)) - http.proxy.host = null
2014-03-24 17:32:32,407 INFO main httpclient.Http
(HttpBase.java:logConf(290)) - http.proxy.port = 8080
2014-03-24 17:32:32,412 INFO main httpclient.Http
(HttpBase.java:logConf(291)) - http.timeout = 60000
2014-03-24 17:32:32,412 INFO main httpclient.Http
(HttpBase.java:logConf(292)) - http.content.limit = 65536
2014-03-24 17:32:32,412 INFO main httpclient.Http
(HttpBase.java:logConf(293)) - http.agent = Nutch-Test/Nutch-2.2.1 (Nutch
protocol-httpclient test)
2014-03-24 17:32:32,412 INFO main httpclient.Http
(HttpBase.java:logConf(294)) - http.accept.language =
en-us,en-gb,en;q=0.7,*;q=0.3
2014-03-24 17:32:32,413 INFO main httpclient.Http
(HttpBase.java:logConf(295)) - http.accept =
text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8
2014-03-24 17:32:32,431 TRACE main httpclient.Http
(Http.java:setCredentials(383)) - Credentials - username: userx; set as
default for realm: ; scheme:
2014-03-24 17:32:32,432 ERROR main httpclient.Http (Http.java:setConf(174))
- Could not read httpclient-auth-test.xml : null
2014-03-24 17:32:32,486 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container Server@4685d9a4 + SelectChannelConnector@127.0.0.1:47500 as
connector
2014-03-24 17:32:32,490 INFO main mortbay.log (Slf4jLog.java:info(67)) -
jetty-6.1.26
2014-03-24 17:32:32,514 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container Server@4685d9a4 + org.mortbay.thread.QueuedThreadPool@50f2fd20 as
threadpool
2014-03-24 17:32:32,518 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started org.mortbay.thread.QueuedThreadPool@50f2fd20
2014-03-24 17:32:32,547 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Container Server@4685d9a4 +
org.mortbay.jetty.servlet.HashSessionIdManager@7b7597b6 as sessionIdManager
2014-03-24 17:32:32,547 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
Init SecureRandom.
2014-03-24 17:32:32,549 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started org.mortbay.jetty.servlet.HashSessionIdManager@7b7597b6
2014-03-24 17:32:32,551 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started org.mortbay.jetty.servlet.HashSessionManager@175cb80
2014-03-24 17:32:32,551 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
filterNameMap=null
2014-03-24 17:32:32,551 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
pathFilters=null
2014-03-24 17:32:32,552 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
servletFilterMap=null
2014-03-24 17:32:32,552 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
servletPathMap={*.jsp=org.apache.jasper.servlet.JspServlet-2007433549}
2014-03-24 17:32:32,552 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
servletNameMap={org.apache.jasper.servlet.JspServlet-2007433549=org.apache.jasper.servlet.JspServlet-2007433549}
2014-03-24 17:32:32,553 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
starting ServletHandler@7f3541d7
2014-03-24 17:32:32,553 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started ServletHandler@7f3541d7
2014-03-24 17:32:32,553 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
starting SessionHandler@6fafced9
2014-03-24 17:32:32,553 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started SessionHandler@6fafced9
2014-03-24 17:32:32,554 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
starting ErrorHandler@1cf1df22
2014-03-24 17:32:32,554 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started ErrorHandler@1cf1df22
2014-03-24 17:32:32,556 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:32,569 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
starting Server@4685d9a4
2014-03-24 17:32:32,585 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started org.mortbay.jetty.nio.SelectChannelConnector$1@493b4526
2014-03-24 17:32:32,594 INFO main mortbay.log (Slf4jLog.java:info(67)) -
Started SelectChannelConnector@127.0.0.1:47500
2014-03-24 17:32:32,595 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started SelectChannelConnector@127.0.0.1:47500
2014-03-24 17:32:32,595 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
started Server@4685d9a4
2014-03-24 17:32:32,979 TRACE main httpclient.Http
(Http.java:resolveCredentials(484)) - Pre-configured credentials with scope
- host: 127.0.0.1; port: 47500; not found for url:
http://127.0.0.1:47500/basic.jsp
2014-03-24 17:32:33,156 DEBUG main tsccm.ThreadSafeClientConnManager
(ThreadSafeClientConnManager.java:getConnection(221)) - Get connection:
HttpRoute[{}->http://127.0.0.1:47500], timeout = 60000
2014-03-24 17:32:33,159 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:getEntryBlocking(350)) - [HttpRoute[{}->
http://127.0.0.1:47500]] total kept alive: 0, total issued: 0, total
allocated: 0 out of 10
2014-03-24 17:32:33,159 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:getFreeEntry(523)) - No free connections
[HttpRoute[{}->http://127.0.0.1:47500]][null]
2014-03-24 17:32:33,160 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:getEntryBlocking(369)) - Available capacity: 10 out
of 10 [HttpRoute[{}->http://127.0.0.1:47500]][null]
2014-03-24 17:32:33,167 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:createEntry(549)) - Creating new connection
[HttpRoute[{}->http://127.0.0.1:47500]]
2014-03-24 17:32:33,208 DEBUG main conn.DefaultClientConnectionOperator
(DefaultClientConnectionOperator.java:openConnection(145)) - Connecting to /
127.0.0.1:47500
2014-03-24 17:32:33,283 DEBUG main protocol.RequestAddCookies
(RequestAddCookies.java:process(132)) - CookieSpec selected: compatibility
2014-03-24 17:32:33,316 DEBUG main protocol.RequestAuthCache
(RequestAuthCache.java:process(75)) - Auth cache not set in the context
2014-03-24 17:32:33,327 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:tryExecute(631)) - Attempt 1 to execute request
2014-03-24 17:32:33,328 DEBUG main conn.DefaultClientConnection
(DefaultClientConnection.java:sendRequestHeader(264)) - Sending request:
GET /basic.jsp HTTP/1.0
2014-03-24 17:32:33,328 DEBUG main http.wire (Wire.java:wire(63)) - >> "GET
/basic.jsp HTTP/1.0[\r][\n]"
2014-03-24 17:32:33,331 DEBUG main http.wire (Wire.java:wire(63)) - >>
"User-Agent: Nutch-Test/Nutch-2.2.1 (Nutch protocol-httpclient
test)[\r][\n]"
2014-03-24 17:32:33,331 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Language: en-us,en-gb,en;q=0.7,*;q=0.3[\r][\n]"
2014-03-24 17:32:33,332 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Charset: utf-8,ISO-8859-1;q=0.7,*;q=0.7[\r][\n]"
2014-03-24 17:32:33,332 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept:
text/html,application/xml;q=0.9,application/xhtml+xml,text/xml;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5[\r][\n]"
2014-03-24 17:32:33,332 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Encoding: x-gzip, gzip, deflate[\r][\n]"
2014-03-24 17:32:33,333 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Host: 127.0.0.1:47500[\r][\n]"
2014-03-24 17:32:33,335 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Connection: Keep-Alive[\r][\n]"
2014-03-24 17:32:33,336 DEBUG main http.wire (Wire.java:wire(63)) - >>
"[\r][\n]"
2014-03-24 17:32:33,336 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(268)) - >> GET /basic.jsp
HTTP/1.0
2014-03-24 17:32:33,336 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> User-Agent:
Nutch-Test/Nutch-2.2.1 (Nutch protocol-httpclient test)
2014-03-24 17:32:33,337 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Language:
en-us,en-gb,en;q=0.7,*;q=0.3
2014-03-24 17:32:33,337 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Charset:
utf-8,ISO-8859-1;q=0.7,*;q=0.7
2014-03-24 17:32:33,339 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept:
text/html,application/xml;q=0.9,application/xhtml+xml,text/xml;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5
2014-03-24 17:32:33,340 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Encoding:
x-gzip, gzip, deflate
2014-03-24 17:32:33,340 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Host:
127.0.0.1:47500
2014-03-24 17:32:33,341 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Connection:
Keep-Alive
2014-03-24 17:32:33,373 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - REQUEST /basic.jsp on
org.mortbay.jetty.HttpConnection@43a4f8f4
2014-03-24 17:32:33,380 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) -
sessionManager=org.mortbay.jetty.servlet.HashSessionManager@175cb80
2014-03-24 17:32:33,380 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - session=null
2014-03-24 17:32:33,381 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) -
servlet=org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:33,381 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - chain=null
2014-03-24 17:32:33,382 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - servlet
holder=org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:33,474 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
compiler.JspRuntimeContext (JspRuntimeContext.java:<init>(102)) - Parent
class loader is: sun.misc.Launcher$AppClassLoader@7b939100
2014-03-24 17:32:33,477 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:init(102)) - Scratch dir for the JSP
engine is: /tmp
2014-03-24 17:32:33,478 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:init(104)) - IMPORTANT: Do not modify
the generated servlets
2014-03-24 17:32:33,478 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(247)) - JspEngine --> /basic.jsp
2014-03-24 17:32:33,478 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(248)) - ServletPath:
/basic.jsp
2014-03-24 17:32:33,479 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(249)) - PathInfo:
null
2014-03-24 17:32:33,479 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(250)) - RealPath:
src/plugin/protocol-httpclient/jsp/basic.jsp
2014-03-24 17:32:33,479 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(251)) - RequestURI:
/basic.jsp
2014-03-24 17:32:33,480 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(252)) - QueryString:
null
2014-03-24 17:32:33,480 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(253)) - Request Params:
2014-03-24 17:32:33,596 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - RESPONSE /basic.jsp 401
2014-03-24 17:32:33,616 DEBUG main http.wire (Wire.java:wire(63)) - <<
"HTTP/1.1 401 Unauthorized[\r][\n]"
2014-03-24 17:32:33,621 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Content-Type: text/html; charset=iso-8859-1[\r][\n]"
2014-03-24 17:32:33,621 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Expires: Thu, 01-Jan-1970 00:00:00 GMT[\r][\n]"
2014-03-24 17:32:33,621 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Set-Cookie: JSESSIONID=13szwkyya0plpp93mehersgrv;Path=/[\r][\n]"
2014-03-24 17:32:33,622 DEBUG main http.wire (Wire.java:wire(63)) - <<
"WWW-Authenticate: Basic realm="realmx"[\r][\n]"
2014-03-24 17:32:33,622 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Content-Length: 6[\r][\n]"
2014-03-24 17:32:33,622 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Connection: keep-alive[\r][\n]"
2014-03-24 17:32:33,623 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Server: Jetty(6.1.26)[\r][\n]"
2014-03-24 17:32:33,623 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\r][\n]"
2014-03-24 17:32:33,625 DEBUG main conn.DefaultClientConnection
(DefaultClientConnection.java:receiveResponseHeader(249)) - Receiving
response: HTTP/1.1 401 Unauthorized
2014-03-24 17:32:33,625 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(252)) - << HTTP/1.1 401
Unauthorized
2014-03-24 17:32:33,625 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
Content-Type: text/html; charset=iso-8859-1
2014-03-24 17:32:33,626 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Expires:
Thu, 01-Jan-1970 00:00:00 GMT
2014-03-24 17:32:33,626 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Set-Cookie:
JSESSIONID=13szwkyya0plpp93mehersgrv;Path=/
2014-03-24 17:32:33,626 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
WWW-Authenticate: Basic realm="realmx"
2014-03-24 17:32:33,626 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
Content-Length: 6
2014-03-24 17:32:33,627 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Connection:
keep-alive
2014-03-24 17:32:33,627 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Server:
Jetty(6.1.26)
2014-03-24 17:32:33,641 DEBUG main protocol.ResponseProcessCookies
(ResponseProcessCookies.java:processCookies(122)) - Cookie accepted:
"[version: 0][name: JSESSIONID][value: 13szwkyya0plpp93mehersgrv][domain:
127.0.0.1][path: /][expiry: null]".
2014-03-24 17:32:33,644 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:execute(477)) - Connection can be kept alive
indefinitely
2014-03-24 17:32:33,644 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:handleResponse(1074)) - Target requested
authentication
2014-03-24 17:32:33,645 DEBUG main
client.DefaultTargetAuthenticationHandler
(AbstractAuthenticationHandler.java:selectScheme(151)) - Authentication
schemes in the order of preference: [Basic]
2014-03-24 17:32:33,645 DEBUG main
client.DefaultTargetAuthenticationHandler
(AbstractAuthenticationHandler.java:selectScheme(161)) - Basic
authentication scheme selected
2014-03-24 17:32:33,651 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:processChallenges(1184)) - Authorization
challenge processed
2014-03-24 17:32:33,652 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:updateAuthState(1212)) - Authentication scope:
BASIC 'realmx'@127.0.0.1:47500
2014-03-24 17:32:33,653 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:updateAuthState(1219)) - Found credentials
2014-03-24 17:32:33,659 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,660 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,660 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,661 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,661 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,661 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,662 DEBUG main protocol.RequestAddCookies
(RequestAddCookies.java:process(132)) - CookieSpec selected: compatibility
2014-03-24 17:32:33,662 DEBUG main protocol.RequestAddCookies
(RequestAddCookies.java:process(184)) - Cookie [version: 0][name:
JSESSIONID][value: 13szwkyya0plpp93mehersgrv][domain: 127.0.0.1][path:
/][expiry: null] match [127.0.0.1:47500/basic.jsp]
2014-03-24 17:32:33,663 DEBUG main protocol.RequestAuthCache
(RequestAuthCache.java:process(75)) - Auth cache not set in the context
2014-03-24 17:32:33,681 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:tryExecute(631)) - Attempt 2 to execute request
2014-03-24 17:32:33,689 DEBUG main conn.DefaultClientConnection
(DefaultClientConnection.java:sendRequestHeader(264)) - Sending request:
GET /basic.jsp HTTP/1.0
2014-03-24 17:32:33,690 DEBUG main http.wire (Wire.java:wire(63)) - >> "GET
/basic.jsp HTTP/1.0[\r][\n]"
2014-03-24 17:32:33,690 DEBUG main http.wire (Wire.java:wire(63)) - >>
"User-Agent: Nutch-Test/Nutch-2.2.1 (Nutch protocol-httpclient
test)[\r][\n]"
2014-03-24 17:32:33,691 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Language: en-us,en-gb,en;q=0.7,*;q=0.3[\r][\n]"
2014-03-24 17:32:33,691 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Charset: utf-8,ISO-8859-1;q=0.7,*;q=0.7[\r][\n]"
2014-03-24 17:32:33,691 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept:
text/html,application/xml;q=0.9,application/xhtml+xml,text/xml;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5[\r][\n]"
2014-03-24 17:32:33,692 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Encoding: x-gzip, gzip, deflate[\r][\n]"
2014-03-24 17:32:33,692 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Host: 127.0.0.1:47500[\r][\n]"
2014-03-24 17:32:33,692 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Connection: Keep-Alive[\r][\n]"
2014-03-24 17:32:33,693 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Cookie: JSESSIONID=13szwkyya0plpp93mehersgrv[\r][\n]"
2014-03-24 17:32:33,693 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Authorization: Basic dXNlcng6cGFzc3g=[\r][\n]"
2014-03-24 17:32:33,694 DEBUG main http.wire (Wire.java:wire(63)) - >>
"[\r][\n]"
2014-03-24 17:32:33,694 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(268)) - >> GET /basic.jsp
HTTP/1.0
2014-03-24 17:32:33,694 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> User-Agent:
Nutch-Test/Nutch-2.2.1 (Nutch protocol-httpclient test)
2014-03-24 17:32:33,694 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Language:
en-us,en-gb,en;q=0.7,*;q=0.3
2014-03-24 17:32:33,695 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Charset:
utf-8,ISO-8859-1;q=0.7,*;q=0.7
2014-03-24 17:32:33,695 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept:
text/html,application/xml;q=0.9,application/xhtml+xml,text/xml;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5
2014-03-24 17:32:33,696 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Encoding:
x-gzip, gzip, deflate
2014-03-24 17:32:33,696 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Host:
127.0.0.1:47500
2014-03-24 17:32:33,696 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Connection:
Keep-Alive
2014-03-24 17:32:33,696 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Cookie:
JSESSIONID=13szwkyya0plpp93mehersgrv
2014-03-24 17:32:33,697 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Authorization:
Basic dXNlcng6cGFzc3g=
2014-03-24 17:32:33,698 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - REQUEST /basic.jsp on
org.mortbay.jetty.HttpConnection@43a4f8f4
2014-03-24 17:32:33,699 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - Got Session ID
13szwkyya0plpp93mehersgrv from cookie
2014-03-24 17:32:33,699 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) -
sessionManager=org.mortbay.jetty.servlet.HashSessionManager@175cb80
2014-03-24 17:32:33,700 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) -
session=org.mortbay.jetty.servlet.HashSessionManager$Session:13szwkyya0plpp93mehersgrv@1391187182
2014-03-24 17:32:33,700 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) -
servlet=org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:33,700 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - chain=null
2014-03-24 17:32:33,700 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - servlet
holder=org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:33,700 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(247)) - JspEngine --> /basic.jsp
2014-03-24 17:32:33,701 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(248)) - ServletPath:
/basic.jsp
2014-03-24 17:32:33,701 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(249)) - PathInfo:
null
2014-03-24 17:32:33,701 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(250)) - RealPath:
src/plugin/protocol-httpclient/jsp/basic.jsp
2014-03-24 17:32:33,701 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(251)) - RequestURI:
/basic.jsp
2014-03-24 17:32:33,702 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(252)) - QueryString:
null
2014-03-24 17:32:33,702 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
servlet.JspServlet (JspServlet.java:service(253)) - Request Params:
2014-03-24 17:32:33,702 DEBUG 1821831627@qtp-1358101792-0 - /basic.jsp
mortbay.log (Slf4jLog.java:debug(40)) - RESPONSE /basic.jsp 200
2014-03-24 17:32:33,703 DEBUG main http.wire (Wire.java:wire(63)) - <<
"HTTP/1.1 200 OK[\r][\n]"
2014-03-24 17:32:33,703 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Content-Type: text/html; charset=iso-8859-1[\r][\n]"
2014-03-24 17:32:33,703 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Content-Length: 150[\r][\n]"
2014-03-24 17:32:33,704 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Connection: keep-alive[\r][\n]"
2014-03-24 17:32:33,704 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Server: Jetty(6.1.26)[\r][\n]"
2014-03-24 17:32:33,704 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\r][\n]"
2014-03-24 17:32:33,704 DEBUG main conn.DefaultClientConnection
(DefaultClientConnection.java:receiveResponseHeader(249)) - Receiving
response: HTTP/1.1 200 OK
2014-03-24 17:32:33,705 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(252)) - << HTTP/1.1 200
OK
2014-03-24 17:32:33,705 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
Content-Type: text/html; charset=iso-8859-1
2014-03-24 17:32:33,706 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
Content-Length: 150
2014-03-24 17:32:33,706 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Connection:
keep-alive
2014-03-24 17:32:33,706 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Server:
Jetty(6.1.26)
2014-03-24 17:32:33,708 DEBUG main protocol.ResponseAuthCache
(ResponseAuthCache.java:cache(114)) - Caching 'basic' auth scheme for
http://127.0.0.1:47500
2014-03-24 17:32:33,710 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:execute(477)) - Connection can be kept alive
indefinitely
2014-03-24 17:32:33,718 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,719 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,719 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,719 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,719 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,720 DEBUG main http.wire (Wire.java:wire(63)) - <<
"<html>[\n]"
2014-03-24 17:32:33,728 DEBUG main http.wire (Wire.java:wire(63)) - <<
"<head><title>Basic Authentication Test</title></head>[\n]"
2014-03-24 17:32:33,729 DEBUG main http.wire (Wire.java:wire(63)) - <<
"<body>[\n]"
2014-03-24 17:32:33,729 DEBUG main http.wire (Wire.java:wire(63)) - <<
"<p>Hi userx, you have been successfully authenticated.</p>[\n]"
2014-03-24 17:32:33,729 DEBUG main http.wire (Wire.java:wire(63)) - <<
"</body>[\n]"
2014-03-24 17:32:33,729 DEBUG main http.wire (Wire.java:wire(63)) - <<
"</html>[\n]"
2014-03-24 17:32:33,730 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,731 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,732 DEBUG main tsccm.ThreadSafeClientConnManager
(ThreadSafeClientConnManager.java:releaseConnection(270)) - Released
connection is reusable.
2014-03-24 17:32:33,733 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:freeEntry(434)) - Releasing connection
[HttpRoute[{}->http://127.0.0.1:47500]][null]
2014-03-24 17:32:33,733 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:freeEntry(460)) - Pooling connection
[HttpRoute[{}->http://127.0.0.1:47500]][null]; keep alive indefinitely
2014-03-24 17:32:33,734 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:notifyWaitingThread(679)) - Notifying no-one, there
are no waiting threads
2014-03-24 17:32:33,734 TRACE main httpclient.Http
(HttpResponse.java:<init>(201)) - url: http://127.0.0.1:47500/basic.jsp;
status code: 200; bytes received: 150
2014-03-24 17:32:33,735 TRACE main httpclient.Http
(Http.java:resolveCredentials(475)) - Pre-configured credentials with scope
- host: 127.0.0.1; port: 47500; found for url:
http://127.0.0.1:47500/basic.jsp?case=1
2014-03-24 17:32:33,735 DEBUG main tsccm.ThreadSafeClientConnManager
(ThreadSafeClientConnManager.java:getConnection(221)) - Get connection:
HttpRoute[{}->http://127.0.0.1:47500], timeout = 60000
2014-03-24 17:32:33,735 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:getEntryBlocking(350)) - [HttpRoute[{}->
http://127.0.0.1:47500]] total kept alive: 1, total issued: 0, total
allocated: 1 out of 10
2014-03-24 17:32:33,736 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:getFreeEntry(498)) - Getting free connection
[HttpRoute[{}->http://127.0.0.1:47500]][null]
2014-03-24 17:32:33,736 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:execute(401)) - Stale connection check
2014-03-24 17:32:33,738 DEBUG main protocol.RequestAddCookies
(RequestAddCookies.java:process(132)) - CookieSpec selected: compatibility
2014-03-24 17:32:33,739 DEBUG main protocol.RequestAddCookies
(RequestAddCookies.java:process(184)) - Cookie [version: 0][name:
JSESSIONID][value: 13szwkyya0plpp93mehersgrv][domain: 127.0.0.1][path:
/][expiry: null] match [127.0.0.1:47500/basic.jsp]
2014-03-24 17:32:33,739 DEBUG main protocol.RequestAuthCache
(RequestAuthCache.java:doPreemptiveAuth(112)) - Re-using cached 'basic'
auth scheme for http://127.0.0.1:47500
2014-03-24 17:32:33,739 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:tryExecute(631)) - Attempt 1 to execute request
2014-03-24 17:32:33,740 DEBUG main conn.DefaultClientConnection
(DefaultClientConnection.java:sendRequestHeader(264)) - Sending request:
GET /basic.jsp?case=1 HTTP/1.0
2014-03-24 17:32:33,740 DEBUG main http.wire (Wire.java:wire(63)) - >> "GET
/basic.jsp?case=1 HTTP/1.0[\r][\n]"
2014-03-24 17:32:33,740 DEBUG main http.wire (Wire.java:wire(63)) - >>
"User-Agent: Nutch-Test/Nutch-2.2.1 (Nutch protocol-httpclient
test)[\r][\n]"
2014-03-24 17:32:33,741 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Language: en-us,en-gb,en;q=0.7,*;q=0.3[\r][\n]"
2014-03-24 17:32:33,741 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Charset: utf-8,ISO-8859-1;q=0.7,*;q=0.7[\r][\n]"
2014-03-24 17:32:33,741 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept:
text/html,application/xml;q=0.9,application/xhtml+xml,text/xml;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5[\r][\n]"
2014-03-24 17:32:33,742 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Accept-Encoding: x-gzip, gzip, deflate[\r][\n]"
2014-03-24 17:32:33,742 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Host: 127.0.0.1:47500[\r][\n]"
2014-03-24 17:32:33,743 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Connection: Keep-Alive[\r][\n]"
2014-03-24 17:32:33,743 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Cookie: JSESSIONID=13szwkyya0plpp93mehersgrv[\r][\n]"
2014-03-24 17:32:33,743 DEBUG main http.wire (Wire.java:wire(63)) - >>
"Authorization: Basic dXNlcng6cGFzc3g=[\r][\n]"
2014-03-24 17:32:33,744 DEBUG main http.wire (Wire.java:wire(63)) - >>
"[\r][\n]"
2014-03-24 17:32:33,744 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(268)) - >> GET
/basic.jsp?case=1 HTTP/1.0
2014-03-24 17:32:33,744 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> User-Agent:
Nutch-Test/Nutch-2.2.1 (Nutch protocol-httpclient test)
2014-03-24 17:32:33,744 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Language:
en-us,en-gb,en;q=0.7,*;q=0.3
2014-03-24 17:32:33,745 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Charset:
utf-8,ISO-8859-1;q=0.7,*;q=0.7
2014-03-24 17:32:33,745 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept:
text/html,application/xml;q=0.9,application/xhtml+xml,text/xml;q=0.9,text/plain;q=0.8,image/png,*/*;q=0.5
2014-03-24 17:32:33,745 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Accept-Encoding:
x-gzip, gzip, deflate
2014-03-24 17:32:33,746 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Host:
127.0.0.1:47500
2014-03-24 17:32:33,746 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Connection:
Keep-Alive
2014-03-24 17:32:33,746 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Cookie:
JSESSIONID=13szwkyya0plpp93mehersgrv
2014-03-24 17:32:33,746 DEBUG main http.headers
(DefaultClientConnection.java:sendRequestHeader(271)) - >> Authorization:
Basic dXNlcng6cGFzc3g=
2014-03-24 17:32:33,747 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) - REQUEST
/basic.jsp on org.mortbay.jetty.HttpConnection@43a4f8f4
2014-03-24 17:32:33,748 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) - Got Session ID
13szwkyya0plpp93mehersgrv from cookie
2014-03-24 17:32:33,748 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) -
sessionManager=org.mortbay.jetty.servlet.HashSessionManager@175cb80
2014-03-24 17:32:33,748 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) -
session=org.mortbay.jetty.servlet.HashSessionManager$Session:13szwkyya0plpp93mehersgrv@1391187182
2014-03-24 17:32:33,748 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) -
servlet=org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:33,748 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) - chain=null
2014-03-24 17:32:33,749 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) - servlet
holder=org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:33,749 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(247)) -
JspEngine --> /basic.jsp
2014-03-24 17:32:33,749 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(248)) -
ServletPath: /basic.jsp
2014-03-24 17:32:33,749 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(249)) -
PathInfo: null
2014-03-24 17:32:33,750 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(250)) -
RealPath: src/plugin/protocol-httpclient/jsp/basic.jsp
2014-03-24 17:32:33,750 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(251)) -
RequestURI: /basic.jsp
2014-03-24 17:32:33,750 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(252)) -
QueryString: case=1
2014-03-24 17:32:33,750 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(253)) -
Request Params:
2014-03-24 17:32:33,754 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 servlet.JspServlet (JspServlet.java:service(257)) -
case = 1
2014-03-24 17:32:33,755 DEBUG 1821831627@qtp-1358101792-0 -
/basic.jsp?case=1 mortbay.log (Slf4jLog.java:debug(40)) - RESPONSE
/basic.jsp 401
2014-03-24 17:32:33,755 DEBUG main http.wire (Wire.java:wire(63)) - <<
"HTTP/1.1 401 Unauthorized[\r][\n]"
2014-03-24 17:32:33,756 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Content-Type: text/html; charset=iso-8859-1[\r][\n]"
2014-03-24 17:32:33,756 DEBUG main http.wire (Wire.java:wire(63)) - <<
"WWW-Authenticate: Basic realm="realm1"[\r][\n]"
2014-03-24 17:32:33,757 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Content-Length: 6[\r][\n]"
2014-03-24 17:32:33,757 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Connection: keep-alive[\r][\n]"
2014-03-24 17:32:33,757 DEBUG main http.wire (Wire.java:wire(63)) - <<
"Server: Jetty(6.1.26)[\r][\n]"
2014-03-24 17:32:33,758 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\r][\n]"
2014-03-24 17:32:33,758 DEBUG main conn.DefaultClientConnection
(DefaultClientConnection.java:receiveResponseHeader(249)) - Receiving
response: HTTP/1.1 401 Unauthorized
2014-03-24 17:32:33,758 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(252)) - << HTTP/1.1 401
Unauthorized
2014-03-24 17:32:33,759 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
Content-Type: text/html; charset=iso-8859-1
2014-03-24 17:32:33,759 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
WWW-Authenticate: Basic realm="realm1"
2014-03-24 17:32:33,759 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - <<
Content-Length: 6
2014-03-24 17:32:33,759 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Connection:
keep-alive
2014-03-24 17:32:33,760 DEBUG main http.headers
(DefaultClientConnection.java:receiveResponseHeader(255)) - << Server:
Jetty(6.1.26)
2014-03-24 17:32:33,760 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:execute(477)) - Connection can be kept alive
indefinitely
2014-03-24 17:32:33,760 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:handleResponse(1074)) - Target requested
authentication
2014-03-24 17:32:33,761 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:processChallenges(1184)) - Authorization
challenge processed
2014-03-24 17:32:33,761 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:updateAuthState(1212)) - Authentication scope:
BASIC 'realm1'@127.0.0.1:47500
2014-03-24 17:32:33,761 DEBUG main client.DefaultHttpClient
(DefaultRequestDirector.java:updateAuthState(1226)) - Authentication failed
2014-03-24 17:32:33,762 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,762 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,762 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,762 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,763 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,763 DEBUG main http.wire (Wire.java:wire(63)) - <<
"[\n]"
2014-03-24 17:32:33,763 DEBUG main tsccm.ThreadSafeClientConnManager
(ThreadSafeClientConnManager.java:releaseConnection(270)) - Released
connection is reusable.
2014-03-24 17:32:33,764 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:freeEntry(434)) - Releasing connection
[HttpRoute[{}->http://127.0.0.1:47500]][null]
2014-03-24 17:32:33,764 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:freeEntry(460)) - Pooling connection
[HttpRoute[{}->http://127.0.0.1:47500]][null]; keep alive indefinitely
2014-03-24 17:32:33,764 DEBUG main tsccm.ConnPoolByRoute
(ConnPoolByRoute.java:notifyWaitingThread(679)) - Notifying no-one, there
are no waiting threads
2014-03-24 17:32:33,764 TRACE main httpclient.Http
(HttpResponse.java:<init>(201)) - url:
http://127.0.0.1:47500/basic.jsp?case=1; status code: 401; bytes received: 6
2014-03-24 17:32:33,765 INFO main mortbay.log (Slf4jLog.java:info(67)) -
Stopped SelectChannelConnector@127.0.0.1:47500
2014-03-24 17:32:33,766 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped org.mortbay.jetty.nio.SelectChannelConnector$1@493b4526
2014-03-24 17:32:33,767 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped SelectChannelConnector@127.0.0.1:47500
2014-03-24 17:32:33,767 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopping Server@4685d9a4
2014-03-24 17:32:33,767 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopping SessionHandler@6fafced9
2014-03-24 17:32:33,768 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopping ServletHandler@7f3541d7
2014-03-24 17:32:33,768 DEBUG main servlet.JspServlet
(JspServlet.java:destroy(279)) - JspServlet.destroy()
2014-03-24 17:32:33,768 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped org.apache.jasper.servlet.JspServlet-2007433549
2014-03-24 17:32:33,768 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped ServletHandler@7f3541d7
2014-03-24 17:32:33,769 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped org.mortbay.jetty.servlet.HashSessionManager@175cb80
2014-03-24 17:32:33,769 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped SessionHandler@6fafced9
2014-03-24 17:32:33,770 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopping ErrorHandler@1cf1df22
2014-03-24 17:32:33,770 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped ErrorHandler@1cf1df22
2014-03-24 17:32:33,770 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped org.mortbay.jetty.servlet.HashSessionIdManager@7b7597b6
2014-03-24 17:32:33,772 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped org.mortbay.thread.QueuedThreadPool@50f2fd20
2014-03-24 17:32:33,772 DEBUG main mortbay.log (Slf4jLog.java:debug(40)) -
stopped Server@4685d9a4
