Read the rules before posting!
http://www.hibernate.org/ForumMailingli ... AskForHelp
Hibernate version:
2.1.8
Mapping documents:
hibernate.cfg.xml
<?xml version='1.0' encoding='UTF-8'?>
<!DOCTYPE hibernate-configuration PUBLIC
"-//Hibernate/Hibernate Configuration DTD 2.0//EN"
"http://hibernate.sourceforge.net/hibernate-configuration-2.0.dtd">
<!-- This is a generated file that is synchronized -->
<!-- by MyEclipse Hibernate tool integration. -->
<hibernate-configuration>
<session-factory>
<!-- properties -->
<property name="connection.username">root</property>
<property name="connection.url">jdbc:mysql://localhost:3306/workflow</property>
<property name="dialect">net.sf.hibernate.dialect.MySQLDialect</property>
<property name="connection.password">blah</property>
<property name="connection.driver_class">com.mysql.jdbc.Driver</property>
<property name="show_sql">true</property>
<!-- mapping files -->
<mapping resource="com/talisen/workflow/hibernate/Group.hbm.xml"/>
<mapping resource="com/talisen/workflow/hibernate/User.hbm.xml"/>
<mapping resource="com/talisen/workflow/hibernate/GroupUser.hbm.xml"/>
</session-factory>
</hibernate-configuration>
Group.hbm.xml
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 2.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd" >
<!--
Based on the Mapping file for the Category class of CaveatEmptor.
-->
<hibernate-mapping package="com.talisen.workflow.hibernate">
<class name="Group" table="GROUPYO">
<!-- Common id property. -->
<id name="groupId" type="java.lang.Integer" column="GROUP_ID"
unsaved-value="null">
<generator class="native" />
</id>
<property name="groupName" type="java.lang.String">
<column name="GROUP_NAME" not-null="true"
unique-key="UNIQUE_NAME_AT_LEVEL" />
</property>
<property name="groupDesc" column="GROUP_DESC"
type="java.lang.String" not-null="false" />
<set name="groupUsers" cascade="none"
order-by="STATUS_ID">
<key column="GROUP_ID" />
<one-to-many
class="com.talisen.workflow.hibernate.GroupUser" />
</set>
</class>
</hibernate-mapping>
User.hbm.xml
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 2.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd" >
<!--
Based on the Mapping file for the Item class of CaveatEmptor.
-->
<hibernate-mapping package="com.talisen.workflow.hibernate">
<class name="User" table="USER">
<!-- Common id property. -->
<id name="userId" type="java.lang.Integer" column="USER_ID"
unsaved-value="null">
<generator class="native" />
</id>
<!-- Name of the item is immutable. -->
<property name="userName" type="java.lang.String"
column="USER_NAME" not-null="true" />
<set name="groupUsers" inverse="true" cascade="none"
order-by="STATUS_ID">
<key column="USER_ID" />
<one-to-many
class="com.talisen.workflow.hibernate.GroupUser" />
</set>
</class>
</hibernate-mapping>
GroupUser.hbm.xml
<?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 package="com.talisen.workflow.hibernate">
<!--Based on the mapping file for the CategorizedItem class of CaveatEmptor. -->
<class name="GroupUser" table="USER_GROUP">
<composite-id name="groupUserKey" class="GroupUser$Id"
unsaved-value="any">
<key-property name="groupId" access="field"
column="GROUP_ID" />
<key-property name="userId" access="field"
column="USER_ID" />
</composite-id>
<many-to-one name="group" insert="false" update="false"
not-null="true" column="GROUP_ID" />
<many-to-one name="user" insert="false" update="false"
not-null="true" column="USER_ID" />
</class>
</hibernate-mapping>
Code between sessionFactory.openSession() and session.close():
try
{
session = SessionFactory.currentSession();
Transaction tx = session.beginTransaction();
Integer userId;
GroupUser gu;
Set guSet;
User user;
Group group;
for (Iterator iter = userIdSet.iterator();iter.hasNext();)
{
userId = new Integer((String) iter.next());
GroupUser.Id id = new GroupUser.Id(groupId, userId);
gu = (GroupUser)session.load(GroupUser.class, id);
gu.getGroup().removeGroupUser(gu);
gu.getUser().removeGroupUser(gu);
session.delete(gu);
}
tx.commit();
}
catch (HibernateException e)
{
System.err.println("Hibernate Exception" + e.getMessage());
throw new RuntimeException(e);
}
Full stack trace of any exception that occurs:
17:06:37,710 ERROR StandardWrapper[/workflow:action]:269 - Servlet.service() for servlet action threw exception
java.lang.ExceptionInInitializerError
at com.mysql.jdbc.SQLError.<clinit>(SQLError.java:89)
at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:2832)
at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:1534)
at com.mysql.jdbc.ServerPreparedStatement.serverExecute(ServerPreparedStatement.java:1344)
at com.mysql.jdbc.ServerPreparedStatement.executeInternal(ServerPreparedStatement.java:957)
at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:1906)
at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:1831)
at com.mysql.jdbc.ServerPreparedStatement.executeBatch(ServerPreparedStatement.java:780)
at net.sf.hibernate.impl.BatchingBatcher.doExecuteBatch(BatchingBatcher.java:54)
at net.sf.hibernate.impl.BatcherImpl.executeBatch(BatcherImpl.java:128)
at net.sf.hibernate.impl.SessionImpl.executeAll(SessionImpl.java:2438)
at net.sf.hibernate.impl.SessionImpl.execute(SessionImpl.java:2395)
at net.sf.hibernate.impl.SessionImpl.flush(SessionImpl.java:2261)
at net.sf.hibernate.transaction.JDBCTransaction.commit(JDBCTransaction.java:61)
at com.talisen.workflow.hibernate.WorkflowService.removeUsersFromGroup(WorkflowService.java:128)
at com.talisen.workflow.action.AddUsersToGroupAction.execute(AddUsersToGroupAction.java:100)
at org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:484)
at org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:274)
at org.apache.struts.action.ActionServlet.process(ActionServlet.java:1482)
at org.apache.struts.action.ActionServlet.doPost(ActionServlet.java:525)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:709)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:237)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:157)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:214)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:825)
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.processConnection(Http11Protocol.java:731)
at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:526)
at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:80)
at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:684)
at java.lang.Thread.run(Thread.java:595)
Caused by: java.lang.NullPointerException
at com.mysql.jdbc.Messages.getString(Messages.java:70)
at com.mysql.jdbc.Util.stackTraceToString(Util.java:118)
at com.mysql.jdbc.Messages.<clinit>(Messages.java:50)
... 36 more
Name and version of the database you are using:
MySQL 4.1.8-nt
The generated SQL (show_sql=true):
Hibernate: select group0_.GROUP_ID as GROUP_ID0_, group0_.GROUP_NAME as GROUP_NAME0_, group0_.GROUP_DESC as GROUP_DESC0_ from GROUPYO group0_ where group0_.GROUP_ID=?
Hibernate: select groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, user1_.USER_ID as USER_ID0_, user1_.USER_NAME as USER_NAME0_ from USER_GROUP groupusers0_ left outer join USER user1_ on groupusers0_.USER_ID=user1_.USER_ID where groupusers0_.GROUP_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: select user0_.USER_ID as USER_ID, user0_.USER_NAME as USER_NAME from USER user0_
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, user1_.USER_ID as USER_ID0_, user1_.USER_NAME as USER_NAME0_ from USER_GROUP groupusers0_ left outer join USER user1_ on groupusers0_.USER_ID=user1_.USER_ID where groupusers0_.GROUP_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: select group0_.GROUP_ID as GROUP_ID0_, group0_.GROUP_NAME as GROUP_NAME0_, group0_.GROUP_DESC as GROUP_DESC0_ from GROUPYO group0_ where group0_.GROUP_ID=?
Hibernate: select groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, user1_.USER_ID as USER_ID0_, user1_.USER_NAME as USER_NAME0_ from USER_GROUP groupusers0_ left outer join USER user1_ on groupusers0_.USER_ID=user1_.USER_ID where groupusers0_.GROUP_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupuser0_.GROUP_ID as GROUP_ID2_, groupuser0_.USER_ID as USER_ID2_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_, user2_.USER_ID as USER_ID1_, user2_.USER_NAME as USER_NAME1_ from USER_GROUP groupuser0_ left outer join GROUPYO group1_ on groupuser0_.GROUP_ID=group1_.GROUP_ID left outer join USER user2_ on groupuser0_.USER_ID=user2_.USER_ID where groupuser0_.GROUP_ID=? and groupuser0_.USER_ID=?
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, user1_.USER_ID as USER_ID0_, user1_.USER_NAME as USER_NAME0_ from USER_GROUP groupusers0_ left outer join USER user1_ on groupusers0_.USER_ID=user1_.USER_ID where groupusers0_.GROUP_ID=? order by groupusers0_.STATUS_ID
Hibernate: select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
Hibernate: update USER_GROUP set GROUP_ID=null where GROUP_ID=? and GROUP_ID=? and USER_ID=?
Debug level Hibernate log excerpt:
17:06:36,835 DEBUG SessionImpl:560 - opened session
17:06:36,835 DEBUG JDBCTransaction:37 - begin
17:06:36,835 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0
17:06:36,835 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0
17:06:36,835 DEBUG JDBCTransaction:41 - current autocommit status:false
17:06:36,835 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:36,835 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:36,850 DEBUG SessionImpl:2130 - object not resolved in any cache [com.talisen.workflow.hibernate.Group#1]
17:06:36,866 DEBUG EntityPersister:410 - Materializing entity: [com.talisen.workflow.hibernate.Group#1]
17:06:36,866 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:36,866 DEBUG SQL:230 - select group0_.GROUP_ID as GROUP_ID0_, group0_.GROUP_NAME as GROUP_NAME0_, group0_.GROUP_DESC as GROUP_DESC0_ from GROUPYO group0_ where group0_.GROUP_ID=?
17:06:36,866 DEBUG BatcherImpl:253 - preparing statement
17:06:36,866 DEBUG Loader:281 - processing result set
17:06:36,866 DEBUG Loader:484 - result row: 1
17:06:36,866 DEBUG Loader:615 - Initializing object from ResultSet: 1
17:06:36,866 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.Group#1
17:06:36,866 DEBUG Loader:298 - done processing result set (1 rows)
17:06:36,866 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:36,866 DEBUG BatcherImpl:275 - closing statement
17:06:36,866 DEBUG Loader:318 - total objects hydrated: 1
17:06:36,866 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.Group#1]
17:06:36,882 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:36,882 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.Group#1]
17:06:36,882 DEBUG SessionImpl:3161 - initializing non-lazy collections
17:06:36,882 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:36,882 DEBUG SessionImpl:3308 - checking second-level cache
17:06:36,882 DEBUG SessionImpl:3314 - collection not cached
17:06:36,882 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:36,882 DEBUG SQL:230 - select groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, user1_.USER_ID as USER_ID0_, user1_.USER_NAME as USER_NAME0_ from USER_GROUP groupusers0_ left outer join USER user1_ on groupusers0_.USER_ID=user1_.USER_ID where groupusers0_.GROUP_ID=? order by groupusers0_.STATUS_ID
17:06:36,882 DEBUG BatcherImpl:253 - preparing statement
17:06:36,882 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:36,882 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:36,882 DEBUG Loader:281 - processing result set
17:06:36,897 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:36,897 DEBUG Loader:615 - Initializing object from ResultSet: 1
17:06:36,897 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.User#1
17:06:36,897 DEBUG Loader:615 - Initializing object from ResultSet: com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:36,897 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:36,897 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:36,897 DEBUG SessionImpl:3073 - reading row
17:06:36,897 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:36,897 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:36,897 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:36,897 DEBUG Loader:484 - result row: 2, com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:36,897 DEBUG Loader:615 - Initializing object from ResultSet: 2
17:06:36,913 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.User#2
17:06:36,913 DEBUG Loader:615 - Initializing object from ResultSet: com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:36,913 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:36,913 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:36,913 DEBUG SessionImpl:3073 - reading row
17:06:36,913 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,913 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,913 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,913 DEBUG Loader:298 - done processing result set (2 rows)
17:06:36,913 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:36,913 DEBUG BatcherImpl:275 - closing statement
17:06:36,913 DEBUG Loader:318 - total objects hydrated: 4
17:06:36,913 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.User#1]
17:06:36,929 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:36,929 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.User#1]
17:06:36,929 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:36,929 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:36,929 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:36,929 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.Group#1]
17:06:36,929 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.User#1]
17:06:36,929 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.User#1]
17:06:36,944 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.User#1]
17:06:36,944 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:36,944 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.User#2]
17:06:36,944 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:36,944 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.User#2]
17:06:36,944 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,944 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:36,944 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:36,944 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.Group#1]
17:06:36,944 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.User#2]
17:06:36,944 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.User#2]
17:06:36,944 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.User#2]
17:06:36,944 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,960 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:36,960 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:36,960 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:36,960 DEBUG SessionImpl:3316 - collection initialized
17:06:36,960 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:36,960 DEBUG SessionImpl:3308 - checking second-level cache
17:06:36,960 DEBUG SessionImpl:3314 - collection not cached
17:06:36,960 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:36,960 DEBUG SQL:230 - select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
17:06:36,960 DEBUG BatcherImpl:253 - preparing statement
17:06:36,960 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:36,960 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:36,975 DEBUG Loader:281 - processing result set
17:06:36,975 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:36,975 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:36,975 DEBUG SessionImpl:3073 - reading row
17:06:36,975 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,975 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,975 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:36,975 DEBUG Loader:298 - done processing result set (1 rows)
17:06:36,975 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:36,991 DEBUG BatcherImpl:275 - closing statement
17:06:36,991 DEBUG Loader:318 - total objects hydrated: 0
17:06:36,991 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:36,991 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:36,991 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:36,991 DEBUG SessionImpl:3316 - collection initialized
17:06:36,991 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:36,991 DEBUG SessionImpl:3308 - checking second-level cache
17:06:36,991 DEBUG SessionImpl:3314 - collection not cached
17:06:36,991 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:36,991 DEBUG SQL:230 - select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
17:06:36,991 DEBUG BatcherImpl:253 - preparing statement
17:06:37,007 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,007 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:37,007 DEBUG Loader:281 - processing result set
17:06:37,007 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,007 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,007 DEBUG SessionImpl:3073 - reading row
17:06:37,007 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,007 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,007 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,007 DEBUG Loader:298 - done processing result set (1 rows)
17:06:37,007 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,007 DEBUG BatcherImpl:275 - closing statement
17:06:37,022 DEBUG Loader:318 - total objects hydrated: 0
17:06:37,022 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:37,022 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,022 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:37,022 DEBUG SessionImpl:3316 - collection initialized
17:06:37,022 DEBUG JDBCTransaction:59 - commit
17:06:37,022 DEBUG SessionImpl:2267 - flushing session
17:06:37,022 DEBUG SessionImpl:2467 - Flushing entities and processing referenced collections
17:06:37,022 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.Group.groupUsers#1], was: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,022 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.User.groupUsers#1], was: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,022 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.User.groupUsers#2], was: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,022 DEBUG SessionImpl:2808 - Processing unreferenced collections
17:06:37,022 DEBUG SessionImpl:2822 - Scheduling collection removes/(re)creates/updates
17:06:37,022 DEBUG SessionImpl:2291 - Flushed: 0 insertions, 0 updates, 0 deletions to 5 objects
17:06:37,038 DEBUG SessionImpl:2296 - Flushed: 0 (re)creations, 0 updates, 0 removals to 3 collections
17:06:37,038 DEBUG Printer:75 - listing entities:
17:06:37,038 DEBUG Printer:82 - com.talisen.workflow.hibernate.User{userName=Joe Schminsky, userId=1, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=1}]}
17:06:37,038 DEBUG Printer:82 - com.talisen.workflow.hibernate.GroupUser{user=User#1, group=Group#1, groupUserKey=GroupUser$Id{groupId=1, userId=1}}
17:06:37,038 DEBUG Printer:82 - com.talisen.workflow.hibernate.GroupUser{user=User#2, group=Group#1, groupUserKey=GroupUser$Id{groupId=1, userId=2}}
17:06:37,038 DEBUG Printer:82 - com.talisen.workflow.hibernate.User{userName=Alex Turo, userId=2, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=2}]}
17:06:37,038 DEBUG Printer:82 - com.talisen.workflow.hibernate.Group{groupId=1, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=1}, GroupUser#GroupUser$Id{groupId=1, userId=2}], groupDesc=A group that contains users that belong to th, groupName=Design Engineering}
17:06:37,038 DEBUG SessionImpl:2380 - executing flush
17:06:37,038 DEBUG SessionImpl:2852 - post flush
17:06:37,054 DEBUG SessionImpl:596 - transaction completion
17:06:37,054 DEBUG SessionImpl:578 - closing session
17:06:37,054 DEBUG SessionImpl:3383 - disconnecting session
17:06:37,054 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1
17:06:37,054 DEBUG SessionImpl:596 - transaction completion
17:06:37,054 DEBUG SessionImpl:560 - opened session
17:06:37,054 DEBUG JDBCTransaction:37 - begin
17:06:37,054 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0
17:06:37,054 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0
17:06:37,054 DEBUG JDBCTransaction:41 - current autocommit status:false
17:06:37,054 DEBUG SessionImpl:1537 - find: from User
17:06:37,054 DEBUG SessionImpl:2267 - flushing session
17:06:37,054 DEBUG SessionImpl:2467 - Flushing entities and processing referenced collections
17:06:37,054 DEBUG SessionImpl:2808 - Processing unreferenced collections
17:06:37,054 DEBUG SessionImpl:2822 - Scheduling collection removes/(re)creates/updates
17:06:37,069 DEBUG SessionImpl:2291 - Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
17:06:37,069 DEBUG SessionImpl:2296 - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
17:06:37,069 DEBUG SessionImpl:1828 - Dont need to execute flush
17:06:37,069 DEBUG QueryTranslator:207 - HQL: from com.talisen.workflow.hibernate.User
17:06:37,069 DEBUG QueryTranslator:208 - SQL: select user0_.USER_ID as USER_ID, user0_.USER_NAME as USER_NAME from USER user0_
17:06:37,069 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,069 DEBUG SQL:230 - select user0_.USER_ID as USER_ID, user0_.USER_NAME as USER_NAME from USER user0_
17:06:37,069 DEBUG BatcherImpl:253 - preparing statement
17:06:37,069 DEBUG Loader:281 - processing result set
17:06:37,069 DEBUG Loader:484 - result row: 1
17:06:37,069 DEBUG Loader:615 - Initializing object from ResultSet: 1
17:06:37,085 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.User#1
17:06:37,085 DEBUG Loader:484 - result row: 2
17:06:37,085 DEBUG Loader:615 - Initializing object from ResultSet: 2
17:06:37,085 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.User#2
17:06:37,085 DEBUG Loader:298 - done processing result set (2 rows)
17:06:37,085 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,085 DEBUG BatcherImpl:275 - closing statement
17:06:37,085 DEBUG Loader:318 - total objects hydrated: 2
17:06:37,085 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.User#1]
17:06:37,085 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,085 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.User#1]
17:06:37,085 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.User#2]
17:06:37,085 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,085 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.User#2]
17:06:37,085 DEBUG SessionImpl:3161 - initializing non-lazy collections
17:06:37,085 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,100 DEBUG SessionImpl:3308 - checking second-level cache
17:06:37,100 DEBUG SessionImpl:3314 - collection not cached
17:06:37,100 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,100 DEBUG SQL:230 - select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
17:06:37,100 DEBUG BatcherImpl:253 - preparing statement
17:06:37,100 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,100 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:37,100 DEBUG Loader:281 - processing result set
17:06:37,100 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,100 DEBUG Loader:615 - Initializing object from ResultSet: 1
17:06:37,100 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.Group#1
17:06:37,116 DEBUG Loader:615 - Initializing object from ResultSet: com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,116 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,116 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,116 DEBUG SessionImpl:3073 - reading row
17:06:37,116 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,116 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,116 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,116 DEBUG Loader:298 - done processing result set (1 rows)
17:06:37,116 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,116 DEBUG BatcherImpl:275 - closing statement
17:06:37,116 DEBUG Loader:318 - total objects hydrated: 2
17:06:37,116 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.Group#1]
17:06:37,116 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,132 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.Group#1]
17:06:37,132 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,132 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:37,132 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:37,132 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.Group#1]
17:06:37,132 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.User#2]
17:06:37,132 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.User#2]
17:06:37,132 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.User#2]
17:06:37,132 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,132 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:37,132 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,147 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:37,147 DEBUG SessionImpl:3316 - collection initialized
17:06:37,147 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,147 DEBUG SessionImpl:3308 - checking second-level cache
17:06:37,147 DEBUG SessionImpl:3314 - collection not cached
17:06:37,147 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,147 DEBUG SQL:230 - select groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, user1_.USER_ID as USER_ID0_, user1_.USER_NAME as USER_NAME0_ from USER_GROUP groupusers0_ left outer join USER user1_ on groupusers0_.USER_ID=user1_.USER_ID where groupusers0_.GROUP_ID=? order by groupusers0_.STATUS_ID
17:06:37,147 DEBUG BatcherImpl:253 - preparing statement
17:06:37,147 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,163 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:37,163 DEBUG Loader:281 - processing result set
17:06:37,163 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,163 DEBUG Loader:615 - Initializing object from ResultSet: com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,163 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,163 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,163 DEBUG SessionImpl:3073 - reading row
17:06:37,163 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,163 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,179 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,179 DEBUG Loader:484 - result row: 2, com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,179 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,179 DEBUG SessionImpl:3073 - reading row
17:06:37,179 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,179 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,179 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,179 DEBUG Loader:298 - done processing result set (2 rows)
17:06:37,179 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,179 DEBUG BatcherImpl:275 - closing statement
17:06:37,179 DEBUG Loader:318 - total objects hydrated: 1
17:06:37,179 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,179 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:37,194 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:37,194 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.Group#1]
17:06:37,194 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.User#1]
17:06:37,194 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.User#1]
17:06:37,194 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.User#1]
17:06:37,194 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,194 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:37,194 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,194 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:37,194 DEBUG SessionImpl:3316 - collection initialized
17:06:37,194 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,194 DEBUG SessionImpl:3308 - checking second-level cache
17:06:37,194 DEBUG SessionImpl:3314 - collection not cached
17:06:37,194 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,210 DEBUG SQL:230 - select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
17:06:37,210 DEBUG BatcherImpl:253 - preparing statement
17:06:37,210 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,210 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:37,210 DEBUG Loader:281 - processing result set
17:06:37,210 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,210 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,210 DEBUG SessionImpl:3073 - reading row
17:06:37,210 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,210 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,225 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,225 DEBUG Loader:298 - done processing result set (1 rows)
17:06:37,225 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,225 DEBUG BatcherImpl:275 - closing statement
17:06:37,225 DEBUG Loader:318 - total objects hydrated: 0
17:06:37,225 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:37,225 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,225 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:37,225 DEBUG SessionImpl:3316 - collection initialized
17:06:37,225 DEBUG JDBCTransaction:59 - commit
17:06:37,225 DEBUG SessionImpl:2267 - flushing session
17:06:37,225 DEBUG SessionImpl:2467 - Flushing entities and processing referenced collections
17:06:37,225 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.User.groupUsers#1], was: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,225 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.User.groupUsers#2], was: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,225 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.Group.groupUsers#1], was: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,225 DEBUG SessionImpl:2808 - Processing unreferenced collections
17:06:37,225 DEBUG SessionImpl:2822 - Scheduling collection removes/(re)creates/updates
17:06:37,241 DEBUG SessionImpl:2291 - Flushed: 0 insertions, 0 updates, 0 deletions to 5 objects
17:06:37,241 DEBUG SessionImpl:2296 - Flushed: 0 (re)creations, 0 updates, 0 removals to 3 collections
17:06:37,241 DEBUG Printer:75 - listing entities:
17:06:37,241 DEBUG Printer:82 - com.talisen.workflow.hibernate.User{userName=Joe Schminsky, userId=1, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=1}]}
17:06:37,241 DEBUG Printer:82 - com.talisen.workflow.hibernate.GroupUser{user=User#1, group=Group#1, groupUserKey=GroupUser$Id{groupId=1, userId=1}}
17:06:37,241 DEBUG Printer:82 - com.talisen.workflow.hibernate.GroupUser{user=User#2, group=Group#1, groupUserKey=GroupUser$Id{groupId=1, userId=2}}
17:06:37,241 DEBUG Printer:82 - com.talisen.workflow.hibernate.User{userName=Alex Turo, userId=2, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=2}]}
17:06:37,257 DEBUG Printer:82 - com.talisen.workflow.hibernate.Group{groupId=1, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=1}, GroupUser#GroupUser$Id{groupId=1, userId=2}], groupDesc=A group that contains users that belong to th, groupName=Design Engineering}
17:06:37,257 DEBUG SessionImpl:2380 - executing flush
17:06:37,257 DEBUG SessionImpl:2852 - post flush
17:06:37,257 DEBUG SessionImpl:596 - transaction completion
17:06:37,257 DEBUG SessionImpl:578 - closing session
17:06:37,257 DEBUG SessionImpl:3383 - disconnecting session
17:06:37,257 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1
17:06:37,257 DEBUG SessionImpl:596 - transaction completion
17:06:37,288 DEBUG SessionImpl:560 - opened session
17:06:37,288 DEBUG JDBCTransaction:37 - begin
17:06:37,288 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0
17:06:37,288 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0
17:06:37,288 DEBUG JDBCTransaction:41 - current autocommit status:false
17:06:37,288 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:37,288 DEBUG SessionImpl:3435 - running Session.finalize()
17:06:37,288 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:37,288 DEBUG SessionImpl:2130 - object not resolved in any cache [com.talisen.workflow.hibernate.Group#1]
17:06:37,288 DEBUG EntityPersister:410 - Materializing entity: [com.talisen.workflow.hibernate.Group#1]
17:06:37,288 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,288 DEBUG SQL:230 - select group0_.GROUP_ID as GROUP_ID0_, group0_.GROUP_NAME as GROUP_NAME0_, group0_.GROUP_DESC as GROUP_DESC0_ from GROUPYO group0_ where group0_.GROUP_ID=?
17:06:37,288 DEBUG BatcherImpl:253 - preparing statement
17:06:37,304 DEBUG Loader:281 - processing result set
17:06:37,304 DEBUG Loader:484 - result row: 1
17:06:37,304 DEBUG Loader:615 - Initializing object from ResultSet: 1
17:06:37,319 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.Group#1
17:06:37,319 DEBUG Loader:298 - done processing result set (1 rows)
17:06:37,319 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,319 DEBUG BatcherImpl:275 - closing statement
17:06:37,319 DEBUG Loader:318 - total objects hydrated: 1
17:06:37,319 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.Group#1]
17:06:37,319 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,319 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.Group#1]
17:06:37,319 DEBUG SessionImpl:3161 - initializing non-lazy collections
17:06:37,319 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,319 DEBUG SessionImpl:3308 - checking second-level cache
17:06:37,319 DEBUG SessionImpl:3314 - collection not cached
17:06:37,319 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,319 DEBUG SQL:230 - select groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, user1_.USER_ID as USER_ID0_, user1_.USER_NAME as USER_NAME0_ from USER_GROUP groupusers0_ left outer join USER user1_ on groupusers0_.USER_ID=user1_.USER_ID where groupusers0_.GROUP_ID=? order by groupusers0_.STATUS_ID
17:06:37,319 DEBUG BatcherImpl:253 - preparing statement
17:06:37,335 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,335 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:37,335 DEBUG Loader:281 - processing result set
17:06:37,335 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,335 DEBUG Loader:615 - Initializing object from ResultSet: 1
17:06:37,335 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.User#1
17:06:37,335 DEBUG Loader:615 - Initializing object from ResultSet: com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,335 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,335 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,335 DEBUG SessionImpl:3073 - reading row
17:06:37,335 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,335 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,350 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,350 DEBUG Loader:484 - result row: 2, com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,366 DEBUG Loader:615 - Initializing object from ResultSet: 2
17:06:37,366 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.User#2
17:06:37,366 DEBUG Loader:615 - Initializing object from ResultSet: com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,366 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,366 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,366 DEBUG SessionImpl:3073 - reading row
17:06:37,366 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,366 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,366 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,366 DEBUG Loader:298 - done processing result set (2 rows)
17:06:37,366 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,366 DEBUG BatcherImpl:275 - closing statement
17:06:37,366 DEBUG Loader:318 - total objects hydrated: 4
17:06:37,382 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.User#1]
17:06:37,382 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,382 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.User#1]
17:06:37,382 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,382 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:37,382 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:37,382 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.Group#1]
17:06:37,382 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.User#1]
17:06:37,382 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.User#1]
17:06:37,382 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.User#1]
17:06:37,382 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,382 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.User#2]
17:06:37,382 DEBUG SessionImpl:3994 - creating collection wrapper:[com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,382 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.User#2]
17:06:37,382 DEBUG SessionImpl:2216 - resolving associations for [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,397 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.Group#1]
17:06:37,397 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.Group#1]
17:06:37,397 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.Group#1]
17:06:37,397 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.User#2]
17:06:37,397 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.User#2]
17:06:37,397 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.User#2]
17:06:37,397 DEBUG SessionImpl:2247 - done materializing entity [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,397 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:37,397 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,397 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:37,397 DEBUG SessionImpl:3316 - collection initialized
17:06:37,397 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,397 DEBUG SessionImpl:3308 - checking second-level cache
17:06:37,413 DEBUG SessionImpl:3314 - collection not cached
17:06:37,413 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,413 DEBUG SQL:230 - select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
17:06:37,413 DEBUG BatcherImpl:253 - preparing statement
17:06:37,413 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,413 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:37,413 DEBUG Loader:281 - processing result set
17:06:37,413 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,413 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,413 DEBUG SessionImpl:3073 - reading row
17:06:37,413 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,413 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,429 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,429 DEBUG Loader:298 - done processing result set (1 rows)
17:06:37,429 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,429 DEBUG BatcherImpl:275 - closing statement
17:06:37,429 DEBUG Loader:318 - total objects hydrated: 0
17:06:37,429 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:37,429 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,429 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:37,429 DEBUG SessionImpl:3316 - collection initialized
17:06:37,429 DEBUG SessionImpl:3307 - initializing collection [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,429 DEBUG SessionImpl:3308 - checking second-level cache
17:06:37,429 DEBUG SessionImpl:3314 - collection not cached
17:06:37,429 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,429 DEBUG SQL:230 - select groupusers0_.USER_ID as USER_ID__, groupusers0_.GROUP_ID as GROUP_ID__, groupusers0_.GROUP_ID as GROUP_ID1_, groupusers0_.USER_ID as USER_ID1_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_ from USER_GROUP groupusers0_ left outer join GROUPYO group1_ on groupusers0_.GROUP_ID=group1_.GROUP_ID where groupusers0_.USER_ID=? order by groupusers0_.STATUS_ID
17:06:37,444 DEBUG BatcherImpl:253 - preparing statement
17:06:37,444 DEBUG Loader:406 - result set contains (possibly empty) collection: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,444 DEBUG SessionImpl:3050 - uninitialized collection: initializing
17:06:37,444 DEBUG Loader:281 - processing result set
17:06:37,444 DEBUG Loader:484 - result row: 1, com.talisen.workflow.hibernate.GroupUser$Id@2
17:06:37,444 DEBUG Loader:371 - found row of collection: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,460 DEBUG SessionImpl:3073 - reading row
17:06:37,460 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,460 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,460 DEBUG SessionImpl:2110 - resolved object in session cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@2]
17:06:37,460 DEBUG Loader:298 - done processing result set (1 rows)
17:06:37,460 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:06:37,475 DEBUG BatcherImpl:275 - closing statement
17:06:37,475 DEBUG Loader:318 - total objects hydrated: 0
17:06:37,475 DEBUG SessionImpl:3109 - 1 collections were found in result set
17:06:37,475 DEBUG SessionImpl:3140 - collection fully initialized: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,475 DEBUG SessionImpl:3143 - 1 collections initialized
17:06:37,475 DEBUG SessionImpl:3316 - collection initialized
17:06:37,475 DEBUG JDBCTransaction:59 - commit
17:06:37,475 DEBUG SessionImpl:2267 - flushing session
17:06:37,475 DEBUG SessionImpl:2467 - Flushing entities and processing referenced collections
17:06:37,475 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.Group.groupUsers#1], was: [com.talisen.workflow.hibernate.Group.groupUsers#1]
17:06:37,475 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.User.groupUsers#1], was: [com.talisen.workflow.hibernate.User.groupUsers#1]
17:06:37,475 DEBUG SessionImpl:2916 - Collection found: [com.talisen.workflow.hibernate.User.groupUsers#2], was: [com.talisen.workflow.hibernate.User.groupUsers#2]
17:06:37,475 DEBUG SessionImpl:2808 - Processing unreferenced collections
17:06:37,475 DEBUG SessionImpl:2822 - Scheduling collection removes/(re)creates/updates
17:06:37,475 DEBUG SessionImpl:2291 - Flushed: 0 insertions, 0 updates, 0 deletions to 5 objects
17:06:37,475 DEBUG SessionImpl:2296 - Flushed: 0 (re)creations, 0 updates, 0 removals to 3 collections
17:06:37,475 DEBUG Printer:75 - listing entities:
17:06:37,475 DEBUG Printer:82 - com.talisen.workflow.hibernate.User{userName=Joe Schminsky, userId=1, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=1}]}
17:06:37,475 DEBUG Printer:82 - com.talisen.workflow.hibernate.GroupUser{user=User#1, group=Group#1, groupUserKey=GroupUser$Id{groupId=1, userId=1}}
17:06:37,475 DEBUG Printer:82 - com.talisen.workflow.hibernate.GroupUser{user=User#2, group=Group#1, groupUserKey=GroupUser$Id{groupId=1, userId=2}}
17:06:37,475 DEBUG Printer:82 - com.talisen.workflow.hibernate.User{userName=Alex Turo, userId=2, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=2}]}
17:06:37,475 DEBUG Printer:82 - com.talisen.workflow.hibernate.Group{groupId=1, groupUsers=[GroupUser#GroupUser$Id{groupId=1, userId=1}, GroupUser#GroupUser$Id{groupId=1, userId=2}], groupDesc=A group that contains users that belong to th, groupName=Design Engineering}
17:06:37,491 DEBUG SessionImpl:2380 - executing flush
17:06:37,491 DEBUG SessionImpl:2852 - post flush
17:06:37,491 DEBUG SessionImpl:596 - transaction completion
17:06:37,491 DEBUG SessionImpl:578 - closing session
17:06:37,491 DEBUG SessionImpl:3383 - disconnecting session
17:06:37,491 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1
17:06:37,491 DEBUG SessionImpl:596 - transaction completion
17:06:37,491 DEBUG SessionImpl:560 - opened session
17:06:37,491 DEBUG JDBCTransaction:37 - begin
17:06:37,491 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0
17:06:37,491 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0
17:06:37,491 DEBUG JDBCTransaction:41 - current autocommit status:false
17:06:37,491 DEBUG SessionImpl:1996 - loading [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,491 DEBUG SessionImpl:2094 - attempting to resolve [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,491 DEBUG SessionImpl:2130 - object not resolved in any cache [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,491 DEBUG EntityPersister:410 - Materializing entity: [com.talisen.workflow.hibernate.GroupUser#com.talisen.workflow.hibernate.GroupUser$Id@3]
17:06:37,491 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:06:37,491 DEBUG SQL:230 - select groupuser0_.GROUP_ID as GROUP_ID2_, groupuser0_.USER_ID as USER_ID2_, group1_.GROUP_ID as GROUP_ID0_, group1_.GROUP_NAME as GROUP_NAME0_, group1_.GROUP_DESC as GROUP_DESC0_, user2_.USER_ID as USER_ID1_, user2_.USER_NAME as USER_NAME1_ from USER_GROUP groupuser0_ left outer join GROUPYO group1_ on groupuser0_.GROUP_ID=group1_.GROUP_ID left outer join USER user2_ on groupuser0_.USER_ID=user2_.USER_ID where groupuser0_.GROUP_ID=? and groupuser0_.USER_ID=?
17:06:37,491 DEBUG BatcherImpl:253 - preparing statement
17:06:37,507 DEBUG Loader:281 - processing result set
17:06:37,507 DEBUG Loader:484 - result row: 1, 2, com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,507 DEBUG Loader:615 - Initializing object from ResultSet: 1
17:06:37,507 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.Group#1
17:06:37,507 DEBUG Loader:615 - Initializing object from ResultSet: 2
17:06:37,507 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.User#2
17:06:37,507 DEBUG Loader:615 - Initializing object from ResultSet: com.talisen.workflow.hibernate.GroupUser$Id@3
17:06:37,507 DEBUG Loader:684 - Hydrating entity: com.talisen.workflow.hibernate.GroupUser#com.talisen.work
Login
FAQ
Search
