|
I need help otherwise I'll hang myself up to the lamp on my desk....
I have a BusinessUnit that is is many-to-many relationship with Webuser and Accounts
So BusinessUnit is father of two children collections: accounts, webusers.
In the test here describe I simply add n account objects in the HashSet of BusinessUnit and remove m of them.
The problem is the following: the subsequent QUERIES returns random number of objects of the collection!!
STEPS:
1. I get an object from Accounts in an Hibernate Session and I add it to the collection of BusinessUnit and call saveOrUpdate.
2. I repeat step 1 few times (3 or 4 times)
3. Then I query with the same QUERY the business object and I get a random number of children in result.
The very same query sometimes picks up all the children, other times some are missing ( I execute the query on a web page so I simply execute a page refresh) and I get a random number of children.
Obviously I'm doing some wrong because it seems that Hibernate gives me back objects that sometimes are the full set in the Database (the table on the DB is OK) and other times it does not like if it is getting partial result from some kind of cache, but what it is?
Hibernate version:
hibernate 2.1
Mapping documents:
This is the Account mapping file:
======================
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC "-//Hibernate/Hibernate Mapping DTD 2.0//EN" "http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd">
<hibernate-mapping>
<class name="misterisk.entity.Account" table="ACCOUNT">
<id name="id" column="ID" type="long" unsaved-value="null">
<generator class="increment"/>
</id>
<property name="name"/>
<set name="businessUnits" table="ACCOUNT_BUSINESS_UNIT" inverse="true" lazy="false">
<key column="account_id"/>
<many-to-many column="unit_id" class="misterisk.entity.BusinessUnit"/>
</set>
</class>
</hibernate-mapping>
Business Unit mapping file:
=================
<hibernate-mapping>
<class name="misterisk.entity.BusinessUnit" table="BIZUNIT">
<id name="id" column="ID" type="long" unsaved-value="null">
<generator class="increment"/>
</id>
<property name="name"/>
<set name="webusers" table="EMPLOYMENT" cascade="all">
<key column="unit_id"/>
<many-to-many class="portal.architect.Webuser">
<column name="webuser_id" not-null="true" />
</many-to-many>
</set>
<set name="accounts" table="ACCOUNT_BUSINESS_UNIT" lazy="false" cascade="all-delete-orphan">
<key column="unit_id"/>
<many-to-many class="misterisk.entity.Account">
<column name="account_id" not-null="true" />
</many-to-many>
</set>
</class>
</hibernate-mapping>
WEBUSER
========
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC "-//Hibernate/Hibernate Mapping DTD 2.0//EN" "http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd">
<hibernate-mapping>
<class name="portal.architect.Webuser" table="WEBUSER">
<id name="id" column="ID" type="long" unsaved-value="null">
<generator class="increment"/>
</id>
<property name="username"/>
<property name="password"/>
<property name="firstname"/>
<property name="middlename"/>
<property name="lastname"/>
<property name="priviledge"/>
<set name="businessUnits" table="EMPLOYMENT" inverse="true" lazy="false" >
<key column="webuser_id" />
<many-to-many column="unit_id" class="misterisk.entity.BusinessUnit"/>
</set>
</class>
</hibernate-mapping>
Code between sessionFactory.openSession() and session.close():
Code to add an Account to a BusinessUnit (account is loaded out of this Session is an other session)
tx = session.beginTransaction();
BusinessUnit unit = (BusinessUnit) session.load(BusinessUnit.class, businessUnit);
if (unit == null) throw new IllegalStateException("unit cannot be null");
unit.addAccount(account);
session.saveOrUpdate(account);
session.saveOrUpdate(unit);
session.flush();
tx.commit();
Code to delete an account from a business unit:
tx = session.beginTransaction();
BusinessUnit unit = (BusinessUnit) session.load(BusinessUnit.class, businessUnit);
unit.removeWebuser(user);
session.saveOrUpdate(unit);
session.flush();
tx.commit();
The code for the POJOs is:
ACCOUNT
-------------------------------------------------------------
public class Account extends FinObject
{
private Set businessUnits = new HashSet();
public Account()
{
}
public void addBusinessUnit(BusinessUnit unit)
{
businessUnits.add(unit);
unit.getAccounts().add(this);
}
public void removeBusinessUnit(BusinessUnit unit)
{
businessUnits.remove(unit);
unit.getAccounts().remove(this);
}
......
BusinessUnit
============================
public class BusinessUnit extends FinObject implements ModuleIF
{
private String name;
private Set webusers = new HashSet();
private Set accounts = new HashSet();
public BusinessUnit()
{
}
public void addAccount(Account account)
{
accounts.add(account);
account.getBusinessUnits().add(this);
}
public void removeAccount(Account account)
{
accounts.remove(account);
account.getBusinessUnits().remove(this);
}
Full stack trace of any exception that occurs:
No exceptions occur
Name and version of the database you are using:
MySql 4.1 but I have the same problem on HSQL and SQL Server
The generated SQL (show_sql=true):
The SQL Statements are listed in the trace attached:
In particular the SQL is:
select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Hibernate: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Debug level Hibernate log excerpt:
In this trace there are 2 consecutive refresh of the page which calls the same query as above.
The first call returns 5 childred, the second refres (after few seconds) returns 6 children. The QUERY is the same!!!
Please help.
FIRST REFRESH
=[2004-12-08 21:26:50,656] - jspview = jsp/misterisk/portlets/businessunitdetails/businessunitaccounts.jsp
=[2004-12-08 21:26:50,656] - HibernateDataLayer.getSession
=[2004-12-08 21:26:50,656] - reconnecting session
=[2004-12-08 21:26:50,656] - find: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:50,656] - parameters: [2]
=[2004-12-08 21:26:50,656] - flushing session
=[2004-12-08 21:26:50,656] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,656] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:50,656] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:50,656] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,656] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,656] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:50,656] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:50,656] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,656] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,656] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,656] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,656] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,656] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,656] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,656] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,656] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,656] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,656] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,656] - Collection dirty: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:50,656] - Collection dirty: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:50,656] - Collection dirty: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:50,656] - Collection dirty: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:50,656] - Collection dirty: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:50,656] - Flushing entities and processing referenced collections
=[2004-12-08 21:26:50,656] - Collection found: [portal.architect.Webuser.businessUnits#1], was: [portal.architect.Webuser.businessUnits#1]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.BusinessUnit.webusers#1], was: [misterisk.entity.BusinessUnit.webusers#1]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.BusinessUnit.accounts#1], was: [misterisk.entity.BusinessUnit.accounts#1]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.BusinessUnit.webusers#2], was: [misterisk.entity.BusinessUnit.webusers#2]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.BusinessUnit.accounts#2], was: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#2], was: [misterisk.entity.Account.businessUnits#2]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#13], was: [misterisk.entity.Account.businessUnits#13]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#14], was: [misterisk.entity.Account.businessUnits#14]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#18], was: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#15], was: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#16], was: [misterisk.entity.Account.businessUnits#16]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#17], was: [misterisk.entity.Account.businessUnits#17]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#19], was: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:50,656] - Collection found: [misterisk.entity.Account.businessUnits#20], was: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:50,656] - Processing unreferenced collections
=[2004-12-08 21:26:50,656] - Scheduling collection removes/(re)creates/updates
=[2004-12-08 21:26:50,656] - Flushed: 0 insertions, 0 updates, 0 deletions to 12 objects
=[2004-12-08 21:26:50,656] - Flushed: 0 (re)creations, 5 updates, 0 removals to 14 collections
=[2004-12-08 21:26:50,656] - listing entities:
=[2004-12-08 21:26:50,656] - misterisk.entity.BusinessUnit{accounts=[], webusers=[], name=roma, id=1}
=[2004-12-08 21:26:50,656] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=333333333, id=20}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=22222222, id=19}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[], name=1111111111, id=18}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=bbbbbbbbbb, id=2}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=ZZZZZZZZZZ, id=13}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[], name=BBBBBBB, id=16}
=[2004-12-08 21:26:50,671] - misterisk.entity.BusinessUnit{accounts=[Account#20, Account#13, Account#14, Account#19, Account#2], webusers=[], name=londra, id=2}
=[2004-12-08 21:26:50,671] - portal.architect.Webuser{lastname=Administrator, password=administrator, priviledge=4, businessUnits=[], middlename=, firstname=Administrator, username=nicholas, id=1}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[], name=AAAAAAAAA, id=15}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[], name=ccccccccccc, id=17}
=[2004-12-08 21:26:50,671] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=WSASASASA, id=14}
=[2004-12-08 21:26:50,671] - Dont need to execute flush
=[2004-12-08 21:26:50,671] - HQL: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:50,671] - SQL: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:50,671] - about to open: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:50,671] - total checked-out connections: 0
=[2004-12-08 21:26:50,671] - using pooled JDBC connection, pool size: 0
=[2004-12-08 21:26:50,671] - select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Hibernate: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:50,671] - preparing statement
=[2004-12-08 21:26:50,671] - binding '2' to parameter: 1
=[2004-12-08 21:26:50,671] - processing result set
=[2004-12-08 21:26:50,671] - returning '2' as column: ID
=[2004-12-08 21:26:50,671] - result row: 2
=[2004-12-08 21:26:50,671] - done processing result set (1 rows)
=[2004-12-08 21:26:50,671] - done closing: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:50,671] - closing statement
=[2004-12-08 21:26:50,671] - total objects hydrated: 0
=[2004-12-08 21:26:50,671] - initializing non-lazy collections
=[2004-12-08 21:26:50,671] - disconnecting session
=[2004-12-08 21:26:50,671] - returning connection to pool, pool size: 1
=[2004-12-08 21:26:50,671] - transaction completion
=[2004-12-08 21:26:50,671] - Browser.doView
=[2004-12-08 21:26:50,671] - request = org.apache.catalina.core.ApplicationHttpRequest@156d7c8
=[2004-12-08 21:26:50,671] - BusinessUnitAccountsService.getObjects
=[2004-12-08 21:26:50,671] - HibernateDataLayer.getSession
=[2004-12-08 21:26:50,671] - reconnecting session
=[2004-12-08 21:26:50,671] - find: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:50,671] - parameters: [2]
=[2004-12-08 21:26:50,671] - flushing session
=[2004-12-08 21:26:50,671] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,671] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:50,671] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:50,671] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,671] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,671] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:50,671] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:50,671] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,671] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,671] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,671] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,671] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,671] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,671] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,671] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,671] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,671] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,671] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,671] - Collection dirty: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:50,671] - Collection dirty: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:50,671] - Collection dirty: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:50,671] - Collection dirty: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:50,671] - Collection dirty: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:50,671] - Flushing entities and processing referenced collections
=[2004-12-08 21:26:50,671] - Collection found: [portal.architect.Webuser.businessUnits#1], was: [portal.architect.Webuser.businessUnits#1]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.webusers#1], was: [misterisk.entity.BusinessUnit.webusers#1]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.accounts#1], was: [misterisk.entity.BusinessUnit.accounts#1]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.webusers#2], was: [misterisk.entity.BusinessUnit.webusers#2]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.accounts#2], was: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#2], was: [misterisk.entity.Account.businessUnits#2]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#13], was: [misterisk.entity.Account.businessUnits#13]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#14], was: [misterisk.entity.Account.businessUnits#14]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#18], was: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#15], was: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#16], was: [misterisk.entity.Account.businessUnits#16]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#17], was: [misterisk.entity.Account.businessUnits#17]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#19], was: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#20], was: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:50,687] - Processing unreferenced collections
=[2004-12-08 21:26:50,687] - Scheduling collection removes/(re)creates/updates
=[2004-12-08 21:26:50,687] - Flushed: 0 insertions, 0 updates, 0 deletions to 12 objects
=[2004-12-08 21:26:50,687] - Flushed: 0 (re)creations, 5 updates, 0 removals to 14 collections
=[2004-12-08 21:26:50,687] - listing entities:
=[2004-12-08 21:26:50,687] - misterisk.entity.BusinessUnit{accounts=[], webusers=[], name=roma, id=1}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=333333333, id=20}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=22222222, id=19}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[], name=1111111111, id=18}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=bbbbbbbbbb, id=2}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=ZZZZZZZZZZ, id=13}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[], name=BBBBBBB, id=16}
=[2004-12-08 21:26:50,687] - misterisk.entity.BusinessUnit{accounts=[Account#20, Account#13, Account#14, Account#19, Account#2], webusers=[], name=londra, id=2}
=[2004-12-08 21:26:50,687] - portal.architect.Webuser{lastname=Administrator, password=administrator, priviledge=4, businessUnits=[], middlename=, firstname=Administrator, username=nicholas, id=1}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[], name=AAAAAAAAA, id=15}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[], name=ccccccccccc, id=17}
=[2004-12-08 21:26:50,687] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=WSASASASA, id=14}
=[2004-12-08 21:26:50,687] - Dont need to execute flush
=[2004-12-08 21:26:50,687] - HQL: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:50,687] - SQL: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:50,687] - about to open: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:50,687] - total checked-out connections: 0
=[2004-12-08 21:26:50,687] - using pooled JDBC connection, pool size: 0
=[2004-12-08 21:26:50,687] - select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Hibernate: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:50,687] - preparing statement
=[2004-12-08 21:26:50,687] - binding '2' to parameter: 1
=[2004-12-08 21:26:50,687] - processing result set
=[2004-12-08 21:26:50,687] - returning '2' as column: ID
=[2004-12-08 21:26:50,687] - result row: 2
=[2004-12-08 21:26:50,687] - done processing result set (1 rows)
=[2004-12-08 21:26:50,687] - done closing: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:50,687] - closing statement
=[2004-12-08 21:26:50,687] - total objects hydrated: 0
=[2004-12-08 21:26:50,687] - initializing non-lazy collections
=[2004-12-08 21:26:50,687] - disconnecting session
=[2004-12-08 21:26:50,687] - returning connection to pool, pool size: 1
=[2004-12-08 21:26:50,687] - transaction completion
=[2004-12-08 21:26:50,687] - unit.getName() = londra
=[2004-12-08 21:26:50,687] - BusinessUnitAccountsService.getObjects
=[2004-12-08 21:26:50,687] - HibernateDataLayer.getSession
=[2004-12-08 21:26:50,687] - reconnecting session
=[2004-12-08 21:26:50,687] - find: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:50,687] - parameters: [2]
=[2004-12-08 21:26:50,687] - flushing session
=[2004-12-08 21:26:50,687] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,687] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:50,687] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:50,687] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,687] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,687] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:50,687] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:50,687] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,687] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,687] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,687] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,687] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,687] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,687] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,687] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,687] - cascading to saveOrUpdate()
=[2004-12-08 21:26:50,687] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:50,687] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:50,687] - Collection dirty: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:50,687] - Collection dirty: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:50,687] - Collection dirty: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:50,687] - Collection dirty: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:50,687] - Collection dirty: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:50,687] - Flushing entities and processing referenced collections
=[2004-12-08 21:26:50,687] - Collection found: [portal.architect.Webuser.businessUnits#1], was: [portal.architect.Webuser.businessUnits#1]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.webusers#1], was: [misterisk.entity.BusinessUnit.webusers#1]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.accounts#1], was: [misterisk.entity.BusinessUnit.accounts#1]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.webusers#2], was: [misterisk.entity.BusinessUnit.webusers#2]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.BusinessUnit.accounts#2], was: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#2], was: [misterisk.entity.Account.businessUnits#2]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#13], was: [misterisk.entity.Account.businessUnits#13]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#14], was: [misterisk.entity.Account.businessUnits#14]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#18], was: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#15], was: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#16], was: [misterisk.entity.Account.businessUnits#16]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#17], was: [misterisk.entity.Account.businessUnits#17]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#19], was: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:50,687] - Collection found: [misterisk.entity.Account.businessUnits#20], was: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:50,687] - Processing unreferenced collections
=[2004-12-08 21:26:50,687] - Scheduling collection removes/(re)creates/updates
=[2004-12-08 21:26:50,687] - Flushed: 0 insertions, 0 updates, 0 deletions to 12 objects
=[2004-12-08 21:26:50,703] - Flushed: 0 (re)creations, 5 updates, 0 removals to 14 collections
=[2004-12-08 21:26:50,703] - listing entities:
=[2004-12-08 21:26:50,703] - misterisk.entity.BusinessUnit{accounts=[], webusers=[], name=roma, id=1}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=333333333, id=20}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=22222222, id=19}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[], name=1111111111, id=18}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=bbbbbbbbbb, id=2}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=ZZZZZZZZZZ, id=13}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[], name=BBBBBBB, id=16}
=[2004-12-08 21:26:50,703] - misterisk.entity.BusinessUnit{accounts=[Account#20, Account#13, Account#14, Account#19, Account#2], webusers=[], name=londra, id=2}
=[2004-12-08 21:26:50,703] - portal.architect.Webuser{lastname=Administrator, password=administrator, priviledge=4, businessUnits=[], middlename=, firstname=Administrator, username=nicholas, id=1}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[], name=AAAAAAAAA, id=15}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[], name=ccccccccccc, id=17}
=[2004-12-08 21:26:50,703] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=WSASASASA, id=14}
=[2004-12-08 21:26:50,703] - Dont need to execute flush
=[2004-12-08 21:26:50,703] - HQL: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:50,703] - SQL: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:50,703] - about to open: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:50,703] - total checked-out connections: 0
=[2004-12-08 21:26:50,703] - using pooled JDBC connection, pool size: 0
=[2004-12-08 21:26:50,703] - select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Hibernate: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:50,703] - preparing statement
=[2004-12-08 21:26:50,703] - binding '2' to parameter: 1
=[2004-12-08 21:26:50,703] - processing result set
=[2004-12-08 21:26:50,703] - returning '2' as column: ID
=[2004-12-08 21:26:50,703] - result row: 2
=[2004-12-08 21:26:50,703] - done processing result set (1 rows)
=[2004-12-08 21:26:50,703] - done closing: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:50,703] - closing statement
=[2004-12-08 21:26:50,703] - total objects hydrated: 0
=[2004-12-08 21:26:50,703] - initializing non-lazy collections
=[2004-12-08 21:26:50,703] - disconnecting session
=[2004-12-08 21:26:50,703] - returning connection to pool, pool size: 1
=[2004-12-08 21:26:50,703] - transaction completion
=[2004-12-08 21:26:50,703] - unit.getName() = londra
SECOND REFRESH
=[2004-12-08 21:26:52,156] - jspview = jsp/misterisk/portlets/businessunitdetails/businessunitaccounts.jsp
=[2004-12-08 21:26:52,156] - HibernateDataLayer.getSession
=[2004-12-08 21:26:52,156] - reconnecting session
=[2004-12-08 21:26:52,156] - find: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:52,156] - parameters: [2]
=[2004-12-08 21:26:52,156] - flushing session
=[2004-12-08 21:26:52,156] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:52,156] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:52,156] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:52,156] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,156] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,156] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,156] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,156] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,156] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,156] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,156] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,156] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,156] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,156] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,156] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,156] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:52,156] - Flushing entities and processing referenced collections
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.BusinessUnit.webusers#2], was: [misterisk.entity.BusinessUnit.webusers#2]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.BusinessUnit.accounts#2], was: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#2], was: [misterisk.entity.Account.businessUnits#2]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#13], was: [misterisk.entity.Account.businessUnits#13]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#14], was: [misterisk.entity.Account.businessUnits#14]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#18], was: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#19], was: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#15], was: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#16], was: [misterisk.entity.Account.businessUnits#16]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#17], was: [misterisk.entity.Account.businessUnits#17]
=[2004-12-08 21:26:52,156] - Collection found: [misterisk.entity.Account.businessUnits#20], was: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:52,156] - Processing unreferenced collections
=[2004-12-08 21:26:52,156] - Scheduling collection removes/(re)creates/updates
=[2004-12-08 21:26:52,156] - Flushed: 0 insertions, 0 updates, 0 deletions to 10 objects
=[2004-12-08 21:26:52,171] - Flushed: 0 (re)creations, 0 updates, 0 removals to 11 collections
=[2004-12-08 21:26:52,171] - listing entities:
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=333333333, id=20}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=22222222, id=19}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=1111111111, id=18}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=bbbbbbbbbb, id=2}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=ZZZZZZZZZZ, id=13}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[], name=BBBBBBB, id=16}
=[2004-12-08 21:26:52,171] - misterisk.entity.BusinessUnit{accounts=[Account#18, Account#20, Account#13, Account#14, Account#19, Account#2], webusers=[], name=londra, id=2}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[], name=AAAAAAAAA, id=15}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[], name=ccccccccccc, id=17}
=[2004-12-08 21:26:52,171] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=WSASASASA, id=14}
=[2004-12-08 21:26:52,171] - Dont need to execute flush
=[2004-12-08 21:26:52,171] - HQL: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:52,171] - SQL: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:52,171] - about to open: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:52,171] - total checked-out connections: 0
=[2004-12-08 21:26:52,171] - using pooled JDBC connection, pool size: 0
=[2004-12-08 21:26:52,171] - select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Hibernate: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:52,171] - preparing statement
=[2004-12-08 21:26:52,171] - binding '2' to parameter: 1
=[2004-12-08 21:26:52,171] - processing result set
=[2004-12-08 21:26:52,171] - returning '2' as column: ID
=[2004-12-08 21:26:52,171] - result row: 2
=[2004-12-08 21:26:52,171] - done processing result set (1 rows)
=[2004-12-08 21:26:52,171] - done closing: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:52,171] - closing statement
=[2004-12-08 21:26:52,171] - total objects hydrated: 0
=[2004-12-08 21:26:52,171] - initializing non-lazy collections
=[2004-12-08 21:26:52,171] - disconnecting session
=[2004-12-08 21:26:52,171] - returning connection to pool, pool size: 1
=[2004-12-08 21:26:52,171] - transaction completion
=[2004-12-08 21:26:52,171] - Browser.doView
=[2004-12-08 21:26:52,171] - request = org.apache.catalina.core.ApplicationHttpRequest@76458f
=[2004-12-08 21:26:52,171] - BusinessUnitAccountsService.getObjects
=[2004-12-08 21:26:52,171] - HibernateDataLayer.getSession
=[2004-12-08 21:26:52,171] - reconnecting session
=[2004-12-08 21:26:52,171] - find: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:52,171] - parameters: [2]
=[2004-12-08 21:26:52,171] - flushing session
=[2004-12-08 21:26:52,171] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:52,171] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:52,171] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:52,171] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,171] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,171] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,171] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,171] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,171] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,171] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,171] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,171] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,171] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,171] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,171] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,171] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:52,171] - Flushing entities and processing referenced collections
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.BusinessUnit.webusers#2], was: [misterisk.entity.BusinessUnit.webusers#2]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.BusinessUnit.accounts#2], was: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.Account.businessUnits#2], was: [misterisk.entity.Account.businessUnits#2]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.Account.businessUnits#13], was: [misterisk.entity.Account.businessUnits#13]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.Account.businessUnits#14], was: [misterisk.entity.Account.businessUnits#14]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.Account.businessUnits#18], was: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.Account.businessUnits#19], was: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.Account.businessUnits#15], was: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:52,171] - Collection found: [misterisk.entity.Account.businessUnits#16], was: [misterisk.entity.Account.businessUnits#16]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#17], was: [misterisk.entity.Account.businessUnits#17]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#20], was: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:52,187] - Processing unreferenced collections
=[2004-12-08 21:26:52,187] - Scheduling collection removes/(re)creates/updates
=[2004-12-08 21:26:52,187] - Flushed: 0 insertions, 0 updates, 0 deletions to 10 objects
=[2004-12-08 21:26:52,187] - Flushed: 0 (re)creations, 0 updates, 0 removals to 11 collections
=[2004-12-08 21:26:52,187] - listing entities:
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=333333333, id=20}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=22222222, id=19}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=1111111111, id=18}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=bbbbbbbbbb, id=2}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=ZZZZZZZZZZ, id=13}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[], name=BBBBBBB, id=16}
=[2004-12-08 21:26:52,187] - misterisk.entity.BusinessUnit{accounts=[Account#18, Account#20, Account#13, Account#14, Account#19, Account#2], webusers=[], name=londra, id=2}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[], name=AAAAAAAAA, id=15}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[], name=ccccccccccc, id=17}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=WSASASASA, id=14}
=[2004-12-08 21:26:52,187] - Dont need to execute flush
=[2004-12-08 21:26:52,187] - HQL: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:52,187] - SQL: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:52,187] - about to open: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:52,187] - total checked-out connections: 0
=[2004-12-08 21:26:52,187] - using pooled JDBC connection, pool size: 0
=[2004-12-08 21:26:52,187] - select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Hibernate: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:52,187] - preparing statement
=[2004-12-08 21:26:52,187] - binding '2' to parameter: 1
=[2004-12-08 21:26:52,187] - processing result set
=[2004-12-08 21:26:52,187] - returning '2' as column: ID
=[2004-12-08 21:26:52,187] - result row: 2
=[2004-12-08 21:26:52,187] - done processing result set (1 rows)
=[2004-12-08 21:26:52,187] - done closing: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:52,187] - closing statement
=[2004-12-08 21:26:52,187] - total objects hydrated: 0
=[2004-12-08 21:26:52,187] - initializing non-lazy collections
=[2004-12-08 21:26:52,187] - disconnecting session
=[2004-12-08 21:26:52,187] - returning connection to pool, pool size: 1
=[2004-12-08 21:26:52,187] - transaction completion
=[2004-12-08 21:26:52,187] - unit.getName() = londra
=[2004-12-08 21:26:52,187] - BusinessUnitAccountsService.getObjects
=[2004-12-08 21:26:52,187] - HibernateDataLayer.getSession
=[2004-12-08 21:26:52,187] - reconnecting session
=[2004-12-08 21:26:52,187] - find: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:52,187] - parameters: [2]
=[2004-12-08 21:26:52,187] - flushing session
=[2004-12-08 21:26:52,187] - processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:52,187] - cascading to collection: misterisk.entity.BusinessUnit.webusers
=[2004-12-08 21:26:52,187] - cascading to collection: misterisk.entity.BusinessUnit.accounts
=[2004-12-08 21:26:52,187] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,187] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,187] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,187] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,187] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,187] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,187] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,187] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,187] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,187] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,187] - cascading to saveOrUpdate()
=[2004-12-08 21:26:52,187] - saveOrUpdate() persistent instance
=[2004-12-08 21:26:52,187] - done processing cascades for: misterisk.entity.BusinessUnit
=[2004-12-08 21:26:52,187] - Flushing entities and processing referenced collections
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.BusinessUnit.webusers#2], was: [misterisk.entity.BusinessUnit.webusers#2]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.BusinessUnit.accounts#2], was: [misterisk.entity.BusinessUnit.accounts#2]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#2], was: [misterisk.entity.Account.businessUnits#2]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#13], was: [misterisk.entity.Account.businessUnits#13]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#14], was: [misterisk.entity.Account.businessUnits#14]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#18], was: [misterisk.entity.Account.businessUnits#18]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#19], was: [misterisk.entity.Account.businessUnits#19]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#15], was: [misterisk.entity.Account.businessUnits#15]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#16], was: [misterisk.entity.Account.businessUnits#16]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#17], was: [misterisk.entity.Account.businessUnits#17]
=[2004-12-08 21:26:52,187] - Collection found: [misterisk.entity.Account.businessUnits#20], was: [misterisk.entity.Account.businessUnits#20]
=[2004-12-08 21:26:52,187] - Processing unreferenced collections
=[2004-12-08 21:26:52,187] - Scheduling collection removes/(re)creates/updates
=[2004-12-08 21:26:52,187] - Flushed: 0 insertions, 0 updates, 0 deletions to 10 objects
=[2004-12-08 21:26:52,187] - Flushed: 0 (re)creations, 0 updates, 0 removals to 11 collections
=[2004-12-08 21:26:52,187] - listing entities:
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=333333333, id=20}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=22222222, id=19}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=1111111111, id=18}
=[2004-12-08 21:26:52,187] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=bbbbbbbbbb, id=2}
=[2004-12-08 21:26:52,203] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=ZZZZZZZZZZ, id=13}
=[2004-12-08 21:26:52,203] - misterisk.entity.Account{businessUnits=[], name=BBBBBBB, id=16}
=[2004-12-08 21:26:52,203] - misterisk.entity.BusinessUnit{accounts=[Account#18, Account#20, Account#13, Account#14, Account#19, Account#2], webusers=[], name=londra, id=2}
=[2004-12-08 21:26:52,203] - misterisk.entity.Account{businessUnits=[], name=AAAAAAAAA, id=15}
=[2004-12-08 21:26:52,203] - misterisk.entity.Account{businessUnits=[], name=ccccccccccc, id=17}
=[2004-12-08 21:26:52,203] - misterisk.entity.Account{businessUnits=[BusinessUnit#2], name=WSASASASA, id=14}
=[2004-12-08 21:26:52,203] - Dont need to execute flush
=[2004-12-08 21:26:52,203] - HQL: from misterisk.entity.BusinessUnit as obj where obj.id = ?
=[2004-12-08 21:26:52,203] - SQL: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:52,203] - about to open: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:52,203] - total checked-out connections: 0
=[2004-12-08 21:26:52,203] - using pooled JDBC connection, pool size: 0
=[2004-12-08 21:26:52,203] - select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
Hibernate: select businessun0_.ID as ID, businessun0_.name as name from BIZUNIT businessun0_ where (businessun0_.ID=? )
=[2004-12-08 21:26:52,203] - preparing statement
=[2004-12-08 21:26:52,203] - binding '2' to parameter: 1
=[2004-12-08 21:26:52,203] - processing result set
=[2004-12-08 21:26:52,203] - returning '2' as column: ID
=[2004-12-08 21:26:52,203] - result row: 2
=[2004-12-08 21:26:52,203] - done processing result set (1 rows)
=[2004-12-08 21:26:52,203] - done closing: 0 open PreparedStatements, 0 open ResultSets
=[2004-12-08 21:26:52,203] - closing statement
=[2004-12-08 21:26:52,203] - total objects hydrated: 0
=[2004-12-08 21:26:52,203] - initializing non-lazy collections
=[2004-12-08 21:26:52,203] - disconnecting session
=[2004-12-08 21:26:52,203] - returning connection to pool, pool size: 1
=[2004-12-08 21:26:52,203] - transaction completion
=[2004-12-08 21:26:52,203] - unit.getName() = londra
|