I found some more detailed logging
Code:
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.loader.Loader:864) - Initializing object from ResultSet: [com.qas.newmedia.internet.core.page.model.Page#6]
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.persister.entity.BasicEntityPersister:1625) - Hydrating entity: [com.qas.newmedia.internet.core.page.model.Page#6]
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.type.NullableType:86) - returning '2' as column: parent2_8_1_
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.type.NullableType:86) - returning '20' as column: peer3_8_1_
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.type.NullableType:86) - returning 'util6' as column: name4_8_1_
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.type.NullableType:86) - returning '2005-06-02 12:20:59' as column: created8_1_
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.type.NullableType:86) - returning 'products.htm' as column: path8_1_
2005-09-20 14:45:51,906 - DEBUG (org.hibernate.type.NullableType:86) - returning 'microsite' as column: template7_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'QuickAddress for Retail : Products' as column: title8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'Products' as column: descript9_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'hljkh' as column: keywords8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'true' as column: no11_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'true' as column: enabled8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'true' as column: visible8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:80) - returning null as column: wa14_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:80) - returning null as column: perm15_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:80) - returning null as column: perm16_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'Products' as column: pns17_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'Products' as column: bns18_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'Products' as column: sns19_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning 'Products' as column: fns20_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.type.NullableType:86) - returning '15' as column: site21_8_1_
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.loader.Loader:399) - done processing result set (1 rows)
2005-09-20 14:45:51,922 - DEBUG (org.hibernate.jdbc.AbstractBatcher:281) - about to close ResultSet (open ResultSets: 1, globally: 1)
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.jdbc.AbstractBatcher:266) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.jdbc.AbstractBatcher:363) - closing statement
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.loader.Loader:450) - total objects hydrated: 2
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.engine.TwoPhaseLoad:96) - resolving associations for [com.qas.newmedia.internet.core.page.model.Site#15]
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.engine.TwoPhaseLoad:167) - done materializing entity [com.qas.newmedia.internet.core.page.model.Site#15]
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.engine.TwoPhaseLoad:96) - resolving associations for [com.qas.newmedia.internet.core.page.model.Page#6]
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.event.def.DefaultLoadEventListener:193) - loading entity: [com.qas.newmedia.internet.core.page.model.Site#15]
2005-09-20 14:45:51,937 - DEBUG (org.hibernate.event.def.DefaultLoadEventListener:326) - attempting to resolve: [com.qas.newmedia.internet.core.page.model.Site#15]
2005-09-20 14:45:51,953 - DEBUG (org.hibernate.event.def.DefaultLoadEventListener:335) - resolved object in session cache: [com.qas.newmedia.internet.core.page.model.Site#15]
2005-09-20 14:45:51,953 - DEBUG (org.hibernate.engine.CollectionLoadContext:134) - creating collection wrapper:[com.qas.newmedia.internet.core.page.model.Page.assets#6]
2005-09-20 14:45:51,969 - INFO (org.hibernate.event.def.DefaultLoadEventListener:129) - Error performing load command
org.hibernate.PropertyAccessException: exception setting property value with CGLIB (set hibernate.cglib.use_reflection_optimizer=false for more info) setter of com.qas.newmedia.internet.core.page.model.Page.setAssets
at org.hibernate.tuple.PojoTuplizer.setPropertyValuesWithOptimizer(PojoTuplizer.java:197)
at org.hibernate.tuple.PojoTuplizer.setPropertyValues(PojoTuplizer.java:167)
at org.hibernate.persister.entity.BasicEntityPersister.setPropertyValues(BasicEntityPersister.java:2879)
at org.hibernate.engine.TwoPhaseLoad.initializeEntity(TwoPhaseLoad.java:113)
at org.hibernate.loader.Loader.initializeEntitiesAndCollections(Loader.java:452)
at org.hibernate.loader.Loader.doQuery(Loader.java:406)
at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:203)
at org.hibernate.loader.Loader.loadEntity(Loader.java:1255)
at org.hibernate.loader.entity.EntityLoader.load(EntityLoader.java:139)
at org.hibernate.loader.entity.EntityLoader.load(EntityLoader.java:124)
at org.hibernate.persister.entity.BasicEntityPersister.load(BasicEntityPersister.java:2453)
at org.hibernate.event.def.DefaultLoadEventListener.loadFromDatasource(DefaultLoadEventListener.java:387)
at org.hibernate.event.def.DefaultLoadEventListener.doLoad(DefaultLoadEventListener.java:368)
at org.hibernate.event.def.DefaultLoadEventListener.load(DefaultLoadEventListener.java:166)
at org.hibernate.event.def.DefaultLoadEventListener.load(DefaultLoadEventListener.java:140)
at org.hibernate.event.def.DefaultLoadEventListener.proxyOrLoad(DefaultLoadEventListener.java:201)
at org.hibernate.event.def.DefaultLoadEventListener.onLoad(DefaultLoadEventListener.java:123)
at org.hibernate.impl.SessionImpl.load(SessionImpl.java:549)
at org.hibernate.impl.SessionImpl.load(SessionImpl.java:544)
at org.springframework.orm.hibernate3.HibernateTemplate$3.doInHibernate(HibernateTemplate.java:422)
at org.springframework.orm.hibernate3.HibernateTemplate.execute(HibernateTemplate.java:310)
at org.springframework.orm.hibernate3.HibernateTemplate.load(HibernateTemplate.java:416)
at org.springframework.orm.hibernate3.HibernateTemplate.load(HibernateTemplate.java:411)
at com.qas.newmedia.internet.core.cms.service.dao.CMSDAOHibernateImpl.load(CMSDAOHibernateImpl.java:28)
at com.qas.newmedia.internet.core.cms.service.CMSServicesImpl.loadPage(CMSServicesImpl.java:27)
at com.qas.newmedia.internet.core.cms.service.CMSServicesImpl.bindAsset(CMSServicesImpl.java:112)
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:585)
at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:310)
at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:155)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:122)
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:57)
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:144)
at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:174)
at $Proxy12.bindAsset(Unknown Source)
at com.qas.newmedia.internet.core.cms.controller.page.AssetPageBindController.handle(AssetPageBindController.java:49)
at org.springframework.web.servlet.mvc.AbstractCommandController.handleRequestInternal(AbstractCommandController.java:79)
at org.springframework.web.servlet.mvc.AbstractController.handleRequest(AbstractController.java:128)
at org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter.handle(SimpleControllerHandlerAdapter.java:44)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:684)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:625)
at org.springframework.web.servlet.FrameworkServlet.serviceWrapper(FrameworkServlet.java:386)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:355)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:709)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:526)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:307)
at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:385)
at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:748)
at org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:678)
at org.apache.jk.common.SocketConnection.runIt(ChannelSocket.java:871)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:684)
at java.lang.Thread.run(Thread.java:595)
Caused by: net.sf.cglib.beans.BulkBeanException: org.hibernate.collection.PersistentSet
at com.qas.newmedia.internet.core.page.model.Page$$BulkBeanByCGLIB$$28b72cdf.setPropertyValues(<generated>)
at org.hibernate.tuple.PojoTuplizer.setPropertyValuesWithOptimizer(PojoTuplizer.java:194)
... 62 more
Caused by: java.lang.ClassCastException: org.hibernate.collection.PersistentSet
... 64 more