Petals BC SOAP

As consumer, the timeout of a sendSync is not properly logged

Details

  • Type: Bug Bug
  • Status: Resolved Resolved
  • Priority: Minor Minor
  • Resolution: Fixed
  • Affects Version/s: 4.0.3
  • Fix Version/s: 4.0.3
  • Component/s: None
  • Security Level: Public
  • Description:
    Hide

    When acting as a consumer, the component use the sendSync method. When a timeout occured, the component log the event as a SEVERE error and log the stack trace.
    Moreover the log instance used is not proper, it the 'Root' logger whereas it should been the component's logger.

    [Petals.Container.Components.petals-bc-soap]-FINE 2010-07-23 16:27:18,921 Accepting a JBI message with Id : petals:uid:F145BD5CDB11CF362E271399686931661
    [Petals.Container.Components.petals-bc-soap]-FINEST 2010-07-23 16:27:18,925 Process an exchange as PROVIDER with id : petals:uid:F145BD5CDB11CF362E271399686931661
    [Petals.Container.Components.petals-bc-soap]-FINE 2010-07-23 16:27:18,926 Intercepting message processing on ACCEPT
    [Petals.Transporter.LocalTransporter]-WARNING 2010-07-23 16:27:18,929 Failed to send synchronously the exchange: petals:uid:F145BD5CDB11CF362E271399686931661. Timeout occured
    [Root]-SEVERE 2010-07-23 16:27:18,932 A timeout occurs calling the consumed service.
    org.apache.axis2.AxisFault: A timeout occurs calling the consumed service.
    at org.ow2.petals.binding.soap.listener.incoming.SOAPProcessor.process(SOAPProcessor.java:146)
    at org.ow2.petals.binding.soap.listener.incoming.PetalsReceiver.process(PetalsReceiver.java:173)
    at org.ow2.petals.binding.soap.listener.incoming.PetalsReceiver.invokeBusinessLogic(PetalsReceiver.java:123)
    at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100)
    at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176)
    at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
    at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133)
    at org.ow2.petals.binding.soap.listener.incoming.servlet.SoapServlet.doPost(SoapServlet.java:121)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:760)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:853)
    at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487)
    at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:362)
    at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
    at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:726)
    at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
    at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
    at org.mortbay.jetty.Server.handle(Server.java:324)
    at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505)
    at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:842)
    at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:648)
    at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211)
    at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380)
    at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395)
    at org.mortbay.thread.BoundedThreadPool$PoolThread.run(BoundedThreadPool.java:450)
    [Petals.Container.Components.petals-bc-soap]-SEVERE 2010-07-23 16:27:18,936 The MessageExchange has been closed by an other component
    java.lang.IllegalStateException: The MessageExchange has been closed by an other component
    at org.ow2.petals.jbi.messaging.exchange.MessageExchangeDecorator.checkComponentOwnsExchange(MessageExchangeDecorator.java:368)
    at org.ow2.petals.jbi.messaging.exchange.MessageExchangeDecorator.getRole(MessageExchangeDecorator.java:221)
    at org.ow2.petals.component.framework.message.ExchangeImpl.getRole(ExchangeImpl.java:716)
    at org.ow2.petals.component.framework.message.ExchangeImpl.isProviderRole(ExchangeImpl.java:838)
    at org.ow2.petals.component.framework.process.MessageExchangeProcessor.process(MessageExchangeProcessor.java:235)
    at org.ow2.petals.component.framework.process.MessageExchangeProcessor.run(MessageExchangeProcessor.java:177)
    at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
    at java.lang.Thread.run(Thread.java:619)

    Show
    When acting as a consumer, the component use the sendSync method. When a timeout occured, the component log the event as a SEVERE error and log the stack trace. Moreover the log instance used is not proper, it the 'Root' logger whereas it should been the component's logger. [Petals.Container.Components.petals-bc-soap]-FINE 2010-07-23 16:27:18,921 Accepting a JBI message with Id : petals:uid:F145BD5CDB11CF362E271399686931661 [Petals.Container.Components.petals-bc-soap]-FINEST 2010-07-23 16:27:18,925 Process an exchange as PROVIDER with id : petals:uid:F145BD5CDB11CF362E271399686931661 [Petals.Container.Components.petals-bc-soap]-FINE 2010-07-23 16:27:18,926 Intercepting message processing on ACCEPT [Petals.Transporter.LocalTransporter]-WARNING 2010-07-23 16:27:18,929 Failed to send synchronously the exchange: petals:uid:F145BD5CDB11CF362E271399686931661. Timeout occured [Root]-SEVERE 2010-07-23 16:27:18,932 A timeout occurs calling the consumed service. org.apache.axis2.AxisFault: A timeout occurs calling the consumed service. at org.ow2.petals.binding.soap.listener.incoming.SOAPProcessor.process(SOAPProcessor.java:146) at org.ow2.petals.binding.soap.listener.incoming.PetalsReceiver.process(PetalsReceiver.java:173) at org.ow2.petals.binding.soap.listener.incoming.PetalsReceiver.invokeBusinessLogic(PetalsReceiver.java:123) at org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:100) at org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:176) at org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275) at org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:133) at org.ow2.petals.binding.soap.listener.incoming.servlet.SoapServlet.doPost(SoapServlet.java:121) at javax.servlet.http.HttpServlet.service(HttpServlet.java:760) at javax.servlet.http.HttpServlet.service(HttpServlet.java:853) at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487) at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:362) at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181) at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:726) at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114) at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152) at org.mortbay.jetty.Server.handle(Server.java:324) at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:505) at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:842) at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:648) at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211) at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:380) at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:395) at org.mortbay.thread.BoundedThreadPool$PoolThread.run(BoundedThreadPool.java:450) [Petals.Container.Components.petals-bc-soap]-SEVERE 2010-07-23 16:27:18,936 The MessageExchange has been closed by an other component java.lang.IllegalStateException: The MessageExchange has been closed by an other component at org.ow2.petals.jbi.messaging.exchange.MessageExchangeDecorator.checkComponentOwnsExchange(MessageExchangeDecorator.java:368) at org.ow2.petals.jbi.messaging.exchange.MessageExchangeDecorator.getRole(MessageExchangeDecorator.java:221) at org.ow2.petals.component.framework.message.ExchangeImpl.getRole(ExchangeImpl.java:716) at org.ow2.petals.component.framework.message.ExchangeImpl.isProviderRole(ExchangeImpl.java:838) at org.ow2.petals.component.framework.process.MessageExchangeProcessor.process(MessageExchangeProcessor.java:235) at org.ow2.petals.component.framework.process.MessageExchangeProcessor.run(MessageExchangeProcessor.java:177) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) at java.lang.Thread.run(Thread.java:619)
  • Environment:
    os: all

Activity

People

  • Assignee:
    noddoux
    Reporter:
    noddoux
  • Watchers:
    0

Dates

  • Created:
    Fri, 23 Jul 2010 - 16:29:37 +0200
    Updated:
    Wed, 15 Sep 2010 - 10:07:29 +0200
    Resolved:
    Wed, 28 Jul 2010 - 17:35:13 +0200