0 Replies Latest reply on Apr 3, 2007 12:05 PM by jamiec

    java.sql.BatchUpdateException: ORA-01003: no statement parse

    jamiec

      We are intermittently seeing the above error when JBPM_LOG table.

      Application is running on Weblogic 9.1 and over an Oracle 10g Database.
      We are using jbpm 3.1 Hibernate Config is set up to Obtain the Datasource from weblogic.

      DEBUG - 2007-04-02 13:46:04,955 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] def.AbstractFlushingEventListener (performExecutions:289) - executing flush
      DEBUG - 2007-04-02 13:46:04,956 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] entity.AbstractEntityPersister (insert:2034) - Inserting entity: [org.jbpm.graph.log.SignalLog#1419785]
      DEBUG - 2007-04-02 13:46:04,957 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (logOpenPreparedStatement:311) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
      DEBUG - 2007-04-02 13:46:04,958 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (openConnection:322) - opening JDBC connection
      DEBUG - 2007-04-02 13:46:04,959 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] hibernate.SQL (log:346) - insert into JBPM_LOG (INDEX_, DATE_, TOKEN_, PARENT_, TRANSITION_, CLASS_, ID_) values (?, ?, ?, ?, ?, 'S', ?)
      DEBUG - 2007-04-02 13:46:04,960 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (getPreparedStatement:424) - preparing statement
      DEBUG - 2007-04-02 13:46:04,961 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] entity.AbstractEntityPersister (dehydrate:1821) - Dehydrating entity: [org.jbpm.graph.log.SignalLog#1419785]
      DEBUG - 2007-04-02 13:46:04,963 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (addToBatch:28) - Adding to batch
      DEBUG - 2007-04-02 13:46:04,964 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] entity.AbstractEntityPersister (insert:2034) - Inserting entity: [org.jbpm.graph.log.TransitionLog#1419786]
      DEBUG - 2007-04-02 13:46:04,964 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (doExecuteBatch:55) - Executing batch size: 1
      DEBUG - 2007-04-02 13:46:05,000 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (checkRowCount:85) - success of batch update unknown: 0
      DEBUG - 2007-04-02 13:46:05,002 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (logClosePreparedStatement:319) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
      DEBUG - 2007-04-02 13:46:05,003 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (closePreparedStatement:470) - closing statement
      DEBUG - 2007-04-02 13:46:05,004 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (aggressiveRelease:305) - aggressively releasing JDBC connection
      DEBUG - 2007-04-02 13:46:05,005 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (closeConnection:342) - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
      DEBUG - 2007-04-02 13:46:05,006 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (logOpenPreparedStatement:311) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
      DEBUG - 2007-04-02 13:46:05,007 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (openConnection:322) - opening JDBC connection
      DEBUG - 2007-04-02 13:46:05,008 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] hibernate.SQL (log:346) - insert into JBPM_LOG (INDEX_, DATE_, TOKEN_, PARENT_, TRANSITION_, SOURCENODE_, DESTINATIONNODE_, CLASS_, ID_) values (?, ?, ?, ?, ?, ?, ?, 'T', ?)
      DEBUG - 2007-04-02 13:46:05,010 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (getPreparedStatement:424) - preparing statement
      DEBUG - 2007-04-02 13:46:05,011 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] entity.AbstractEntityPersister (dehydrate:1821) - Dehydrating entity: [org.jbpm.graph.log.TransitionLog#1419786]
      DEBUG - 2007-04-02 13:46:05,012 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (addToBatch:28) - Adding to batch
      DEBUG - 2007-04-02 13:46:05,013 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] entity.AbstractEntityPersister (insert:2034) - Inserting entity: [org.jbpm.graph.log.ActionLog#1419787]
      DEBUG - 2007-04-02 13:46:05,014 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (doExecuteBatch:55) - Executing batch size: 1
      DEBUG - 2007-04-02 13:46:05,017 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (checkRowCount:85) - success of batch update unknown: 0
      DEBUG - 2007-04-02 13:46:05,018 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (logClosePreparedStatement:319) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
      DEBUG - 2007-04-02 13:46:05,020 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (closePreparedStatement:470) - closing statement
      DEBUG - 2007-04-02 13:46:05,021 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (aggressiveRelease:305) - aggressively releasing JDBC connection
      DEBUG - 2007-04-02 13:46:05,022 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (closeConnection:342) - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
      DEBUG - 2007-04-02 13:46:05,023 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (logOpenPreparedStatement:311) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
      DEBUG - 2007-04-02 13:46:05,024 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (openConnection:322) - opening JDBC connection
      DEBUG - 2007-04-02 13:46:05,025 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] hibernate.SQL (log:346) - insert into JBPM_LOG (INDEX_, DATE_, TOKEN_, PARENT_, EXCEPTION_, ACTION_, CLASS_, ID_) values (?, ?, ?, ?, ?, ?, 'A', ?)
      DEBUG - 2007-04-02 13:46:05,026 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (getPreparedStatement:424) - preparing statement
      DEBUG - 2007-04-02 13:46:05,027 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] entity.AbstractEntityPersister (dehydrate:1821) - Dehydrating entity: [org.jbpm.graph.log.ActionLog#1419787]
      DEBUG - 2007-04-02 13:46:05,028 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (addToBatch:28) - Adding to batch
      DEBUG - 2007-04-02 13:46:05,030 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] entity.AbstractEntityPersister (insert:2034) - Inserting entity: [org.jbpm.taskmgmt.log.TaskCreateLog#1419788]
      DEBUG - 2007-04-02 13:46:05,031 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (doExecuteBatch:55) - Executing batch size: 1
      DEBUG - 2007-04-02 13:46:05,126 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (logClosePreparedStatement:319) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
      DEBUG - 2007-04-02 13:46:05,127 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.AbstractBatcher (closePreparedStatement:470) - closing statement
      DEBUG - 2007-04-02 13:46:05,129 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (aggressiveRelease:305) - aggressively releasing JDBC connection
      DEBUG - 2007-04-02 13:46:05,130 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] jdbc.ConnectionManager (closeConnection:342) - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
      DEBUG - 2007-04-02 13:46:05,132 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] util.JDBCExceptionReporter (logExceptions:63) - Could not execute JDBC batch update [insert into JBPM_LOG (INDEX_, DATE_, TOKEN_, PARENT_, EXCEPTION_, ACTION_, CLASS_, ID_) values (?, ?, ?, ?, ?, ?, 'A', ?)]
      java.sql.BatchUpdateException: ORA-01003: no statement parsed

      at oracle.jdbc.driver.DatabaseError.throwBatchUpdateException(DatabaseError.java:367)
      at oracle.jdbc.driver.OraclePreparedStatement.executeBatch(OraclePreparedStatement.java:9040)
      at weblogic.jdbc.wrapper.PreparedStatement.executeBatch(PreparedStatement.java:157)
      at org.hibernate.jdbc.BatchingBatcher.doExecuteBatch(BatchingBatcher.java:58)
      at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:195)
      at org.hibernate.jdbc.AbstractBatcher.prepareStatement(AbstractBatcher.java:91)
      at org.hibernate.jdbc.AbstractBatcher.prepareStatement(AbstractBatcher.java:86)
      at org.hibernate.jdbc.AbstractBatcher.prepareBatchStatement(AbstractBatcher.java:171)
      at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2048)
      at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2427)
      at org.hibernate.action.EntityInsertAction.execute(EntityInsertAction.java:51)
      at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:243)
      at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:227)
      at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:140)
      at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:296)
      at org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:27)
      at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:1007)
      at org.hibernate.impl.SessionImpl.managedFlush(SessionImpl.java:354)
      at org.hibernate.transaction.JTATransaction.commit(JTATransaction.java:135)
      at org.jbpm.persistence.db.DbPersistenceService.close(DbPersistenceService.java:161)
      at org.jbpm.svc.Services.close(Services.java:211)
      at org.jbpm.JbpmContext.close(JbpmContext.java:138)
      at com.us..coe.wf.CoeSession.close(CoeSession.java:129)
      at com.us.CreateAndMatchHelper.createProcessInstance(CreateAndMatchHelper.java:254)
      at com.us.CreateAndMatchHelper.createNewWorkObject(CreateAndMatchHelper.java:172)
      at com.us..wms.integration.service.WMSIntegrationService.createNewWorkObject(WMSIntegrationService.java:109)
      at com.us..wms.integration.service.WMSIntegrationService.createOrMatchWorkObjects(WMSIntegrationService.java:167)
      at com.us..wms.integration.service.WMSIntegrationService.processIndexGroups(WMSIntegrationService.java:456)
      at com.us..wms.integration.controller.WMSIntegrationRequestController.processIndexGroups(WMSIntegrationRequestController.java:88)
      at sun.reflect.GeneratedMethodAccessor435.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at com.us.WMSIntegrationRequestController.processRequest(WMSIntegrationRequestController.java:58)
      at com.us.WMSIntegrationServiceFacadeBean.processRequest(WMSIntegrationServiceFacadeBean.java:61)
      at com.us.WMSIntegrationService_e5qmk6_EOImpl.processRequest(WMSIntegrationService_e5qmk6_EOImpl.java:61)
      at com.us.WMSIntegrationService_e5qmk6_EOImpl_WLSkel.invoke(Unknown Source)
      at weblogic.rmi.internal.BasicServerRef.invoke(BasicServerRef.java:517)
      at weblogic.rmi.cluster.ClusterableServerRef.invoke(ClusterableServerRef.java:224)
      at weblogic.rmi.internal.BasicServerRef$1.run(BasicServerRef.java:407)
      at weblogic.security.acl.internal.AuthenticatedSubject.doAs(AuthenticatedSubject.java:363)
      at weblogic.security.service.SecurityManager.runAs(SecurityManager.java:147)
      at weblogic.rmi.internal.BasicServerRef.handleRequest(BasicServerRef.java:403)
      at weblogic.rmi.internal.BasicServerRef.access$300(BasicServerRef.java:56)
      at weblogic.rmi.internal.BasicServerRef$BasicExecuteRequest.run(BasicServerRef.java:934)
      at weblogic.work.ExecuteThread.execute(ExecuteThread.java:207)
      at weblogic.work.ExecuteThread.run(ExecuteThread.java:179)
      WARN - 2007-04-02 13:46:05,134 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] util.JDBCExceptionReporter (logExceptions:71) - SQL Error: 1003, SQLState: 72000
      ERROR - 2007-04-02 13:46:05,135 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] util.JDBCExceptionReporter (logExceptions:72) - ORA-01003: no statement parsed

      WARN - 2007-04-02 13:46:05,136 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] util.JDBCExceptionReporter (logExceptions:71) - SQL Error: 1003, SQLState: 72000
      ERROR - 2007-04-02 13:46:05,137 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] util.JDBCExceptionReporter (logExceptions:72) - ORA-01003: no statement parsed

      ERROR - 2007-04-02 13:46:05,138 [[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'] def.AbstractFlushingEventListener (performExecutions:299) - Could not synchronize database state with session
      org.hibernate.exception.GenericJDBCException: Could not execute JDBC batch update
      at org.hibernate.exception.SQLStateConverter.handledNonSpecificException(SQLStateConverter.java:91)
      at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:79)
      at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
      at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:202)
      at org.hibernate.jdbc.AbstractBatcher.prepareStatement(AbstractBatcher.java:91)
      at org.hibernate.jdbc.AbstractBatcher.prepareStatement(AbstractBatcher.java:86)
      at org.hibernate.jdbc.AbstractBatcher.prepareBatchStatement(AbstractBatcher.java:171)
      at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2048)
      at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2427)
      at org.hibernate.action.EntityInsertAction.execute(EntityInsertAction.java:51)
      at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:243)
      at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:227)
      at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:140)
      at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:296)
      at org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:27)
      at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:1007)
      at org.hibernate.impl.SessionImpl.managedFlush(SessionImpl.java:354)
      at org.hibernate.transaction.JTATransaction.commit(JTATransaction.java:135)
      at org.jbpm.persistence.db.DbPersistenceService.close(DbPersistenceService.java:161)
      at org.jbpm.svc.Services.close(Services.java:211)
      at org.jbpm.JbpmContext.close(JbpmContext.java:138)
      at com.us..coe.wf.CoeSession.close(CoeSession.java:129)
      at com.us..wms.integration.helper.CreateAndMatchHelper.createProcessInstance(CreateAndMatchHelper.java:254)
      at com.us..wms.integration.helper.CreateAndMatchHelper.createNewWorkObject(CreateAndMatchHelper.java:172)
      at com.us..wms.integration.service.WMSIntegrationService.createNewWorkObject(WMSIntegrationService.java:109)
      at com.us..wms.integration.service.WMSIntegrationService.createOrMatchWorkObjects(WMSIntegrationService.java:167)
      at com.us..wms.integration.service.WMSIntegrationService.processIndexGroups(WMSIntegrationService.java:456)
      at com.us..wms.integration.controller.WMSIntegrationRequestController.processIndexGroups(WMSIntegrationRequestController.java:88)
      at sun.reflect.GeneratedMethodAccessor435.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at com.us..wms.integration.controller.WMSIntegrationRequestController.processRequest(WMSIntegrationRequestController.java:58)
      at com.us..wms.integration.WMSIntegrationServiceFacadeBean.processRequest(WMSIntegrationServiceFacadeBean.java:61)
      at com.us..wms.integration.WMSIntegrationService_e5qmk6_EOImpl.processRequest(WMSIntegrationService_e5qmk6_EOImpl.java:61)
      at com.us..wms.integration.WMSIntegrationService_e5qmk6_EOImpl_WLSkel.invoke(Unknown Source)
      at weblogic.rmi.internal.BasicServerRef.invoke(BasicServerRef.java:517)
      at weblogic.rmi.cluster.ClusterableServerRef.invoke(ClusterableServerRef.java:224)
      at weblogic.rmi.internal.BasicServerRef$1.run(BasicServerRef.java:407)
      at weblogic.security.acl.internal.AuthenticatedSubject.doAs(AuthenticatedSubject.java:363)
      at weblogic.security.service.SecurityManager.runAs(SecurityManager.java:147)
      at weblogic.rmi.internal.BasicServerRef.handleRequest(BasicServerRef.java:403)
      at weblogic.rmi.internal.BasicServerRef.access$300(BasicServerRef.java:56)
      at weblogic.rmi.internal.BasicServerRef$BasicExecuteRequest.run(BasicServerRef.java:934)
      at weblogic.work.ExecuteThread.execute(ExecuteThread.java:207)
      at weblogic.work.ExecuteThread.run(ExecuteThread.java:179)
      Caused by: java.sql.BatchUpdateException: ORA-01003: no statement parsed

      at oracle.jdbc.driver.DatabaseError.throwBatchUpdateException(DatabaseError.java:367)
      at oracle.jdbc.driver.OraclePreparedStatement.executeBatch(OraclePreparedStatement.java:9040)
      at weblogic.jdbc.wrapper.PreparedStatement.executeBatch(PreparedStatement.java:157)
      at org.hibernate.jdbc.BatchingBatcher.doExecuteBatch(BatchingBatcher.java:58)
      at org.hibernate.jdbc.AbstractBatcher.executeBatch(AbstractBatcher.java:195)
      ... 41 more