Hello,
I am new in Hibernate,Spring and for some days on configuring this Project and now I have some Problems with Hibernate.
I don't know where the Problem is, that the sessionFactory can not be created. I tried it also with the HibernateAnnotaions Lib, but get also Exceptions: javax/.../... can not be found, sorry don't have it in mind anymore....

Hibernate version:3.2

Mapping documents:
<?xml version="1.0" encoding="UTF-8"?>
<!DOCTYPE beans PUBLIC "-//SPRING//DTD BEAN//EN" "http://www.springframework.org/dtd/spring-beans-2.0.dtd">
<beans>

<!-- load milestone.properties -->
<bean id="propertyConfigurer" class="org.springframework.beans.factory.config.PropertyPlaceholderConfigurer">
<property name="location" value="/WEB-INF/context/portlet/milestone.properties"/>
</bean>

<!-- Resolve Logical View Names to actual JSP Files -->

<bean id="viewResolver" class="org.springframework.web.servlet.view.InternalResourceViewResolver">
<property name="cache" value="false" />
<property name="viewClass" value="org.springframework.web.servlet.view.JstlView" />
<property name="prefix" value="WEB-INF/jsp"/>
<property name="suffix" value=".jsp"/>
</bean>


<!-- Controller -->

<bean id="mileStoneListController" class="main.org.jboss.portlet.milestonebeta.controller.MileStoneListController">
<property name="mileStoneService" ref="mileStoneService"/>
</bean>

<bean id="mileStoneDetailsController" class="main.org.jboss.portlet.milestonebeta.controller.MileStoneDetailsController">
<property name="mileStoneService" ref="mileStoneService"/>
</bean>

<bean id="mileStoneDeleteController" class="main.org.jboss.portlet.milestonebeta.controller.MileStoneDeleteController">
<property name="mileStoneService" ref="mileStoneService"/>
</bean>

<bean id="mileStoneEditFormValidator" class="main.org.jboss.portlet.milestonebeta.command.validator.MileStoneEditFormValidator"/>
<bean id="mileStoneEditController" class="main.org.jboss.portlet.milestonebeta.controller.MileStoneEditController">
<property name="mileStoneService" ref="mileStoneService"/>
<property name="validator" ref="mileStoneEditFormValidator"/>
<property name="commandName" ref="mileStoneForm"/>
<property name="commandClass" ref="main.org.jboss.portlet.milestonebeta.command.MileStoneEditForm"/>
<property name="formView" ref="view/edit"/>
</bean>

<bean id="mileStoneSearchController" class="main.org.jboss.portlet.milestonebeta.controller.MileStoneSearchController">
<property name="mileStoneSearchService" ref="mileStoneSearchService"/>
<property name="commandName" value="searchForm"/>
<property name="commandClass" value="main.org.jboss.portlet.milestonebeta.command.MileStoneSearchForm"/>
<property name="formView" value="view/search"/>
<property name="successView" value="view/search"/>
</bean>

<bean id="mileStonePickController" class="main.org.jboss.portlet.milestonebeta.controller.MileStonePickController">
<property name="mileStoneService" ref="mileStoneService"/>
</bean>


<bean id="mileStonePropertiesFormValidator" class="main.org.jboss.portlet.milestonebeta.command.validator.MileStonePropertiesFormValidator"/>
<bean id="mileStonePropertiesController" class="main.org.jboss.portlet.milestonebeta.controller.MileStonePropertiesController">
<property name="mileStoneService" ref="mileStoneService"/>
<property name="validator" ref="mileStonePropertiesFormValidator"/>
<property name="commandName" ref="propertiesForm"/>
<property name="commandClass" ref="main.org.jboss.portlet.milestonebeta.command.MileStonePropertiesForm"/>
<property name="formView" ref="edit/properties"/>
</bean>

<!-- Service: Accessing ... -->

<bean id="mileStoneService" class="main.org.jboss.portlet.milestonebeta.service.MileStoneService">
<property name="portletPropertyManager" ref="portletPropertyDao"/>
<property name="entryManager" ref="entryDao"/>
<!--<property name="userService" ref="userService"/>-->
</bean>

<bean id="mileStoneSearchService" class="main.org.jboss.portlet.milestonebeta.service.MileStoneSearchService">
<property name="entryManager" ref="entryDao"/>
</bean>
<!-- Handler -->

<bean id="portletModeHandlerMapping" class="org.springframework.web.portlet.handler.PortletModeHandlerMapping">
<property name="portletModeMap">
<map>
<entry key="view" value-ref="mileStoneListController"/>
</map>
</property>
</bean>

<bean id="portletModeParameterHandlerMapping" class="org.springframework.web.portlet.handler.PortletModeParameterHandlerMapping">
<property name="portletModeParameterMap">
<map>
<entry key="view">
<map>
<entry key="pickMileStone"><ref bean="mileStonePickController"/></entry>
<!--<entry key="showResult"><ref bean="resultController"/></entry>-->
</map>
</entry>
</map>
</property>
</bean>

<!-- AutoProxyCreator, automatically creates AOP Proxies at runtime -->

<bean id="autoProxyCreator" class="org.springframework.aop.framework.autoproxy.DefaultAdvisorAutoProxyCreator">
<property name="proxyTargetClass" value="true"/>
</bean>

<!-- DAOs -->

<bean id="accessLevelDao" class="main.org.jboss.portlet.milestonebeta.persistence.AccessLevelManager">
<property name="sessionFactory" ref="sessionFactory" />
</bean>

<bean id="dataTypeDao" class="main.org.jboss.portlet.milestonebeta.persistence.DataTypeManager">
<property name="sessionFactory" ref="sessionFactory" />
</bean>

<bean id="entryDao" class="main.org.jboss.portlet.milestonebeta.persistence.EntryManager">
<property name="sessionFactory" ref="sessionFactory" />
</bean>

<bean id="viewDao" class="main.org.jboss.portlet.milestonebeta.persistence.ViewManager">
<property name="sessionFactory" ref="sessionFactory" />
</bean>

<bean id="portletPropertyDao" class="main.org.jboss.portlet.milestonebeta.persistence.PortletPropertyManager">
<property name="sessionFactory" ref="sessionFactory" />
</bean>

<!-- JDBC Datasource -->

<bean id="dataSource" class="org.springframework.jdbc.datasource.DriverManagerDataSource">
<property name="driverClassName" value="${database.drvr}"/>
<property name="url" value="${database.conn}"/>
<property name="username" value="${database.user}"/>
<property name="password" value="${database.pass}"/>
</bean>

<!-- <bean id="sessionFactory" class="org.springframework.orm.hibernate3.annotation.AnnotationSessionFactoryBean" destroy-method="destroy">-->
<bean id="sessionFactory" class="org.springframework.orm.hibernate3.LocalSessionFactoryBean">
<property name="dataSource" ref="dataSource"/>
<property name="configLocation" value="/WEB-INF/hibernate.cfg.xml"/>
<!--<property name="annotatedClasses">
<list>
<value>main.org.jboss.portlet.milestonebeta.dto.AccessLevel</value>
<value>main.org.jboss.portlet.milestonebeta.dto.DataType</value>
<value>main.org.jboss.portlet.milestonebeta.dto.GenericEntry</value>
<value>main.org.jboss.portlet.milestonebeta.dto.PortletProperty</value>
<value>main.org.jboss.portlet.milestonebeta.dto.View</value>
</list>
</property>-->
<property name="hibernateProperties">
<props>
<prop key="hibernate.dialect">${hibernate.dialect}</prop>
<prop key="hibernate.show_sql">${hibernate.show_sql}</prop>
<prop key="hibernate.jdbc.use_scrollable_resultset">${hibernate.jdbc.use_scrollable_resultset}</prop>
<prop key="hibernate.cache.use_query_cache">${hibernate.cache.use_query_cache}</prop>
</props>
</property>
</bean>

<!-- HIBERNATE -->

<bean id="openSessionInViewInteceptor" class="org.springframework.orm.hibernate3.support.PortletOpenSessionInViewInterceptor">
<property name="sessionFactory" ref="sessionFactory"/>
</bean>


</beans>

MileStoneListController:

public class MileStoneListController extends AbstractController{

static Logger logger = Logger.getLogger(MileStoneListController.class);

private MileStoneService mileStoneService;

/**
* Getter for MileStoneService
*
* @return mileStoneService
*/
public MileStoneService getMileStoneService() {
return mileStoneService;
}

/**
* Setter for MileStoneService
*
* @param mileStoneService
*/
public void setMileStoneService(MileStoneService mileStoneService) {
this.mileStoneService = mileStoneService;
}

/**
* Requests the MileStones for a specific User an sets the attributes:<br/>
* - milestonecount <br/>
* - maxmilestonecount <br/>
* - milestones <br/>
*
* @return ModelAndView
*/
public ModelAndView handleRenderRequestInternal(RenderRequest request, RenderResponse response){

Map<String, Object> model = new HashMap<String, Object>();
int showMileStones = 0;

try{
List<Entry> milestones = getMileStoneService().getMileStonesForUser(request.getRemoteUser());
model.put("milestonecount", milestones.size());

if(request.getWindowState() == WindowState.NORMAL)
showMileStones = getMileStoneService().getPortletPropertyManager().
getPortletProperty().getNormalWindowStateMaxMileStoneCount();
else if(request.getWindowState() == WindowState.MAXIMIZED)
showMileStones = getMileStoneService().getPortletPropertyManager().
getPortletProperty().getMaximizedWindowStateMaxMileStoneCount();

model.put("maxmilestonecount", showMileStones);
model.put("milestones", milestones);

return new ModelAndView("view/list", model);

} catch (Exception e){
logger.warn(e.getMessage());
return null;
}
}

}

MileStoneService:

public class MileStoneService {

static Logger logger = Logger.getLogger(MileStoneListController.class);

private PortletPropertyManager portletPropertyManager;
private EntryManager entryManager;

public EntryManager getEntryManager() {
return entryManager;
}


public void setEntryManager(EntryManager entryManager) {
this.entryManager = entryManager;
}


public PortletPropertyManager getPortletPropertyManager() {
return portletPropertyManager;
}


public void setPortletPropertyManager(
PortletPropertyManager portletPropertyManager) {
this.portletPropertyManager = portletPropertyManager;
}


public List<Entry> getMileStonesForUser(String remoteUser) {

// User Service hier aufrufen nicht vergessen bzw. darauf achten das
// getEntrySet nur die Entries lädt, die auch für den
// Benutzer sichtbar sind.
return getEntryManager().getEntrySet();
}


public void process(MileStoneEditForm form) {
try {
Entry entry = getEntryManager().loadEntryById(form.getId());
BeanUtils.copyProperties(form, (GenericEntry) entry);
getEntryManager().editEntry(entry);
} catch (Exception e) {
logger.fatal(e.getMessage());
}
}

}

PortletPropertyManager (DAO):
public class PortletPropertyManager extends HibernateDaoSupport{

static Logger logger = Logger.getLogger(EntryManager.class);

private PortletProperty portletProperty;

/**
* Getter Method for portletProperty Object
* @return returns a Object of Type ProtletProperty
*/
public PortletProperty getPortletProperty() {
return portletProperty;
}

/**
* Setter Method for portletProperty
* @param portletProperty Patameter for setting portletProperty Object
*/
public void setPortletProperty(PortletProperty protletProperty) {
this.portletProperty = protletProperty;
}

/**
* Method for updating a PortletProperty
* @param portletProperty the new Portlet Property
* @return returns true if update is successfull, false if not
*/
public boolean updatePortletProperty(PortletProperty portletProperty)
{
try {
getHibernateTemplate().update((PortletProperty)portletProperty);
return true;
} catch (Exception e) {
logger.fatal(e.getMessage());
return false;
}
}
}
Full stack trace of any exception that occurs:
2007-03-26 17:10:53,609 INFO [org.apache.myfaces.config.FacesConfigurator] - Reading standard config org/apache/myfaces/resource/standard-faces-config.xml
2007-03-26 17:10:53,859 INFO [org.apache.myfaces.config.FacesConfigurator] - Reading config jar:file:/C:/jboss-4.0.4.GA/server/default/lib/tomahawk-1.1.3.jar!/META-INF/faces-config.xml
2007-03-26 17:10:53,906 INFO [org.apache.myfaces.config.FacesConfigurator] - Reading config jar:file:/C:/jboss-4.0.4.GA/server/default/tmp/deploy/tmp5233jsf-facelets.jar!/META-INF/faces-config.xml
2007-03-26 17:10:53,953 INFO [org.apache.myfaces.config.FacesConfigurator] - Reading config jar:file:/C:/jboss-4.0.4.GA/server/default/tmp/deploy/tmp5250tomahawk.jar!/META-INF/faces-config.xml
2007-03-26 17:10:54,000 INFO [org.apache.myfaces.config.FacesConfigurator] - Reading config jar:file:/C:/jboss-4.0.4.GA/server/default/tmp/deploy/tmp5325MileStoneBeta2-exp.war/WEB-INF/lib/tomahawk-1.1.3.jar!/META-INF/faces-config.xml
2007-03-26 17:10:54,046 INFO [org.apache.myfaces.config.FacesConfigurator] - Reading config /WEB-INF/faces-config.xml
2007-03-26 17:10:54,062 ERROR [org.apache.myfaces.util.LocaleUtils] - Locale name null or empty, ignoring
2007-03-26 17:10:54,484 INFO [org.apache.myfaces.webapp.StartupServletContextListener] - ServletContext 'C:\jboss-4.0.4.GA\server\default\.\tmp\deploy\tmp5325MileStoneBeta2-exp.war\' initialized.
2007-03-26 17:10:54,484 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/MileStoneBeta2]] - Loading Spring root WebApplicationContext
2007-03-26 17:10:54,734 DEBUG [org.hibernate.jdbc.JDBCContext] - successfully registered Synchronization
2007-03-26 17:10:54,734 DEBUG [org.hibernate.impl.SessionImpl] - opened session at timestamp: 4812428307390464
2007-03-26 17:10:54,734 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNode#3
2007-03-26 17:10:54,734 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNode#3 is null
2007-03-26 17:10:54,734 DEBUG [org.hibernate.loader.Loader] - loading entity: [org.jboss.portal.core.impl.model.portal.ObjectNode#3]
2007-03-26 17:10:54,734 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-03-26 17:10:54,734 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-03-26 17:10:54,734 DEBUG [org.hibernate.SQL] - select objectnode0_.PK as PK19_1_, objectnode0_.PATH as PATH19_1_, objectnode0_.NAME as NAME19_1_, objectnode0_.PARENT_KEY as PARENT4_19_1_, securityco1_.NODE_KEY as NODE3_3_, securityco1_.PK as PK3_, securityco1_.ROLE as ROLE3_, securityco1_.PK as PK28_0_, securityco1_.ROLE as ROLE28_0_, securityco1_.NODE_KEY as NODE3_28_0_, actions2_.PK as PK4_, actions2_.ACTIONS as ACTIONS4_ from JBP_OBJECT_NODE objectnode0_ left outer join JBP_OBJECT_NODE_SEC securityco1_ on objectnode0_.PK=securityco1_.NODE_KEY left outer join JBP_OBJECT_NODE_SEC_ACTIONS actions2_ on securityco1_.PK=actions2_.PK where objectnode0_.PK=?
2007-03-26 17:10:55,656 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0)
2007-03-26 17:10:55,656 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint#2], EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#3]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints#3]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions#2]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close ResultSet (open ResultSets: 1, globally: 1)
2007-03-26 17:10:55,656 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-03-26 17:10:55,656 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-03-26 17:10:55,656 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint#2]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint#2]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint#2
2007-03-26 17:10:55,656 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint#2 is null
2007-03-26 17:10:55,656 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint#2]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.ObjectNode#3]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#3
2007-03-26 17:10:55,656 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#3 is null
2007-03-26 17:10:55,656 DEBUG [org.hibernate.loader.Loader] - loading entity: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl#3]
2007-03-26 17:10:55,656 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-03-26 17:10:55,656 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-03-26 17:10:55,671 DEBUG [org.hibernate.SQL] - select portalobje0_.PK as PK20_0_, portalobje0_.LISTENER as LISTENER20_0_, portalobje0_4_.INSTANCE_REF as INSTANCE2_27_0_, case when portalobje0_1_.PK is not null then 1 when portalobje0_2_.PK is not null then 2 when portalobje0_3_.PK is not null then 3 when portalobje0_4_.PK is not null then 4 when portalobje0_.PK is not null then 0 end as clazz_0_, declaredpr1_.OBJECT_KEY as OBJECT1_2_, declaredpr1_.jbp_VALUE as jbp2_2_, declaredpr1_.NAME as NAME2_, modes2_.PK as PK3_, modes2_.name as name3_, windowstat3_.PK as PK4_, windowstat3_.name as name4_ from JBP_PORTAL_OBJECT portalobje0_ left outer join JBP_CONTEXT portalobje0_1_ on portalobje0_.PK=portalobje0_1_.PK left outer join JBP_PORTAL portalobje0_2_ on portalobje0_.PK=portalobje0_2_.PK left outer join JBP_PAGE portalobje0_3_ on portalobje0_.PK=portalobje0_3_.PK left outer join JBP_WINDOW portalobje0_4_ on portalobje0_.PK=portalobje0_4_.PK left outer join JBP_PORTAL_OBJECT_PROPS declaredpr1_ on portalobje0_.PK=declaredpr1_.OBJECT_KEY left outer join JBP_PORTAL_MODE modes2_ on portalobje0_.PK=modes2_.PK left outer join JBP_PORTAL_WINDOW_STATE windowstat3_ on portalobje0_.PK=windowstat3_.PK where portalobje0_.PK=?
2007-03-26 17:10:56,000 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0)
2007-03-26 17:10:56,000 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close ResultSet (open ResultSets: 1, globally: 1)
2007-03-26 17:10:56,000 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-03-26 17:10:56,000 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-03-26 17:10:56,000 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.PageImpl#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.PageImpl#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#3
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#3 is null
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.PageImpl#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#3
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#3 is null
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.modes#3
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.modes#3 is null
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#3
2007-03-26 17:10:56,000 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#3 is null
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#3]
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,000 DEBUG [org.hibernate.loader.Loader] - done entity load
2007-03-26 17:10:56,000 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.ObjectNode#3]
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNode#3
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNode#3 is null
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.ObjectNode#3]
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints#3]
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints#3
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints#3 is null
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints#3]
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.ObjectNode.securityConstraints
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions#2]
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions#2
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions#2 is null
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions#2]
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.ObjectNodeSecurityConstraint.actions
2007-03-26 17:10:56,015 DEBUG [org.hibernate.engine.StatefulPersistenceContext] - initializing non-lazy collections
2007-03-26 17:10:56,015 DEBUG [org.hibernate.loader.Loader] - done entity load
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNode.children#3
2007-03-26 17:10:56,015 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNode.children#3 is null
2007-03-26 17:10:56,015 DEBUG [org.hibernate.loader.Loader] - loading collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,015 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-03-26 17:10:56,015 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-03-26 17:10:56,015 DEBUG [org.hibernate.SQL] - select children0_.PARENT_KEY as PARENT4_1_, children0_.PK as PK1_, children0_.NAME as NAME1_, children0_.PK as PK19_0_, children0_.PATH as PATH19_0_, children0_.NAME as NAME19_0_, children0_.PARENT_KEY as PARENT4_19_0_ from JBP_OBJECT_NODE children0_ where children0_.PARENT_KEY=?
2007-03-26 17:10:56,031 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0)
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#4]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#5]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#6]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#7]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#8]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,031 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#72]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#183]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.ObjectNode#191]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.ObjectNode.children#3]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close ResultSet (open ResultSets: 1, globally: 1)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.ObjectNode#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#4
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#4 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - loading entity: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-03-26 17:10:56,046 DEBUG [org.hibernate.SQL] - select portalobje0_.PK as PK20_0_, portalobje0_.LISTENER as LISTENER20_0_, portalobje0_4_.INSTANCE_REF as INSTANCE2_27_0_, case when portalobje0_1_.PK is not null then 1 when portalobje0_2_.PK is not null then 2 when portalobje0_3_.PK is not null then 3 when portalobje0_4_.PK is not null then 4 when portalobje0_.PK is not null then 0 end as clazz_0_, declaredpr1_.OBJECT_KEY as OBJECT1_2_, declaredpr1_.jbp_VALUE as jbp2_2_, declaredpr1_.NAME as NAME2_, modes2_.PK as PK3_, modes2_.name as name3_, windowstat3_.PK as PK4_, windowstat3_.name as name4_ from JBP_PORTAL_OBJECT portalobje0_ left outer join JBP_CONTEXT portalobje0_1_ on portalobje0_.PK=portalobje0_1_.PK left outer join JBP_PORTAL portalobje0_2_ on portalobje0_.PK=portalobje0_2_.PK left outer join JBP_PAGE portalobje0_3_ on portalobje0_.PK=portalobje0_3_.PK left outer join JBP_WINDOW portalobje0_4_ on portalobje0_.PK=portalobje0_4_.PK left outer join JBP_PORTAL_OBJECT_PROPS declaredpr1_ on portalobje0_.PK=declaredpr1_.OBJECT_KEY left outer join JBP_PORTAL_MODE modes2_ on portalobje0_.PK=modes2_.PK left outer join JBP_PORTAL_WINDOW_STATE windowstat3_ on portalobje0_.PK=windowstat3_.PK where portalobje0_.PK=?
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close ResultSet (open ResultSets: 1, globally: 1)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.WindowImpl#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.WindowImpl#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#4
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#4 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.WindowImpl#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#4
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#4 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.modes#4
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.modes#4 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#4
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#4 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - done entity load
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.ObjectNode#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNode#4
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNode#4 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.ObjectNode#4]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.ObjectNode#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#5
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#5 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - loading entity: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-03-26 17:10:56,046 DEBUG [org.hibernate.SQL] - select portalobje0_.PK as PK20_0_, portalobje0_.LISTENER as LISTENER20_0_, portalobje0_4_.INSTANCE_REF as INSTANCE2_27_0_, case when portalobje0_1_.PK is not null then 1 when portalobje0_2_.PK is not null then 2 when portalobje0_3_.PK is not null then 3 when portalobje0_4_.PK is not null then 4 when portalobje0_.PK is not null then 0 end as clazz_0_, declaredpr1_.OBJECT_KEY as OBJECT1_2_, declaredpr1_.jbp_VALUE as jbp2_2_, declaredpr1_.NAME as NAME2_, modes2_.PK as PK3_, modes2_.name as name3_, windowstat3_.PK as PK4_, windowstat3_.name as name4_ from JBP_PORTAL_OBJECT portalobje0_ left outer join JBP_CONTEXT portalobje0_1_ on portalobje0_.PK=portalobje0_1_.PK left outer join JBP_PORTAL portalobje0_2_ on portalobje0_.PK=portalobje0_2_.PK left outer join JBP_PAGE portalobje0_3_ on portalobje0_.PK=portalobje0_3_.PK left outer join JBP_WINDOW portalobje0_4_ on portalobje0_.PK=portalobje0_4_.PK left outer join JBP_PORTAL_OBJECT_PROPS declaredpr1_ on portalobje0_.PK=declaredpr1_.OBJECT_KEY left outer join JBP_PORTAL_MODE modes2_ on portalobje0_.PK=modes2_.PK left outer join JBP_PORTAL_WINDOW_STATE windowstat3_ on portalobje0_.PK=windowstat3_.PK where portalobje0_.PK=?
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close ResultSet (open ResultSets: 1, globally: 1)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-03-26 17:10:56,046 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.WindowImpl#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.WindowImpl#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#5
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#5 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.WindowImpl#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#5
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#5 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.modes#5
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.modes#5 is null
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,046 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#5]
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#5
2007-03-26 17:10:56,046 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#5 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#5]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - done entity load
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.ObjectNode#5]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNode#5
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNode#5 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.ObjectNode#5]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.ObjectNode#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - loading entity: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-03-26 17:10:56,062 DEBUG [org.hibernate.SQL] - select portalobje0_.PK as PK20_0_, portalobje0_.LISTENER as LISTENER20_0_, portalobje0_4_.INSTANCE_REF as INSTANCE2_27_0_, case when portalobje0_1_.PK is not null then 1 when portalobje0_2_.PK is not null then 2 when portalobje0_3_.PK is not null then 3 when portalobje0_4_.PK is not null then 4 when portalobje0_.PK is not null then 0 end as clazz_0_, declaredpr1_.OBJECT_KEY as OBJECT1_2_, declaredpr1_.jbp_VALUE as jbp2_2_, declaredpr1_.NAME as NAME2_, modes2_.PK as PK3_, modes2_.name as name3_, windowstat3_.PK as PK4_, windowstat3_.name as name4_ from JBP_PORTAL_OBJECT portalobje0_ left outer join JBP_CONTEXT portalobje0_1_ on portalobje0_.PK=portalobje0_1_.PK left outer join JBP_PORTAL portalobje0_2_ on portalobje0_.PK=portalobje0_2_.PK left outer join JBP_PAGE portalobje0_3_ on portalobje0_.PK=portalobje0_3_.PK left outer join JBP_WINDOW portalobje0_4_ on portalobje0_.PK=portalobje0_4_.PK left outer join JBP_PORTAL_OBJECT_PROPS declaredpr1_ on portalobje0_.PK=declaredpr1_.OBJECT_KEY left outer join JBP_PORTAL_MODE modes2_ on portalobje0_.PK=modes2_.PK left outer join JBP_PORTAL_WINDOW_STATE windowstat3_ on portalobje0_.PK=windowstat3_.PK where portalobje0_.PK=?
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close ResultSet (open ResultSets: 1, globally: 1)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.WindowImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.WindowImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#6 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.WindowImpl#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.modes
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - collection fully initialized: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections initialized for role: org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - done entity load
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.ObjectNode#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.ObjectNode#6
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.ObjectNode#6 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.ObjectNode#6]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.ObjectNode#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#7
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#7 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - loading entity: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.ConnectionManager] - opening JDBC connection
2007-03-26 17:10:56,062 DEBUG [org.hibernate.SQL] - select portalobje0_.PK as PK20_0_, portalobje0_.LISTENER as LISTENER20_0_, portalobje0_4_.INSTANCE_REF as INSTANCE2_27_0_, case when portalobje0_1_.PK is not null then 1 when portalobje0_2_.PK is not null then 2 when portalobje0_3_.PK is not null then 3 when portalobje0_4_.PK is not null then 4 when portalobje0_.PK is not null then 0 end as clazz_0_, declaredpr1_.OBJECT_KEY as OBJECT1_2_, declaredpr1_.jbp_VALUE as jbp2_2_, declaredpr1_.NAME as NAME2_, modes2_.PK as PK3_, modes2_.name as name3_, windowstat3_.PK as PK4_, windowstat3_.name as name4_ from JBP_PORTAL_OBJECT portalobje0_ left outer join JBP_CONTEXT portalobje0_1_ on portalobje0_.PK=portalobje0_1_.PK left outer join JBP_PORTAL portalobje0_2_ on portalobje0_.PK=portalobje0_2_.PK left outer join JBP_PAGE portalobje0_3_ on portalobje0_.PK=portalobje0_3_.PK left outer join JBP_WINDOW portalobje0_4_ on portalobje0_.PK=portalobje0_4_.PK left outer join JBP_PORTAL_OBJECT_PROPS declaredpr1_ on portalobje0_.PK=declaredpr1_.OBJECT_KEY left outer join JBP_PORTAL_MODE modes2_ on portalobje0_.PK=modes2_.PK left outer join JBP_PORTAL_WINDOW_STATE windowstat3_ on portalobje0_.PK=windowstat3_.PK where portalobje0_.PK=?
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to open ResultSet (open ResultSets: 0, globally: 0)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result row: EntityKey[org.jboss.portal.core.impl.model.portal.PortalObjectImpl#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - found row of collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.modes#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.loader.Loader] - result set contains (possibly empty) collection: [org.jboss.portal.core.impl.model.portal.PortalImpl.windowStates#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close ResultSet (open ResultSets: 1, globally: 1)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.AbstractBatcher] - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.ConnectionManager] - aggressively releasing JDBC connection
2007-03-26 17:10:56,062 DEBUG [org.hibernate.jdbc.ConnectionManager] - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - resolving associations for [org.jboss.portal.core.impl.model.portal.WindowImpl#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - adding entity to second-level cache: [org.jboss.portal.core.impl.model.portal.WindowImpl#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl#7
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl#7 is null
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.TwoPhaseLoad] - done materializing entity [org.jboss.portal.core.impl.model.portal.WindowImpl#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - 1 collections were found in result set for role: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties
2007-03-26 17:10:56,062 DEBUG [org.hibernate.engine.CollectionLoadContext] - Caching collection: [org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#7]
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - key: org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#7
2007-03-26 17:10:56,062 DEBUG [org.hibernate.cache.EhCache] - Element for org.jboss.portal.core.impl.model.portal.PortalObjectImpl.declaredProperties#7 is null
2007-03-26 17:10:56,062

I have solved my problem, it was a misconfiguration of dataSource and sessionFactory