[
https://issues.apache.org/jira/browse/HTTPCLIENT-1012?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12920729#action_12920729
]
chowdareddy somu commented on HTTPCLIENT-1012:
----------------------------------------------
Hi Oleg,
Thanks for you reply.. we are releasing the connection in our application when
ever any exception happens by calling consumeContent() or abort() method..
though i'm suspecting that when there is any exception happens connection is
not getting to back to pool..
My question is there if any socket connection exception happens while executing
the Http Request then the response object is null so there is nothing to
consume the content, what happens in this case.. will that connection is going
back to the pool? or it just expires? If I close the expiry connection using
the closeExpiredConnections() method , will it create new connection for that??
And I have small test program where I can get socket connection exception(by
giving Socket timeout low).. here is there debug info... I don't understand why
it says, connection Closed, connection shut down and released connection is not
reusable?
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:484 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:109 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:125 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 0,
allocated: 0 out of 5
2010/10/13 15:22:38:125 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:125 EDT [DEBUG] ConnPoolByRoute - Available capacity: 5 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:125 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 1,
allocated: 1 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 4 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 2,
allocated: 2 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 3 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 3,
allocated: 3 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 2 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:140 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:203 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984462 HTTP/1.1
2010/10/13 15:22:38:203 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984467 HTTP/1.1
2010/10/13 15:22:38:203 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984469 HTTP/1.1
2010/10/13 15:22:38:203 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984468 HTTP/1.1
2010/10/13 15:22:38:203 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984466 HTTP/1.1
2010/10/13 15:22:38:250 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:265 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:265 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:265 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:265 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:265 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:265 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:265 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:265 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]<?xml version="1.0"
encoding="UTF-8" standalone="yes"?><DocFrosting><mindex><comp dbid="A29324168"
type="ABS"><rep dbid="A30971068"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984469</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:265 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324146" type="ABS"><rep
dbid="A30971046"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984462</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:265 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 2,
allocated: 2 out of 5
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Available capacity: 3 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324164" type="ABS"><rep
dbid="A30971064"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984467</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:265 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 3,
allocated: 3 out of 5
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Available capacity: 2 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:265 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:281 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984462 HTTP/1.1
2010/10/13 15:22:38:281 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984467 HTTP/1.1
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:281 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:281 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984465 HTTP/1.1
2010/10/13 15:22:38:296 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:296 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:296 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:296 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:296 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:296 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:130)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:127)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:233)
at
org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:210)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:271)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:233)
at
org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:209)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:292)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:126)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:483)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:597)
at
com.proquest.services.ems.ConnectionReuseTest$WorkerThread.run(ConnectionReuseTest.java:129)
2010/10/13 15:22:38:296 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:296 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:296 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:296 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:296 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:296 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:296 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:296 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:296 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:130)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:127)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:233)
at
org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:210)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:271)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:233)
at
org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:209)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:292)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:126)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:483)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:597)
at
com.proquest.services.ems.ConnectionReuseTest$WorkerThread.run(ConnectionReuseTest.java:129)
2010/10/13 15:22:38:312 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984460 HTTP/1.1
2010/10/13 15:22:38:312 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984463 HTTP/1.1
2010/10/13 15:22:38:312 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:312 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:312 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:312 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324146" type="ABS"><rep
dbid="A30971046"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984462</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984464 HTTP/1.1
2010/10/13 15:22:38:312 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:312 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:312 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324164" type="ABS"><rep
dbid="A30971064"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984467</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:312 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:312 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:328 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:328 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984461 HTTP/1.1
2010/10/13 15:22:38:359 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:359 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:359 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:359 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324140" type="ABS"><rep
dbid="A30971040"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984460</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:359 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:359 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984460 HTTP/1.1
2010/10/13 15:22:38:375 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:375 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:375 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:375 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:375 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:375 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:130)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:127)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:233)
at
org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:210)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:271)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:233)
at
org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:209)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:292)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:126)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:483)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:597)
at
com.proquest.services.ems.ConnectionReuseTest$WorkerThread.run(ConnectionReuseTest.java:129)
2010/10/13 15:22:38:375 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:375 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:375 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:375 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:375 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984462 HTTP/1.1
2010/10/13 15:22:38:390 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:390 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:390 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:390 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324140" type="ABS"><rep
dbid="A30971040"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984460</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 5,
allocated: 5 out of 5
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - Available capacity: 0 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:390 EDT [DEBUG] ConnPoolByRoute - Need to wait for
connection [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:390 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984460 HTTP/1.1
2010/10/13 15:22:38:406 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:406 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:406 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:406 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:130)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:127)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:233)
at
org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:210)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:271)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:233)
at
org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:209)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:292)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:126)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:483)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:597)
at
com.proquest.services.ems.ConnectionReuseTest$WorkerThread.run(ConnectionReuseTest.java:129)
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:406 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:406 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:406 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:406 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Notifying thread waiting
on pool [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:130)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:127)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:233)
at
org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:210)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:271)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:233)
at
org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:209)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:292)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:126)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:483)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:597)
at
com.proquest.services.ems.ConnectionReuseTest$WorkerThread.run(ConnectionReuseTest.java:129)
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 4,
allocated: 4 out of 5
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Available capacity: 1 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:406 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:406 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984469 HTTP/1.1
2010/10/13 15:22:38:421 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984467 HTTP/1.1
2010/10/13 15:22:38:421 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:421 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:421 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:421 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:421 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:421 EDT [DEBUG] ConnPoolByRoute - Notifying no-one, there
are no waiting threads
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:130)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:127)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:233)
at
org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:210)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:271)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:233)
at
org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:209)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:292)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:126)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:483)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:597)
at
com.proquest.services.ems.ConnectionReuseTest$WorkerThread.run(ConnectionReuseTest.java:129)
2010/10/13 15:22:38:453 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:453 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:453 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Notifying no-one, there
are no waiting threads
2010/10/13 15:22:38:453 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 3,
allocated: 3 out of 5
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Available capacity: 2 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:453 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324164" type="ABS"><rep
dbid="A30971064"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984467</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
<?xml version="1.0" encoding="UTF-8"
standalone="yes"?><DocFrosting><mindex><comp dbid="A29324168" type="ABS"><rep
dbid="A30971068"
type="ABS"><rights>R1</rights><mimetype>text/xml</mimetype><repattrib
name="resides">FAST</repattrib></rep></comp><comp type="CIT"><rep
type="CIT"><rights>R1</rights><repattrib
name="resides">FAST</repattrib></rep></comp><relatedId rel="dup"
idType="44">9984469</relatedId></mindex><rmap><rclass><rights>R1</rights><product>1007813|1007946</product><advancedFmt>false</advancedFmt></rclass></rmap><searchRights><appearsIn><product>1007813|1007946</product></appearsIn></searchRights></DocFrosting>
2010/10/13 15:22:38:453 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:453 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Notifying no-one, there
are no waiting threads
2010/10/13 15:22:38:453 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 3,
allocated: 3 out of 5
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Available capacity: 2 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:453 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
2010/10/13 15:22:38:453 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984467 HTTP/1.1
2010/10/13 15:22:38:453 EDT [DEBUG] DefaultClientConnection - Sending request:
GET /documentfrosting/object/9984469 HTTP/1.1
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Connection closed
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:484 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute - Notifying no-one, there
are no waiting threads
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:130)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:127)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:233)
at
org.apache.http.impl.conn.DefaultResponseParser.parseHead(DefaultResponseParser.java:98)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:210)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:271)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:233)
at
org.apache.http.impl.conn.AbstractClientConnAdapter.receiveResponseHeader(AbstractClientConnAdapter.java:209)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:292)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:126)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:483)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
at
org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:597)
at
com.proquest.services.ems.ConnectionReuseTest$WorkerThread.run(ConnectionReuseTest.java:129)
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Receiving
response: HTTP/1.1 200 The request has succeeded
2010/10/13 15:22:38:484 EDT [DEBUG] DefaultClientConnection - Connection shut
down
2010/10/13 15:22:38:484 EDT [DEBUG] ThreadSafeClientConnManager - Released
connection is not reusable.
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute - Releasing connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute - Notifying no-one, there
are no waiting threads
2010/10/13 15:22:38:484 EDT [DEBUG] ThreadSafeClientConnManager - Get
connection: HttpRoute[{}->http://nightlyservices.aa1.pqe:80], timeout = 0
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute -
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]] kept alive: 0, issued: 2,
allocated: 2 out of 5
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute - No free connections
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute - Available capacity: 3 out
of 5 [HttpRoute[{}->http://nightlyservices.aa1.pqe:80]][null]
2010/10/13 15:22:38:484 EDT [DEBUG] ConnPoolByRoute - Creating new connection
[HttpRoute[{}->http://nightlyservices.aa1.pqe:80]]
> ThreadSafeClientConnManager Connection pool leak issue
> -------------------------------------------------------
>
> Key: HTTPCLIENT-1012
> URL: https://issues.apache.org/jira/browse/HTTPCLIENT-1012
> Project: HttpComponents HttpClient
> Issue Type: Bug
> Components: HttpConn
> Affects Versions: 4.0.3
> Reporter: chowdareddy somu
>
> Hi,
> We are using the HttpClient4.0.3(latest) version for our application where we
> need to serve the http request to our web app by calling the underlying
> services.
> Application gets an average 50 threads at a time and we are maintaining the
> connection pool on per host basis. we configured the following HttpParam
> values.. And we are calling the abort() and consumeContent() methods if there
> are any exceptions due to backed service problem, and for success requests we
> are extracting the response using the get content method( InputStream is =
> httpResponse.getEntity().getContent())
> Application runs contionusly for 3 to 4 hrs fine, after that its getting the
> out of connections and it throws below exception..
> Config Values
> http.connection.timeout = 5000
> http.socket.timeout = 300000
> http.conn-manager.timeout = 1000
> http.conn-manager.max-per-route = 100
> http.conn-manager.max-total = 100
> private static HttpConnectionManagerFactory instance = null;
> private Map<String, ClientConnectionManager> map = new HashMap<String,
> ClientConnectionManager>();
> private HttpConnectionManagerFactory() {
> }
> public static synchronized HttpConnectionManagerFactory getInstance() {
> if (instance == null) {
> instance = new HttpConnectionManagerFactory();
> }
> return instance;
> }
> public synchronized ClientConnectionManager getConnectionManager(URI
> uri) {
> if (!map.containsKey(uri.getHost())) {
> HttpParams params =
> HttpProperties.getInstance().getHttpParams(uri);
> SchemeRegistry registry = new SchemeRegistry();
> Scheme http = new Scheme("http",
> PlainSocketFactory.getSocketFactory(), 80);
> registry.register(http);
> map.put(uri.getHost(), new
> ThreadSafeClientConnManager(params, registry));
> }
> return map.get(uri.getHost());
> }
> public HttpClient getClient(HttpUriRequest request) {
> ClientConnectionManager connectionManager =
> HttpConnectionManagerFactory.getInstance().getConnectionManager(request.getURI());
> HttpParams params =
> HttpProperties.getInstance().getHttpParams(request.getURI());
> .............
> }
> HttpClient httpClient =
> HttpClientFactory.getInstance().getClient(httpRequest);
> tracker.startTimer();
> HttpResponse httpResponse = null;
> try {
> try {
> httpResponse =
> httpClient.execute(httpRequest);
> } finally {
> tracker.stopTimer();
> }
> StatusLine statusLine =
> httpResponse.getStatusLine();
> tracker.setStatusLine(statusLine);
> ..........................
> }
> Caused by: java.io.IOException:
> org.apache.http.conn.ConnectionPoolTimeoutException: Timeout waiting for
> connection
> at
> com.proquest.services.ems.service.HttpRetrieve.getFollowingRedirection(HttpRetrieve.java:194)
> at
> com.proquest.services.ems.service.MorningstarMediaService.resolveResource(MorningstarMediaService.java:73)
> ... 46 more
> Caused by: org.apache.http.conn.ConnectionPoolTimeoutException: Timeout
> waiting for connection
> at
> org.apache.http.impl.conn.tsccm.ConnPoolByRoute.getEntryBlocking(ConnPoolByRoute.java:345)
> at
> org.apache.http.impl.conn.tsccm.ConnPoolByRoute$1.getPoolEntry(ConnPoolByRoute.java:228)
> at
> org.apache.http.impl.conn.tsccm.ThreadSafeClientConnManager$1.getConnection(ThreadSafeClientConnManager.java:172)
> at
> org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:390)
> at
> org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:641)
> at
> org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:576)
> at
> org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:554)
> at
> com.proquest.services.ems.service.HttpRetrieve.getFollowingRedirection(HttpRetrieve.java:155)
> any idea???
--
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
