1 Reply Latest reply on Jun 8, 2011 10:34 AM by zenzei2k

    Jboss 4.2.3 and org.jboss.util.NestedSQLException: Transaction TransactionImple < ac, BasicAction: status: ActionStatus.COMMITTED > cannot proceed STATUS_COMMITTED

    zenzei2k

      Hi! I'm using jboss 4.2.3 with Hibernate 3.2.4.sp1 and spring 2.5.6, and sometimes in my hibernate.log I see this kind of trace. This trace is not logged as ERROR but it doesn't look good to me so I don't know if it's an error that should be discarded, or there is something I could do to trace it better, cause it didn't generate any other stacktrace in server.log or my application.log.

       

      Sorry I don't give any more info but I don't know what else can I tell about it.

       

      2011-06-01 12:13:49,406 2185125 DEBUG [org.hibernate.jdbc.AbstractBatcher] (Timer-2:) about to open PreparedStatement (open PreparedStatements: 0, globally: 1)
      2011-06-01 12:13:49,406 2185125 DEBUG [org.hibernate.SQL] (Timer-2:) update Jugada set estado=?, idTipoSerie=?, identificador=?, idTipoJuego=?, idCartonHasta=?, desde=?, hasta=?, datos=?, fechaComienzo=?, fechaFin=?, idCartonDesde=?, recaudacion=?, pagos=? where idJugada=?
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding '1' to parameter: 1
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding '1' to parameter: 2
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding '3' to parameter: 3
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding '27' to parameter: 4
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding '114955' to parameter: 5
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding null to parameter: 6
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding null to parameter: 7
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.StringType] (Timer-2:) binding '' to parameter: 8
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.TimestampType] (Timer-2:) binding '2011-06-01 12:14:03' to parameter: 9
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.TimestampType] (Timer-2:) binding null to parameter: 10
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.IntegerType] (Timer-2:) binding '114955' to parameter: 11
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.DoubleType] (Timer-2:) binding '0.0' to parameter: 12
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.DoubleType] (Timer-2:) binding '0.0' to parameter: 13
      2011-06-01 12:13:49,406 2185125 TRACE [org.hibernate.type.LongType] (Timer-2:) binding '18444' to parameter: 14
      2011-06-01 12:13:49,406 2185125 DEBUG [org.hibernate.jdbc.AbstractBatcher] (Timer-2:) Executing batch size: 1
      2011-06-01 12:13:49,421 2185140 DEBUG [org.hibernate.jdbc.AbstractBatcher] (Timer-2:) about to close PreparedStatement (open PreparedStatements: 1, globally: 3)
      2011-06-01 12:13:49,421 2185140 DEBUG [org.hibernate.jdbc.ConnectionManager] (Timer-2:) skipping aggressive-release due to flush cycle
      2011-06-01 12:13:49,421 2185140 DEBUG [org.hibernate.jdbc.ConnectionManager] (Timer-2:) skipping aggresive-release due to borrowed connection
      2011-06-01 12:13:49,437 2185156 DEBUG [org.hibernate.jdbc.ConnectionManager] (Timer-2:) releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
      2011-06-01 12:13:49,437 2185156 DEBUG [org.hibernate.util.JDBCExceptionReporter] (Timer-2:) could not log warnings
      org.jboss.util.NestedSQLException: Transaction TransactionImple < ac, BasicAction: -3f57ebd8:905:4de64ea6:4b08 status: ActionStatus.COMMITTED > cannot proceed STATUS_COMMITTED; - nested throwable: (javax.transaction.RollbackException: Transaction TransactionImple < ac, BasicAction: -3f57ebd8:905:4de64ea6:4b08 status: ActionStatus.COMMITTED > cannot proceed STATUS_COMMITTED)
          at org.jboss.resource.adapter.jdbc.WrapperDataSource.checkTransactionActive(WrapperDataSource.java:165)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.checkTransactionActive(WrappedConnection.java:833)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.checkStatus(WrappedConnection.java:848)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.checkTransaction(WrappedConnection.java:825)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.getWarnings(WrappedConnection.java:618)
          at org.hibernate.util.JDBCExceptionReporter.logAndClearWarnings(JDBCExceptionReporter.java:22)
          at org.hibernate.jdbc.ConnectionManager.closeConnection(ConnectionManager.java:449)
          at org.hibernate.jdbc.ConnectionManager.cleanup(ConnectionManager.java:385)
          at org.hibernate.jdbc.ConnectionManager.close(ConnectionManager.java:324)
          at org.hibernate.impl.SessionImpl.close(SessionImpl.java:298)
          at org.hibernate.impl.SessionImpl.managedClose(SessionImpl.java:354)
          at org.hibernate.transaction.CacheSynchronization.afterCompletion(CacheSynchronization.java:90)
          at com.arjuna.ats.internal.jta.resources.arjunacore.SynchronizationImple.afterCompletion(SynchronizationImple.java:136)
          at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.afterCompletion(TwoPhaseCoordinator.java:340)
          at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:93)
          at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:177)
          at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1389)
          at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:135)
          at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:87)
          at org.jboss.aspects.tx.TxPolicy.endTransaction(TxPolicy.java:175)
          at org.jboss.aspects.tx.TxPolicy.invokeInOurTx(TxPolicy.java:87)
          at org.jboss.aspects.tx.TxInterceptor$Required.invoke(TxInterceptor.java:191)
          at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101)
          at org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:95)
          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:110)
          at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101)
          at org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:46)
          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:304)
          at org.jboss.ejb3.remoting.IsLocalInterceptor.invokeLocal(IsLocalInterceptor.java:81)
          at org.jboss.ejb3.remoting.IsLocalInterceptor.invoke(IsLocalInterceptor.java:72)
          at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101)
          at org.jboss.ejb3.stateless.StatelessRemoteProxy.invoke(StatelessRemoteProxy.java:107)
          at $Proxy131.perform(Unknown Source)
          at sun.reflect.GeneratedMethodAccessor102.invoke(Unknown Source)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
          at java.lang.reflect.Method.invoke(Method.java:597)
          at org.springframework.remoting.rmi.RmiClientInterceptorUtils.invokeRemoteMethod(RmiClientInterceptorUtils.java:108)
          at org.springframework.ejb.access.SimpleRemoteSlsbInvokerInterceptor.doInvoke(SimpleRemoteSlsbInvokerInterceptor.java:98)
          at org.springframework.ejb.access.AbstractRemoteSlsbInvokerInterceptor.invokeInContext(AbstractRemoteSlsbInvokerInterceptor.java:137)
          at org.springframework.ejb.access.AbstractSlsbInvokerInterceptor.invoke(AbstractSlsbInvokerInterceptor.java:188)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
          at $Proxy162.perform(Unknown Source)
          at com.server.scheduler.TestScheduler.perform(TestScheduler.java:42)
          at org.jboss.varia.scheduler.Scheduler$Listener.handleNotification(Scheduler.java:1251)
          at sun.reflect.GeneratedMethodAccessor5.invoke(Unknown Source)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
          at java.lang.reflect.Method.invoke(Method.java:597)
          at org.jboss.mx.notification.NotificationListenerProxy.invoke(NotificationListenerProxy.java:153)
          at $Proxy11.handleNotification(Unknown Source)
          at javax.management.NotificationBroadcasterSupport.handleNotification(NotificationBroadcasterSupport.java:257)
          at javax.management.NotificationBroadcasterSupport$SendNotifJob.run(NotificationBroadcasterSupport.java:322)
          at javax.management.NotificationBroadcasterSupport$1.execute(NotificationBroadcasterSupport.java:307)
          at javax.management.NotificationBroadcasterSupport.sendNotification(NotificationBroadcasterSupport.java:229)
          at javax.management.timer.Timer.sendNotification(Timer.java:1237)
          at javax.management.timer.Timer.notifyAlarmClock(Timer.java:1206)
          at javax.management.timer.TimerAlarmClock.run(Timer.java:1289)
          at java.util.TimerThread.mainLoop(Timer.java:512)
          at java.util.TimerThread.run(Timer.java:462)
      Caused by: javax.transaction.RollbackException: Transaction TransactionImple < ac, BasicAction: -3f57ebd8:905:4de64ea6:4b08 status: ActionStatus.COMMITTED > cannot proceed STATUS_COMMITTED
          at org.jboss.resource.connectionmanager.TxConnectionManager.checkTransactionActive(TxConnectionManager.java:282)
          at org.jboss.resource.connectionmanager.BaseConnectionManager2$ConnectionManagerProxy.checkTransactionActive(BaseConnectionManager2.java:880)
          at org.jboss.resource.adapter.jdbc.WrapperDataSource.checkTransactionActive(WrapperDataSource.java:161)
          ... 65 more
      2011-06-01 12:13:49,453 2185172 DEBUG [org.hibernate.util.JDBCExceptionReporter] (Timer-2:) could not clear warnings
      org.jboss.util.NestedSQLException: Transaction TransactionImple < ac, BasicAction: -3f57ebd8:905:4de64ea6:4b08 status: ActionStatus.COMMITTED > cannot proceed STATUS_COMMITTED; - nested throwable: (javax.transaction.RollbackException: Transaction TransactionImple < ac, BasicAction: -3f57ebd8:905:4de64ea6:4b08 status: ActionStatus.COMMITTED > cannot proceed STATUS_COMMITTED)
          at org.jboss.resource.adapter.jdbc.WrapperDataSource.checkTransactionActive(WrapperDataSource.java:165)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.checkTransactionActive(WrappedConnection.java:833)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.checkStatus(WrappedConnection.java:848)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.checkTransaction(WrappedConnection.java:825)
          at org.jboss.resource.adapter.jdbc.WrappedConnection.clearWarnings(WrappedConnection.java:639)
          at org.hibernate.util.JDBCExceptionReporter.logAndClearWarnings(JDBCExceptionReporter.java:31)
          at org.hibernate.jdbc.ConnectionManager.closeConnection(ConnectionManager.java:449)
          at org.hibernate.jdbc.ConnectionManager.cleanup(ConnectionManager.java:385)
          at org.hibernate.jdbc.ConnectionManager.close(ConnectionManager.java:324)
          at org.hibernate.impl.SessionImpl.close(SessionImpl.java:298)
          at org.hibernate.impl.SessionImpl.managedClose(SessionImpl.java:354)
          at org.hibernate.transaction.CacheSynchronization.afterCompletion(CacheSynchronization.java:90)
          at com.arjuna.ats.internal.jta.resources.arjunacore.SynchronizationImple.afterCompletion(SynchronizationImple.java:136)
          at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.afterCompletion(TwoPhaseCoordinator.java:340)
          at com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.end(TwoPhaseCoordinator.java:93)
          at com.arjuna.ats.arjuna.AtomicAction.commit(AtomicAction.java:177)
          at com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple.commitAndDisassociate(TransactionImple.java:1389)
          at com.arjuna.ats.internal.jta.transaction.arjunacore.BaseTransaction.commit(BaseTransaction.java:135)
          at com.arjuna.ats.jbossatx.BaseTransactionManagerDelegate.commit(BaseTransactionManagerDelegate.java:87)
          at org.jboss.aspects.tx.TxPolicy.endTransaction(TxPolicy.java:175)
          at org.jboss.aspects.tx.TxPolicy.invokeInOurTx(TxPolicy.java:87)
          at org.jboss.aspects.tx.TxInterceptor$Required.invoke(TxInterceptor.java:191)
          at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101)
          at org.jboss.aspects.tx.TxPropagationInterceptor.invoke(TxPropagationInterceptor.java:95)
          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:110)
          at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101)
          at org.jboss.ejb3.ENCPropagationInterceptor.invoke(ENCPropagationInterceptor.java:46)
          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:304)
          at org.jboss.ejb3.remoting.IsLocalInterceptor.invokeLocal(IsLocalInterceptor.java:81)
          at org.jboss.ejb3.remoting.IsLocalInterceptor.invoke(IsLocalInterceptor.java:72)
          at org.jboss.aop.joinpoint.MethodInvocation.invokeNext(MethodInvocation.java:101)
          at org.jboss.ejb3.stateless.StatelessRemoteProxy.invoke(StatelessRemoteProxy.java:107)
          at $Proxy131.perform(Unknown Source)
          at sun.reflect.GeneratedMethodAccessor102.invoke(Unknown Source)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
          at java.lang.reflect.Method.invoke(Method.java:597)
          at org.springframework.remoting.rmi.RmiClientInterceptorUtils.invokeRemoteMethod(RmiClientInterceptorUtils.java:108)
          at org.springframework.ejb.access.SimpleRemoteSlsbInvokerInterceptor.doInvoke(SimpleRemoteSlsbInvokerInterceptor.java:98)
          at org.springframework.ejb.access.AbstractRemoteSlsbInvokerInterceptor.invokeInContext(AbstractRemoteSlsbInvokerInterceptor.java:137)
          at org.springframework.ejb.access.AbstractSlsbInvokerInterceptor.invoke(AbstractSlsbInvokerInterceptor.java:188)
          at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
          at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
          at $Proxy162.perform(Unknown Source)
          at server.scheduler.TestScheduler.perform(TestScheduler.java:42)
          at org.jboss.varia.scheduler.Scheduler$Listener.handleNotification(Scheduler.java:1251)
          at sun.reflect.GeneratedMethodAccessor5.invoke(Unknown Source)
          at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
          at java.lang.reflect.Method.invoke(Method.java:597)
          at org.jboss.mx.notification.NotificationListenerProxy.invoke(NotificationListenerProxy.java:153)
          at $Proxy11.handleNotification(Unknown Source)
          at javax.management.NotificationBroadcasterSupport.handleNotification(NotificationBroadcasterSupport.java:257)
          at javax.management.NotificationBroadcasterSupport$SendNotifJob.run(NotificationBroadcasterSupport.java:322)
          at javax.management.NotificationBroadcasterSupport$1.execute(NotificationBroadcasterSupport.java:307)
          at javax.management.NotificationBroadcasterSupport.sendNotification(NotificationBroadcasterSupport.java:229)
          at javax.management.timer.Timer.sendNotification(Timer.java:1237)
          at javax.management.timer.Timer.notifyAlarmClock(Timer.java:1206)
          at javax.management.timer.TimerAlarmClock.run(Timer.java:1289)
          at java.util.TimerThread.mainLoop(Timer.java:512)
          at java.util.TimerThread.run(Timer.java:462)
      Caused by: javax.transaction.RollbackException: Transaction TransactionImple < ac, BasicAction: -3f57ebd8:905:4de64ea6:4b08 status: ActionStatus.COMMITTED > cannot proceed STATUS_COMMITTED
          at org.jboss.resource.connectionmanager.TxConnectionManager.checkTransactionActive(TxConnectionManager.java:282)
          at org.jboss.resource.connectionmanager.BaseConnectionManager2$ConnectionManagerProxy.checkTransactionActive(BaseConnectionManager2.java:880)
          at org.jboss.resource.adapter.jdbc.WrapperDataSource.checkTransactionActive(WrapperDataSource.java:161)
          ... 65 more
      

       

      Thanks in advance!