Harm

I'm really surprised by this. The system is under load much higher than 
this in many sites. We will take a look. I haven't seen the message 
"Request Already Submitted", so that should give us a clue. Thanks for 
the detailed feedback. Can you also include the SOAP message you are 
submitting?

Paul

Harm Verhagen wrote:
> 
> 
> 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 <http://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 <http://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

-- 
Paul Fremantle
CTO and Co-Founder, WSO2
OASIS WS-RX TC Co-chair
VP, Apache Synapse

Office: +44 844 484 8143
Cell: +44 798 447 4618

blog: http://pzf.fremantle.org
[EMAIL PROTECTED]

"Oxygenating the Web Service Platform", www.wso2.com

_______________________________________________
Esb-java-user mailing list
[email protected]
http://mailman.wso2.org/cgi-bin/mailman/listinfo/esb-java-user

Reply via email to