Error while closing connection handle | Failure to delist re
s0d0 Nov 16, 2006 8:48 AMHi
I'm getting following errors when closing connection to JMS server
using XA transactions. Any ideas why?
Br,
Juha Moisio
2006-11-16 12:12:23,124 DEBUG [Sonic Resource Adapter for JCA] UNABLE to find connections in available connections 2006-11-16 12:12:23,174 DEBUG [Sonic Resource Adapter for JCA] New connection, reference count is: 1 2006-11-16 12:12:23,212 DEBUG [fi.logiasoftware.messageserver.services.backend.MessageSenderBase] Checking server transaction type 2006-11-16 12:12:23,212 DEBUG [fi.logiasoftware.messageserver.services.backend.MessageSenderBase] Creating xasession 2006-11-16 12:12:23,235 DEBUG [Sonic Resource Adapter for JCA] Reference Count is now: 2 2006-11-16 12:12:23,243 DEBUG [Sonic Resource Adapter for JCA] Timer-162 XAResource=511057526 XAResourceWrapper CTOR, managed connection=com.sonicsw.sonicmq.j2ee.jmsra.impl.JMSSessionManagedConnection@47a047a0 2006-11-16 12:12:23,244 DEBUG [Sonic Resource Adapter for JCA] Timer-162 XAResource=511057526 XAResourceWrapper.start: GlobalId=1--3f3db8c2:8c56:455c36fb:15d, BranchQual=-3f3db8c2:8c56:455c36fb:17c,TMNOFLAGS 2006-11-16 12:12:23,244 DEBUG [Sonic Resource Adapter for JCA] Timer-162 XAResource=511057526 XAResourceWrapper.enterTransaction: GlobalId=1--3f3db8c2:8c56:455c36fb:15d, BranchQual=-3f3db8c2:8c56:455c36fb:17c 2006-11-16 12:12:23,264 DEBUG [fi.logiasoftware.messageserver.services.backend.MessageSenderBase] XAsession created 2006-11-16 12:12:23,332 DEBUG [fi.logiasoftware.messageserver.services.backend.MessageSenderBase] Setting properties 2006-11-16 12:12:23,333 DEBUG [fi.logiasoftware.messageserver.services.backend.MessageSenderBase] Setting text 2006-11-16 12:12:23,347 DEBUG [fi.logiasoftware.messageserver.services.backend.MessageSenderBase] sending message 2006-11-16 12:12:23,362 INFO [fi.logiasoftware.messageserver.services.handlers.FTPProtocolHandler] Executing action: delete for message UD.SHPORD_105840551163583985997748000 [192.194.71.123] 2006-11-16 12:12:23,494 DEBUG [Sonic Resource Adapter for JCA] Connection Closed event generated 2006-11-16 12:12:23,495 DEBUG [Sonic Resource Adapter for JCA] Timer-162 XAResource=511057526 XAResourceWrapper.end: GlobalId=1--3f3db8c2:8c56:455c36fb:15d, BranchQual=-3f3db8c2:8c56:455c36fb:17c,TMSUSPEND 2006-11-16 12:12:23,500 WARN [com.arjuna.ats.jta.logging.loggerI18N] [com.arjuna.ats.internal.jta.transaction.arjunacore.delistresource] [com.arjuna.ats.internal.jta.transaction.arjunacore.delistresource] TransactionImple.delistResource - caught exception during delist : [com.arjuna.ats.jta.utils.unknownerrorcode] Unknown error code:0 2006-11-16 12:12:23,504 ERROR [org.jboss.resource.connectionmanager.TxConnectionManager] Error while closing connection handle! javax.resource.ResourceException: Failure to delist resource: org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@440a440a[state=NORMAL mc=com.sonicsw.sonicmq.j2ee.jmsra.impl.JMSSessionManagedConnection@47a047a0 handles=0 lastUse=1163671943243 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@79ae79ae context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@26a826a8 xaResource=com.sonicsw.sonicmq.j2ee.jmsra.impl.XAResourceWrapper@1e761e76 txSync=null] at org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener.delist(TxConnectionManager.java:582) at org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener.connectionClosed(TxConnectionManager.java:622) at com.sonicsw.sonicmq.j2ee.jmsra.impl.JMSConnectionEventListener.sendEvent(JMSConnectionEventListener.java:78) at com.sonicsw.sonicmq.j2ee.jmsra.impl.JMSSessionManagedConnection.sendEvent(JMSSessionManagedConnection.java:380) at com.sonicsw.sonicmq.j2ee.jmsra.impl.JMSSessionAdapter.close(JMSSessionAdapter.java:164) at fi.logiasoftware.messageserver.services.backend.MessageSenderBase.shutdownConnection(MessageSenderBase.java:184) at fi.logiasoftware.messageserver.services.backend.PollingBean.processMessage(PollingBean.java:401) at fi.logiasoftware.messageserver.services.backend.PollingBean.processDirectories(PollingBean.java:340) at fi.logiasoftware.messageserver.services.backend.PollingBean.poll(PollingBean.java:211) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:615) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:112) at org.jboss.ejb3.interceptor.InvocationContextImpl.proceed(InvocationContextImpl.java:166) at org.jboss.ejb3.interceptor.EJB3InterceptorsInterceptor.invoke(EJB3InterceptorsInterceptor.java:63) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.entity.TransactionScopedEntityManagerInterceptor.invoke(TransactionScopedEntityManagerInterceptor.java:54) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.AllowedOperationsInterceptor.invoke(AllowedOperationsInterceptor.java:46) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.aspects.tx.TxPolicy.invokeInCallerTx(TxPolicy.java:126) at org.jboss.aspects.tx.TxInterceptor$Required.invoke(TxInterceptor.java:195) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:76) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.stateless.StatelessInstanceInterceptor.invoke(StatelessInstanceInterceptor.java:62) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.aspects.security.AuthenticationInterceptor.invoke(AuthenticationInterceptor.java:77) at org.jboss.ejb3.security.Ejb3AuthenticationInterceptor.invoke(Ejb3AuthenticationInterceptor.java:102) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:47) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.asynchronous.AsynchronousInterceptor.invoke(AsynchronousInterceptor.java:106) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.stateless.StatelessContainer.dynamicInvoke(StatelessContainer.java:263) at org.jboss.ejb3.remoting.IsLocalInterceptor.invoke(IsLocalInterceptor.java:58) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.stateless.StatelessRemoteProxy.invoke(StatelessRemoteProxy.java:102) at $Proxy233.poll(Unknown Source) at fi.logiasoftware.messageserver.services.backend.SchedulerBean.ejbTimeout(SchedulerBean.java:242) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:615) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:112) at org.jboss.ejb3.interceptor.InvocationContextImpl.proceed(InvocationContextImpl.java:166) at org.jboss.ejb3.interceptor.EJB3InterceptorsInterceptor.invoke(EJB3InterceptorsInterceptor.java:63) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.entity.TransactionScopedEntityManagerInterceptor.invoke(TransactionScopedEntityManagerInterceptor.java:54) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.AllowedOperationsInterceptor.invoke(AllowedOperationsInterceptor.java:46) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.aspects.tx.TxPolicy.invokeInOurTx(TxPolicy.java:79) at org.jboss.aspects.tx.TxInterceptor$RequiresNew.invoke(TxInterceptor.java:262) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:76) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.stateless.StatelessInstanceInterceptor.invoke(StatelessInstanceInterceptor.java:62) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.aspects.security.AuthenticationInterceptor.invoke(AuthenticationInterceptor.java:77) at org.jboss.ejb3.security.Ejb3AuthenticationInterceptor.invoke(Ejb3AuthenticationInterceptor.java:102) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:47) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.asynchronous.AsynchronousInterceptor.invoke(AsynchronousInterceptor.java:106) at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101) at org.jboss.ejb3.stateless.StatelessContainer.callTimeout(StatelessContainer.java:150) at org.jboss.ejb.txtimer.TimerImpl$TimerTaskImpl.run(TimerImpl.java:524) at java.util.TimerThread.mainLoop(Timer.java:527) at java.util.TimerThread.run(Timer.java:477) 2006-11-16 12:12:23,550 DEBUG [Sonic Resource Adapter for JCA] Cleaning up session 2006-11-16 12:12:23,550 DEBUG [Sonic Resource Adapter for JCA] Timer-162 DESTROYING SESSION 1637507482 XAResource=511057526 2006-11-16 12:12:23,550 DEBUG [Sonic Resource Adapter for JCA] Timer-162 CALLING XAResource.waitForCompletion ON SESSION 1637507482 XAResource=511057526 2006-11-16 12:12:23,550 DEBUG [Sonic Resource Adapter for JCA] Timer-162 XAResource=511057526 XAResourceWrapper.waitForCompletion 2006-11-16 12:12:23,550 DEBUG [Sonic Resource Adapter for JCA] Timer-162 XAResource=511057526 in XAResourceWrapper waitForCompletion waiting for transaction to complete on another thread
@TransactionAttribute(TransactionAttributeType.REQUIRES_NEW) private void processMessage(AbstractProtocolHandler handler, String msgData, HashMap m, String queueName, DirectoryInfo dirInfo, MessageContainer msgC, Chain chain, Integer stepId, String jobId) { SonicConnection jmsConn = null; try { jmsConn = openConnection(); sendMessage(jmsConn, msgData, m, queueName); handler.doAction(dirInfo, msgC.getAbsPath(), msgC.getFilename()); if (chain.getTracking() == 1) { trackingWriter.writeLog(chain.getCustomer().getId(), chain .getId(), stepId, jobId, msgC.getFilename(), "", ""); } } catch (ProtocolHandlerException e) { statusWriter.writeLog(chain.getCustomer().getId(), chain.getId(), stepId, jobId, "Excecuting action " + dirInfo.getAction() + " for message failed. Reason: " + e.getMessage()); throw new EJBException(e); } catch (JMSException e) { statusWriter.writeLog(chain.getCustomer().getId(), chain.getId(), stepId, jobId, "Sending message to JMS queue failed. Reason: " + e.getMessage()); throw new EJBException(e); } finally { shutdownConnection(jmsConn); } }