Minimal code - boy, that's hard. I'll try to stitch something together...
Code:
SectionSubmission sectionSubmission = ... // from elsewhere - new or old
session.save(sectionSubmission);
for (Iterator iterator = sectionSubmission.getSection().getFields().values().iterator(); iterator.hasNext();) {
Field field = (Field)iterator.next();
Observation obs = sectionSubmission.getObservation(field);
if (obs == null) {
obs = new Observation();
obs.setField(field);
sectionSubmission.addObservation(obs);
} else {
String version = request.getParameter(field.getName() + "-version");
if (version == null) {
log.warn("Null version for: " + field.getName());
} else {
if (!version.equals(obs.getVersion().toString())) {
error(request, response, HttpServletResponse.SC_FORBIDDEN,
"Cannot update submission, version collision");
return false;
}
}
}
String value = request.getParameter(field.getName());
if (value == null) {
//log.warn("Null request parameter value for: " + field.getName());
value = "";
}
obs.setValue(value);
session.save(obs);
}
...
tx.commit();
The StateObject exception is being tossed at transaction.commit(), the original stack trace shows that.
I'm going to try to only show the relevant portion of the log file; let me know if I should include more or put it up in webspace somewhere:
[code]
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select hibernate_sequence.nextval from dual
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.id.SequenceGenerator: Sequence identifier generated: 1764
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.impl.SessionImpl: saving [com.rhoworld.edc.model.Observation#1764]
DEBUG net.sf.hibernate.engine.Versioning: Seeding: 2004-02-06 11:42:40.939
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select hibernate_sequence.nextval from dual
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.id.SequenceGenerator: Sequence identifier generated: 1765
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.impl.SessionImpl: saving [com.rhoworld.edc.model.Observation#1765]
DEBUG net.sf.hibernate.engine.Versioning: Seeding: 2004-02-06 11:42:40.949
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select hibernate_sequence.nextval from dual
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.id.SequenceGenerator: Sequence identifier generated: 1766
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.impl.SessionImpl: saving [com.rhoworld.edc.model.Observation#1766]
DEBUG net.sf.hibernate.engine.Versioning: Seeding: 2004-02-06 11:42:40.949
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select hibernate_sequence.nextval from dual
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.id.SequenceGenerator: Sequence identifier generated: 1767
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.impl.SessionImpl: saving [com.rhoworld.edc.model.Observation#1767]
DEBUG net.sf.hibernate.engine.Versioning: Seeding: 2004-02-06 11:42:40.949
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select hibernate_sequence.nextval from dual
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.id.SequenceGenerator: Sequence identifier generated: 1768
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.impl.SessionImpl: saving [com.rhoworld.edc.model.Observation#1768]
DEBUG net.sf.hibernate.engine.Versioning: Seeding: 2004-02-06 11:42:40.959
DEBUG net.sf.hibernate.impl.SessionImpl: initializing collection [com.rhoworld.edc.model.Section.sections#290]
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select section_0_.id as id__, form1_.id as id0_, form1_.name as name0_, form1_.label as label0_, form1_.labelPattern as labelPat4_0_, form1_.minSubmissions as minSubmi5_0_, form1_.maxSubmissions as maxSubmi6_0_, form1_.study_id as study_id0_, study2_.id as id1_, study2_.name as name1_, study2_.label as label1_, study2_.subjectNamePattern as subjectN4_1_, study2_.subjectLabel as subjectL5_1_, study2_.dateFormat as dateFormat1_, study2_.path as path1_, section_0_.id as id2_, section_0_.subclass as subclass2_, section_0_.name as name2_, section_0_.labelPattern as labelPat4_2_, section_0_.minSubmissions as minSubmi5_2_, section_0_.maxSubmissions as maxSubmi6_2_, section_0_.form_id as form_id2_, section_0_.pageNumber as pageNumber2_, section_0_.section_id as section_id2_ from SECTION_TABLE section_0_, FORM_TABLE form1_, STUDY_TABLE study2_ where section_0_.section_id=? and section_0_.form_id=form1_.id(+) and form1_.study_id=study2_.id(+)
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.type.LongType: binding '290' to parameter: 1
DEBUG net.sf.hibernate.loader.Loader: processing result set
DEBUG net.sf.hibernate.loader.Loader: done processing result set (0 rows)
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.loader.Loader: total objects hydrated: 0
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select hibernate_sequence.nextval from dual
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.id.SequenceGenerator: Sequence identifier generated: 1769
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.impl.SessionImpl: saving [com.rhoworld.edc.model.Observation#1769]
DEBUG net.sf.hibernate.engine.Versioning: Seeding: 2004-02-06 11:42:40.969
DEBUG com.rhoworld.edc.model.SectionSubmission: Cannot parse date field TODAYDT
java.lang.Exception: does not match the pattern: \s*(-?\d{1,4})\s*
at com.rhoworld.edc.model.NumberField.getComparableValue(NumberField.java:21)
at com.rhoworld.edc.model.SectionSubmission.validate(SectionSubmission.java:109)
at com.rhoworld.edc.servlet.Retriever.doAddSectionSubmission(Retriever.java:184)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:324)
at com.rhoworld.roe.servlet.Finder.dispatch(Finder.java:283)
at com.rhoworld.roe.servlet.Finder.service(Finder.java:229)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:853)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:247)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:193)
at com.rhoworld.edc.servlet.CommonFilter.doFilter(CommonFilter.java:88)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:213)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:193)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:260)
at org.apache.catalina.core.StandardPipeline$StandardPipelineValveContext.invokeNext(StandardPipeline.java:643)
at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:480)
at org.apache.catalina.core.ContainerBase.invoke(ContainerBase.java:995)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
at org.apache.catalina.core.StandardPipeline$StandardPipelineValveContext.invokeNext(StandardPipeline.java:643)
at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:480)
at org.apache.catalina.core.ContainerBase.invoke(ContainerBase.java:995)
at org.apache.catalina.core.StandardContext.invoke(StandardContext.java:2415)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:180)
at org.apache.catalina.core.StandardPipeline$StandardPipelineValveContext.invokeNext(StandardPipeline.java:643)
at org.apache.catalina.valves.ErrorDispatcherValve.invoke(ErrorDispatcherValve.java:170)
at org.apache.catalina.core.StandardPipeline$StandardPipelineValveContext.invokeNext(StandardPipeline.java:641)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:172)
at org.apache.catalina.core.StandardPipeline$StandardPipelineValveContext.invokeNext(StandardPipeline.java:641)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:509)
at org.apache.catalina.core.StandardPipeline$StandardPipelineValveContext.invokeNext(StandardPipeline.java:641)
at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:480)
at org.apache.catalina.core.ContainerBase.invoke(ContainerBase.java:995)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:174)
at org.apache.catalina.core.StandardPipeline$StandardPipelineValveContext.invokeNext(StandardPipeline.java:643)
at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:480)
at org.apache.catalina.core.ContainerBase.invoke(ContainerBase.java:995)
at org.apache.coyote.tomcat4.CoyoteAdapter.service(CoyoteAdapter.java:223)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:432)
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.processConnection(Http11Protocol.java:386)
at org.apache.tomcat.util.net.TcpWorkerThread.runIt(PoolTcpEndpoint.java:534)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:530)
at java.lang.Thread.run(Thread.java:534)
DEBUG com.rhoworld.edc.model.Observation: validating observation: for field: KARNSKY
DEBUG com.rhoworld.edc.model.Observation: validating observation: for field: LANSKY
DEBUG com.rhoworld.edc.model.Observation: validating observation: for field: TODAYDA
DEBUG com.rhoworld.edc.model.Observation: validating observation: for field: TODAYDT
DEBUG com.rhoworld.edc.model.Observation: missing value is not allowed: TODAYDT
DEBUG com.rhoworld.edc.model.Observation: validating observation: for field: TODAYMO
DEBUG com.rhoworld.edc.model.Observation: validating observation: for field: TODAYYR
DEBUG net.sf.hibernate.impl.SessionImpl: initializing collection [com.rhoworld.edc.model.Study.subjects#1]
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select subject_0_.id as id__, subject_0_.id as id, subject_0_.name as name, subject_0_.label as label, subject_0_.study_id as study_id from SUBJECT_TABLE subject_0_ where subject_0_.study_id=?
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.type.LongType: binding '1' to parameter: 1
DEBUG net.sf.hibernate.loader.Loader: processing result set
DEBUG net.sf.hibernate.type.LongType: returning '1680' as column: id
DEBUG net.sf.hibernate.loader.Loader: result row: 1680
DEBUG net.sf.hibernate.type.LongType: returning '1680' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Subject#1680]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Subject#1680]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Subject#1680]
DEBUG net.sf.hibernate.loader.Loader: done processing result set (1 rows)
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.loader.Loader: total objects hydrated: 0
DEBUG net.sf.hibernate.impl.SessionImpl: initializing collection [com.rhoworld.edc.model.Study.forms#1]
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select form_tab0_.id as id__, form_tab0_.id as id, form_tab0_.name as name, form_tab0_.label as label, form_tab0_.labelPattern as labelPat4_, form_tab0_.minSubmissions as minSubmi5_, form_tab0_.maxSubmissions as maxSubmi6_, form_tab0_.study_id as study_id from FORM_TABLE form_tab0_ where form_tab0_.study_id=?
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.type.LongType: binding '1' to parameter: 1
DEBUG net.sf.hibernate.loader.Loader: processing result set
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: id
DEBUG net.sf.hibernate.loader.Loader: result row: 2
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.type.LongType: returning '1141' as column: id
DEBUG net.sf.hibernate.loader.Loader: result row: 1141
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 1141
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.Form#1141
DEBUG net.sf.hibernate.type.StringType: returning 'GVHD' as column: name
DEBUG net.sf.hibernate.type.StringType: returning 'GVHD' as column: label
DEBUG net.sf.hibernate.type.StringType: returning 'Form dated {16.TODAYDT}' as column: labelPat4_
DEBUG net.sf.hibernate.type.IntegerType: returning '0' as column: minSubmi5_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_
DEBUG net.sf.hibernate.type.LongType: returning '1' as column: study_id
DEBUG net.sf.hibernate.type.LongType: returning '1141' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#1141]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#1141]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#1141]
DEBUG net.sf.hibernate.type.LongType: returning '1518' as column: id
DEBUG net.sf.hibernate.loader.Loader: result row: 1518
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 1518
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.Form#1518
DEBUG net.sf.hibernate.type.StringType: returning 'CNS Event' as column: name
DEBUG net.sf.hibernate.type.StringType: returning 'CNS Event' as column: label
DEBUG net.sf.hibernate.type.StringType: returning 'Event dated {24.REPRTDT}' as column: labelPat4_
DEBUG net.sf.hibernate.type.IntegerType: returning '0' as column: minSubmi5_
DEBUG net.sf.hibernate.type.IntegerType: returning '0' as column: maxSubmi6_
DEBUG net.sf.hibernate.type.LongType: returning '1' as column: study_id
DEBUG net.sf.hibernate.type.LongType: returning '1518' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#1518]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#1518]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#1518]
DEBUG net.sf.hibernate.loader.Loader: done processing result set (3 rows)
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.loader.Loader: total objects hydrated: 2
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.Form#1141]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Study#1]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Study#1]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Study#1]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.Form#1141]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.Form#1518]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Study#1]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Study#1]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Study#1]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.Form#1518]
DEBUG net.sf.hibernate.impl.SessionImpl: initializing collection [com.rhoworld.edc.model.Form.sections#2]
DEBUG net.sf.hibernate.impl.BatcherImpl: about to open: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: prepared statement get: select section_0_.id as id__, section_0_.pageNumber as pageNumber__, section1_.id as id0_, section1_.subclass as subclass0_, section1_.name as name0_, section1_.labelPattern as labelPat4_0_, section1_.minSubmissions as minSubmi5_0_, section1_.maxSubmissions as maxSubmi6_0_, section1_.form_id as form_id0_, section1_.pageNumber as pageNumber0_, section1_.section_id as section_id0_, section_0_.id as id1_, section_0_.subclass as subclass1_, section_0_.name as name1_, section_0_.labelPattern as labelPat4_1_, section_0_.minSubmissions as minSubmi5_1_, section_0_.maxSubmissions as maxSubmi6_1_, section_0_.form_id as form_id1_, section_0_.pageNumber as pageNumber1_, section_0_.section_id as section_id1_ from SECTION_TABLE section_0_, SECTION_TABLE section1_ where section_0_.form_id=? and section_0_.section_id=section1_.id(+)
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: preparing statement
DEBUG net.sf.hibernate.type.LongType: binding '2' to parameter: 1
DEBUG net.sf.hibernate.loader.Loader: processing result set
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '3' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 3
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 3
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#3
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Physical Exam' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '3' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#3]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#3]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#3]
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '46' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 46
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 46
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#46
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '2' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Hematological Evaluation' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '46' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#46]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#46]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#46]
DEBUG net.sf.hibernate.type.IntegerType: returning '2' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '143' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 143
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 143
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#143
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '3' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Studies of Engraftment' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '143' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#143]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#143]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#143]
DEBUG net.sf.hibernate.type.IntegerType: returning '3' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '223' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 223
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 223
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#223
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '4' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Renal and Hepatic Studies' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '223' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#223]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#223]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#223]
DEBUG net.sf.hibernate.type.IntegerType: returning '4' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '271' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 271
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 271
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#271
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '5' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Urinalysis' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '271' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#271]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#271]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#271]
DEBUG net.sf.hibernate.type.IntegerType: returning '5' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '290' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 290
DEBUG net.sf.hibernate.type.LongType: returning '290' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#290]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#290]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#290]
DEBUG net.sf.hibernate.type.IntegerType: returning '6' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '301' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 301
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 301
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#301
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '7' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Pulmonary Studies' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '301' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#301]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#301]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#301]
DEBUG net.sf.hibernate.type.IntegerType: returning '7' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '355' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 355
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 355
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#355
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '8' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Intelligence Testing' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '355' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#355]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#355]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#355]
DEBUG net.sf.hibernate.type.IntegerType: returning '8' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '421' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 421
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 421
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#421
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '9' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Child Behavior Checklist' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '421' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#421]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#421]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#421]
DEBUG net.sf.hibernate.type.IntegerType: returning '9' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '448' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 448
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 448
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#448
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '10' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Child Behavior Checklist: Validity Assessment' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '448' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#448]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#448]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#448]
DEBUG net.sf.hibernate.type.IntegerType: returning '10' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '527' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 527
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 527
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#527
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '11' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Neurologic Studies' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '527' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#527]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#527]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#527]
DEBUG net.sf.hibernate.type.IntegerType: returning '11' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '605' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 605
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 605
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#605
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '12' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Neurologic Studies' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '605' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#605]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#605]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#605]
DEBUG net.sf.hibernate.type.IntegerType: returning '12' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '718' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 718
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 718
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#718
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '13' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Growth and Development' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '718' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#718]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#718]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#718]
DEBUG net.sf.hibernate.type.IntegerType: returning '13' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '746' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 746
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 746
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#746
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '14' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Growth and Development' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '746' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#746]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#746]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#746]
DEBUG net.sf.hibernate.type.IntegerType: returning '14' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '828' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 828
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 828
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#828
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '15' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Interim Events' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '828' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#828]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#828]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#828]
DEBUG net.sf.hibernate.type.IntegerType: returning '15' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '924' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 924
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 924
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#924
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '20' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Visual Acuity' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '924' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#924]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#924]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#924]
DEBUG net.sf.hibernate.type.IntegerType: returning '20' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '963' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 963
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 963
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#963
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '21' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Immune Reconstitution Studies' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '963' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#963]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#963]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#963]
DEBUG net.sf.hibernate.type.IntegerType: returning '21' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '1067' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 1067
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 1067
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#1067
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '22' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Medications' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '1067' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#1067]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#1067]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#1067]
DEBUG net.sf.hibernate.type.IntegerType: returning '22' as column: pageNumber__
DEBUG net.sf.hibernate.type.LongType: returning null as column: id0_
DEBUG net.sf.hibernate.type.LongType: returning '1080' as column: id1_
DEBUG net.sf.hibernate.loader.Loader: result row: null, 1080
DEBUG net.sf.hibernate.type.StringType: returning 'P' as column: subclass1_
DEBUG net.sf.hibernate.loader.Loader: Initializing object from ResultSet: 1080
DEBUG net.sf.hibernate.loader.Loader: Hydrating entity: com.rhoworld.edc.model.PageSection#1080
DEBUG net.sf.hibernate.type.LongType: returning '2' as column: form_id1_
DEBUG net.sf.hibernate.type.IntegerType: returning '23' as column: pageNumber1_
DEBUG net.sf.hibernate.type.StringType: returning 'Study Samples Shipping' as column: name1_
DEBUG net.sf.hibernate.type.StringType: returning '{TODAYDT}' as column: labelPat4_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: minSubmi5_1_
DEBUG net.sf.hibernate.type.IntegerType: returning '1' as column: maxSubmi6_1_
DEBUG net.sf.hibernate.type.LongType: returning '1080' as column: id__
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Section#1080]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Section#1080]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Section#1080]
DEBUG net.sf.hibernate.type.IntegerType: returning '23' as column: pageNumber__
DEBUG net.sf.hibernate.loader.Loader: done processing result set (19 rows)
DEBUG net.sf.hibernate.impl.BatcherImpl: done closing: 0 open PreparedStatements, 0 open ResultSets
DEBUG net.sf.hibernate.impl.SessionFactoryImpl: closing statement
DEBUG net.sf.hibernate.loader.Loader: total objects hydrated: 18
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#3]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#3]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#46]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#46]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#143]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#143]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#223]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#223]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#271]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#271]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#301]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#301]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#355]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#355]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#421]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#421]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#448]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#448]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#527]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#527]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#605]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#605]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#718]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#718]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#746]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#746]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#828]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#828]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#924]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#924]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#963]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#963]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#1067]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#1067]
DEBUG net.sf.hibernate.impl.SessionImpl: resolving associations for [com.rhoworld.edc.model.PageSection#1080]
DEBUG net.sf.hibernate.impl.SessionImpl: loading [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: attempting to resolve [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: resolved object in session cache [com.rhoworld.edc.model.Form#2]
DEBUG net.sf.hibernate.impl.SessionImpl: done materializing entity [com.rhoworld.edc.model.PageSection#1080]
DEBUG net.sf.hibernate.transaction.JDBCTransaction: commit
DEBUG net.sf.hibernate.impl.SessionImpl: flushing session
DEBUG net.sf.hibernate.engine.Cascades: processing cascades for: com.rhoworld.edc.model.Form
DEBUG net.sf.hibernate.engine.Cascades: cascading to collection: com.rhoworld.edc.model.Form.sections
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: done processing cascades for: com.rhoworld.edc.model.Form
DEBUG net.sf.hibernate.engine.Cascades: processing cascades for: com.rhoworld.edc.model.Study
DEBUG net.sf.hibernate.engine.Cascades: cascading to collection: com.rhoworld.edc.model.Study.subjects
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to collection: com.rhoworld.edc.model.Study.forms
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUpdate()
DEBUG net.sf.hibernate.impl.SessionImpl: saveOrUpdate() persistent instance
DEBUG net.sf.hibernate.engine.Cascades: cascading to saveOrUp