Hi
here is scenario i am running into:
During hibernate flush, Hibernate is trying to persist the ApplicantResponse object and throws the following exception. The interesting part is it doesn't throw the exception all the time. it throws only for few users. lets say around 25% to 30% of the users. This is in stress environment and we use the same input for all the users. This also happens in production occasionally.
When i look at the hibernate logs it says it is setting the bind parameter value for APPLICANT_ID as you can see below.
Please let me know if you need more information.
I would really appreciate any help with this.
Environment:
OC4J 10.1.2, Struts 1.1, Spring 1.2.8, Hibernate 3.2.5, Oracle 9i release2
2008-06-18 15:59:19,973 DEBUG org.hibernate.persister.entity.AbstractEntityPersister - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Inserting entity: [org.act.survey.applicant.model.impl.ApplicantResponseImpl#87032911]
2008-06-18 15:59:19,973 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2008-06-18 15:59:19,973 DEBUG org.hibernate.SQL - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - insert into SURVEY.APPLICANT_RESPONSE (SURVEY_QUESTION_ID, SURVEY_QUESTION_NAME, ESSAY, response, score, RESPONSE_MEANING, APPLICANT_ID, LAST_MODIFIED_DATE, LAST_MODIFIED_BY, APPLICANT_RESPONSE_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
2008-06-18 15:59:19,973 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - preparing statement
2008-06-18 15:59:19,973 DEBUG org.hibernate.persister.entity.AbstractEntityPersister - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Dehydrating entity: [org.act.survey.applicant.model.impl.ApplicantResponseImpl#87032911]
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'questionId-86851236' to parameter: 1
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'questionId-86851236' to parameter: 1
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'C7' to parameter: 2
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'C7' to parameter: 2
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TextType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 3
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TextType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 3
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 4
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 4
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.DoubleType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 5
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.DoubleType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 5
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 6
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 6
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032295' to parameter: 7
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032295' to parameter: 7
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '2008-06-18 15:59:19' to parameter: 8
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '2008-06-18 15:59:19' to parameter: 8
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'YHAJMMMCGHDSAOATN' to parameter: 9
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'YHAJMMMCGHDSAOATN' to parameter: 9
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032911' to parameter: 10
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032911' to parameter: 10
2008-06-18 15:59:19,973 DEBUG org.hibernate.persister.entity.AbstractEntityPersister - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Dehydrating entity: [org.act.survey.applicant.model.impl.ApplicantResponseImpl#87032911]
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'questionId-86851236' to parameter: 1
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'questionId-86851236' to parameter: 1
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'C7' to parameter: 2
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'C7' to parameter: 2
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TextType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 3
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TextType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 3
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 4
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 4
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.DoubleType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 5
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.DoubleType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 5
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 6
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding null to parameter: 6
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032295' to parameter: 7
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032295' to parameter: 7
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '2008-06-18 15:59:19' to parameter: 8
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '2008-06-18 15:59:19' to parameter: 8
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'YHAJMMMCGHDSAOATN' to parameter: 9
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding 'YHAJMMMCGHDSAOATN' to parameter: 9
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032911' to parameter: 10
2008-06-18 15:59:19,974 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '87032911' to parameter: 10
2008-06-18 15:59:19,976 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2008-06-18 15:59:19,976 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - closing statement
2008-06-18 15:59:19,976 DEBUG org.hibernate.util.JDBCExceptionReporter - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - could not insert: [org.act.survey.applicant.model.impl.ApplicantResponseImpl] [insert into SURVEY.APPLICANT_RESPONSE (SURVEY_QUESTION_ID, SURVEY_QUESTION_NAME, ESSAY, response, score, RESPONSE_MEANING, APPLICANT_ID, LAST_MODIFIED_DATE, LAST_MODIFIED_BY, APPLICANT_RESPONSE_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?)]
java.sql.SQLException: ORA-01400: cannot insert NULL into ("SURVEY"."APPLICANT_RESPONSE"."APPLICANT_ID")
at oracle.jdbc.driver.DatabaseError.throwSqlException(DatabaseError.java:137)
at oracle.jdbc.driver.T4CTTIoer.processError(T4CTTIoer.java:304)
at oracle.jdbc.driver.T4CTTIoer.processError(T4CTTIoer.java:271)
at oracle.jdbc.driver.T4C8Oall.receive(T4C8Oall.java:625)
at oracle.jdbc.driver.T4CPreparedStatement.doOall8(T4CPreparedStatement.java:181)
at oracle.jdbc.driver.T4CPreparedStatement.execute_for_rows(T4CPreparedStatement.java:629)
at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1153)
at oracle.jdbc.driver.OraclePreparedStatement.executeInternal(OraclePreparedStatement.java:2932)
at oracle.jdbc.driver.OraclePreparedStatement.executeUpdate(OraclePreparedStatement.java:3004)
at com.evermind.sql.FilterPreparedStatement.executeUpdate(FilterPreparedStatement.java:240)
at com.evermind.sql.FilterPreparedStatement.executeUpdate(FilterPreparedStatement.java:240)
at com.evermind.sql.PreparedStatementBCELProxy.executeUpdate(PreparedStatementBCELProxy.java:46)
at org.hibernate.jdbc.NonBatchingBatcher.addToBatch(NonBatchingBatcher.java:23)
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2247)
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2660)
at org.hibernate.action.EntityInsertAction.execute(EntityInsertAction.java:56)
at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:250)
at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:234)
at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:141)
at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:298)
at org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:27)
at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:1000)
at org.hibernate.impl.SessionImpl.managedFlush(SessionImpl.java:338)
at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:106)
at org.springframework.orm.hibernate3.HibernateTransactionManager.doCommit(HibernateTransactionManager.java:584)
at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:500)
at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:473)
at org.springframework.transaction.interceptor.TransactionAspectSupport.doCommitTransactionAfterReturning(TransactionAspectSupport.java:267)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:170)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:176)
at $Proxy20.saveApplicant(Unknown Source)
at org.act.survey.action.BlockAction.save(BlockAction.java:132)
at sun.reflect.GeneratedMethodAccessor509.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:324)
at org.apache.struts.actions.DispatchAction.dispatchMethod(DispatchAction.java:280)
at org.apache.struts.actions.DispatchAction.execute(DispatchAction.java:216)
at org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:484)
at org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:274)
at org.apache.struts.action.ActionServlet.process(ActionServlet.java:1482)
at org.apache.struts.action.ActionServlet.doPost(ActionServlet.java:525)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:760)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:853)
at com.evermind.server.http.ResourceFilterChain.doFilter(ResourceFilterChain.java:65)
at org.act.survey.filter.AuditInformationFilter.doFilterInternal(AuditInformationFilter.java:29)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:77)
at com.evermind.server.http.EvermindFilterChain.doFilter(EvermindFilterChain.java:16)
at org.act.vtc.util.hibernate.OpenSessionInViewFilter.doFilter(OpenSessionInViewFilter.java:47)
at com.evermind.server.http.EvermindFilterChain.doFilter(EvermindFilterChain.java:20)
at org.springframework.orm.hibernate3.support.OpenSessionInViewFilter.doFilterInternal(OpenSessionInViewFilter.java:174)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:77)
at com.evermind.server.http.EvermindFilterChain.doFilter(EvermindFilterChain.java:20)
at org.act.survey.filter.CharacterEncodingFilter.doFilter(CharacterEncodingFilter.java:30)
at com.evermind.server.http.ServletRequestDispatcher.invoke(ServletRequestDispatcher.java:659)
at com.evermind.server.http.ServletRequestDispatcher.forwardInternal(ServletRequestDispatcher.java:330)
at com.evermind.server.http.HttpRequestHandler.processRequest(HttpRequestHandler.java:830)
at com.evermind.server.http.AJPRequestHandler.run(AJPRequestHandler.java:224)
at com.evermind.server.http.AJPRequestHandler.run(AJPRequestHandler.java:133)
at com.evermind.util.ReleasableResourcePooledExecutor$MyWorker.run(ReleasableResourcePooledExecutor.java:192)
at java.lang.Thread.run(Thread.java:534)
2008-06-18 15:59:19,977 WARN org.hibernate.util.JDBCExceptionReporter - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - SQL Error: 1400, SQLState: 23000
2008-06-18 15:59:19,977 ERROR org.hibernate.util.JDBCExceptionReporter - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - ORA-01400: cannot insert NULL into ("SURVEY"."APPLICANT_RESPONSE"."APPLICANT_ID")
2008-06-18 15:59:19,977 ERROR org.hibernate.event.def.AbstractFlushingEventListener - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Could not synchronize database state with session
org.hibernate.exception.ConstraintViolationException: could not insert: [org.act.survey.applicant.model.impl.ApplicantResponseImpl]
at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:71)
at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2267)
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2660)
at org.hibernate.action.EntityInsertAction.execute(EntityInsertAction.java:56)
at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:250)
at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:234)
at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:141)
at org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:298)
at org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:27)
at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:1000)
at org.hibernate.impl.SessionImpl.managedFlush(SessionImpl.java:338)
at org.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:106)
at org.springframework.orm.hibernate3.HibernateTransactionManager.doCommit(HibernateTransactionManager.java:584)
at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:500)
at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:473)
at org.springframework.transaction.interceptor.TransactionAspectSupport.doCommitTransactionAfterReturning(TransactionAspectSupport.java:267)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:170)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:176)
at $Proxy20.saveApplicant(Unknown Source)
at org.act.survey.action.BlockAction.save(BlockAction.java:132)
at sun.reflect.GeneratedMethodAccessor509.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:324)
at org.apache.struts.actions.DispatchAction.dispatchMethod(DispatchAction.java:280)
at org.apache.struts.actions.DispatchAction.execute(DispatchAction.java:216)
at org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:484)
at org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:274)
at org.apache.struts.action.ActionServlet.process(ActionServlet.java:1482)
at org.apache.struts.action.ActionServlet.doPost(ActionServlet.java:525)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:760)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:853)
at com.evermind.server.http.ResourceFilterChain.doFilter(ResourceFilterChain.java:65)
at org.act.survey.filter.AuditInformationFilter.doFilterInternal(AuditInformationFilter.java:29)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:77)
at com.evermind.server.http.EvermindFilterChain.doFilter(EvermindFilterChain.java:16)
at org.act.vtc.util.hibernate.OpenSessionInViewFilter.doFilter(OpenSessionInViewFilter.java:47)
at com.evermind.server.http.EvermindFilterChain.doFilter(EvermindFilterChain.java:20)
at org.springframework.orm.hibernate3.support.OpenSessionInViewFilter.doFilterInternal(OpenSessionInViewFilter.java:174)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:77)
at com.evermind.server.http.EvermindFilterChain.doFilter(EvermindFilterChain.java:20)
at org.act.survey.filter.CharacterEncodingFilter.doFilter(CharacterEncodingFilter.java:30)
at com.evermind.server.http.ServletRequestDispatcher.invoke(ServletRequestDispatcher.java:659)
at com.evermind.server.http.ServletRequestDispatcher.forwardInternal(ServletRequestDispatcher.java:330)
at com.evermind.server.http.HttpRequestHandler.processRequest(HttpRequestHandler.java:830)
at com.evermind.server.http.AJPRequestHandler.run(AJPRequestHandler.java:224)
at com.evermind.server.http.AJPRequestHandler.run(AJPRequestHandler.java:133)
at com.evermind.util.ReleasableResourcePooledExecutor$MyWorker.run(ReleasableResourcePooledExecutor.java:192)
at java.lang.Thread.run(Thread.java:534)
Caused by: java.sql.SQLException: ORA-01400: cannot insert NULL into ("SURVEY"."APPLICANT_RESPONSE"."APPLICANT_ID")
at oracle.jdbc.driver.DatabaseError.throwSqlException(DatabaseError.java:137)
at oracle.jdbc.driver.T4CTTIoer.processError(T4CTTIoer.java:304)
at oracle.jdbc.driver.T4CTTIoer.processError(T4CTTIoer.java:271)
at oracle.jdbc.driver.T4C8Oall.receive(T4C8Oall.java:625)
at oracle.jdbc.driver.T4CPreparedStatement.doOall8(T4CPreparedStatement.java:181)
at oracle.jdbc.driver.T4CPreparedStatement.execute_for_rows(T4CPreparedStatement.java:629)
at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1153)
at oracle.jdbc.driver.OraclePreparedStatement.executeInternal(OraclePreparedStatement.java:2932)
at oracle.jdbc.driver.OraclePreparedStatement.executeUpdate(OraclePreparedStatement.java:3004)
at com.evermind.sql.FilterPreparedStatement.executeUpdate(FilterPreparedStatement.java:240)
at com.evermind.sql.FilterPreparedStatement.executeUpdate(FilterPreparedStatement.java:240)
at com.evermind.sql.PreparedStatementBCELProxy.executeUpdate(PreparedStatementBCELProxy.java:46)
at org.hibernate.jdbc.NonBatchingBatcher.addToBatch(NonBatchingBatcher.java:23)
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:2247)
... 47 more
Mapping documents:
ApplicantImpl.hbm.xml
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 3.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd">
<hibernate-mapping>
<typedef class="org.act.survey.util.BooleanType" name="varchar_boolean" />
<class name="org.act.survey.applicant.model.impl.ApplicantImpl"
table="APPLICANT"
schema="SURVEY"
proxy="org.act.survey.applicant.model.Applicant">
<id name="id" column="APPLICANT_ID">
<generator class="sequence">
<param name="sequence">SURVEY.SEQ_GENERIC</param>
</generator>
</id>
<natural-id>
<property name="externalId" column="EXTERNAL_ID"/>
</natural-id>
<property name="status"/>
<property name="token"/>
<property name="eligibilityPassed" column="ELIGIBILITY_PASSED" />
<property name="surveyId" column="SURVEY_ID" />
<property name="realmId" column="REALM_ID" />
<property name="paymentWaived" column="PAYMENT_WAIVED" type="varchar_boolean"/>
<property name="paymentWaiverReason" column="PAYMENT_WAIVER_REASON" />
<property name="startTime" column="START_TIME" />
<property name="endTime" column="END_TIME" />
<property name="restartCount" column="RESTART_COUNT" />
<property name="userName" column="USER_NAME" />
<property name="sessionStartTime" column="SESSION_START_TIME" />
<property name="completeTime" column="COMPLETE_TIME" />
<property name="comments" column="COMMENTS" />
<property name="flag" column="FLAG" type="varchar_boolean"/>
<property name="applicantType" column="APPLICANT_TYPE" />
<set name="blockIds" table="SURVEY.APPLICANT_SURVEY_BLOCK" lazy="true" >
<key column="APPLICANT_ID" not-null="true" />
<element type="long" column="SURVEY_BLOCK_ID" />
</set>
<property name="createDate" type="timestamp" column="CREATE_DATE" insert="false" update="false"/>
<property name="lastModifiedDate" type="timestamp" column="LAST_MODIFIED_DATE" />
<property name="lastModifiedBy" column="LAST_MODIFIED_BY"/>
<map name="responses" lazy="true" cascade="all-delete-orphan" inverse="true">
<key column="APPLICANT_ID" not-null="true"/>
<map-key formula="SURVEY_QUESTION_ID" type="java.lang.String"/>
<one-to-many class="org.act.survey.applicant.model.impl.ApplicantResponseImpl"/>
<filter name="block" condition="SURVEY_QUESTION_ID in (select survey_question_id from survey.survey_question responses0_ where survey_block_id in (select survey_block_id from survey.survey_block responses0_ where name = :blockName))"/>
</map>
<list name="score" lazy="true" cascade="all">
<key column="APPLICANT_ID" not-null="true"/>
<list-index column="ORDER_NUMBER"/>
<one-to-many class="org.act.survey.applicant.model.impl.ScoreImpl" />
</list>
<set name="suppApplicants" lazy="true" table="APPLICANT" inverse="true" cascade="all-delete-orphan" >
<key column="PARENT_APPLICANT_ID" />
<one-to-many class="org.act.survey.applicant.model.impl.ApplicantImpl" />
</set>
<many-to-one name="parent" column="PARENT_APPLICANT_ID" cascade="none" class="org.act.survey.applicant.model.impl.ApplicantImpl" not-found="ignore"/>
<filter name="surveyRealmFilter" condition=":surveyRealmFilter = REALM_ID"/>
</class>
<query name="ApplicantImpl.getApplicantByExternalId">
<![CDATA[
from ApplicantImpl aimpl
where aimpl.externalId = :externalId
]]>
</query>
<query name="ApplicantImpl.getApplicantsBySurveyId">
<![CDATA[
from ApplicantImpl aimpl
where aimpl.surveyId = :surveyId
]]>
</query>
<query name="ApplicantImpl.getApplicantsByResponse">
<![CDATA[
from ApplicantImpl aimpl, ApplicantResponseImpl arImpl
where aimpl.id=arImpl.applicant.id and aimpl.surveyId = :surveyId and aimpl.status != :status and arImpl.surveyQuestionName=:questionName and arImpl.response = :response and aimpl.externalId != :externalId
]]>
</query>
<query name="ApplicantImpl.getApplicantsByResponseStatus">
<![CDATA[
from ApplicantImpl aimpl, ApplicantResponseImpl arImpl
where aimpl.id=arImpl.applicant.id and aimpl.surveyId = :surveyId and aimpl.status = :status and arImpl.surveyQuestionName=:questionName and arImpl.response = :response and aimpl.externalId != :externalId
]]>
</query>
<filter-def name="block">
<filter-param name="blockName" type="string"/>
</filter-def>
</hibernate-mapping>
ApplciantResponseImpl.hbm.xml
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 3.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd">
<hibernate-mapping>
<class name="org.act.survey.applicant.model.impl.ApplicantResponseImpl"
table="APPLICANT_RESPONSE"
schema="SURVEY"
proxy="org.act.survey.applicant.model.ApplicantResponse">
<id name="responseId" column="APPLICANT_RESPONSE_ID">
<generator class="sequence">
<param name="sequence">SURVEY.SEQ_GENERIC</param>
</generator>
</id>
<property name="surveyQuestionId" column="SURVEY_QUESTION_ID"/>
<property name="surveyQuestionName" column="SURVEY_QUESTION_NAME"/>
<property name="essay" column="ESSAY" type="text"/>
<property name="response"/>
<property name="score"/>
<property name="responseMeaning" column="RESPONSE_MEANING"/>
<map name="choices" cascade="all-delete-orphan" lazy="true" inverse="true">
<key column="APPLICANT_RESPONSE_ID" not-null="true"/>
<map-key formula="SURVEY_QUESTION_CHOICE_ID" type="java.lang.String"/>
<one-to-many class="org.act.survey.applicant.model.impl.ApplicantResponseChoiceImpl"/>
</map>
<many-to-one name="applicant" column="APPLICANT_ID" not-null="true" class="org.act.survey.applicant.model.impl.ApplicantImpl"/>
<property name="createDate" type="timestamp" column="CREATE_DATE" insert="false" update="false" lazy="true"/>
<property name="lastModifiedDate" type="timestamp" column="LAST_MODIFIED_DATE" />
<property name="lastModifiedBy" column="LAST_MODIFIED_BY" lazy="true"/>
</class>
</hibernate-mapping>
ApplicantResponseChoiceImpl.hbm.xml
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 3.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd">
<hibernate-mapping>
<class name="org.act.survey.applicant.model.impl.ApplicantResponseChoiceImpl"
table="APPLICANT_RESPONSE_CHOICE"
schema="SURVEY"
proxy="org.act.survey.applicant.model.ApplicantResponseChoice">
<id name="choiceId" column="APPLICANT_RESP_CHOICE_ID">
<generator class="sequence">
<param name="sequence">SURVEY.SEQ_GENERIC</param>
</generator>
</id>
<property name="surveyQuestionChoiceId" column="SURVEY_QUESTION_CHOICE_ID"/>
<property name="response" />
<many-to-one name="applicantResponse" column="APPLICANT_RESPONSE_ID" not-null="true" class="org.act.survey.applicant.model.impl.ApplicantResponseImpl"/>
<property name="createDate" type="timestamp" column="CREATE_DATE" insert="false" update="false" lazy="false"/>
<property name="lastModifiedDate" type="timestamp" column="LAST_MODIFIED_DATE" />
<property name="lastModifiedBy" column="LAST_MODIFIED_BY" lazy="false"/>
</class>
</hibernate-mapping>
Code between sessionFactory.openSession() and session.close():
2008-06-18 15:59:19,754 DEBUG org.springframework.orm.hibernate3.support.OpenSessionInViewFilter - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - Using SessionFactory 'survey-session-factory' for OpenSessionInViewFilter
2008-06-18 15:59:19,754 DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - Returning cached instance of singleton bean 'survey-session-factory'
2008-06-18 15:59:19,754 DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - Bean with name 'survey-session-factory' is a factory bean
2008-06-18 15:59:19,754 DEBUG org.springframework.orm.hibernate3.support.OpenSessionInViewFilter - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - Opening single Hibernate Session in OpenSessionInViewFilter
2008-06-18 15:59:19,754 DEBUG org.springframework.orm.hibernate3.SessionFactoryUtils - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - Opening Hibernate Session
2008-06-18 15:59:19,754 DEBUG org.hibernate.impl.SessionImpl - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - opened session at timestamp: 12138227597
2008-06-18 15:59:19,754 DEBUG org.hibernate.impl.SessionImpl - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - setting flush mode to: NEVER
2008-06-18 15:59:19,754 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - Bound value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,754 DEBUG org.act.survey.filter.AuditInformationFilter - HTTP Session 97947f1430dc37491ba9f30d4698a1e2fe47d7284941 - retrieved the following username = YHAJMMMCGHDSAOATN
2008-06-18 15:59:19,755 DEBUG org.act.survey.SurveyRequestProcessor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - processPreprocess kicking off, requestURI = /survey/block.do
2008-06-18 15:59:19,755 DEBUG org.act.survey.SurveyRequestProcessor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - validating applicant: id = 852379, realmId = 64490001, surveyId = 86851254, token = 1671105861243424658819422361240691421
2008-06-18 15:59:19,755 DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Returning cached instance of singleton bean 'surveyservice-applicant-service'
2008-06-18 15:59:19,755 DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Bean with name 'surveyservice-applicant-service' is a factory bean
2008-06-18 15:59:19,755 DEBUG org.springframework.transaction.interceptor.TransactionInterceptor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Getting transaction for org.act.survey.applicant.service.ApplicantService.loadApplicantByExternalId
2008-06-18 15:59:19,755 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] bound to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,755 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Found thread-bound Session [org.hibernate.impl.SessionImpl@1f12b9e] for Hibernate transaction
2008-06-18 15:59:19,755 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Using transaction object [org.springframework.orm.hibernate3.HibernateTransactionManager$HibernateTransactionObject@66cc83]
2008-06-18 15:59:19,755 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Creating new transaction with name [org.act.survey.applicant.service.ApplicantService.loadApplicantByExternalId]
2008-06-18 15:59:19,755 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Preparing JDBC Connection of Hibernate Session [org.hibernate.impl.SessionImpl@1f12b9e]
2008-06-18 15:59:19,755 DEBUG org.hibernate.jdbc.ConnectionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - opening JDBC connection
2008-06-18 15:59:19,755 DEBUG org.springframework.jdbc.datasource.DataSourceUtils - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Setting JDBC Connection [com.evermind.sql.OracleConnectionBCELProxy__com_evermind_sql_OrionCMTConnection__SQLBCELProxy@fcb4de] read-only
2008-06-18 15:59:19,756 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - begin
2008-06-18 15:59:19,756 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - current autocommit status: true
2008-06-18 15:59:19,756 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - disabling autocommit
2008-06-18 15:59:19,756 DEBUG org.hibernate.jdbc.JDBCContext - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - after transaction begin
2008-06-18 15:59:19,756 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Exposing Hibernate transaction as JDBC transaction [com.evermind.sql.OracleConnectionBCELProxy__com_evermind_sql_OrionCMTConnection__SQLBCELProxy@fcb4de]
2008-06-18 15:59:19,757 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Bound value [org.springframework.jdbc.datasource.ConnectionHolder@c6824e] for key [com.evermind.sql.OrionCMTDataSource@1555cf5] to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,757 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Initializing transaction synchronization
2008-06-18 15:59:19,757 DEBUG org.springframework.transaction.interceptor.TransactionInterceptor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Don't need to create transaction for [org.act.survey.applicant.dao.ApplicantDao.getApplicantByExternalId]: this method isn't transactional
2008-06-18 15:59:19,757 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] bound to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,757 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] bound to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,757 DEBUG org.springframework.orm.hibernate3.HibernateTemplate - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Found thread-bound Session for HibernateTemplate
2008-06-18 15:59:19,757 DEBUG org.hibernate.engine.query.QueryPlanCache - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - located HQL query plan in cache (
from ApplicantImpl aimpl
where aimpl.externalId = :externalId
)
2008-06-18 15:59:19,757 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] bound to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,757 DEBUG org.hibernate.engine.query.QueryPlanCache - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - located HQL query plan in cache (
from ApplicantImpl aimpl
where aimpl.externalId = :externalId
)
2008-06-18 15:59:19,757 DEBUG org.hibernate.engine.query.HQLQueryPlan - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - find:
from ApplicantImpl aimpl
where aimpl.externalId = :externalId
2008-06-18 15:59:19,757 DEBUG org.hibernate.engine.QueryParameters - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - named parameters: {externalId=852379}
2008-06-18 15:59:19,758 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2008-06-18 15:59:19,758 DEBUG org.hibernate.SQL - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - select applicanti0_.APPLICANT_ID as APPLICANT1_0_, applicanti0_.EXTERNAL_ID as EXTERNAL2_0_, applicanti0_.status as status0_, applicanti0_.token as token0_, applicanti0_.ELIGIBILITY_PASSED as ELIGIBIL5_0_, applicanti0_.SURVEY_ID as SURVEY6_0_, applicanti0_.REALM_ID as REALM7_0_, applicanti0_.PAYMENT_WAIVED as PAYMENT8_0_, applicanti0_.PAYMENT_WAIVER_REASON as PAYMENT9_0_, applicanti0_.START_TIME as START10_0_, applicanti0_.END_TIME as END11_0_, applicanti0_.RESTART_COUNT as RESTART12_0_, applicanti0_.USER_NAME as USER13_0_, applicanti0_.SESSION_START_TIME as SESSION14_0_, applicanti0_.COMPLETE_TIME as COMPLETE15_0_, applicanti0_.COMMENTS as COMMENTS0_, applicanti0_.FLAG as FLAG0_, applicanti0_.APPLICANT_TYPE as APPLICANT18_0_, applicanti0_.CREATE_DATE as CREATE19_0_, applicanti0_.LAST_MODIFIED_DATE as LAST20_0_, applicanti0_.LAST_MODIFIED_BY as LAST21_0_, applicanti0_.PARENT_APPLICANT_ID as PARENT22_0_ from SURVEY.APPLICANT applicanti0_ where applicanti0_.EXTERNAL_ID=?
2008-06-18 15:59:19,758 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - preparing statement
2008-06-18 15:59:19,758 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '852379' to parameter: 1
2008-06-18 15:59:19,758 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - binding '852379' to parameter: 1
2008-06-18 15:59:19,759 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - about to open ResultSet (open ResultSets: 0, globally: 0)
2008-06-18 15:59:19,759 DEBUG org.hibernate.loader.Loader - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - processing result set
2008-06-18 15:59:19,759 DEBUG org.hibernate.loader.Loader - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - result set row: 0
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '87032295' as column: APPLICANT1_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '87032295' as column: APPLICANT1_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.loader.Loader - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - result row: EntityKey[org.act.survey.applicant.model.impl.ApplicantImpl#87032295]
2008-06-18 15:59:19,759 DEBUG org.hibernate.loader.Loader - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Initializing object from ResultSet: [org.act.survey.applicant.model.impl.ApplicantImpl#87032295]
2008-06-18 15:59:19,759 DEBUG org.hibernate.persister.entity.AbstractEntityPersister - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Hydrating entity: [org.act.survey.applicant.model.impl.ApplicantImpl#87032295]
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '852379' as column: EXTERNAL2_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '852379' as column: EXTERNAL2_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'INPROGRESS' as column: status0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'INPROGRESS' as column: status0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '1671105861243424658819422361240691421' as column: token0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '1671105861243424658819422361240691421' as column: token0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: ELIGIBIL5_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: ELIGIBIL5_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '86851254' as column: SURVEY6_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '86851254' as column: SURVEY6_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '64490001' as column: REALM7_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '64490001' as column: REALM7_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: PAYMENT9_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: PAYMENT9_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:05' as column: START10_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:05' as column: START10_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: END11_0_
2008-06-18 15:59:19,759 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: END11_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.IntegerType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '0' as column: RESTART12_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.IntegerType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '0' as column: RESTART12_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'YHAJMMMCGHDSAOATN' as column: USER13_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'YHAJMMMCGHDSAOATN' as column: USER13_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:05' as column: SESSION14_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:05' as column: SESSION14_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: COMPLETE15_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: COMPLETE15_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: COMMENTS0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: COMMENTS0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'Examinee' as column: APPLICANT18_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'Examinee' as column: APPLICANT18_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:01' as column: CREATE19_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:01' as column: CREATE19_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:05' as column: LAST20_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.TimestampType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning '2008-06-18 15:59:05' as column: LAST20_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'YHAJMMMCGHDSAOATN' as column: LAST21_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.StringType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning 'YHAJMMMCGHDSAOATN' as column: LAST21_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: PARENT22_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.type.LongType - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - returning null as column: PARENT22_0_
2008-06-18 15:59:19,760 DEBUG org.hibernate.loader.Loader - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - done processing result set (1 rows)
2008-06-18 15:59:19,760 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - about to close ResultSet (open ResultSets: 1, globally: 1)
2008-06-18 15:59:19,760 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2008-06-18 15:59:19,760 DEBUG org.hibernate.jdbc.AbstractBatcher - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - closing statement
2008-06-18 15:59:19,760 DEBUG org.hibernate.loader.Loader - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - total objects hydrated: 1
2008-06-18 15:59:19,761 DEBUG org.hibernate.engine.TwoPhaseLoad - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - resolving associations for [org.act.survey.applicant.model.impl.ApplicantImpl#87032295]
2008-06-18 15:59:19,761 DEBUG org.hibernate.engine.loading.LoadContexts - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - creating collection wrapper:[org.act.survey.applicant.model.impl.ApplicantImpl.blockIds#87032295]
2008-06-18 15:59:19,761 DEBUG org.hibernate.engine.loading.LoadContexts - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - creating collection wrapper:[org.act.survey.applicant.model.impl.ApplicantImpl.responses#87032295]
2008-06-18 15:59:19,761 DEBUG org.hibernate.engine.loading.LoadContexts - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - creating collection wrapper:[org.act.survey.applicant.model.impl.ApplicantImpl.score#87032295]
2008-06-18 15:59:19,761 DEBUG org.hibernate.engine.loading.LoadContexts - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - creating collection wrapper:[org.act.survey.applicant.model.impl.ApplicantImpl.suppApplicants#87032295]
2008-06-18 15:59:19,761 DEBUG org.hibernate.engine.TwoPhaseLoad - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - done materializing entity [org.act.survey.applicant.model.impl.ApplicantImpl#87032295]
2008-06-18 15:59:19,761 DEBUG org.hibernate.engine.StatefulPersistenceContext - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - initializing non-lazy collections
2008-06-18 15:59:19,761 DEBUG org.springframework.orm.hibernate3.HibernateTemplate - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Not closing pre-bound Hibernate Session after HibernateTemplate
2008-06-18 15:59:19,761 DEBUG org.springframework.transaction.interceptor.TransactionInterceptor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Invoking commit for transaction on org.act.survey.applicant.service.ApplicantService.loadApplicantByExternalId
2008-06-18 15:59:19,761 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Triggering beforeCommit synchronization
2008-06-18 15:59:19,761 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Triggering beforeCompletion synchronization
2008-06-18 15:59:19,761 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Initiating transaction commit
2008-06-18 15:59:19,762 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Committing Hibernate transaction on Session [org.hibernate.impl.SessionImpl@1f12b9e]
2008-06-18 15:59:19,762 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - commit
2008-06-18 15:59:19,762 DEBUG org.hibernate.jdbc.JDBCContext - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - before transaction completion
2008-06-18 15:59:19,762 DEBUG org.hibernate.impl.SessionImpl - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - before transaction completion
2008-06-18 15:59:19,762 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - re-enabling autocommit
2008-06-18 15:59:19,762 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - committed JDBC Connection
2008-06-18 15:59:19,762 DEBUG org.hibernate.jdbc.JDBCContext - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - after transaction completion
2008-06-18 15:59:19,762 DEBUG org.hibernate.jdbc.ConnectionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - transaction completed on session with on_close connection release mode; be sure to close the session to release JDBC resources!
2008-06-18 15:59:19,762 DEBUG org.hibernate.impl.SessionImpl - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - after transaction completion
2008-06-18 15:59:19,762 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Triggering afterCompletion synchronization
2008-06-18 15:59:19,762 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Clearing transaction synchronization
2008-06-18 15:59:19,763 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Removed value [org.springframework.jdbc.datasource.ConnectionHolder@c6824e] for key [com.evermind.sql.OrionCMTDataSource@1555cf5] from thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,763 DEBUG org.springframework.jdbc.datasource.DataSourceUtils - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Resetting read-only flag of JDBC Connection [com.evermind.sql.OracleConnectionBCELProxy__com_evermind_sql_OrionCMTConnection__SQLBCELProxy@fcb4de]
2008-06-18 15:59:19,763 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Not closing pre-bound Hibernate Session [org.hibernate.impl.SessionImpl@1f12b9e] after transaction
2008-06-18 15:59:19,763 DEBUG org.act.survey.SurveyRequestProcessor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - applicant is valid
2008-06-18 15:59:19,763 INFO org.act.survey.SurveyRequestProcessor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Session mode = survey
2008-06-18 15:59:19,764 DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Returning cached instance of singleton bean 'surveyservice-applicant-service'
2008-06-18 15:59:19,764 DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Bean with name 'surveyservice-applicant-service' is a factory bean
2008-06-18 15:59:19,764 DEBUG org.springframework.transaction.interceptor.TransactionInterceptor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Getting transaction for org.act.survey.applicant.service.ApplicantService.getApplicant
2008-06-18 15:59:19,764 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] bound to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,764 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Found thread-bound Session [org.hibernate.impl.SessionImpl@1f12b9e] for Hibernate transaction
2008-06-18 15:59:19,764 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Using transaction object [org.springframework.orm.hibernate3.HibernateTransactionManager$HibernateTransactionObject@5e25cc]
2008-06-18 15:59:19,764 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Creating new transaction with name [org.act.survey.applicant.service.ApplicantService.getApplicant]
2008-06-18 15:59:19,764 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Preparing JDBC Connection of Hibernate Session [org.hibernate.impl.SessionImpl@1f12b9e]
2008-06-18 15:59:19,764 DEBUG org.springframework.jdbc.datasource.DataSourceUtils - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Setting JDBC Connection [com.evermind.sql.OracleConnectionBCELProxy__com_evermind_sql_OrionCMTConnection__SQLBCELProxy@fcb4de] read-only
2008-06-18 15:59:19,765 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - begin
2008-06-18 15:59:19,765 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - current autocommit status: true
2008-06-18 15:59:19,765 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - disabling autocommit
2008-06-18 15:59:19,765 DEBUG org.hibernate.jdbc.JDBCContext - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - after transaction begin
2008-06-18 15:59:19,765 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Exposing Hibernate transaction as JDBC transaction [com.evermind.sql.OracleConnectionBCELProxy__com_evermind_sql_OrionCMTConnection__SQLBCELProxy@fcb4de]
2008-06-18 15:59:19,765 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Bound value [org.springframework.jdbc.datasource.ConnectionHolder@103754a] for key [com.evermind.sql.OrionCMTDataSource@1555cf5] to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,765 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Initializing transaction synchronization
2008-06-18 15:59:19,765 DEBUG org.springframework.transaction.interceptor.TransactionInterceptor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Don't need to create transaction for [org.act.survey.applicant.dao.ApplicantDao.getApplicant]: this method isn't transactional
2008-06-18 15:59:19,765 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] bound to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,765 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Retrieved value [org.springframework.orm.hibernate3.SessionHolder@18309b0] for key [org.hibernate.impl.SessionFactoryImpl@f0541d] bound to thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,765 DEBUG org.springframework.orm.hibernate3.HibernateTemplate - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Found thread-bound Session for HibernateTemplate
2008-06-18 15:59:19,766 DEBUG org.hibernate.event.def.DefaultLoadEventListener - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - loading entity: [org.act.survey.applicant.model.impl.ApplicantImpl#87032295]
2008-06-18 15:59:19,766 DEBUG org.hibernate.event.def.DefaultLoadEventListener - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - entity found in session cache
2008-06-18 15:59:19,766 DEBUG org.springframework.orm.hibernate3.HibernateTemplate - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Not closing pre-bound Hibernate Session after HibernateTemplate
2008-06-18 15:59:19,766 DEBUG org.springframework.transaction.interceptor.TransactionInterceptor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Invoking commit for transaction on org.act.survey.applicant.service.ApplicantService.getApplicant
2008-06-18 15:59:19,766 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Triggering beforeCommit synchronization
2008-06-18 15:59:19,766 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Triggering beforeCompletion synchronization
2008-06-18 15:59:19,766 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Initiating transaction commit
2008-06-18 15:59:19,766 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Committing Hibernate transaction on Session [org.hibernate.impl.SessionImpl@1f12b9e]
2008-06-18 15:59:19,766 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - commit
2008-06-18 15:59:19,766 DEBUG org.hibernate.jdbc.JDBCContext - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - before transaction completion
2008-06-18 15:59:19,766 DEBUG org.hibernate.impl.SessionImpl - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - before transaction completion
2008-06-18 15:59:19,766 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - re-enabling autocommit
2008-06-18 15:59:19,766 DEBUG org.hibernate.transaction.JDBCTransaction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - committed JDBC Connection
2008-06-18 15:59:19,766 DEBUG org.hibernate.jdbc.JDBCContext - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - after transaction completion
2008-06-18 15:59:19,766 DEBUG org.hibernate.jdbc.ConnectionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - transaction completed on session with on_close connection release mode; be sure to close the session to release JDBC resources!
2008-06-18 15:59:19,766 DEBUG org.hibernate.impl.SessionImpl - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - after transaction completion
2008-06-18 15:59:19,766 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Triggering afterCompletion synchronization
2008-06-18 15:59:19,767 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Clearing transaction synchronization
2008-06-18 15:59:19,767 DEBUG org.springframework.transaction.support.TransactionSynchronizationManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Removed value [org.springframework.jdbc.datasource.ConnectionHolder@103754a] for key [com.evermind.sql.OrionCMTDataSource@1555cf5] from thread [AJPRequestHandler-ApplicationServerThread-16]
2008-06-18 15:59:19,767 DEBUG org.springframework.jdbc.datasource.DataSourceUtils - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Resetting read-only flag of JDBC Connection [com.evermind.sql.OracleConnectionBCELProxy__com_evermind_sql_OrionCMTConnection__SQLBCELProxy@fcb4de]
2008-06-18 15:59:19,767 DEBUG org.springframework.orm.hibernate3.HibernateTransactionManager - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Not closing pre-bound Hibernate Session [org.hibernate.impl.SessionImpl@1f12b9e] after transaction
2008-06-18 15:59:19,767 DEBUG org.springframework.web.struts.DelegatingActionUtils - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - DelegatingActionProxy with mapping path '/block' and module prefix '' delegating to Spring bean with name [/block]
2008-06-18 15:59:19,767 DEBUG org.springframework.beans.factory.support.DefaultListableBeanFactory - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Returning cached instance of singleton bean '/block'
2008-06-18 15:59:19,767 DEBUG org.act.survey.action.BlockAction - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - processing a save action
2008-06-18 15:59:19,770 DEBUG org.springframework.transaction.interceptor.TransactionInterceptor - HTTP Session 97947f1430dc691c4731e7b34341b6f8e22d0950f7c9 - Getting transaction for org.act.survey.applicant.service.ApplicantService.getApplicant
2008-06-18 15:59:19,770 DEBUG org.springframework.transaction.support.Transacti
Login
FAQ
Search
