"Guillaume Nodet" <[EMAIL PROTECTED]> wrote in
message news:[EMAIL PROTECTED]
> Do you any exception logged when you run this test ?
>
Here is the debug log. I didn't see anything that stood out. The only
exception is the HttpClient timing out.
I appreciate the help.
Thanks,
James
-----------------------------------------
2006-08-18 09:24:28,265 [main ] DEBUG
- enter HttpClient.executeMethod(HttpMethod)
2006-08-18 09:24:28,265 [main ] DEBUG
- enter
HttpClient.executeMethod(HostConfiguration,HttpMethod,HttpState)
2006-08-18 09:24:28,265 [main ] DEBUG
rector - Attempt number 1 to process request
2006-08-18 09:24:28,265 [main ] DEBUG
- enter HttpConnection.open()
2006-08-18 09:24:28,265 [main ] DEBUG
- Open connection to localhost:8192
2006-08-18 09:24:28,280 [main ] DEBUG
- enter HttpMethodBase.execute(HttpState, HttpConnection)
2006-08-18 09:24:28,280 [main ] DEBUG
- enter HttpMethodBase.writeRequest(HttpState,
HttpConnection)
2006-08-18 09:24:28,280 [main ] DEBUG
- enter HttpMethodBase.writeRequestLine(HttpState,
HttpConnection)
2006-08-18 09:24:28,280 [main ] DEBUG
- enter HttpMethodBase.generateRequestLine(HttpConnection,
String, String, String, String)
2006-08-18 09:24:28,296 [main ] DEBUG
- >> "POST /PingService/ HTTP/1.1[\r][\n]"
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.print(String)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[])
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[], int, int)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter
HttpMethodBase.writeRequestHeaders(HttpState,HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
losingMethod - enter
EntityEnclosingMethod.addRequestHeaders(HttpState, HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
inueMethod - enter
ExpectContinueMethod.addRequestHeaders(HttpState, HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpMethodBase.addRequestHeaders(HttpState,
HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpMethodBase.addUserAgentRequestHeaders(HttpState,
HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpMethodBase.addHostRequestHeader(HttpState,
HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
- Adding Host request header
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpMethodBase.addCookieRequestHeader(HttpState,
HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpState.getCookies()
2006-08-18 09:24:28,312 [main ] DEBUG
- enter CookieSpecBase.match(String, int, String, boolean,
Cookie[])
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpMethodBase.addProxyConnectionHeader(HttpState,
HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
losingMethod - enter
EntityEnclosingMethod.addContentLengthRequestHeader(HttpState,
HttpConnection)
2006-08-18 09:24:28,312 [main ] DEBUG
losingMethod - enter
EntityEnclosingMethod.getRequestContentLength()
2006-08-18 09:24:28,312 [main ] DEBUG
- enter PostMethod.hasRequestContent()
2006-08-18 09:24:28,312 [main ] DEBUG
losingMethod - enter EntityEnclosingMethod.hasRequestContent()
2006-08-18 09:24:28,312 [main ] DEBUG
- HttpMethodBase.addRequestHeader(Header)
2006-08-18 09:24:28,312 [main ] DEBUG
losingMethod - enter EntityEnclosingMethod.renerateRequestBody()
2006-08-18 09:24:28,312 [main ] DEBUG
- >> "User-Agent: Jakarta Commons-HttpClient/3.0[\r][\n]"
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.print(String)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[])
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[], int, int)
2006-08-18 09:24:28,312 [main ] DEBUG
- >> "Host: localhost:8192[\r][\n]"
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.print(String)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[])
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[], int, int)
2006-08-18 09:24:28,312 [main ] DEBUG
- >> "Content-Length: 284[\r][\n]"
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.print(String)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[])
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.write(byte[], int, int)
2006-08-18 09:24:28,312 [main ] DEBUG
- enter HttpConnection.writeLine()
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpConnection.write(byte[])
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpConnection.write(byte[], int, int)
2006-08-18 09:24:28,327 [main ] DEBUG
- >> "[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
losingMethod - enter
EntityEnclosingMethod.writeRequestBody(HttpState, HttpConnection)
2006-08-18 09:24:28,327 [main ] DEBUG
- enter PostMethod.hasRequestContent()
2006-08-18 09:24:28,327 [main ] DEBUG
losingMethod - enter EntityEnclosingMethod.hasRequestContent()
2006-08-18 09:24:28,327 [main ] DEBUG
losingMethod - enter
EntityEnclosingMethod.getRequestContentLength()
2006-08-18 09:24:28,327 [main ] DEBUG
- enter PostMethod.hasRequestContent()
2006-08-18 09:24:28,327 [main ] DEBUG
losingMethod - enter EntityEnclosingMethod.hasRequestContent()
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpConnection.getRequestOutputStream()
2006-08-18 09:24:28,327 [main ] DEBUG
- >> "<?xml version="1.0"?>[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
- >> "<soapenv:Envelope
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";
xmlns:urn="urn:servicemix:soap-binding">[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
- >> " <soapenv:Body>[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
- >> " <urn:ping>[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
- >> " <urn:request>MESSAGE IN</urn:request>[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
- >> " </urn:ping>[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
- >> " </soapenv:Body>[\r][\n]"
2006-08-18 09:24:28,327 [main ] DEBUG
- >> "</soapenv:Envelope>"
2006-08-18 09:24:28,327 [main ] DEBUG
losingMethod - Request body sent
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpConnection.flushRequestOutputStream()
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpMethodBase.readResponse(HttpState,
HttpConnection)
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpMethodBase.readStatusLine(HttpState,
HttpConnection)
2006-08-18 09:24:28,327 [ @ 0.0.0.0:8192] DEBUG
- Dispatching job: [EMAIL PROTECTED],io=0,w=true,b=0|0]
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpConnection.readLine()
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpParser.readLine(InputStream, String)
2006-08-18 09:24:28,327 [main ] DEBUG
- enter HttpParser.readRawLine()
2006-08-18 09:24:28,327 [- /PingService/] DEBUG
- REQUEST /PingService/ on [EMAIL PROTECTED]
2006-08-18 09:24:28,327 [- /PingService/] DEBUG
- servlet=jbiServlet
2006-08-18 09:24:28,327 [- /PingService/] DEBUG
- chain=null
2006-08-18 09:24:28,327 [- /PingService/] DEBUG
- servelet holder=jbiServlet
2006-08-18 09:24:28,874 [- /PingService/] DEBUG
nnelImpl - Send ID:iConnectJavaDev-3996-1155907363421-2:0 in
DeliveryChannel{HttpComponent}
2006-08-18 09:24:29,124 [- /PingService/] DEBUG
nnelImpl - Sent: MessageExchange[
id: ID:iConnectJavaDev-3996-1155907363421-2:0
status: Active
role: consumer
service: {urn:servicemix:soap-binding}simple-JSR-service
endpoint: simple-JSR-service-endpoint
operation: {urn:servicemix:soap-binding}ping
in: <?xml version="1.0" encoding="UTF-8"?><urn:ping
xmlns:urn="urn:servicemix:soap-binding"
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><urn:request>MESSAGE
IN</urn:request></urn:ping>
]
2006-08-18 09:24:29,140 [- /PingService/] DEBUG
- Routing exchange MessageExchange[
id: ID:iConnectJavaDev-3996-1155907363421-2:0
status: Active
role: provider
service: {urn:servicemix:soap-binding}simple-JSR-service
endpoint: simple-JSR-service-endpoint
operation: {urn:servicemix:soap-binding}ping
in: <?xml version="1.0" encoding="UTF-8"?><urn:ping
xmlns:urn="urn:servicemix:soap-binding"
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><urn:request>MESSAGE
IN</urn:request></urn:ping>
] to:
ServiceEndpoint[service={urn:servicemix:soap-binding}simple-JSR-service,endpoint=simple-JSR-service-endpoint]
2006-08-18 09:24:29,140 [- /PingService/] DEBUG
- Called Flow send
2006-08-18 09:24:29,140 [- /PingService/] DEBUG
nnelImpl - Processing inbound exchange: MessageExchange[
id: ID:iConnectJavaDev-3996-1155907363421-2:0
status: Active
role: provider
service: {urn:servicemix:soap-binding}simple-JSR-service
endpoint: simple-JSR-service-endpoint
operation: {urn:servicemix:soap-binding}ping
in: <?xml version="1.0" encoding="UTF-8"?><urn:ping
xmlns:urn="urn:servicemix:soap-binding"
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><urn:request>MESSAGE
IN</urn:request></urn:ping>
]
2006-08-18 09:24:29,140 [- /PingService/] DEBUG
nnelImpl - Received: MessageExchange[
id: ID:iConnectJavaDev-3996-1155907363421-2:0
status: Active
role: provider
service: {urn:servicemix:soap-binding}simple-JSR-service
endpoint: simple-JSR-service-endpoint
operation: {urn:servicemix:soap-binding}ping
in: <?xml version="1.0" encoding="UTF-8"?><urn:ping
xmlns:urn="urn:servicemix:soap-binding"
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><urn:request>MESSAGE
IN</urn:request></urn:ping>
]
2006-08-18 09:24:29,155 [- /PingService/] DEBUG
- Received exchange: status: Active, role: Provider
2006-08-18 09:24:29,155 [- /PingService/] DEBUG
- Creating new channel for uri:
urn:xfire:transport:jbi:11559074691550-253729794
2006-08-18 09:24:29,187 [- /PingService/] DEBUG
- Received message to null
2006-08-18 09:24:29,202 [- /PingService/] DEBUG
- Invoking handler
org.codehaus.xfire.handler.LocateBindingHandler in phase dispatch
2006-08-18 09:24:29,202 [- /PingService/] DEBUG
- Invoking handler
org.codehaus.xfire.soap.handler.SoapBodyHandler in phase dispatch
2006-08-18 09:24:29,202 [- /PingService/] DEBUG
- Invoking handler
org.codehaus.xfire.handler.DispatchServiceHandler in phase dispatch
2006-08-18 09:24:29,202 [- /PingService/] DEBUG
- Invoking handler
org.codehaus.xfire.service.binding.ServiceInvocationHandler in phase service
PINGED: MESSAGE IN
2006-08-18 09:24:29,218 [- /PingService/] DEBUG
- Invoking handler
org.codehaus.xfire.handler.OutMessageSender in phase send
2006-08-18 09:24:29,233 [- /PingService/] DEBUG
nnelImpl - Send ID:iConnectJavaDev-3996-1155907363421-2:0 in
DeliveryChannel{JSR181Component}
2006-08-18 09:24:29,265 [- /PingService/] DEBUG
nnelImpl - Sent: MessageExchange[
id: ID:iConnectJavaDev-3996-1155907363421-2:0
status: Active
role: provider
service: {urn:servicemix:soap-binding}simple-JSR-service
endpoint: simple-JSR-service-endpoint
operation: {urn:servicemix:soap-binding}ping
in: <?xml version="1.0" encoding="UTF-8"?><urn:ping
xmlns:urn="urn:servicemix:soap-binding"
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><urn:request>MESSAGE
IN</urn:request></urn:ping>
out: <?xml version="1.0" encoding="UTF-8"?><pingResponse
xmlns="urn:servicemix:soap-binding"><out
xmlns="urn:servicemix:soap-binding">Ping: MESSAGE IN</out></pingResponse>
]
2006-08-18 09:24:29,265 [- /PingService/] DEBUG
- Called Flow send
2006-08-18 09:24:29,280 [- /PingService/] DEBUG
nnelImpl - Processing inbound exchange: MessageExchange[
id: ID:iConnectJavaDev-3996-1155907363421-2:0
status: Active
role: consumer
service: {urn:servicemix:soap-binding}simple-JSR-service
endpoint: simple-JSR-service-endpoint
operation: {urn:servicemix:soap-binding}ping
in: <?xml version="1.0" encoding="UTF-8"?><urn:ping
xmlns:urn="urn:servicemix:soap-binding"
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><urn:request>MESSAGE
IN</urn:request></urn:ping>
out: <?xml version="1.0" encoding="UTF-8"?><pingResponse
xmlns="urn:servicemix:soap-binding"><out
xmlns="urn:servicemix:soap-binding">Ping: MESSAGE IN</out></pingResponse>
]
2006-08-18 09:24:29,280 [- /PingService/] DEBUG
nnelImpl - Received: MessageExchange[
id: ID:iConnectJavaDev-3996-1155907363421-2:0
status: Active
role: consumer
service: {urn:servicemix:soap-binding}simple-JSR-service
endpoint: simple-JSR-service-endpoint
operation: {urn:servicemix:soap-binding}ping
in: <?xml version="1.0" encoding="UTF-8"?><urn:ping
xmlns:urn="urn:servicemix:soap-binding"
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><urn:request>MESSAGE
IN</urn:request></urn:ping>
out: <?xml version="1.0" encoding="UTF-8"?><pingResponse
xmlns="urn:servicemix:soap-binding"><out
xmlns="urn:servicemix:soap-binding">Ping: MESSAGE IN</out></pingResponse>
]
2006-08-18 09:24:29,280 [- /PingService/] DEBUG
- Received exchange: status: Active, role: Consumer
2006-08-18 09:24:29,296 [btpool0-2 ] DEBUG
- continuation
[EMAIL PROTECTED]
2006-08-18 09:24:58,327 [main ] DEBUG
rector - Closing the connection.
2006-08-18 09:24:58,327 [main ] DEBUG
- enter HttpConnection.close()
2006-08-18 09:24:58,327 [main ] DEBUG
- enter HttpConnection.closeSockedAndStreams()
2006-08-18 09:24:58,327 [main ] INFO
irector - I/O exception
(org.apache.commons.httpclient.NoHttpResponseException) caught when
processing request: The server localhost failed to respond
2006-08-18 09:24:58,374 [main ] DEBUG
rector - The server localhost failed to respond
org.apache.commons.httpclient.NoHttpResponseException: The server localhost
failed to respond
at
org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1835)
at
org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1590)
at
org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:995)
at
org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:397)
at
org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:170)
at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:396)
at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:324)
at com.stiles.iconnect.WeirdTest.testMe(WeirdTest.java:70)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at junit.framework.TestCase.runTest(TestCase.java:154)
at junit.framework.TestCase.runBare(TestCase.java:127)
at junit.framework.TestResult$1.protect(TestResult.java:106)
at junit.framework.TestResult.runProtected(TestResult.java:124)
at junit.framework.TestResult.run(TestResult.java:109)
at junit.framework.TestCase.run(TestCase.java:118)
at junit.framework.TestSuite.runTest(TestSuite.java:208)
at junit.framework.TestSuite.run(TestSuite.java:203)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.runTests(RemoteTestRunner.java:478)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.run(RemoteTestRunner.java:344)
at
org.eclipse.jdt.internal.junit.runner.RemoteTestRunner.main(RemoteTestRunner.java:196)
2006-08-18 09:24:58,421 [main ] INFO
irector - Retrying request
2006-08-18 09:24:58,421 [main ] DEBUG
rector - Attempt number 2 to process request
At this point in time the request tries again until, after the 4th failure,
the HttpClient throws a NoHttpResponseException.
------------------
