Hi folks,
I'm experiencing very unstable connections when I use the wso2 ESB to proxy
a soap interface.
I guess this problem makes it unusable for production.
To test I'm using soapui (www.soapui.org) to issue soap requests on the
"messageDelivery" interface.
Whenever I use my servers soap interface directly everything works stable,
but when I let the ESB proxy this interface the ESB stops working even when
under low load.
Whenever I do multiple soap requests sequentially, (still low load, every
second one request).
I see the ESB already barf after proxying 3 or 4 messages.
Its _very_ easy to reproduce, I never can issue (manually) more then 4 soap
requests without getting this error.
*what error do I see:*
from ESB logging.
2008-09-16 15:33:29,157 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] ERROR
ClientHandler Unexpected HTTP protocol error: Request already submitted
org.apache.http.HttpException: Request already submitted
at
org.apache.http.impl.nio.DefaultNHttpClientConnection.submitRequest(DefaultNHttpClientConnection.java:203)
This looks a bit like synapse ticket 344
https://issues.apache.org/jira/browse/SYNAPSE-344
except that I see this problem already under very low loads.
Does anyone have clue whats going on here ?
Or better, does anyone now a fix/workaround ?
*complete error log*
2008-09-16 15:33:29,141 [127.0.0.1-vloeki_v01] [HttpClientWorker-8] DEBUG
SendMediator End : Send mediator
2008-09-16 15:33:29,142 [127.0.0.1-vloeki_v01] [HttpClientWorker-8] DEBUG
SequenceMediator End : Sequence <out>
2008-09-16 15:33:29,152 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
ProxyServiceMessageReceiver Proxy Service messageDelivery received a n
ew message from : 192.168.6.142
2008-09-16 15:33:29,152 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
ProxyServiceMessageReceiver Message To: /soap/messageDelivery
2008-09-16 15:33:29,152 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
ProxyServiceMessageReceiver SOAPAction:
2008-09-16 15:33:29,152 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
ProxyServiceMessageReceiver WSA-Action:
2008-09-16 15:33:29,153 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
ProxyServiceMessageReceiver Using sequence named : md_seq for incoming
message mediation
2008-09-16 15:33:29,153 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
SequenceMediator Start : Sequence <md_seq>
2008-09-16 15:33:29,153 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
SequenceMediator Sequence <SequenceMediator> :: mediate()
2008-09-16 15:33:29,154 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
SendMediator Start : Send mediator
2008-09-16 15:33:29,154 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
AddressEndpoint Start : Address Endpoint
2008-09-16 15:33:29,154 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
AddressEndpoint Sending message to endpoint : AnonymousEndpoint resolv
es to address =
http://localhost:8180/boost-platform/services/messageDelivery
2008-09-16 15:33:29,154 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
AddressEndpoint SOAPAction:
2008-09-16 15:33:29,155 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
AddressEndpoint WSA-Action:
2008-09-16 15:33:29,155 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
Axis2FlexibleMEPClient Sending [add = false] [sec = false] [rm = false
] [mtom = false] [swa = false] [format = null] [force soap11=false] [force
soap12=false] [pox=false] [get=false] [encoding=null] [to Address: /s
oap/messageDelivery]
2008-09-16 15:33:29,155 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
SynapseCallbackReceiver Callback added. Total callbacks waiting for :
1
2008-09-16 15:33:29,157 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] ERROR
ClientHandler Unexpected HTTP protocol error: Request already submitte
d
org.apache.http.HttpException: Request already submitted
at
org.apache.http.impl.nio.DefaultNHttpClientConnection.submitRequest(DefaultNHttpClientConnection.java:203)
at
org.apache.synapse.transport.nhttp.ClientHandler.submitRequest(ClientHandler.java:142)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOSender.sendAsyncRequest(HttpCoreNIOSender.java:340)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOSender.invoke(HttpCoreNIOSender.java:256)
at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:448)
at
org.apache.synapse.core.axis2.DynamicAxisOperation$DynamicOperationClient.send(DynamicAxisOperation.java:190)
at
org.apache.synapse.core.axis2.DynamicAxisOperation$DynamicOperationClient.executeImpl(DynamicAxisOperation.java:174)
at
org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
at
org.apache.synapse.core.axis2.Axis2FlexibleMEPClient.send(Axis2FlexibleMEPClient.java:288)
at
org.apache.synapse.core.axis2.Axis2Sender.sendOn(Axis2Sender.java:57)
at
org.apache.synapse.core.axis2.Axis2SynapseEnvironment.send(Axis2SynapseEnvironment.java:222)
at
org.apache.synapse.endpoints.AddressEndpoint.send(AddressEndpoint.java:195)
at
org.apache.synapse.mediators.builtin.SendMediator.mediate(SendMediator.java:157)
at
org.apache.synapse.mediators.AbstractListMediator.mediate(AbstractListMediator.java:58)
at
org.apache.synapse.mediators.base.SequenceMediator.mediate(SequenceMediator.java:125)
at
org.apache.synapse.core.axis2.ProxyServiceMessageReceiver.receive(ProxyServiceMessageReceiver.java:149)
at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
at
org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
at
org.apache.synapse.transport.nhttp.ServerWorker.processPost(ServerWorker.java:253)
at
org.apache.synapse.transport.nhttp.ServerWorker.run(ServerWorker.java:194)
at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
at java.lang.Thread.run(Thread.java:619)
2008-09-16 15:33:29,159 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
SendMediator End : Send mediator
2008-09-16 15:33:29,160 [127.0.0.1-vloeki_v01] [HttpServerWorker-9] DEBUG
SequenceMediator End : Sequence <md_seq>
2008-09-16 15:33:29,161 [127.0.0.1-vloeki_v01] [HttpClientWorker-9] DEBUG
SynapseCallbackReceiver Callback removed. Pending callbacks count : 0
2008-09-16 15:33:29,162 [127.0.0.1-vloeki_v01] [HttpClientWorker-9] WARN
FaultHandler Fault handler - setting ERROR_MESSAGE : Abnormal connecti
on close
2008-09-16 15:33:29,163 [127.0.0.1-vloeki_v01] [HttpClientWorker-9] WARN
FaultHandler Fault handler - setting ERROR_DETAIL : java.lang.Exceptio
:
*ESB config*
I'm using a simple wdsl proxy, no extra processing, translations etc...
<?xml version="1.0" encoding="UTF-8"?>
<syn:definitions xmlns:syn="http://ws.apache.org/ns/synapse";>
<syn:registry provider="org.wso2.esb.registry.WSO2Registry"/>
<syn:proxy name="messageDelivery" startOnLoad="true">
<syn:target inSequence="md_seq" outSequence="out"/>
<syn:publishWSDL uri="
http://localhost:8180/boost-platform/services/messageDelivery?wsdl"/>
</syn:proxy>
<syn:sequence name="md_seq">
<syn:send>
<syn:endpoint>
<syn:address uri="
http://localhost:8180/boost-platform/services/messageDelivery"/>
</syn:endpoint>
</syn:send>
</syn:sequence>
<syn:sequence name="fault">
<syn:log/>
</syn:sequence>
<syn:sequence statistics="enable" name="main" trace="enable">
<syn:in>
<syn:log level="full"/>
</syn:in>
<syn:out>
<syn:send/>
</syn:out>
</syn:sequence>
<syn:sequence name="out">
<syn:send/>
</syn:sequence>
</syn:definitions>
*version:
*wso2-esb-java-1.7.1 on debian. (java 6 (also tried 5)
Regards,
Harm
_______________________________________________
Esb-java-user mailing list
[email protected]
http://mailman.wso2.org/cgi-bin/mailman/listinfo/esb-java-user
