All pastes #2673551 Raw Edit

JMS XA log

public unlisted text v1 · immutable
#2673551 ·published 2014-03-22 16:44 UTC
rendered paste body
2014-03-22 19:19:36,858 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.JBossConnectionConsumer] added delegator->JBossMessage[22863956814053376]:PERSISTENT, deliveryId=0 to session
2014-03-22 19:19:36,859 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.JBossConnectionConsumer] JBossConnectionConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a, 1] starting serverSession org.jboss.resource.adapter.jms.inflow.JmsServerSession@36981124
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.JBossConnectionConsumer] JBossConnectionConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a, 1]'s serverSession processed messages
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.JBossConnectionConsumer] JBossConnectionConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a, 1] attempting to get message with receiveNoWait
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.container.ClientConsumer] ClientConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a] receiving, timeout = -1
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.container.ClientConsumer] ClientConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a]: receive, noWait
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.container.ClientConsumer] ClientConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a]: no message available
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.JBossConnectionConsumer] receiveNoWait did not retrieve any message
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.JBossConnectionConsumer] JBossConnectionConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a, 1] attempting to get message with blocking receive (no timeout)
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.container.ClientConsumer] ClientConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a] receiving, timeout = 0
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.container.ClientConsumer] ClientConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a]: receive, no timeout
2014-03-22 19:19:36,861 [Connection Consumer for dest JBossQueue[TaskManager.Request.Queue] id=1] TRACE [org.jboss.jms.client.container.ClientConsumer] ClientConsumer[ib-bstp33th-1-z2oo33th-o04era-y1s3x6a] waiting on main lock, no timeout
2014-03-22 19:19:36,872 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.MessagingXAResource] MessagingXAResource[fb-rqtp33th-1-z2oo33th-o04era-y1s3x6a] starting < 131075, 26, 24, 4945971025756565254589957975458535150100985510048589850971025756565254589957975458535150100985510048589851 >, flags: 0
2014-03-22 19:19:36,872 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.MessagingXAResource] Converting local tx into global tx branch
2014-03-22 19:19:36,872 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] converting LocalTx[gb-sqtp33th-1-z2oo33th-o04era-y1s3x6a] to MessagingXid (1832580949 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50
2014-03-22 19:19:36,872 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] getting transaction for MessagingXid (1832580949 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50
2014-03-22 19:19:36,872 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.MessagingXAResource] MessagingXAResource[fb-rqtp33th-1-z2oo33th-o04era-y1s3x6a] setting current xid to MessagingXid (1832580949 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50,  previous LocalTx[gb-sqtp33th-1-z2oo33th-o04era-y1s3x6a]
2014-03-22 19:19:36,872 [WorkManager(2)-3] TRACE [org.jboss.jms.client.JBossSession] run() called
2014-03-22 19:19:36,874 [WorkManager(2)-3] TRACE [org.jboss.jms.client.container.SessionAspect] run()
2014-03-22 19:19:36,875 [WorkManager(2)-3] TRACE [org.jboss.jms.client.container.SessionAspect] sending delegator->JBossMessage[22863956814053376]:PERSISTENT, deliveryId=0 to the message listener
2014-03-22 19:19:36,875 [WorkManager(2)-3] TRACE [org.jboss.jms.client.container.SessionAspect] sending acknowlegment transactionally, queueing on resource manager
2014-03-22 19:19:36,876 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] adding Delivery[0, delegator->JBossMessage[22863956814053376]:PERSISTENT, deliveryId=0] to transaction MessagingXid (1832580949 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50
2014-03-22 19:19:36,876 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] getting transaction for MessagingXid (1832580949 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50
2014-03-22 19:19:36,876 [WorkManager(2)-3] TRACE [org.jboss.jms.client.container.ClientConsumer] calling listener's onMessage(delegator->JBossMessage[22863956814053376]:PERSISTENT, deliveryId=0)
2014-03-22 19:19:36,888 [WorkManager(2)-3] TRACE [org.jboss.jms.client.container.ClientConsumer] listener's onMessage() finished
2014-03-22 19:19:36,888 [WorkManager(2)-3] TRACE [org.jboss.jms.client.container.ClientConsumer] Calling postDeliver
2014-03-22 19:19:36,889 [WorkManager(2)-3] TRACE [org.jboss.jms.client.container.ClientConsumer] Called postDeliver
2014-03-22 19:19:36,889 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.MessagingXAResource] MessagingXAResource[fb-rqtp33th-1-z2oo33th-o04era-y1s3x6a] ending < 131075, 26, 24, 4945971025756565254589957975458535150100985510048589850971025756565254589957975458535150100985510048589851 >, flags: 67108864
2014-03-22 19:19:36,889 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.MessagingXAResource] MessagingXAResource[fb-rqtp33th-1-z2oo33th-o04era-y1s3x6a] unsetting current xid MessagingXid (2041183783 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50,  previous MessagingXid (1832580949 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50
2014-03-22 19:19:36,889 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] ending MessagingXid (2041183783 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50, success=true
2014-03-22 19:19:36,889 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] getting transaction for MessagingXid (2041183783 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50
2014-03-22 19:19:36,889 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.MessagingXAResource] MessagingXAResource[fb-rqtp33th-1-z2oo33th-o04era-y1s3x6a] committing < 131075, 26, 24, 4945971025756565254589957975458535150100985510048589850971025756565254589957975458535150100985510048589851 > (one phase)
2014-03-22 19:19:36,889 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] commiting xid MessagingXid (20445367 bq:97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.51 formatID:131075 gtxid:49.45.97.102.57.56.56.52.54.58.99.57.97.54.58.53.51.50.100.98.55.100.48.58.98.50, onePhase=true
2014-03-22 19:19:36,890 [WorkManager(2)-3] TRACE [org.jboss.jms.tx.ResourceManager] got tx: org.jboss.jms.tx.ClientTransaction@1a9b701 state 1
2014-03-22 19:19:36,890 [WorkManager(2)-3] TRACE [org.jboss.jms.client.delegate.DelegateSupport] ConnectionDelegate[1509726255, ID=ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a, SID=0] invoking org.jboss.jms.wireformat.ConnectionSendTransactionRequest@2d2da381 synchronously on server using Client[1574557473]
2014-03-22 19:19:36,890 [WorkManager(2)-3] TRACE [org.jboss.jms.server.remoting.JMSServerInvocationHandler] invoking InvocationRequest[f498153, JMS, org.jboss.jms.wireformat.ConnectionSendTransactionRequest@2d2da381]
2014-03-22 19:19:36,890 [WorkManager(2)-3] TRACE [org.jboss.jms.server.container.ServerLogInterceptor] invoking ConnectionAdvised->ConnectionEndpoint[ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a].sendTransaction(TransactionRequest[ONE_PHASE_COMMIT, null], false)
2014-03-22 19:19:36,890 [WorkManager(2)-3] TRACE [org.jboss.jms.server.endpoint.ServerConnectionEndpoint] ConnectionEndpoint[ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a] received ONE_PHASE_COMMIT request
2014-03-22 19:19:36,890 [WorkManager(2)-3] TRACE [org.jboss.jms.server.endpoint.ServerConnectionEndpoint] ConnectionEndpoint[ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a] processing transaction TX(22863956818165761):ACTIVE
2014-03-22 19:19:36,890 [WorkManager(2)-3] TRACE [org.jboss.jms.server.endpoint.ServerSessionEndpoint] SessionEndpoint[hb-2rtp33th-1-z2oo33th-o04era-y1s3x6a] acknowledging transactionally 1 messages for TX(22863956818165761):ACTIVE
2014-03-22 19:19:36,892 [WorkManager(2)-3] TRACE [org.jboss.jms.server.endpoint.ServerConnectionEndpoint] ConnectionEndpoint[ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a] processed transaction TX(22863956818165761):ACTIVE
2014-03-22 19:19:37,065 [WorkManager(2)-3] TRACE [org.jboss.jms.server.endpoint.ServerConnectionEndpoint] ConnectionEndpoint[ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a] processed transaction successfully
2014-03-22 19:19:37,065 [WorkManager(2)-3] TRACE [org.jboss.jms.server.container.ServerLogInterceptor] ConnectionAdvised->ConnectionEndpoint[ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a].sendTransaction() OK
2014-03-22 19:19:37,065 [WorkManager(2)-3] TRACE [org.jboss.jms.client.delegate.DelegateSupport] ConnectionDelegate[1509726255, ID=ma-9ctp33th-1-z2oo33th-o04era-y1s3x6a, SID=0] got server response for org.jboss.jms.wireformat.ConnectionSendTransactionRequest@2d2da381: null