1 Reply Latest reply on Feb 22, 2006 5:04 PM by ananner

    java.lang.InterruptedException occurs when running JBPM-db 3

    ananner

      When running the JBPM 3.1 DB test scripts, the scripts will run for approximately 10-15 mins until it locks up and hangs. This is the last error displayed in the console:

      --------------------

      [junit] 14:37:22,660 [JbpmCommandExecutor] WARN BasicResourcePool : com.mchange.v2.resourcepool.BasicResourcePool@b
      6d6ab -- an attempt to checkout a resource was interrupted, and the pool is still live: some other thread must have either interrupted the Thread attempting checkout!
      [junit] java.lang.InterruptedException
      [junit] at java.lang.Object.wait(Native Method)
      [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAcquire(BasicResourcePool.java:968)
      [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:208)
      [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.j
      ava:260)
      [junit] at com.mchange.v2.c3p0.PoolBackedDataSource.getConnection(PoolBackedDataSource.java:94)
      [junit] at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:35)
      [junit] at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:315)
      [junit] at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:109)
      [junit] at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:137)
      [junit] at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:57)
      [junit] at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1262)
      [junit] at org.jbpm.persistence.db.DbPersistenceService.getSession(DbPersistenceService.java:98)
      [junit] at org.jbpm.persistence.db.DbPersistenceService.getMessagingSession(DbPersistenceService.java:234)
      [junit] at org.jbpm.JbpmContext.getMessagingSession(JbpmContext.java:411)
      [junit] at org.jbpm.msg.db.DbMessageService.(DbMessageService.java:49)
      [junit] at org.jbpm.msg.db.DbMessageServiceFactory.openService(DbMessageServiceFactory.java:32)
      [junit] at org.jbpm.svc.Services.getService(Services.java:136)
      [junit] at org.jbpm.svc.Services.getMessageService(Services.java:172)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.executeCommand(CommandExecutorThread.java:111)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.run(CommandExecutorThread.java:79)
      [junit] 14:37:22,660 [JbpmCommandExecutor] DEBUG SqlUtils : Converting Throwable to SQLException...
      [junit] java.lang.InterruptedException
      [junit] at java.lang.Object.wait(Native Method)
      [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAcquire(BasicResourcePool.java:968)
      [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:208)
      [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.j
      ava:260)
      [junit] at com.mchange.v2.c3p0.PoolBackedDataSource.getConnection(PoolBackedDataSource.java:94)
      [junit] at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:35)
      [junit] at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:315)
      [junit] at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:109)
      [junit] at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:137)
      [junit] at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:57)
      [junit] at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1262)
      [junit] at org.jbpm.persistence.db.DbPersistenceService.getSession(DbPersistenceService.java:98)
      [junit] at org.jbpm.persistence.db.DbPersistenceService.getMessagingSession(DbPersistenceService.java:234)
      [junit] at org.jbpm.JbpmContext.getMessagingSession(JbpmContext.java:411)
      [junit] at org.jbpm.msg.db.DbMessageService.(DbMessageService.java:49)
      [junit] at org.jbpm.msg.db.DbMessageServiceFactory.openService(DbMessageServiceFactory.java:32)
      [junit] at org.jbpm.svc.Services.getService(Services.java:136)
      [junit] at org.jbpm.svc.Services.getMessageService(Services.java:172)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.executeCommand(CommandExecutorThread.java:111)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.run(CommandExecutorThread.java:79)
      [junit] 14:37:22,676 [JbpmCommandExecutor] WARN JDBCExceptionReporter : SQL Error: 0, SQLState: null
      [junit] 14:37:22,676 [JbpmCommandExecutor] ERROR JDBCExceptionReporter : An SQLException was provoked by the followi
      ng failure: java.lang.InterruptedException
      [junit] 14:37:22,676 [JbpmCommandExecutor] DEBUG CommandExecutorThread : command 'null' threw exception. rolling bac
      k transaction
      [junit] org.hibernate.exception.GenericJDBCException: Cannot open connection
      [junit] at org.hibernate.exception.SQLStateConverter.handledNonSpecificException(SQLStateConverter.java:91)
      [junit] at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:79)
      [junit] at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
      [junit] at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:29)
      [junit] at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:318)
      [junit] at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:109)
      [junit] org.jbpm.JbpmException: User provided session was combined with setRollbackOnly. With user provided hiberna
      te sessions, the user is responsible for managing transactions
      [junit] at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:137)
      [junit] at org.jbpm.persistence.db.DbPersistenceService.close(DbPersistenceService.java:138)
      [junit] at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:57)
      [junit] at org.jbpm.svc.Services.close(Services.java:211)
      [junit] at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1262)
      [junit] at org.jbpm.JbpmContext.close(JbpmContext.java:138)
      [junit] at org.jbpm.persistence.db.DbPersistenceService.getSession(DbPersistenceService.java:98)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.executeCommand(CommandExecutorThread.java:138)
      [junit] at org.jbpm.persistence.db.DbPersistenceService.getMessagingSession(DbPersistenceService.java:234)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.run(CommandExecutorThread.java:79)
      [junit] at org.jbpm.JbpmContext.getMessagingSession(JbpmContext.java:411)
      [junit] at org.jbpm.msg.db.DbMessageService.(DbMessageService.java:49)
      [junit] at org.jbpm.msg.db.DbMessageServiceFactory.openService(DbMessageServiceFactory.java:32)
      [junit] at org.jbpm.svc.Services.getService(Services.java:136)
      [junit] at org.jbpm.svc.Services.getMessageService(Services.java:172)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.executeCommand(CommandExecutorThread.java:111)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.run(CommandExecutorThread.java:79)
      [junit] Caused by: java.sql.SQLException: An SQLException was provoked by the following failure: java.lang.Interrupt
      edException
      [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:104)
      [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:65)
      [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:62)
      [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.j
      ava:266)
      [junit] at com.mchange.v2.c3p0.PoolBackedDataSource.getConnection(PoolBackedDataSource.java:94)
      [junit] at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:35)
      [junit] at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:315)
      [junit] ... 13 more
      [junit] Caused by: java.lang.InterruptedException
      [junit] at java.lang.Object.wait(Native Method)
      [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAcquire(BasicResourcePool.java:968)
      [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:208)
      [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.j
      ava:260)
      [junit] ... 16 more
      [junit] 14:37:22,676 [JbpmCommandExecutor] DEBUG JbpmContext : closing JbpmContext
      [junit] 14:37:22,676 [JbpmCommandExecutor] DEBUG Services : closing service 'persistence': org.jbpm.persistence.db.D
      bPersistenceService@360ac1
      [junit] 14:37:22,676 [JbpmCommandExecutor] ERROR Services : problem closing service 'persistence'
      [junit] org.jbpm.JbpmException: User provided session was combined with setRollbackOnly. With user provided hiberna
      te sessions, the user is responsible for managing transactions
      [junit] at org.jbpm.persistence.db.DbPersistenceService.close(DbPersistenceService.java:138)
      [junit] at org.jbpm.svc.Services.close(Services.java:211)
      [junit] at org.jbpm.JbpmContext.close(JbpmContext.java:138)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.executeCommand(CommandExecutorThread.java:138)
      [junit] at org.jbpm.msg.command.CommandExecutorThread.run(CommandExecutorThread.java:79)
      [junit] 14:37:22,676 [JbpmCommandExecutor] ERROR CommandExecutorThread : org.jbpm.JbpmException: problem closing ser
      vices {persistence=org.jbpm.JbpmException: User provided session was combined with setRollbackOnly. With user provided
      hibernate sessions, the user is responsible for managing transactions}
      [junit] 14:37:27,676 [JbpmCommandExecutor] DEBUG JbpmContextInfo : creating jbpm context with service factories '[me
      ssage, scheduler, logging, persistence, authentication]'
      [junit] 14:37:27,676 [JbpmCommandExecutor] DEBUG JbpmContext : creating JbpmContext
      [junit] 14:37:27,676 [JbpmCommandExecutor] DEBUG DbPersistenceServiceFactory : creating persistence service
      [junit] 14:37:27,676 [JbpmCommandExecutor] DEBUG DbPersistenceService : creating hibernate session
      [junit] 14:37:27,676 [JbpmCommandExecutor] DEBUG DbPersistenceService : beginning hibernate transaction
      [junit] 14:37:27,676 [JbpmCommandExecutor] DEBUG BasicResourcePool : awaitAvailable(): com.mchange.v2.c3p0.impl.NewP
      ooledConnection@e22f2b
      [junit] 14:37:27,676 [JbpmCommandExecutor] DEBUG BasicResourcePool : trace com.mchange.v2.resourcepool.BasicResource
      Pool@b6d6ab [managed: 3, unused: 0, excluded: 0] (e.g. com.mchange.v2.c3p0.impl.NewPooledConnection@e22f2b)