[SM-1438] Exceptions while shutting down ServiceMix

• Type: Bug
• Status: Resolved
• Priority: Minor
• Resolution: Fixed
• Affects Version/s: 3.3
• Fix Version/s: 3.3.1, 3.4.0
• Assignee: Gert Vanthienen
• Reporter: Lars Heinemann
• Created: 03/Jul/08 11:51
• Updated: 09/Dec/08 11:09
• Resolved: 09/Dec/08 11:09

Description

When shutting down ServiceMix the following exceptions are thrown:

INFO - LogTask - Logging system reconfigured using file: file:/mnt/development/apache-servicemix-3.3-SNAPSHOT/conf/log4j.xml
INFO - JBIContainer - Shutting down ServiceMix JBI Container (ServiceMix) stopped
ERROR - Service - Async error occurred: javax.jms.JMSException: Invalid acknowledgment: MessageAck

{commandId = 14, responseRequired = false, ackType = 3, consumerId = ID:cpreqlhe-50980-1215085236717-2:2:-1:2, firstMessageId = ID:cpreqlhe-50980-1215085236717-2:10:3:1:1, lastMessageId = ID:cpreqlhe-50980-1215085236717-2:10:3:1:1, destination = topic://org.apache.servicemix.JCAFlow, transactionId = null, messageCount = 1}

javax.jms.JMSException: Invalid acknowledgment: MessageAck

{commandId = 14, responseRequired = false, ackType = 3, consumerId = ID:cpreqlhe-50980-1215085236717-2:2:-1:2, firstMessageId = ID:cpreqlhe-50980-1215085236717-2:10:3:1:1, lastMessageId = ID:cpreqlhe-50980-1215085236717-2:10:3:1:1, destination = topic://org.apache.servicemix.JCAFlow, transactionId = null, messageCount = 1}

at org.apache.activemq.broker.region.TopicSubscription.acknowledge(TopicSubscription.java:216)
at org.apache.activemq.broker.region.AbstractRegion.acknowledge(AbstractRegion.java:364)
at org.apache.activemq.broker.region.RegionBroker.acknowledge(RegionBroker.java:470)
at org.apache.activemq.broker.TransactionBroker.acknowledge(TransactionBroker.java:194)
at org.apache.activemq.broker.BrokerFilter.acknowledge(BrokerFilter.java:73)
at org.apache.activemq.broker.BrokerFilter.acknowledge(BrokerFilter.java:73)
at org.apache.activemq.broker.MutableBrokerFilter.acknowledge(MutableBrokerFilter.java:84)
at org.apache.activemq.broker.TransportConnection.processMessageAck(TransportConnection.java:443)
at org.apache.activemq.command.MessageAck.visit(MessageAck.java:196)
at org.apache.activemq.broker.TransportConnection.service(TransportConnection.java:292)
at org.apache.activemq.broker.TransportConnection$1.onCommand(TransportConnection.java:180)
at org.apache.activemq.transport.TransportFilter.onCommand(TransportFilter.java:68)
at org.apache.activemq.transport.WireFormatNegotiator.onCommand(WireFormatNegotiator.java:143)
at org.apache.activemq.transport.InactivityMonitor.onCommand(InactivityMonitor.java:206)
at org.apache.activemq.transport.TransportSupport.doConsume(TransportSupport.java:84)
at org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:196)
at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:183)
at java.lang.Thread.run(Thread.java:595)
ERROR - Service - Async error occurred: javax.jms.JMSException: Invalid acknowledgment: MessageAck

{commandId = 11, responseRequired = false, ackType = 3, consumerId = ID:cpreqlhe-50980-1215085236717-2:3:-1:2, firstMessageId = ID:cpreqlhe-50980-1215085236717-1:0:0:0:2063, lastMessageId = ID:cpreqlhe-50980-1215085236717-1:0:0:0:2063, destination = topic://ActiveMQ.Advisory.Consumer.Topic.org.apache.servicemix.JCAFlow, transactionId = null, messageCount = 1}

javax.jms.JMSException: Invalid acknowledgment: MessageAck

{commandId = 11, responseRequired = false, ackType = 3, consumerId = ID:cpreqlhe-50980-1215085236717-2:3:-1:2, firstMessageId = ID:cpreqlhe-50980-1215085236717-1:0:0:0:2063, lastMessageId = ID:cpreqlhe-50980-1215085236717-1:0:0:0:2063, destination = topic://ActiveMQ.Advisory.Consumer.Topic.org.apache.servicemix.JCAFlow, transactionId = null, messageCount = 1}

at org.apache.activemq.broker.region.TopicSubscription.acknowledge(TopicSubscription.java:216)
at org.apache.activemq.broker.region.AbstractRegion.acknowledge(AbstractRegion.java:364)
at org.apache.activemq.broker.region.RegionBroker.acknowledge(RegionBroker.java:470)
at org.apache.activemq.broker.TransactionBroker.acknowledge(TransactionBroker.java:194)
at org.apache.activemq.broker.BrokerFilter.acknowledge(BrokerFilter.java:73)
at org.apache.activemq.broker.BrokerFilter.acknowledge(BrokerFilter.java:73)
at org.apache.activemq.broker.MutableBrokerFilter.acknowledge(MutableBrokerFilter.java:84)
at org.apache.activemq.broker.TransportConnection.processMessageAck(TransportConnection.java:443)
at org.apache.activemq.command.MessageAck.visit(MessageAck.java:196)
at org.apache.activemq.broker.TransportConnection.service(TransportConnection.java:292)
at org.apache.activemq.broker.TransportConnection$1.onCommand(TransportConnection.java:180)
at org.apache.activemq.transport.TransportFilter.onCommand(TransportFilter.java:68)
at org.apache.activemq.transport.WireFormatNegotiator.onCommand(WireFormatNegotiator.java:143)
at org.apache.activemq.transport.InactivityMonitor.onCommand(InactivityMonitor.java:206)
at org.apache.activemq.transport.TransportSupport.doConsume(TransportSupport.java:84)
at org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:196)
at org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:183)
at java.lang.Thread.run(Thread.java:595)
INFO - JBIContainer - Deactivating component #SubscriptionManager#
INFO - QuartzScheduler - Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED paused.
INFO - QuartzScheduler - Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED shutting down.
INFO - QuartzScheduler - Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED paused.
INFO - QuartzScheduler - Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED shutdown complete.
INFO - JBIContainer - ServiceMix JBI Container (ServiceMix) stopped

Disabling the JCA Flow fixes the problem.

Issue Links

• depends upon: SM-1723 Upgrade to ActiveMQ 5.2.0