activemq-users mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Gary Tully <gary.tu...@gmail.com>
Subject Re: Transaction not started XA problems
Date Fri, 03 Jun 2011 13:55:36 GMT
that is a little odd. All I can think of is that the underlying
connection is dropped in the exception case, wonder if that is the
case. It would cause any unprepared transactions to be rolledback.
Also, the xa start is sent async to the broker, but the timing from
the logs does not indicate a race here.

If you can enable debug level logging for the broker:
org.apache.activemq.transaction.XATransaction

it could provide an insight and the connection drop would be visible
in the broker log also.
Think we need to see the logs from the broker for a failure case.



On 2 June 2011 12:41, James Black <be_strew@yahoo.co.uk> wrote:
> Hi,
>
> first of thanks very much for the prompt suggestions.  I have enabled
> Atomikos, ActiveMQ, and Spring JMS logging.
>
> The posts below show the logs both for a transaction that succeeds and one
> that fails.  In both cases there is nothing on the queues to consume.
>
> In both cases the transaction is committed but in the failing case the
> exception occurs after Prepare is called by ActiveMQ.
>
> Also in the failed exception the InactivityMonitor has logged some activity
> after the transaction was started and before it was committed.
>
> ===== Failed Transaction to consume from a queue =====
>
> 2011-06-02 11:33:57,809 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning NULL!
> 2011-06-02 11:33:57,812 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning NULL!
> 2011-06-02 11:33:57,814 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning NULL!
> 2011-06-02 11:33:57,814 [ListenerContainer-3] INFO  -
> [com.atomikos.diagnostics.Slf4jConsole] : createCompositeTransaction ( 10000
> ): created new ROOT transaction with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,814 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,816 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,817 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,820 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,820 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,820 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,821 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,822 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,824 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,824 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,825 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,830 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,830 [ListenerContainer-3] INFO  -
> [com.atomikos.diagnostics.Slf4jConsole] : registerSynchronization (
> com.atomikos.jms.ConsumerProducerSupport$JmsRequeueSynchronization@39b7f681
> ) for transaction 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,830 [ListenerContainer-3] INFO  -
> [com.atomikos.diagnostics.Slf4jConsole] : addParticipant (
> XAResourceTransaction:
> 3139322E3136382E302E31372E746D30303437373030303031:3139322E3136382E302E31372E746D343737
> ) for transaction 192.168.0.17.tm0047700001
> 2011-06-02 11:33:57,830 [ListenerContainer-3] INFO  -
> [com.atomikos.diagnostics.Slf4jConsole] : XAResource.start (
> 3139322E3136382E302E31372E746D30303437373030303031:3139322E3136382E302E31372E746D343737
> , XAResource.TMNOFLAGS ) on resource XAJMS_PROC represented by XAResource
> instance TransactionContext{transactionId=null}
> 2011-06-02 11:33:57,831 [ListenerContainer-3] DEBUG -
> [org.apache.activemq.TransactionContext] : Start:
> 192.168.0.17.tm0047700001192.168.0.17.tm477
> 2011-06-02 11:33:57,831 [ListenerContainer-3] DEBUG -
> [org.apache.activemq.TransactionContext] : Started XA transaction:
> XID:1096044365:3139322e3136382e302e31372e746d30303437373030303031:3139322e3136382e302e31372e746d343737
> 2011-06-02 11:33:57,916 [InactivityMonitor WriteCheck] DEBUG -
> [org.apache.activemq.transport.InactivityMonitor$2] :
> org.apache.activemq.transport.InactivityMonitor$2@517ff60e 10000 ms elapsed
> since last write check.
> 2011-06-02 11:33:57,916 [InactivityMonitor WriteCheck] TRACE -
> [org.apache.activemq.transport.InactivityMonitor] :
> tcp://iodine/192.168.0.53:61617 message sent since last write check,
> resetting flag
> 2011-06-02 11:33:58,832 [ListenerContainer-3] TRACE -
> [org.springframework.jms.listener.AbstractPollingMessageListenerContainer] :
> Consumer [atomikos MessageConsumer proxy for ActiveMQMessageConsumer {
> value=ID:servername-56564-1307010782619-0:6:96:1, started=true }] of
> transactional session [ActiveMQSession
> {id=ID:servername-56564-1307010782619-0:6:96,started=true}] did not receive
> a message
> 2011-06-02 11:33:58,833 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:58,833 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:58,833 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:58,834 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:58,834 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:58,834 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0047700001
> 2011-06-02 11:33:58,835 [ListenerContainer-3] INFO  -
> [com.atomikos.diagnostics.Slf4jConsole] : commit() done (by application) of
> transaction 192.168.0.17.tm0047700001
> 2011-06-02 11:33:58,835 [ListenerContainer-3] INFO  -
> [com.atomikos.diagnostics.Slf4jConsole] : XAResource.end (
> 3139322E3136382E302E31372E746D30303437373030303031:3139322E3136382E302E31372E746D343737
> , XAResource.TMSUCCESS ) on resource XAJMS_PROC represented by XAResource
> instance
> TransactionContext{transactionId=XID:1096044365:3139322e3136382e302e31372e746d30303437373030303031:3139322e3136382e302e31372e746d343737}
> 2011-06-02 11:33:58,837 [ListenerContainer-3] DEBUG -
> [org.apache.activemq.TransactionContext] : End:
> 192.168.0.17.tm0047700001192.168.0.17.tm477
> 2011-06-02 11:33:58,843 [ListenerContainer-3] DEBUG -
> [org.apache.activemq.TransactionContext] : Ended XA transaction:
> XID:1096044365:3139322e3136382e302e31372e746d30303437373030303031:3139322e3136382e302e31372e746d343737
> 2011-06-02 11:33:58,844 [ListenerContainer-3] DEBUG -
> [com.atomikos.diagnostics.Slf4jConsole] : About to call prepare on
> XAResource instance: TransactionContext{transactionId=null}
> 2011-06-02 11:33:58,844 [ListenerContainer-3] DEBUG -
> [org.apache.activemq.TransactionContext] : Prepare:
> 192.168.0.17.tm0047700001192.168.0.17.tm477
> javax.jms.JMSException: Transaction
> 'XID:1096044365:3139322e3136382e302e31372e746d30303437373030303031:3139322e3136382e302e31372e746d343737'
> has not been started.
>        at
> org.apache.activemq.util.JMSExceptionSupport.create(JMSExceptionSupport.java:49)
>        at
> org.apache.activemq.ActiveMQConnection.syncSendPacket(ActiveMQConnection.java:1295)
>        at
> org.apache.activemq.TransactionContext.syncSendPacketWithInterruptionHandling(TransactionContext.java:707)
>        at
> org.apache.activemq.TransactionContext.prepare(TransactionContext.java:428)
>        at
> com.atomikos.datasource.xa.XAResourceTransaction.prepare(XAResourceTransaction.java:622)
>        at com.atomikos.icatch.imp.PrepareMessage.send(PrepareMessage.java:61)
>        at
> com.atomikos.icatch.imp.PropagationMessage.submit(PropagationMessage.java:111)
>        at
> com.atomikos.icatch.imp.Propagator$PropagatorThread.run(Propagator.java:87)
>        at
> com.atomikos.icatch.imp.Propagator.submitPropagationMessage(Propagator.java:66)
>        at
> com.atomikos.icatch.imp.ActiveStateHandler.prepare(ActiveStateHandler.java:173)
>        at com.atomikos.icatch.imp.CoordinatorImp.prepare(CoordinatorImp.java:832)
>        at
> com.atomikos.icatch.imp.CoordinatorImp.terminate(CoordinatorImp.java:1159)
>        at
> com.atomikos.icatch.imp.CompositeTerminatorImp.commit(CompositeTerminatorImp.java:92)
>        at com.atomikos.icatch.jta.TransactionImp.commit(TransactionImp.java:236)
>        at
> com.atomikos.icatch.jta.TransactionManagerImp.commit(TransactionManagerImp.java:498)
>        at
> com.atomikos.icatch.jta.UserTransactionImp.commit(UserTransactionImp.java:129)
>        at
> org.springframework.transaction.jta.JtaTransactionManager.doCommit(JtaTransactionManager.java:1009)
>        at
> org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:754)
>        at
> org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:723)
>        at
> org.springframework.jms.listener.AbstractPollingMessageListenerContainer.receiveAndExecute(AbstractPollingMessageListenerContainer.java:257)
>        at
> org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.invokeListener(DefaultMessageListenerContainer.java:1058)
>        at
> org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.executeOngoingLoop(DefaultMessageListenerContainer.java:1050)
>        at
> org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.run(DefaultMessageListenerContainer.java:947)
>        at java.lang.Thread.run(Thread.java:662)
> Caused by: javax.transaction.xa.XAException: Transaction
> 'XID:1096044365:3139322e3136382e302e31372e746d30303437373030303031:3139322e3136382e302e31372e746d343737'
> has not been started.
>        at
> org.apache.activemq.broker.TransactionBroker.getTransaction(TransactionBroker.java:290)
>        at
> org.apache.activemq.broker.TransactionBroker.prepareTransaction(TransactionBroker.java:167)
>        at
> org.apache.activemq.broker.MutableBrokerFilter.prepareTransaction(MutableBrokerFilter.java:115)
>        at
> org.apache.activemq.broker.TransportConnection.processPrepareTransaction(TransportConnection.java:402)
>        at
> org.apache.activemq.command.TransactionInfo.visit(TransactionInfo.java:98)
>        at
> org.apache.activemq.broker.TransportConnection.service(TransportConnection.java:306)
>        at
> org.apache.activemq.broker.TransportConnection$1.onCommand(TransportConnection.java:179)
>        at
> org.apache.activemq.transport.TransportFilter.onCommand(TransportFilter.java:69)
>        at
> org.apache.activemq.transport.WireFormatNegotiator.onCommand(WireFormatNegotiator.java:113)
>        at
> org.apache.activemq.transport.TransportSupport.doConsume(TransportSupport.java:83)
>        at
> org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:220)
>        at
> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:202)
>        at java.lang.Thread.run(Unknown Source)
> 2011-06-02 11:33:58,868 [ListenerContainer-3] DEBUG -
> [org.apache.activemq.ActiveMQMessageConsumer] : remove:
> ID:servername-56564-1307010782619-0:6:96:1, lastDeliveredSequenceId:0
> 2011-06-02 11:33:58,871 [ListenerContainer-3] INFO  -
> [com.atomikos.diagnostics.Slf4jConsole] : XAResource.rollback (
> 3139322E3136382E302E31372E746D30303437373030303031:3139322E3136382E302E31372E746D343737
> ) on resource XAJMS_PROC represented by XAResource instance
> TransactionContext{transactionId=null}
> 2011-06-02 11:33:58,871 [ListenerContainer-3] DEBUG -
> [org.apache.activemq.TransactionContext] : Rollback:
> 192.168.0.17.tm0047700001192.168.0.17.tm477
> 2011-06-02 11:33:58,876 [ListenerContainer-3] WARN  -
> [com.atomikos.diagnostics.Slf4jConsole] : XA resource 'XAJMS_PROC': rollback
> for XID
> '3139322E3136382E302E31372E746D30303437373030303031:3139322E3136382E302E31372E746D343737'
> raised 0: unknown
> javax.transaction.xa.XAException: Transaction
> 'XID:1096044365:3139322e3136382e302e31372e746d30303437373030303031:3139322e3136382e302e31372e746d343737'
> has not been started.
>        at
> org.apache.activemq.TransactionContext.toXAException(TransactionContext.java:732)
>        at
> org.apache.activemq.TransactionContext.rollback(TransactionContext.java:497)
>        at
> com.atomikos.datasource.xa.XAResourceTransaction.rollback(XAResourceTransaction.java:690)
>        at com.atomikos.icatch.imp.RollbackMessage.send(RollbackMessage.java:72)
>        at
> com.atomikos.icatch.imp.PropagationMessage.submit(PropagationMessage.java:111)
>        at
> com.atomikos.icatch.imp.Propagator$PropagatorThread.run(Propagator.java:87)
>        at
> com.atomikos.icatch.imp.Propagator.submitPropagationMessage(Propagator.java:66)
>        at
> com.atomikos.icatch.imp.CoordinatorStateHandler.rollback(CoordinatorStateHandler.java:746)
>        at
> com.atomikos.icatch.imp.ActiveStateHandler.prepare(ActiveStateHandler.java:218)
>        at com.atomikos.icatch.imp.CoordinatorImp.prepare(CoordinatorImp.java:832)
>        at
> com.atomikos.icatch.imp.CoordinatorImp.terminate(CoordinatorImp.java:1159)
>        at
> com.atomikos.icatch.imp.CompositeTerminatorImp.commit(CompositeTerminatorImp.java:92)
>        at com.atomikos.icatch.jta.TransactionImp.commit(TransactionImp.java:236)
>        at
> com.atomikos.icatch.jta.TransactionManagerImp.commit(TransactionManagerImp.java:498)
>        at
> com.atomikos.icatch.jta.UserTransactionImp.commit(UserTransactionImp.java:129)
>        at
> org.springframework.transaction.jta.JtaTransactionManager.doCommit(JtaTransactionManager.java:1009)
>        at
> org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:754)
>        at
> org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:723)
>        at
> org.springframework.jms.listener.AbstractPollingMessageListenerContainer.receiveAndExecute(AbstractPollingMessageListenerContainer.java:257)
>        at
> org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.invokeListener(DefaultMessageListenerContainer.java:1058)
>        at
> org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.executeOngoingLoop(DefaultMessageListenerContainer.java:1050)
>        at
> org.springframework.jms.listener.DefaultMessageListenerContainer$AsyncMessageListenerInvoker.run(DefaultMessageListenerContainer.java:947)
>        at java.lang.Thread.run(Thread.java:662)
> Caused by: javax.transaction.xa.XAException: Transaction
> 'XID:1096044365:3139322e3136382e302e31372e746d30303437373030303031:3139322e3136382e302e31372e746d343737'
> has not been started.
>        at
> org.apache.activemq.broker.TransactionBroker.getTransaction(TransactionBroker.java:290)
>        at
> org.apache.activemq.broker.TransactionBroker.rollbackTransaction(TransactionBroker.java:177)
>        at
> org.apache.activemq.broker.MutableBrokerFilter.rollbackTransaction(MutableBrokerFilter.java:131)
>        at
> org.apache.activemq.broker.TransportConnection.processRollbackTransaction(TransportConnection.java:436)
>        at
> org.apache.activemq.command.TransactionInfo.visit(TransactionInfo.java:104)
>        at
> org.apache.activemq.broker.TransportConnection.service(TransportConnection.java:306)
>        at
> org.apache.activemq.broker.TransportConnection$1.onCommand(TransportConnection.java:179)
>        at
> org.apache.activemq.transport.TransportFilter.onCommand(TransportFilter.java:69)
>        at
> org.apache.activemq.transport.WireFormatNegotiator.onCommand(WireFormatNegotiator.java:113)
>        at
> org.apache.activemq.transport.TransportSupport.doConsume(TransportSupport.java:83)
>        at
> org.apache.activemq.transport.tcp.TcpTransport.doRun(TcpTransport.java:220)
>        at
> org.apache.activemq.transport.tcp.TcpTransport.run(TcpTransport.java:202)
>        at java.lang.Thread.run(Unknown Source)
>
>
> ===== Successful Transaction to consume from a queue =====
>
>        602     2011-06-02      10:20:58,956     [listenerContainer-4] INFO
 -
> [com.atomikos.diagnostics.Slf4jConsole] : createCompositeTransaction ( 10000
> ): created new ROOT transaction with id 192.168.0.17.tm0001400001
>        629     2011-06-02      10:20:58,965     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        633     2011-06-02      10:20:58,968     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        638     2011-06-02      10:20:58,969     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        639     2011-06-02      10:20:58,970     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        640     2011-06-02      10:20:58,971     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        642     2011-06-02      10:20:58,971     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        643     2011-06-02      10:20:58,971     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        645     2011-06-02      10:20:58,971     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        649     2011-06-02      10:20:58,971     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        651     2011-06-02      10:20:58,973     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        659     2011-06-02      10:20:58,974     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        672     2011-06-02      10:20:58,980     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        674     2011-06-02      10:20:58,981     [listenerContainer-4] INFO
 -
> [com.atomikos.diagnostics.Slf4jConsole] : registerSynchronization (
> com.atomikos.jms.ConsumerProducerSupport$JmsRequeueSynchronization@57af55a2
> ) for transaction 192.168.0.17.tm0001400001
>        676     2011-06-02      10:20:58,981     [listenerContainer-4] INFO
 -
> [com.atomikos.diagnostics.Slf4jConsole] : addParticipant (
> XAResourceTransaction:
> 3139322E3136382E302E31372E746D30303031343030303031:3139322E3136382E302E31372E746D3133
> ) for transaction 192.168.0.17.tm0001400001
>        677     2011-06-02      10:20:58,982     [listenerContainer-4] INFO
 -
> [com.atomikos.diagnostics.Slf4jConsole] : XAResource.start (
> 3139322E3136382E302E31372E746D30303031343030303031:3139322E3136382E302E31372E746D3133
> , XAResource.TMNOFLAGS ) on resource XAJMS_PROC represented by XAResource
> instance TransactionContext{transactionId=null}
>        678     2011-06-02      10:20:58,982     [listenerContainer-4] DEBUG
-
> [org.apache.activemq.TransactionContext] : Start:
> 192.168.0.17.tm0001400001192.168.0.17.tm13
>        681     2011-06-02      10:20:58,982     [listenerContainer-4] DEBUG
-
> [org.apache.activemq.TransactionContext] : Started XA transaction:
> XID:1096044365:3139322e3136382e302e31372e746d30303031343030303031:3139322e3136382e302e31372e746d3133
>        828     2011-06-02      10:20:59,984     [listenerContainer-4] TRACE
-
> [org.springframework.jms.listener.AbstractPollingMessageListenerContainer] :
> Consumer [atomikos MessageConsumer proxy for ActiveMQMessageConsumer {
> value=ID:servername-54601-1307006451773-0:3:4:1, started=true }] of
> transactional session [ActiveMQSession
> {id=ID:servername-54601-1307006451773-0:3:4,started=true}] did not receive a
> message
>        829     2011-06-02      10:20:59,985     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        830     2011-06-02      10:20:59,986     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        831     2011-06-02      10:20:59,986     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        832     2011-06-02      10:20:59,986     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        833     2011-06-02      10:20:59,987     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        834     2011-06-02      10:20:59,987     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : getCompositeTransaction()
> returning instance with id 192.168.0.17.tm0001400001
>        835     2011-06-02      10:20:59,987     [listenerContainer-4] INFO
 -
> [com.atomikos.diagnostics.Slf4jConsole] : commit() done (by application) of
> transaction 192.168.0.17.tm0001400001
>        840     2011-06-02      10:20:59,987     [listenerContainer-4] INFO
 -
> [com.atomikos.diagnostics.Slf4jConsole] : XAResource.end (
> 3139322E3136382E302E31372E746D30303031343030303031:3139322E3136382E302E31372E746D3133
> , XAResource.TMSUCCESS ) on resource XAJMS_PROC represented by XAResource
> instance
> TransactionContext{transactionId=XID:1096044365:3139322e3136382e302e31372e746d30303031343030303031:3139322e3136382e302e31372e746d3133}
>        848     2011-06-02      10:20:59,990     [listenerContainer-4] DEBUG
-
> [org.apache.activemq.TransactionContext] : End:
> 192.168.0.17.tm0001400001192.168.0.17.tm13
>        853     2011-06-02      10:20:59,991     [listenerContainer-4] DEBUG
-
> [org.apache.activemq.TransactionContext] : Ended XA transaction:
> XID:1096044365:3139322e3136382e302e31372e746d30303031343030303031:3139322e3136382e302e31372e746d3133
>        855     2011-06-02      10:20:59,992     [listenerContainer-4] DEBUG
-
> [com.atomikos.diagnostics.Slf4jConsole] : About to call prepare on
> XAResource instance: TransactionContext{transactionId=null}
>        856     2011-06-02      10:20:59,992     [listenerContainer-4] DEBUG
-
> [org.apache.activemq.TransactionContext] : Prepare:
> 192.168.0.17.tm0001400001192.168.0.17.tm13
>        859     2011-06-02      10:20:59,993     [listenerContainer-4] DEBUG
-
> [org.apache.activemq.TransactionContext] : firing afterCommit callbacks on
> XA_RDONLY from prepare: 192.168.0.17.tm0001400001192.168.0.17.tm13
>        868     2011-06-02      10:20:59,993     [listenerContainer-4] DEBUG
-
> [org.apache.activemq.ActiveMQMessageConsumer] : remove:
> ID:servername-54601-1307006451773-0:3:4:1, lastDeliveredSequenceId:0
>
> --
> View this message in context: http://activemq.2283324.n4.nabble.com/Transaction-not-started-XA-problems-tp3565540p3568151.html
> Sent from the ActiveMQ - User mailing list archive at Nabble.com.
>



-- 
http://fusesource.com
http://blog.garytully.com

Mime
View raw message