[jboss-user] [JBoss Messaging] - Messages delivery stops after a while

lieth78 do-not-reply at jboss.com
Mon Nov 6 13:23:41 EST 2006


I am using JBoss 4.0.4 GA and JBoss Messaging 1.0.1 GA on Windows XP.

I have a web application that reads messages from a queue or sends messages to a queue when requested by a client.

I put 10,000 messages into the queue to create my test data.
Now I start a client that polls the web application and loops to try and receive one JMS message : at the beginning, everything works fine, 

jboss.jms.server.endpoint.ServerSessionEndpoint] creating consumer for JBossQueue[BBrQueueFillerTest], selector null, subscription null
2006-11-06 19:07:04,974 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483642] constructed
2006-11-06 19:07:04,974 DEBUG [org.jboss.jms.server.ServerPeer] ServerPeer [server.0] caching consumer -2147483642
2006-11-06 19:07:04,974 DEBUG [org.jboss.jms.server.endpoint.ServerSessionEndpoint] created and registered ConsumerEndpoint[-2147483642]
2006-11-06 19:07:04,974 DEBUG [org.jboss.jms.server.endpoint.ServerConnectionEndpoint] ConnectionEndpoint[-2147483646] started
2006-11-06 19:07:04,990 DEBUG [org.jboss.jms.client.JBossSession] attempting to create consumer for destination:JBossQueue[BBrQueueFillerTest]
2006-11-06 19:07:04,990 DEBUG [org.jboss.jms.server.endpoint.ServerSessionEndpoint] creating consumer for JBossQueue[BBrQueueFillerTest], selector null, subscription null
2006-11-06 19:07:04,990 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483641] constructed
2006-11-06 19:07:04,990 DEBUG [org.jboss.jms.server.ServerPeer] ServerPeer [server.0] caching consumer -2147483641
2006-11-06 19:07:04,990 DEBUG [org.jboss.jms.server.endpoint.ServerSessionEndpoint] created and registered ConsumerEndpoint[-2147483641]
2006-11-06 19:07:04,990 DEBUG [org.jboss.jms.server.endpoint.ServerConnectionEndpoint] ConnectionEndpoint[-2147483646] started

...



but after about 25 messages, I have the following messages in the JBoss log, and further receive calls return empty results (the queue still contains many messages, but none is returned any more!):




2006-11-06 19:08:22,158 WARN  [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] Reference[1449]:RELIABLE has exceed maximum delivery attempts and will be removed
2006-11-06 19:08:22,158 DEBUG [org.jboss.jms.client.remoting.MessageCallbackHandler] MessageCallbackHandler[-2147483643] closing
2006-11-06 19:08:22,158 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483643] NOT started yet!
2006-11-06 19:08:22,158 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483643] NOT started yet!
2006-11-06 19:08:22,174 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483643] NOT started yet!
2006-11-06 19:08:22,174 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483643] NOT started yet!
2006-11-06 19:08:22,174 DEBUG [org.jboss.jms.client.container.ClosedInterceptor] ClosedInterceptor.ClientConsumerDelegate[-2147483643] closed
2006-11-06 19:08:22,174 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483586] NOT started yet!
2006-11-06 19:08:22,174 DEBUG [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] ConsumerEndpoint[-2147483586] NOT started yet!
2006-11-06 19:08:22,174 DEBUG [org.jboss.jms.client.remoting.MessageCallbackHandler] MessageCallbackHandler[-2147483586] closing
2006-11-06 19:08:22,174 WARN  [org.jboss.jms.server.endpoint.ServerConsumerEndpoint] Reference[1449]:RELIABLE has exceed maximum delivery attempts and will be removed
...


And then, when I stop the client, further errors are displayed in JBoss log:

19:08:32,392 ERROR [ExceptionUtil] ConsumerEndpoint[-2147483592] closing [aac2v-hgilj8-eu76poci-1-eu76u3d4-r]
javax.jms.IllegalStateException: Cannot find delivery to cancel:-2147483592
        at org.jboss.jms.server.endpoint.ServerConsumerEndpoint.cancelDelivery(ServerConsumerEndpoint.java:583)
        at org.jboss.jms.server.endpoint.ServerConsumerEndpoint.stop(ServerConsumerEndpoint.java:665)
        at org.jboss.jms.server.endpoint.ServerConsumerEndpoint.closing(ServerConsumerEndpoint.java:336)
        at org.jboss.jms.server.endpoint.advised.ConsumerAdvised.org$jboss$jms$server$endpoint$advised$ConsumerAdvised$closing$aop(ConsumerAdvised.jav
a:64)
        at sun.reflect.GeneratedMethodAccessor97.invoke(Unknown Source)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:324)
        at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:112)
        at org.jboss.jms.server.container.ServerLogInterceptor.invoke(ServerLogInterceptor.java:105)
        at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101)
        at org.jboss.aop.Advisor.dynamicInvoke(Advisor.java:723)
        at org.jboss.aop.Dispatcher.invoke(Dispatcher.java:101)
        at org.jboss.jms.server.remoting.JMSServerInvocationHandler.invoke(JMSServerInvocationHandler.java:127)
        at org.jboss.remoting.ServerInvoker.invoke(ServerInvoker.java:1008)
        at org.jboss.remoting.transport.local.LocalClientInvoker.invoke(LocalClientInvoker.java:98)
        at org.jboss.remoting.Client.invoke(Client.java:589)
        at org.jboss.remoting.Client.invoke(Client.java:581)
        at org.jboss.jms.client.delegate.DelegateSupport.invoke(DelegateSupport.java:111)
        at org.jboss.jms.client.delegate.ClientConsumerDelegate$closing_4945873952494833124.invokeNext(ClientConsumerDelegate$closing_4945873952494833
124.java)
        at org.jboss.jms.client.container.ConsumerAspect.handleClosing(ConsumerAspect.java:107)
        at org.jboss.aop.advice.org.jboss.jms.client.container.ConsumerAspect26.invoke(ConsumerAspect26.java)
        at org.jboss.jms.client.delegate.ClientConsumerDelegate$closing_4945873952494833124.invokeNext(ClientConsumerDelegate$closing_4945873952494833
124.java)
        at org.jboss.jms.client.container.ClosedInterceptor.invoke(ClosedInterceptor.java:182)
        at org.jboss.aop.advice.PerInstanceInterceptor.invoke(PerInstanceInterceptor.java:117)
        at org.jboss.jms.client.delegate.ClientConsumerDelegate$closing_4945873952494833124.invokeNext(ClientConsumerDelegate$closing_4945873952494833
124.java)
        at org.jboss.jms.client.container.ExceptionInterceptor.invoke(ExceptionInterceptor.java:69)
        at org.jboss.jms.client.delegate.ClientConsumerDelegate$closing_4945873952494833124.invokeNext(ClientConsumerDelegate$closing_4945873952494833
124.java)
        at org.jboss.jms.client.container.ClientLogInterceptor.invoke(ClientLogInterceptor.java:107)
        at org.jboss.jms.client.delegate.ClientConsumerDelegate$closing_4945873952494833124.invokeNext(ClientConsumerDelegate$closing_4945873952494833
124.java)
        at org.jboss.jms.client.delegate.ClientConsumerDelegate.closing(ClientConsumerDelegate.java)
        at org.jboss.jms.client.container.ClosedInterceptor.maintainRelatives(ClosedInterceptor.java:300)
        at org.jboss.jms.client.container.ClosedInterceptor.invoke(ClosedInterceptor.java:177)
        at org.jboss.aop.advice.PerInstanceInterceptor.invoke(PerInstanceInterceptor.java:117)
        at org.jboss.jms.client.delegate.ClientSessionDelegate$closing_4945873952494833124.invokeNext(ClientSessionDelegate$closing_494587395249483312
4.java)
        at org.jboss.jms.client.container.ExceptionInterceptor.invoke(ExceptionInterceptor.java:69)
        at org.jboss.jms.client.delegate.ClientSessionDelegate$closing_4945873952494833124.invokeNext(ClientSessionDelegate$closing_494587395249483312
4.java)
        at org.jboss.jms.client.container.ClientLogInterceptor.invoke(ClientLogInterceptor.java:107)
        at org.jboss.jms.client.delegate.ClientSessionDelegate$closing_4945873952494833124.invokeNext(ClientSessionDelegate$closing_494587395249483312
4.java)
        at org.jboss.jms.client.delegate.ClientSessionDelegate.closing(ClientSessionDelegate.java)
        at org.jboss.jms.client.container.ClosedInterceptor.maintainRelatives(ClosedInterceptor.java:300)
        at org.jboss.jms.client.container.ClosedInterceptor.invoke(ClosedInterceptor.java:177)
        at org.jboss.aop.advice.PerInstanceInterceptor.invoke(PerInstanceInterceptor.java:117)
        at org.jboss.jms.client.delegate.ClientConnectionDelegate$closing_4945873952494833124.invokeNext(ClientConnectionDelegate$closing_494587395249
4833124.java)
        at org.jboss.jms.client.container.ExceptionInterceptor.invoke(ExceptionInterceptor.java:69)
        at org.jboss.jms.client.delegate.ClientConnectionDelegate$closing_4945873952494833124.invokeNext(ClientConnectionDelegate$closing_494587395249
4833124.java)
        at org.jboss.jms.client.container.ClientLogInterceptor.invoke(ClientLogInterceptor.java:107)
        at org.jboss.jms.client.delegate.ClientConnectionDelegate$closing_4945873952494833124.invokeNext(ClientConnectionDelegate$closing_494587395249
4833124.java)
        at org.jboss.jms.client.delegate.ClientConnectionDelegate.closing(ClientConnectionDelegate.java)
        at org.jboss.jms.client.JBossConnection.close(JBossConnection.java:131)
        at com.systar.gateway.services.jms.JMSQueueService.endService(JMSQueueService.java:150)
        at com.systar.gateway.services.GatewayService.stop(GatewayService.java:269)
        at com.systar.gateway.services.GatewayService.stop(GatewayService.java:230)
        at com.systar.gateway.services.JavaGateway.stopService(JavaGateway.java:107)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:324)
        at org.apache.axis.providers.java.RPCProvider.invokeMethod(RPCProvider.java:397)
        at org.apache.axis.providers.java.RPCProvider.processMessage(RPCProvider.java:186)
        at org.apache.axis.providers.java.JavaProvider.invoke(JavaProvider.java:323)
        at org.apache.axis.strategies.InvocationStrategy.visit(InvocationStrategy.java:32)
        at org.apache.axis.SimpleChain.doVisiting(SimpleChain.java:118)
        at org.apache.axis.SimpleChain.invoke(SimpleChain.java:83)
        at org.apache.axis.handlers.soap.SOAPService.invoke(SOAPService.java:454)
        at org.apache.axis.server.AxisServer.invoke(AxisServer.java:281)
        at org.apache.axis.transport.http.AxisServlet.doPost(AxisServlet.java:699)
        at com.systar.gateway.SystarAxisServlet.doPost(SystarAxisServlet.java:86)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
        at org.apache.axis.transport.http.AxisServletBase.service(AxisServletBase.java:327)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:810)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
        at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
        at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
        at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
        at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:175)
        at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:74)
        at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
        at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
        at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
        at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
        at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:869)
        at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:664)
        at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527)
        at org.apache.tomcat.util.net.MasterSlaveWorkerThread.run(MasterSlaveWorkerThread.java:112)
        at java.lang.Thread.run(Thread.java:534)


I tried with both Hypersonic and MySql as persistence manager, and tried several isolation levels with MySql too (TRANSACTION_SERIALIZABLE, TRANSACTION_READ_COMMITTED, TRANSACTION_REPEATABLE_READ) but I get the same result...

The web application and its client together work perfectly with JBossMQ, so I think the problem does not come from the code itself...

Any idea of what is happenning when using JBoss Messaging?

View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=3983516#3983516

Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=3983516



More information about the jboss-user mailing list