Getting GenericJDBCException: could not initialize a collection:
This should be fairly straight forward so I must be doing something wrong!
Hibernate version: 3.0.5
Mapping documents:
associate.hbm.xml
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 3.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd">
<hibernate-mapping>
<class name="Associate" table="associate">
<id name="id" column="associate_id">
<generator class="increment"/>
</id>
<property name="associateName" type="string" column="associate_name" />
<set name="partyGroups" table="assoc_party_group_xref" lazy="false" inverse="true">
<key column="associate_id"/>
<many-to-many column="party_group_id" class="PartyGroup" />
</set>
</class>
</hibernate-mapping>
partygroup.hbm.xml
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
"-//Hibernate/Hibernate Mapping DTD 3.0//EN"
"http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd">
<hibernate-mapping>
<class name="PartyGroup" table="party_group">
<id name="id" column="party_group_id">
<generator class="increment"/>
</id>
<property name="partyGroupName" type="string" column="party_group_name"/>
</class>
</hibernate-mapping>
Code between sessionFactory.openSession() and session.close():
import org.hibernate.Transaction;
import org.hibernate.Session;
import java.util.Date;
import java.util.List;
public class POSManager {
public static void main(String[] args) {
POSManager mgr = new POSManager();
if (args[0].equals("store-location")) {
mgr.createAndStoreLocation("My Location");
}
else if (args[0].equals("list-locations")) {
List locs = mgr.listLocations();
for (int i = 0; i < locs.size(); i++) {
Location theLoc = (Location) locs.get(i);
System.out.println("Location: " + theLoc.getLocationName() +
" ID: " + theLoc.getId());
}
}
else if (args[0].equals("list-associates")) {
List locs = mgr.listAssociates();
for (int i = 0; i < locs.size(); i++) {
Associate entry = (Associate) locs.get(i);
System.out.println("Associate: " + entry.getAssociateName() +
" ID: " + entry.getId() +
" PartyGroups : " + entry.getPartyGroups());
}
}
else if (args[0].equals("list-partygroups")) {
List locs = mgr.listPartyGroups();
for (int i = 0; i < locs.size(); i++) {
PartyGroup entry = (PartyGroup) locs.get(i);
System.out.println("PartyGroup: " + entry.getPartyGroupName() +
" ID: " + entry.getId());
}
}
HibernateUtil.sessionFactory.close();
}
private void createAndStoreLocation(String title) {
Session session = HibernateUtil.currentSession();
Transaction tx = session.beginTransaction();
Location theLocation = new Location();
theLocation.setLocationName(title);
session.save(theLocation);
tx.commit();
HibernateUtil.closeSession();
}
private List listLocations() {
Session session = HibernateUtil.currentSession();
Transaction tx = session.beginTransaction();
List result = session.createQuery("from Location").list();
tx.commit();
session.close();
return result;
}
private List listAssociates() {
Session session = HibernateUtil.currentSession();
Transaction tx = session.beginTransaction();
List result = session.createQuery("from Associate").list();
tx.commit();
session.close();
return result;
}
private List listPartyGroups() {
Session session = HibernateUtil.currentSession();
Transaction tx = session.beginTransaction();
List result = session.createQuery("from PartyGroup").list();
tx.commit();
session.close();
return result;
}
}
Full stack trace of any exception that occurs:
run2:
[java] 21:28:22,531 INFO Environment:464 - Hibernate 3.0.5
[java] 21:28:22,531 INFO Environment:477 - hibernate.properties not found
[java] 21:28:22,546 INFO Environment:510 - using CGLIB reflection optimizer
[java] 21:28:22,546 INFO Environment:540 - using JDK 1.4 java.sql.Timestamp handling
[java] 21:28:22,656 INFO Configuration:1110 - configuring from resource: /hibernate.cfg.xml
[java] 21:28:22,656 INFO Configuration:1081 - Configuration resource: /hibernate.cfg.xml
[java] 21:28:23,062 DEBUG DTDEntityResolver:42 - trying to locate
http://hibernate.sourceforge.net/hibernate-config
uration-3.0.dtd in classpath under org/hibernate/
[java] 21:28:23,062 DEBUG DTDEntityResolver:53 - found
http://hibernate.sourceforge.net/hibern ... ration-3.0
.dtd in classpath
[java] 21:28:23,125 DEBUG Configuration:1067 - hibernate.connection.url=jdbc:mysql://127.0.0.1:3306/test
[java] 21:28:23,125 DEBUG Configuration:1067 - hibernate.connection.driver_class=com.mysql.jdbc.Driver
[java] 21:28:23,125 DEBUG Configuration:1067 - hibernate.connection.username=root
[java] 21:28:23,125 DEBUG Configuration:1067 - hibernate.connection.password=mikemil
[java] 21:28:23,140 DEBUG Configuration:1067 - dialect=org.hibernate.dialect.MySQLDialect
[java] 21:28:23,140 DEBUG Configuration:1067 - hibernate.transaction.factory_class=org.hibernate.transaction.JDBCTr
ansactionFactory
[java] 21:28:23,140 DEBUG Configuration:1067 - connection.pool_size=1
[java] 21:28:23,140 DEBUG Configuration:1067 - show_sql=true
[java] 21:28:23,140 DEBUG Configuration:1262 - null<-org.dom4j.tree.DefaultAttribute@a761fe [Attribute: name resour
ce value "Associate.hbm.xml"]
[java] 21:28:23,140 INFO Configuration:444 - Mapping resource: Associate.hbm.xml
[java] 21:28:23,156 DEBUG DTDEntityResolver:42 - trying to locate
http://hibernate.sourceforge.net/hibernate-mappin
g-3.0.dtd in classpath under org/hibernate/
[java] 21:28:23,156 DEBUG DTDEntityResolver:53 - found
http://hibernate.sourceforge.net/hibern ... ng-3.0.dtd i
n classpath
[java] 21:28:23,578 INFO HbmBinder:260 - Mapping class: Associate -> associate
[java] 21:28:23,609 DEBUG HbmBinder:1099 - Mapped property: id -> associate_id
[java] 21:28:23,625 DEBUG HbmBinder:1099 - Mapped property: associateName -> associate_name
[java] 21:28:23,640 INFO HbmBinder:1218 - Mapping collection: Associate.partyGroups -> assoc_party_group_xref
[java] 21:28:23,640 DEBUG HbmBinder:1099 - Mapped property: partyGroups
[java] 21:28:23,640 DEBUG Configuration:1262 - null<-org.dom4j.tree.DefaultAttribute@1016632 [Attribute: name resou
rce value "Location.hbm.xml"]
[java] 21:28:23,734 INFO Configuration:444 - Mapping resource: Location.hbm.xml
[java] 21:28:23,734 DEBUG DTDEntityResolver:42 - trying to locate
http://hibernate.sourceforge.net/hibernate-mappin
g-3.0.dtd in classpath under org/hibernate/
[java] 21:28:23,750 DEBUG DTDEntityResolver:53 - found
http://hibernate.sourceforge.net/hibern ... ng-3.0.dtd i
n classpath
[java] 21:28:23,890 INFO HbmBinder:260 - Mapping class: Location -> location
[java] 21:28:23,906 DEBUG HbmBinder:1099 - Mapped property: Id -> location_id
[java] 21:28:23,906 DEBUG HbmBinder:1099 - Mapped property: locationName -> location_name
[java] 21:28:23,906 DEBUG Configuration:1262 - null<-org.dom4j.tree.DefaultAttribute@1b000e7 [Attribute: name resou
rce value "PartyGroup.hbm.xml"]
[java] 21:28:23,906 INFO Configuration:444 - Mapping resource: PartyGroup.hbm.xml
[java] 21:28:23,906 DEBUG DTDEntityResolver:42 - trying to locate
http://hibernate.sourceforge.net/hibernate-mappin
g-3.0.dtd in classpath under org/hibernate/
[java] 21:28:23,906 DEBUG DTDEntityResolver:53 - found
http://hibernate.sourceforge.net/hibern ... ng-3.0.dtd i
n classpath
[java] 21:28:24,000 INFO HbmBinder:260 - Mapping class: PartyGroup -> party_group
[java] 21:28:24,015 DEBUG HbmBinder:1099 - Mapped property: id -> party_group_id
[java] 21:28:24,015 DEBUG HbmBinder:1099 - Mapped property: partyGroupName -> party_group_name
[java] 21:28:24,015 INFO Configuration:1222 - Configured SessionFactory: null
[java] 21:28:24,015 DEBUG Configuration:1223 - properties: {hibernate.connection.password=mikemil, java.runtime.nam
e=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=D:\java\jdk1.5.0\jre\bin, java.vm.version=1.5.
0-b64, hibernate.connection.username=root, java.vm.vendor=Sun Microsystems Inc., java.vendor.url=http://java.sun.com/, p
ath.separator=;, java.vm.name=Java HotSpot(TM) Server VM, file.encoding.pkg=sun.io, user.country=US, sun.os.patch.level=
Service Pack 2, java.vm.specification.name=Java Virtual Machine Specification, user.dir=D:\eclipseworkspace\workspace\hi
bernateTutorial, java.runtime.version=1.5.0-b64, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.di
rs=D:\java\jdk1.5.0\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\mike\LOCALS~1\Temp\, line.separator=
[java] , java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows XP, sun.jnu.encoding=Cp
1252, java.library.path=D:\java\jdk1.5.0\jre\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\system32;C:\WINDOWS;C:\WIND
OWS\System32\Wbem;d:\vslick\win;C:\Program Files\Microsoft SQL Server\80\Tools\Binn\;C:\Program Files\Common Files\Roxio
Shared\DLLShared;D:\mysql\MySQL Server 5.0\bin;d:\jwsdp-1.3\jwsdp-shared\bin;d:\vslick\win;d:\ant\bin;d:\ant\lib;d:\jav
a\jdk1.5.0\bin;d:\CVS, java.specification.name=Java Platform API Specification, java.class.version=49.0, hibernate.conne
ction.pool_size=1, sun.management.compiler=HotSpot Server Compiler, hibernate.transaction.factory_class=org.hibernate.tr
ansaction.JDBCTransactionFactory, os.version=5.1, user.home=C:\Documents and Settings\mike, user.timezone=America/Chicag
o, java.awt.printerjob=sun.awt.windows.WPrinterJob, file.encoding=Cp1252, java.specification.version=1.5, hibernate.conn
ection.driver_class=com.mysql.jdbc.Driver, show_sql=true, user.name=mike, java.class.path=D:\eclipseworkspace\workspace\
hibernateTutorial\bin;D:\eclipseworkspace\workspace\hibernateTutorial\lib\Tidy.jar;D:\eclipseworkspace\workspace\hiberna
teTutorial\lib\ant-1.6.3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\ant-antlr-1.6.3.jar;D:\eclipseworkspace
\workspace\hibernateTutorial\lib\ant-junit-1.6.3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\ant-launcher-1.
6.3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\ant-swing-1.6.3.jar;D:\eclipseworkspace\workspace\hibernateT
utorial\lib\antlr-2.7.5H3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\asm-attrs.jar;D:\eclipseworkspace\work
space\hibernateTutorial\lib\asm.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\c3p0-0.8.5.2.jar;D:\eclipseworks
pace\workspace\hibernateTutorial\lib\cglib-2.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\cleanimports.jar;
D:\eclipseworkspace\workspace\hibernateTutorial\lib\commons-collections-2.1.1.jar;D:\eclipseworkspace\workspace\hibernat
eTutorial\lib\commons-lang-2.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\commons-logging-1.0.4.jar;D:\ecli
pseworkspace\workspace\hibernateTutorial\lib\concurrent-1.3.2.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\co
nnector.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\dom4j-1.6.jar;D:\eclipseworkspace\workspace\hibernateTut
orial\lib\ehcache-1.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\hibernate3.jar;D:\eclipseworkspace\workspa
ce\hibernateTutorial\lib\hsqldb.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jaas.jar;D:\eclipseworkspace\wor
kspace\hibernateTutorial\lib\jacc-1_0-fr.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jaxen-1.1-beta-4.jar;D:
\eclipseworkspace\workspace\hibernateTutorial\lib\jboss-cache.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jb
oss-common.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jboss-jmx.jar;D:\eclipseworkspace\workspace\hibernate
Tutorial\lib\jboss-system.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jdbc2_0-stdext.jar;D:\eclipseworkspace
\workspace\hibernateTutorial\lib\jgroups-2.2.7.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jta.jar;D:\eclips
eworkspace\workspace\hibernateTutorial\lib\junit-3.8.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\log4j-1.2
.9.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\mysql-connector-java-3.1.1-alpha-bin.jar;D:\eclipseworkspace\
workspace\hibernateTutorial\lib\oscache-2.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\proxool-0.8.3.jar;D:
\eclipseworkspace\workspace\hibernateTutorial\lib\swarmcache-1.0rc2.jar;D:\eclipseworkspace\workspace\hibernateTutorial\
lib\velocity-1.4.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\velocity-tools-generic-1.1.jar;D:\eclipseworksp
ace\workspace\hibernateTutorial\lib\versioncheck.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\xerces-2.6.2.ja
r;D:\eclipseworkspace\workspace\hibernateTutorial\lib\xml-apis.jar, hibernate.show_sql=true, java.vm.specification.versi
on=1.0, java.home=D:\java\jdk1.5.0\jre, sun.arch.data.model=32, hibernate.dialect=org.hibernate.dialect.MySQLDialect, hi
bernate.connection.url=jdbc:mysql://127.0.0.1:3306/test, connection.pool_size=1, user.language=en, java.specification.ve
ndor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, hibernate.cglib.use_reflection_optimizer=true, java.vm
.info=mixed mode, java.version=1.5.0, java.ext.dirs=D:\java\jdk1.5.0\jre\lib\ext, sun.boot.class.path=D:\java\jdk1.5.0\j
re\lib\rt.jar;D:\java\jdk1.5.0\jre\lib\i18n.jar;D:\java\jdk1.5.0\jre\lib\sunrsasign.jar;D:\java\jdk1.5.0\jre\lib\jsse.ja
r;D:\java\jdk1.5.0\jre\lib\jce.jar;D:\java\jdk1.5.0\jre\lib\charsets.jar;D:\java\jdk1.5.0\jre\classes, java.vendor=Sun M
icrosystems Inc., file.separator=\, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.io.unicode.encodi
ng=UnicodeLittle, sun.cpu.endian=little, sun.desktop=windows, dialect=org.hibernate.dialect.MySQLDialect, sun.cpu.isalis
t=}
[java] 21:28:24,250 DEBUG Configuration:998 - Preparing to build session factory with filters : {}
[java] 21:28:24,250 INFO Configuration:875 - processing extends queue
[java] 21:28:24,265 INFO Configuration:879 - processing collection mappings
[java] 21:28:24,265 DEBUG HbmBinder:2466 - Second pass for collection: Associate.partyGroups
[java] 21:28:24,453 DEBUG HbmBinder:2482 - Mapped collection key: associate_id, element: party_group_id
[java] 21:28:24,453 INFO Configuration:888 - processing association property references
[java] 21:28:24,453 INFO Configuration:917 - processing foreign key constraints
[java] 21:28:24,625 DEBUG Configuration:964 - resolving reference to class: Associate
[java] 21:28:24,687 DEBUG Configuration:964 - resolving reference to class: PartyGroup
[java] 21:28:24,703 INFO DriverManagerConnectionProvider:41 - Using Hibernate built-in connection pool (not for pr
oduction use!)
[java] 21:28:24,703 INFO DriverManagerConnectionProvider:42 - Hibernate connection pool size: 1
[java] 21:28:24,703 INFO DriverManagerConnectionProvider:45 - autocommit mode: false
[java] 21:28:24,718 INFO DriverManagerConnectionProvider:80 - using driver: com.mysql.jdbc.Driver at URL: jdbc:mys
ql://127.0.0.1:3306/test
[java] 21:28:28,515 INFO DriverManagerConnectionProvider:83 - connection properties: {user=root, password=mikemil}
[java] 21:28:28,546 DEBUG DriverManagerConnectionProvider:93 - total checked-out connections: 0
[java] 21:28:28,546 DEBUG DriverManagerConnectionProvider:109 - opening new JDBC connection
[java] 21:28:29,593 DEBUG DriverManagerConnectionProvider:115 - created connection to: jdbc:mysql://127.0.0.1:3306/
test, Isolation Level: 4
[java] 21:28:29,593 INFO SettingsFactory:77 - RDBMS: MySQL, version: 5.0.12-beta-nt
[java] 21:28:29,593 INFO SettingsFactory:78 - JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-3.1
.1-alpha ( $Date: 2004/02/06 17:15:32 $, $Revision: 1.27.4.29 $ )
[java] 21:28:29,593 DEBUG DriverManagerConnectionProvider:129 - returning connection to pool, pool size: 1
[java] 21:28:29,640 INFO Dialect:92 - Using dialect: org.hibernate.dialect.MySQLDialect
[java] 21:28:29,640 INFO TransactionFactoryFactory:34 - Transaction strategy: org.hibernate.transaction.JDBCTransa
ctionFactory
[java] 21:28:29,656 INFO TransactionManagerLookupFactory:33 - No TransactionManagerLookup configured (in JTA envir
onment, use of read-write or transactional second-level cache is not recommended)
[java] 21:28:29,656 INFO SettingsFactory:125 - Automatic flush during beforeCompletion(): disabled
[java] 21:28:29,656 INFO SettingsFactory:129 - Automatic session close at end of transaction: disabled
[java] 21:28:30,109 INFO SettingsFactory:136 - JDBC batch size: 15
[java] 21:28:30,109 INFO SettingsFactory:139 - JDBC batch updates for versioned data: disabled
[java] 21:28:30,125 INFO SettingsFactory:144 - Scrollable result sets: enabled
[java] 21:28:30,125 DEBUG SettingsFactory:148 - Wrap result sets: disabled
[java] 21:28:30,125 INFO SettingsFactory:152 - JDBC3 getGeneratedKeys(): enabled
[java] 21:28:30,125 INFO SettingsFactory:160 - Connection release mode: null
[java] 21:28:30,125 INFO SettingsFactory:184 - Maximum outer join fetch depth: 2
[java] 21:28:30,687 INFO SettingsFactory:187 - Default batch fetch size: 1
[java] 21:28:30,687 INFO SettingsFactory:191 - Generate SQL with comments: disabled
[java] 21:28:30,687 INFO SettingsFactory:195 - Order SQL updates by primary key: disabled
[java] 21:28:30,687 INFO SettingsFactory:334 - Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
[java] 21:28:30,687 INFO ASTQueryTranslatorFactory:21 - Using ASTQueryTranslatorFactory
[java] 21:28:30,687 INFO SettingsFactory:203 - Query language substitutions: {}
[java] 21:28:30,687 INFO SettingsFactory:209 - Second-level cache: enabled
[java] 21:28:31,250 INFO SettingsFactory:213 - Query cache: disabled
[java] 21:28:31,250 INFO SettingsFactory:321 - Cache provider: org.hibernate.cache.EhCacheProvider
[java] 21:28:31,250 INFO SettingsFactory:228 - Optimize cache for minimal puts: disabled
[java] 21:28:31,250 INFO SettingsFactory:237 - Structured second-level cache entries: disabled
[java] 21:28:31,250 DEBUG SQLExceptionConverterFactory:52 - Using dialect defined converter
[java] 21:28:31,265 INFO SettingsFactory:257 - Echoing all SQL to stdout
[java] 21:28:31,265 INFO SettingsFactory:261 - Statistics: disabled
[java] 21:28:31,734 INFO SettingsFactory:265 - Deleted entity synthetic identifier rollback: disabled
[java] 21:28:31,734 INFO SettingsFactory:279 - Default entity-mode: pojo
[java] 21:28:32,000 INFO SessionFactoryImpl:152 - building session factory
[java] 21:28:32,000 DEBUG SessionFactoryImpl:161 - Session factory constructed with filter configurations : {}
[java] 21:28:32,015 DEBUG SessionFactoryImpl:164 - instantiating session factory with properties: {hibernate.connec
tion.password=mikemil, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=D:\java
\jdk1.5.0\jre\bin, java.vm.version=1.5.0-b64, hibernate.connection.username=root, java.vm.vendor=Sun Microsystems Inc.,
java.vendor.url=http://java.sun.com/, path.separator=;, java.vm.name=Java HotSpot(TM) Server VM, file.encoding.pkg=sun.i
o, user.country=US, sun.os.patch.level=Service Pack 2, java.vm.specification.name=Java Virtual Machine Specification, us
er.dir=D:\eclipseworkspace\workspace\hibernateTutorial, java.runtime.version=1.5.0-b64, java.awt.graphicsenv=sun.awt.Win
32GraphicsEnvironment, java.endorsed.dirs=D:\java\jdk1.5.0\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\mik
e\LOCALS~1\Temp\, line.separator=
[java] , java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows XP, sun.jnu.encoding=Cp
1252, java.library.path=D:\java\jdk1.5.0\jre\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\system32;C:\WINDOWS;C:\WIND
OWS\System32\Wbem;d:\vslick\win;C:\Program Files\Microsoft SQL Server\80\Tools\Binn\;C:\Program Files\Common Files\Roxio
Shared\DLLShared;D:\mysql\MySQL Server 5.0\bin;d:\jwsdp-1.3\jwsdp-shared\bin;d:\vslick\win;d:\ant\bin;d:\ant\lib;d:\jav
a\jdk1.5.0\bin;d:\CVS, java.specification.name=Java Platform API Specification, java.class.version=49.0, hibernate.conne
ction.pool_size=1, sun.management.compiler=HotSpot Server Compiler, hibernate.transaction.factory_class=org.hibernate.tr
ansaction.JDBCTransactionFactory, os.version=5.1, user.home=C:\Documents and Settings\mike, user.timezone=America/Chicag
o, java.awt.printerjob=sun.awt.windows.WPrinterJob, file.encoding=Cp1252, java.specification.version=1.5, hibernate.conn
ection.driver_class=com.mysql.jdbc.Driver, show_sql=true, user.name=mike, java.class.path=D:\eclipseworkspace\workspace\
hibernateTutorial\bin;D:\eclipseworkspace\workspace\hibernateTutorial\lib\Tidy.jar;D:\eclipseworkspace\workspace\hiberna
teTutorial\lib\ant-1.6.3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\ant-antlr-1.6.3.jar;D:\eclipseworkspace
\workspace\hibernateTutorial\lib\ant-junit-1.6.3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\ant-launcher-1.
6.3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\ant-swing-1.6.3.jar;D:\eclipseworkspace\workspace\hibernateT
utorial\lib\antlr-2.7.5H3.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\asm-attrs.jar;D:\eclipseworkspace\work
space\hibernateTutorial\lib\asm.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\c3p0-0.8.5.2.jar;D:\eclipseworks
pace\workspace\hibernateTutorial\lib\cglib-2.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\cleanimports.jar;
D:\eclipseworkspace\workspace\hibernateTutorial\lib\commons-collections-2.1.1.jar;D:\eclipseworkspace\workspace\hibernat
eTutorial\lib\commons-lang-2.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\commons-logging-1.0.4.jar;D:\ecli
pseworkspace\workspace\hibernateTutorial\lib\concurrent-1.3.2.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\co
nnector.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\dom4j-1.6.jar;D:\eclipseworkspace\workspace\hibernateTut
orial\lib\ehcache-1.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\hibernate3.jar;D:\eclipseworkspace\workspa
ce\hibernateTutorial\lib\hsqldb.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jaas.jar;D:\eclipseworkspace\wor
kspace\hibernateTutorial\lib\jacc-1_0-fr.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jaxen-1.1-beta-4.jar;D:
\eclipseworkspace\workspace\hibernateTutorial\lib\jboss-cache.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jb
oss-common.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jboss-jmx.jar;D:\eclipseworkspace\workspace\hibernate
Tutorial\lib\jboss-system.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jdbc2_0-stdext.jar;D:\eclipseworkspace
\workspace\hibernateTutorial\lib\jgroups-2.2.7.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\jta.jar;D:\eclips
eworkspace\workspace\hibernateTutorial\lib\junit-3.8.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\log4j-1.2
.9.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\mysql-connector-java-3.1.1-alpha-bin.jar;D:\eclipseworkspace\
workspace\hibernateTutorial\lib\oscache-2.1.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\proxool-0.8.3.jar;D:
\eclipseworkspace\workspace\hibernateTutorial\lib\swarmcache-1.0rc2.jar;D:\eclipseworkspace\workspace\hibernateTutorial\
lib\velocity-1.4.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\velocity-tools-generic-1.1.jar;D:\eclipseworksp
ace\workspace\hibernateTutorial\lib\versioncheck.jar;D:\eclipseworkspace\workspace\hibernateTutorial\lib\xerces-2.6.2.ja
r;D:\eclipseworkspace\workspace\hibernateTutorial\lib\xml-apis.jar, hibernate.show_sql=true, java.vm.specification.versi
on=1.0, java.home=D:\java\jdk1.5.0\jre, sun.arch.data.model=32, hibernate.dialect=org.hibernate.dialect.MySQLDialect, hi
bernate.connection.url=jdbc:mysql://127.0.0.1:3306/test, connection.pool_size=1, user.language=en, java.specification.ve
ndor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, hibernate.cglib.use_reflection_optimizer=true, java.vm
.info=mixed mode, java.version=1.5.0, java.ext.dirs=D:\java\jdk1.5.0\jre\lib\ext, sun.boot.class.path=D:\java\jdk1.5.0\j
re\lib\rt.jar;D:\java\jdk1.5.0\jre\lib\i18n.jar;D:\java\jdk1.5.0\jre\lib\sunrsasign.jar;D:\java\jdk1.5.0\jre\lib\jsse.ja
r;D:\java\jdk1.5.0\jre\lib\jce.jar;D:\java\jdk1.5.0\jre\lib\charsets.jar;D:\java\jdk1.5.0\jre\classes, java.vendor=Sun M
icrosystems Inc., file.separator=\, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.io.unicode.encodi
ng=UnicodeLittle, sun.cpu.endian=little, sun.desktop=windows, dialect=org.hibernate.dialect.MySQLDialect, sun.cpu.isalis
t=}
[java] 21:28:32,328 WARN Configurator:126 - No configuration found. Configuring ehcache from ehcache-failsafe.xml
found in the classpath: jar:file:/D:/eclipseworkspace/workspace/hibernateTutorial/lib/ehcache-1.1.jar!/ehcache-failsafe.
xml
[java] 21:28:33,031 DEBUG BasicEntityPersister:2220 - Static SQL for entity: PartyGroup
[java] 21:28:33,031 DEBUG BasicEntityPersister:2222 - Version select: select party_group_id from party_group where
party_group_id =?
[java] 21:28:33,031 DEBUG BasicEntityPersister:2223 - Snapshot select: select partygroup_.party_group_id, partygro
up_.party_group_name as party2_3_ from party_group partygroup_ where partygroup_.party_group_id=?
[java] 21:28:33,453 DEBUG BasicEntityPersister:2225 - Insert 0: insert into party_group (party_group_name, party_g
roup_id) values (?, ?)
[java] 21:28:33,453 DEBUG BasicEntityPersister:2226 - Update 0: update party_group set party_group_name=? where pa
rty_group_id=?
[java] 21:28:33,453 DEBUG BasicEntityPersister:2227 - Delete 0: delete from party_group where party_group_id=?
[java] 21:28:33,531 DEBUG BasicEntityPersister:2220 - Static SQL for entity: Associate
[java] 21:28:33,531 DEBUG BasicEntityPersister:2222 - Version select: select associate_id from associate where ass
ociate_id =?
[java] 21:28:37,406 DEBUG BasicEntityPersister:2223 - Snapshot select: select associate_.associate_id, associate_.
associate_name as associate2_0_ from associate associate_ where associate_.associate_id=?
[java] 21:28:37,406 DEBUG BasicEntityPersister:2225 - Insert 0: insert into associate (associate_name, associate_i
d) values (?, ?)
[java] 21:28:37,406 DEBUG BasicEntityPersister:2226 - Update 0: update associate set associate_name=? where associ
ate_id=?
[java] 21:28:37,421 DEBUG BasicEntityPersister:2227 - Delete 0: delete from associate where associate_id=?
[java] 21:28:38,187 DEBUG BasicEntityPersister:2220 - Static SQL for entity: Location
[java] 21:28:38,187 DEBUG BasicEntityPersister:2222 - Version select: select location_id from location where locat
ion_id =?
[java] 21:28:38,187 DEBUG BasicEntityPersister:2223 - Snapshot select: select location_.location_id, location_.loc
ation_name as location2_2_ from location location_ where location_.location_id=?
[java] 21:28:38,187 DEBUG BasicEntityPersister:2225 - Insert 0: insert into location (location_name, location_id)
values (?, ?)
[java] 21:28:38,187 DEBUG BasicEntityPersister:2226 - Update 0: update location set location_name=? where location
_id=?
[java] 21:28:38,718 DEBUG BasicEntityPersister:2227 - Delete 0: delete from location where location_id=?
[java] 21:28:38,750 DEBUG AbstractCollectionPersister:479 - Static SQL for collection: Associate.partyGroups
[java] 21:28:38,750 DEBUG AbstractCollectionPersister:480 - Row insert: insert into assoc_party_group_xref (associ
ate_id, party_group_id) values (?, ?)
[java] 21:28:38,750 DEBUG AbstractCollectionPersister:481 - Row update: update assoc_party_group_xref set party_gr
oup_id=? where associate_id=? and party_group_id=?
[java] 21:28:38,750 DEBUG AbstractCollectionPersister:482 - Row delete: delete from assoc_party_group_xref where a
ssociate_id=? and party_group_id=?
[java] 21:28:39,375 DEBUG AbstractCollectionPersister:483 - One-shot delete: delete from assoc_party_group_xref wh
ere associate_id=?
[java] 21:28:39,421 DEBUG EntityLoader:95 - Static select for entity PartyGroup: select partygroup0_.party_group_id
as party1_0_, partygroup0_.party_group_name as party2_3_0_ from party_group partygroup0_ where partygroup0_.party_group
_id=?
[java] 21:28:39,421 DEBUG EntityLoader:95 - Static select for entity PartyGroup: select partygroup0_.party_group_id
as party1_0_, partygroup0_.party_group_name as party2_3_0_ from party_group partygroup0_ where partygroup0_.party_group
_id=?
[java] 21:28:40,015 DEBUG EntityLoader:95 - Static select for entity PartyGroup: select partygroup0_.party_group_id
as party1_0_, partygroup0_.party_group_name as party2_3_0_ from party_group partygroup0_ where partygroup0_.party_group
_id=? for update
[java] 21:28:40,015 DEBUG EntityLoader:95 - Static select for entity PartyGroup: select partygroup0_.party_group_id
as party1_0_, partygroup0_.party_group_name as party2_3_0_ from party_group partygroup0_ where partygroup0_.party_group
_id=? for update
[java] 21:28:40,031 DEBUG EntityLoader:95 - Static select for entity Associate: select associate0_.associate_id as
associate1_0_, associate0_.associate_name as associate2_0_0_ from associate associate0_ where associate0_.associate_id=?
[java] 21:28:40,828 DEBUG EntityLoader:95 - Static select for entity Associate: select associate0_.associate_id as
associate1_0_, associate0_.associate_name as associate2_0_0_ from associate associate0_ where associate0_.associate_id=?
[java] 21:28:40,828 DEBUG EntityLoader:95 - Static select for entity Associate: select associate0_.associate_id as
associate1_0_, associate0_.associate_name as associate2_0_0_ from associate associate0_ where associate0_.associate_id=?
for update
[java] 21:28:40,828 DEBUG EntityLoader:95 - Static select for entity Associate: select associate0_.associate_id as
associate1_0_, associate0_.associate_name as associate2_0_0_ from associate associate0_ where associate0_.associate_id=?
for update
[java] 21:28:41,312 DEBUG EntityLoader:95 - Static select for entity Location: select location0_.location_id as loc
ation1_0_, location0_.location_name as location2_2_0_ from location location0_ where location0_.location_id=?
[java] 21:28:41,312 DEBUG EntityLoader:95 - Static select for entity Location: select location0_.location_id as loc
ation1_0_, location0_.location_name as location2_2_0_ from location location0_ where location0_.location_id=?
[java] 21:28:41,312 DEBUG EntityLoader:95 - Static select for entity Location: select location0_.location_id as loc
ation1_0_, location0_.location_name as location2_2_0_ from location location0_ where location0_.location_id=? for update
[java] 21:28:42,031 DEBUG EntityLoader:95 - Static select for entity Location: select location0_.location_id as loc
ation1_0_, location0_.location_name as location2_2_0_ from location location0_ where location0_.location_id=? for update
[java] 21:28:42,078 DEBUG CollectionLoader:94 - Static select for collection Associate.partyGroups: select partygro
up0_.associate_id as associate1_1_, partygroup0_.party_group_id as party2_1_, partygroup1_.party_group_id as party1_0_,
partygroup1_.party_group_name as party2_3_0_ from assoc_party_group_xref partygroup0_ inner join party_group partygroup1
_ on partygroup0_.party_group_id=partygroup1_.party_group_id where partygroup0_.associate_id=?
[java] 21:28:42,609 DEBUG SessionFactoryObjectFactory:39 - initializing class SessionFactoryObjectFactory
[java] 21:28:42,609 DEBUG SessionFactoryObjectFactory:76 - registered: 98804203073a346701073a3491e10000 (unnamed)
[java] 21:28:42,609 INFO SessionFactoryObjectFactory:82 - Not binding factory to JNDI, no JNDI name configured
[java] 21:28:42,609 DEBUG SessionFactoryImpl:262 - instantiated session factory
[java] 21:28:42,609 INFO SessionFactoryImpl:379 - Checking 0 named queries
[java] 21:28:42,687 DEBUG SessionImpl:250 - opened session at timestamp: 4630744771072000
[java] 21:28:43,078 DEBUG JDBCTransaction:46 - begin
[java] 21:28:43,078 DEBUG ConnectionManager:296 - opening JDBC connection
[java] 21:28:43,078 DEBUG DriverManagerConnectionProvider:93 - total checked-out connections: 0
[java] 21:28:43,078 DEBUG DriverManagerConnectionProvider:99 - using pooled JDBC connection, pool size: 0
[java] 21:28:43,078 DEBUG JDBCTransaction:50 - current autocommit status: false
[java] 21:28:43,109 DEBUG SessionImpl:829 - find: from Associate
[java] 21:28:43,109 DEBUG QueryParameters:224 - named parameters: {}
[java] 21:28:43,218 DEBUG QueryTranslatorImpl:207 - parse() - HQL: from Associate
[java] 21:28:43,750 DEBUG AST:223 - --- HQL AST ---
[java] \-[QUERY] 'query'
[java] \-[SELECT_FROM] 'SELECT_FROM'
[java] \-[FROM] 'from'
[java] \-[RANGE] 'RANGE'
[java] \-[IDENT] 'Associate'
[java] 21:28:43,750 DEBUG ErrorCounter:72 - throwQueryException() : no errors
[java] 21:28:43,828 DEBUG HqlSqlBaseWalker:120 - query() << begin, level = 1
[java] 21:28:43,859 DEBUG FromElement:88 - FromClause{level=1} : Associate (no alias) -> associate0_
[java] 21:28:43,859 DEBUG HqlSqlBaseWalker:125 - query() : finishing up , level = 1
[java] 21:28:43,859 DEBUG HqlSqlWalker:331 - processQuery() : ( SELECT ( FromClause{level=1} associate associate0_
) )
[java] 21:28:44,468 DEBUG HqlSqlWalker:451 - Derived SELECT clause created.
[java] 21:28:44,484 DEBUG JoinProcessor:112 - Using FROM fragment [associate associate0_]
[java] 21:28:44,484 DEBUG HqlSqlBaseWalker:128 - query() >> end, level = 1
[java] 21:28:44,500 DEBUG AST:193 - --- SQL AST ---
[java] \-[SELECT] QueryNode: 'SELECT' querySpaces (associate)
[java] +-[SELECT_CLAUSE] SelectClause: '{derived select clause}'
[java] | +-[SELECT_EXPR] SelectExpressionImpl: 'associate0_.associate_id as associate1_' {FromElement{explicit
,not a collection join,not a fetch join,fetch non-lazy properties,classAlias=null,role=null,tableName=associate,tableAli
as=associate0_,colums={,className=Associate}}}
[java] | \-[SQL_TOKEN] SqlFragment: 'associate0_.associate_name as associate2_0_'
[java] \-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClass
Alias=[], fromElementByTableAlias=[associate0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElem
ents=[]}
[java] \-[FROM_FRAGMENT] FromElement: 'associate associate0_' FromElement{explicit,not a collection join,not
a fetch join,fetch non-lazy properties,classAlias=null,role=null,tableName=associate,tableAlias=associate0_,colums={,cl
assName=Associate}}
[java] 21:28:45,421 DEBUG ErrorCounter:72 - throwQueryException() : no errors
[java] 21:28:45,437 DEBUG QueryTranslatorImpl:177 - HQL: from Associate
[java] 21:28:45,453 DEBUG QueryTranslatorImpl:178 - SQL: select associate0_.associate_id as associate1_, associate0
_.associate_name as associate2_0_ from associate associate0_
[java] 21:28:45,453 DEBUG ErrorCounter:72 - throwQueryException() : no errors
[java] 21:28:45,453 DEBUG AbstractBatcher:290 - about to open PreparedStatement (open PreparedStatements: 0, global
ly: 0)
[java] 21:28:45,453 DEBUG SQL:324 - select associate0_.associate_id as associate1_, associate0_.associate_name as a
ssociate2_0_ from associate associate0_
[java] Hibernate: select associate0_.associate_id as associate1_, associate0_.associate_name as associate2_0_ from
associate associate0_
[java] 21:28:46,625 DEBUG AbstractBatcher:378 - preparing statement
[java] 21:28:46,656 DEBUG AbstractBatcher:306 - about to open ResultSet (open ResultSets: 0, globally: 0)
[java] 21:28:46,656 DEBUG Loader:405 - processing result set
[java] 21:28:46,656 DEBUG Loader:410 - result set row: 0
[java] 21:28:46,656 DEBUG LongType:86 - returning '1' as column: associate1_
[java] 21:28:46,671 DEBUG Loader:828 - result row: EntityKey[Associate#1]
[java] 21:28:47,515 DEBUG Loader:978 - Initializing object from ResultSet: [Associate#1]
[java] 21:28:47,531 DEBUG BasicEntityPersister:1651 - Hydrating entity: [Associate#1]
[java] 21:28:47,531 DEBUG StringType:86 - returning 'Mike Miller' as column: associate2_0_
[java] 21:28:47,531 DEBUG Loader:410 - result set row: 1
[java] 21:28:47,531 DEBUG LongType:86 - returning '2' as column: associate1_
[java] 21:28:47,531 DEBUG Loader:828 - result row: EntityKey[Associate#2]
[java] 21:28:47,546 DEBUG Loader:978 - Initializing object from ResultSet: [Associate#2]
[java] 21:28:48,234 DEBUG BasicEntityPersister:1651 - Hydrating entity: [Associate#2]
[java] 21:28:48,234 DEBUG StringType:86 - returning 'Dave Malechek' as column: associate2_0_
[java] 21:28:48,234 DEBUG Loader:410 - result set row: 2
[java] 21:28:48,234 DEBUG LongType:86 - returning '3' as column: associate1_
[java] 21:28:48,234 DEBUG Loader:828 - result row: EntityKey[Associate#3]
[java] 21:28:48,250 DEBUG Loader:978 - Initializing object from ResultSet: [Associate#3]
[java] 21:28:48,250 DEBUG BasicEntityPersister:1651 - Hydrating entity: [Associate#3]
[java] 21:28:48,796 DEBUG StringType:86 - returning 'Melissa Briones' as column: associate2_0_
[java] 21:28:48,796 DEBUG Loader:410 - result set row: 3
[java] 21:28:48,796 DEBUG LongType:86 - returning '4' as column: associate1_
[java] 21:28:48,796 DEBUG Loader:828 - result row: EntityKey[Associate#4]
[java] 21:28:48,796 DEBUG Loader:978 - Initializing object from ResultSet: [Associate#4]
[java] 21:28:48,812 DEBUG BasicEntityPersister:1651 - Hydrating entity: [Associate#4]
[java] 21:28:48,812 DEBUG StringType:86 - returning 'Venkat Narayanan' as column: associate2_0_
[java] 21:28:49,359 DEBUG Loader:429 - done processing result set (4 rows)
[java] 21:28:49,359 DEBUG AbstractBatcher:313 - about to close ResultSet (open ResultSets: 1, globally: 1)
[java] 21:28:49,359 DEBUG AbstractBatcher:298 - about to close PreparedStatement (open PreparedStatements: 1, globa
lly: 1)
[java] 21:28:49,375 DEBUG AbstractBatcher:416 - closing statement
[java] 21:28:49,375 DEBUG Loader:528 - total objects hydrated: 4
[java] 21:28:49,375 DEBUG TwoPhaseLoad:96 - resolving associations for [Associate#1]
[java] 21:28:49,390 DEBUG CollectionLoadContext:141 - creating collection wrapper:[Associate.partyGroups#1]
[java] 21:28:49,937 DEBUG TwoPhaseLoad:167 - done materializing entity [Associate#1]
[java] 21:28:49,937 DEBUG TwoPhaseLoad:96 - resolving associations for [Associate#2]
[java] 21:28:49,937 DEBUG CollectionLoadContext:141 - creating collection wrapper:[Associate.partyGroups#2]
[java] 21:28:49,937 DEBUG TwoPhaseLoad:167 - done materializing entity [Associate#2]
[java] 21:28:49,937 DEBUG TwoPhaseLoad:96 - resolving associations for [Associate#3]
[java] 21:28:49,937 DEBUG CollectionLoadContext:141 - creating collection wrapper:[Associate.partyGroups#3]
[java] 21:28:50,578 DEBUG TwoPhaseLoad:167 - done materializing entity [Associate#3]
[java] 21:28:50,578 DEBUG TwoPhaseLoad:96 - resolving associations for [Associate#4]
[java] 21:28:50,578 DEBUG CollectionLoadContext:141 - creating collection wrapper:[Associate.partyGroups#4]
[java] 21:28:50,578 DEBUG TwoPhaseLoad:167 - done materializing entity [Associate#4]
[java] 21:28:50,578 DEBUG PersistenceContext:789 - initializing non-lazy collections
[java] 21:28:50,578 DEBUG DefaultInitializeCollectionEventListener:42 - initializing collection [Associate.partyGro
ups#4]
[java] 21:28:51,046 DEBUG DefaultInitializeCollectionEventListener:47 - checking second-level cache
[java] 21:28:51,046 DEBUG DefaultInitializeCollectionEventListener:59 - collection not cached
[java] 21:28:51,062 DEBUG Loader:1426 - loading collection: [Associate.partyGroups#4]
[java] 21:28:51,062 DEBUG AbstractBatcher:290 - about to open PreparedStatement (open PreparedStatements: 0, global
ly: 0)
[java] 21:28:51,062 DEBUG SQL:324 - select partygroup0_.associate_id as associate1_1_, partygroup0_.party_group_id
as party2_1_, partygroup1_.party_group_id as party1_0_, partygroup1_.party_group_name as party2_3_0_ from assoc_party_gr
oup_xref partygroup0_ inner join party_group partygroup1_ on partygroup0_.party_group_id=partygroup1_.party_group_id whe
re partygroup0_.associate_id=?
[java] Hibernate: select partygroup0_.associate_id as associate1_1_, partygroup0_.party_group_id as party2_1_, part
ygroup1_.party_group_id as party1_0_, partygroup1_.party_group_name as party2_3_0_ from assoc_party_group_xref partygrou
p0_ inner join party_group partygroup1_ on partygroup0_.party_group_id=partygroup1_.party_group_id where partygroup0_.as
sociate_id=?
[java] 21:28:51,531 DEBUG AbstractBatcher:378 - preparing statement
[java] 21:28:51,546 DEBUG LongType:59 - binding '4' to parameter: 1
[java] 21:28:51,546 DEBUG AbstractBatcher:306 - about to open ResultSet (open ResultSets: 0, globally: 0)
[java] 21:28:52,093 DEBUG Loader:718 - result set contains (possibly empty) collection: [Associate.partyGroups#4]
[java] 21:28:52,109 DEBUG CollectionLoadContext:85 - uninitialized collection: initializing
[java] 21:28:52,109 DEBUG Loader:405 - processing result set
[java] 21:28:52,109 DEBUG Loader:410 - result set row: 0
[java] 21:28:52,109 DEBUG LongType:86 - returning '8030594856897372528' as column: party1_0_
[java] 21:28:52,109 DEBUG Loader:828 - result row: EntityKey[PartyGroup#8030594856897372528]
[java] 21:28:52,109 DEBUG Loader:978 - Initializing object from ResultSet: [PartyGroup#8030594856897372528]
[java] 21:28:52,828 DEBUG BasicEntityPersister:1651 - Hydrating entity: [PartyGroup#8030594856897372528]
[java] 21:28:52,828 DEBUG StringType:86 - returning 'p0_?assoc_party_group_xref
[java] associate1_1_?associate_id?? ΒΆ #P ' as column: party2_3
_0_21:28:52,859 DEBUG AbstractBatcher:313 - about to close ResultSet (open ResultSets: 1, globally: 1)
[java] 21:28:52,859 DEBUG AbstractBatcher:298 - about to close PreparedStatement (open PreparedStatements: 1, globa
lly: 1)
[java] Exception in thread "main" org.hibernate.exception.GenericJDBCException: could not initialize a collection:
[Associate.partyGroups#4]
[java] 21:28:52,859 DEBUG AbstractBatcher:416 - closing statement
[java] at org.hibernate.exception.ErrorCodeConverter.handledNonSpecificException(ErrorCodeConverter.java:92)
[java] 21:28:53,484 DEBUG JDBCExceptionReporter:63 - could not initialize a collection: [Associate.partyGroups#4] [
select partygroup0_.associate_id as associate1_1_, partygroup0_.party_group_id as party2_1_, partygroup1_.party_group_id
as party1_0_, partygroup1_.party_group_name as party2_3_0_ from assoc_party_group_xref partygroup0_ inner join party_gr
oup partygroup1_ on partygroup0_.party_group_id=partygroup1_.party_group_id where partygroup0_.associate_id=?]
[java] at org.hibernate.exception.ErrorCodeConverter.convert(ErrorCodeConverter.java:80)
[java] java.sql.SQLException: Column 'associate1_1_' not found.
[java] at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
[java] at com.mysql.jdbc.ResultSet.findColumn(ResultSet.java:2288)
[java] at org.hibernate.loader.Loader.loadCollection(Loader.java:1441)
[java] at com.mysql.jdbc.ResultSet.getLong(ResultSet.java:1356)
[java] at org.hibernate.loader.collection.CollectionLoader.initialize(CollectionLoader.java:99)
[java] at org.hibernate.type.LongType.get(LongType.java:26)
[java] at org.hibernate.persister.collection.AbstractCollectionPersister.initialize(AbstractCollectionPersister
.java:488)
[java] at org.hibernate.type.NullableType.nullSafeGet(NullableType.java:77)
[java] at org.hibernate.event.def.DefaultInitializeCollectionEventListener.onInitializeCollection(DefaultInitia
lizeCollectionEventListener.java:60)
[java] at org.hibernate.type.NullableType.nullSafeGet(NullableType.java:68)
[java] at org.hibernate.impl.SessionImpl.initializeCollection(SessionImpl.java:1430)
[java] at org.hibernate.persister.collection.AbstractCollectionPersister.readKey(AbstractCollectionPersister.ja
va:633)
[java] at org.hibernate.collection.AbstractPersistentCollection.forceInitialization(AbstractPersistentCollectio
n.java:280)
[java] at org.hibernate.loader.Loader.readCollectionElement(Loader.java:648)
[java] at org.hibernate.engine.PersistenceContext.initializeNonLazyCollections(PersistenceContext.java:796)
[java] at org.hibernate.loader.Loader.readCollectionElements(Loader.java:370)
[java] at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:223)
[java] at org.hibernate.loader.Loader.getRowFromResultSet(Loader.java:314)
[java] at org.hibernate.loader.Loader.doList(Loader.java:1593)
[java] at org.hibernate.loader.Loader.doQuery(Loader.java:412)
[java] at org.hibernate.loader.Loader.list(Loader.java:1577)
[java] at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:218)
[java] at org.hibernate.loader.hql.QueryLoader.list(QueryLoader.java:395)
[java] at org.hibernate.loader.Loader.loadCollection(Loader.java:1434)
[java] at org.hibernate.hql.ast.QueryTranslatorImpl.list(QueryTranslatorImpl.java:271)
[java] at org.hibernate.loader.collection.CollectionLoader.initialize(CollectionLoader.java:99)
[java] at org.hibernate.impl.SessionImpl.list(SessionImpl.java:844)
[java] at org.hibernate.persister.collection.AbstractCollectionPersister.initialize(AbstractCollectionPersister
.java:488)
[java] at org.hibernate.impl.QueryImpl.list(QueryImpl.java:74)
[java] at org.hibernate.event.def.DefaultInitializeCollectionEventListener.onInitializeCollection(DefaultInitia
lizeCollectionEventListener.java:60)
[java] at POSManager.listAssociates(Unknown Source)
[java] at org.hibernate.impl.SessionImpl.initializeCollection(SessionImpl.java:1430)
[java] at POSManager.main(Unknown Source)
[java] at org.hibernate.collection.AbstractPersistentCollection.forceInitialization(AbstractPersistentCollectio
n.java:280)
[java] Caused by: java.sql.SQLException: Column 'associate1_1_' not found.
[java] at org.hibernate.engine.PersistenceContext.initializeNonLazyCollections(PersistenceContext.java:796)
[java] at com.mysql.jdbc.ResultSet.findColumn(ResultSet.java:2288)
[java] at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:223)
[java] at com.mysql.jdbc.ResultSet.getLong(ResultSet.java:1356)
[java] at org.hibernate.loader.Loader.doList(Loader.java:1593)
[java] at org.hibernate.type.LongType.get(LongType.java:26)
[java] at org.hibernate.loader.Loader.list(Loader.java:1577)
[java] at org.hibernate.type.NullableType.nullSafeGet(NullableType.java:77)
[java] at org.hibernate.loader.hql.QueryLoader.list(QueryLoader.java:395)
[java] at org.hibernate.type.NullableType.nullSafeGet(NullableType.java:68)
[java] at org.hibernate.hql.ast.QueryTranslatorImpl.list(QueryTranslatorImpl.java:271)
[java] at org.hibernate.persister.collection.AbstractCollectionPersister.readKey(AbstractCollectionPersister.ja
va:633)
[java] at org.hibernate.impl.SessionImpl.list(SessionImpl.java:844)
[java] at org.hibernate.loader.Loader.readCollectionElement(Loader.java:648)
[java] at org.hibernate.impl.QueryImpl.list(QueryImpl.java:74)
[java] at org.hibernate.loader.Loader.readCollectionElements(Loader.java:370)
[java] at POSManager.listAssociates(Unknown Source)
[java] at org.hibernate.loader.Loader.getRowFromResultSet(Loader.java:314)
[java] at POSManager.main(Unknown Source)
[java] at org.hibernate.loader.Loader.doQuery(Loader.java:412)
[java] 21:28:53,875 WARN JDBCExceptionReporter:71 - SQL Error: 0, SQLState: S0022
[java] at org.hibernate.loader.Loader.doQueryAndInitializeNonLazyCollections(Loader.java:218)
[java] 21:28:53,875 ERROR JDBCExceptionReporter:72 - Column 'associate1_1_' not found.
[java] at org.hibernate.loader.Loader.loadCollection(Loader.java:1434)
[java] ... 15 more
[java] Java Result: 1
Name and version of the database you are using:
MySql 5.0.12
The generated SQL (show_sql=true):
see above
Debug level Hibernate log excerpt:
see above