org.hibernate.LazyInitializationException: session is not connected

Hibernate JIRA | David Erickson | 1 decade ago
  1. 0

    ----------------------------------------------------------------- Summary ----------------------------------------------------------------- Using HQL along with "fetch all properties" does not appear to be working in any of the cases I've used it on, where at least one column is marked as lazy="true". I assume if this does not work then lazy loading via criteria does not work either.. that ought to be checked at the same time. Hibernate.initialize(property) works, however if you select a list of objects you would have n+1 selects to call Hibernate.initialize on each of them.. so its critical we get HQL and criteria capable of eagerly fetching these column level lazy props in the initial object select statements. ----------------------------------------------------------------- Class ----------------------------------------------------------------- public class TestClass { private Long id; private String lazyString; public Long getId() { return id; } public void setId(Long id) { this.id = id; } public String getLazyString() { return lazyString; } public void setLazyString(String lazyString) { this.lazyString = lazyString; } } ----------------------------------------------------------------- Mapping ----------------------------------------------------------------- <?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="org.tecas.model.TestClass" table="TEST_CLASS"> <id name="id" column="ID" type="long" unsaved-value="null"> <generator class="native"/> </id> <property name="lazyString" column="LAZY_STRING" lazy="true"/> </class> <query name="TestClass.By.id"><![CDATA[ from org.tecas.model.TestClass tc fetch all properties where tc.id = :id]]></query> <query name="TestClass.By.ids"><![CDATA[ from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids)]]></query> </hibernate-mapping> ----------------------------------------------------------------- DAO Methods (Used in a spring environment extending HibernateDaoSupport) ----------------------------------------------------------------- public TestClass getTestClass(final Long id) { return (TestClass) getHibernateTemplate().execute(new HibernateCallback() { public Object doInHibernate(Session session) throws HibernateException, SQLException { return session.getNamedQuery("TestClass.By.id") .setLong("id", id) .uniqueResult(); } }); } public Set<TestClass> getTestClass(final Set<Long> ids) { Collection results = (Collection) getHibernateTemplate().execute(new HibernateCallback() { public Object doInHibernate(Session session) throws HibernateException, SQLException { return session.getNamedQuery("TestClass.By.ids") .setParameterList("ids", ids) .list(); } }); return new HashSet<TestClass>(results); } ----------------------------------------------------------------- Test Cases ----------------------------------------------------------------- public void testGetTestClass() throws Exception { TestClassDaoImpl testClassDao = getTestClassDaoImpl(); TestClass tc = testClassDao.getTestClass(new Long(1)); String lazyString = tc.getLazyString(); // <-- EXCEPTION } public void testGetTestClasses() throws Exception { TestClassDaoImpl testClassDao = getTestClassDaoImpl(); Set<Long> ids = new HashSet<Long>(); ids.add(new Long(1)); ids.add(new Long(2)); Set<TestClass> tcs = testClassDao.getTestClass(ids); for (Iterator it = tcs.iterator(); it.hasNext(); ) { TestClass tc = (TestClass) it.next(); String lazyString = tc.getLazyString(); // <-- EXCEPTION } } ----------------------------------------------------------------- Debug Log Output + Lazy Exceptions ----------------------------------------------------------------- 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - Hibernate 3.0.5 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - hibernate.properties not found 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - using CGLIB reflection optimizer 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - using JDK 1.4 java.sql.Timestamp handling 2005-07-06 14:18:57,296 [INFO ] org.hibernate.cfg.Configuration - Mapping file: C:\projects\TECAS\Webapp\target\classes\org\tecas\model\TestClass.hbm.xml 2005-07-06 14:18:57,296 [DEBUG] org.hibernate.util.DTDEntityResolver - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd in classpath under org/hibernate/ 2005-07-06 14:18:57,296 [DEBUG] org.hibernate.util.DTDEntityResolver - found http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd in classpath 2005-07-06 14:18:57,312 [INFO ] org.hibernate.cfg.HbmBinder - Mapping class: org.tecas.model.TestClass -> TEST_CLASS 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Mapped property: id -> ID 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Mapped property: lazyString -> LAZY_STRING 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Named query: TestClass.By.id -> from org.tecas.model.TestClass tc fetch all properties where tc.id = :id 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Named query: TestClass.By.ids -> from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids) 2005-07-06 14:18:57,343 [INFO ] org.hibernate.connection.ConnectionProviderFactory - Initializing connection provider: org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider 2005-07-06 14:18:57,718 [INFO ] org.hibernate.cfg.SettingsFactory - RDBMS: HSQL Database Engine, version: 1.8.0 2005-07-06 14:18:57,718 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC driver: HSQL Database Engine Driver, version: 1.8.0 2005-07-06 14:18:57,734 [INFO ] org.hibernate.dialect.Dialect - Using dialect: org.hibernate.dialect.HSQLDialect 2005-07-06 14:18:57,750 [INFO ] org.hibernate.transaction.TransactionFactoryFactory - Using default transaction strategy (direct JDBC transactions) 2005-07-06 14:18:57,750 [INFO ] org.hibernate.transaction.TransactionManagerLookupFactory - No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended) 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Automatic flush during beforeCompletion(): disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Automatic session close at end of transaction: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC batch size: 15 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC batch updates for versioned data: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Scrollable result sets: enabled 2005-07-06 14:18:57,750 [DEBUG] org.hibernate.cfg.SettingsFactory - Wrap result sets: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC3 getGeneratedKeys(): disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Connection release mode: null 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Default batch fetch size: 1 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Generate SQL with comments: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Order SQL updates by primary key: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 2005-07-06 14:18:57,750 [INFO ] org.hibernate.hql.ast.ASTQueryTranslatorFactory - Using ASTQueryTranslatorFactory 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Query language substitutions: {} 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Second-level cache: enabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Query cache: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Cache provider: org.hibernate.cache.EhCacheProvider 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Optimize cache for minimal puts: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Structured second-level cache entries: disabled 2005-07-06 14:18:57,765 [DEBUG] org.hibernate.exception.SQLExceptionConverterFactory - Using dialect defined converter 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Echoing all SQL to stdout 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Statistics: disabled 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Deleted entity synthetic identifier rollback: disabled 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Default entity-mode: pojo 2005-07-06 14:18:57,890 [INFO ] org.hibernate.impl.SessionFactoryImpl - building session factory 2005-07-06 14:18:57,890 [DEBUG] org.hibernate.impl.SessionFactoryImpl - Session factory constructed with filter configurations : {} 2005-07-06 14:18:57,890 [DEBUG] org.hibernate.impl.SessionFactoryImpl - instantiating session factory with properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=C:\Java\jdk1.5.0_01\jre\bin, java.vm.version=1.5.0_01-b08, java.vm.vendor=Sun Microsystems Inc., java.vendor.url=http://java.sun.com/, path.separator=;, java.vm.name=Java HotSpot(TM) Client VM, file.encoding.pkg=sun.io, idea.launcher.port=7538, user.country=US, sun.os.patch.level=Service Pack 2, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\projects\TECAS\Webapp, java.runtime.version=1.5.0_01-b08, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, basedir=C:\projects\TECAS\Webapp, java.endorsed.dirs=C:\Java\jdk1.5.0_01\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\halcy\LOCALS~1\Temp\, line.separator= , java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows XP, sun.jnu.encoding=Cp1252, java.library.path=C:\Java\jdk1.5.0_01\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\WinSCP3\;C:\Program Files\Apache Software Foundation\Maven 1.0\bin;C:\Java\jdk1.5.0_01\bin;C:\Java\apache-ant-1.6.2\bin;C:\Program Files\Support Tools\;C:\Program Files\OpenSSH\bin;C:\Program Files\ATI Technologies\ATI.ACE\;C:\Program Files\TortoiseCVS\, java.specification.name=Java Platform API Specification, java.class.version=49.0, sun.management.compiler=HotSpot Client Compiler, os.version=5.1, user.home=C:\Documents and Settings\halcy, user.timezone=America/Denver, java.awt.printerjob=sun.awt.windows.WPrinterJob, file.encoding=windows-1252, java.specification.version=1.5, java.class.path=C:\Java\jdk1.5.0_01\jre\lib\charsets.jar;C:\Java\jdk1.5.0_01\jre\lib\deploy.jar;C:\Java\jdk1.5.0_01\jre\lib\javaws.jar;C:\Java\jdk1.5.0_01\jre\lib\jce.jar;C:\Java\jdk1.5.0_01\jre\lib\jsse.jar;C:\Java\jdk1.5.0_01\jre\lib\plugin.jar;C:\Java\jdk1.5.0_01\jre\lib\rt.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\dnsns.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\localedata.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\sunjce_provider.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\sunpkcs11.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\jai_codec.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\jai_core.jar;C:\projects\TECAS\Webapp\target\test;C:\projects\TECAS\Webapp\target\classes;C:\projects\TECAS\Webapp\src\lib\mail-1_3_2.jar;C:\projects\TECAS\Webapp\src\lib\activation-1_0_2.jar;C:\projects\TECAS\Webapp\src\lib\jaxen-1.1-beta-4.jar;C:\projects\TECAS\Webapp\src\lib\junit-3.8.1.jar;C:\projects\TECAS\Webapp\src\lib\dom4j-1.6.jar;C:\projects\TECAS\Webapp\src\lib\jta.jar;C:\projects\TECAS\Webapp\src\lib\antlr-2.7.5H3.jar;C:\projects\TECAS\Webapp\src\lib\hibernate3.jar;C:\projects\TECAS\Webapp\src\lib\jdbc2_0-stdext.jar;C:\projects\TECAS\Webapp\src\lib\commons-collections-2.1.1.jar;C:\projects\TECAS\Webapp\src\lib\cglib-2.1.jar;C:\projects\TECAS\Webapp\src\lib\asm.jar;C:\projects\TECAS\Webapp\src\lib\asm-attrs.jar;C:\projects\TECAS\Webapp\src\lib\xml-apis.jar;C:\projects\TECAS\Webapp\src\lib\commons-logging-1.0.4.jar;C:\projects\TECAS\Webapp\src\lib\log4j-1.2.9.jar;C:\projects\TECAS\Webapp\src\lib\ehcache-1.1.jar;C:\projects\TECAS\Webapp\src\lib\hsqldb.jar;C:\projects\TECAS\Webapp\src\lib\dbunit-2.1.jar;C:\projects\TECAS\Webapp\src\lib\commons-dbcp-1.2.1.jar;C:\projects\TECAS\Webapp\src\lib\commons-pool-1.2.jar;C:\projects\TECAS\Client\target\classes;C:\projects\TECAS\Client\src\lib\mailet-api-3.0.jar;C:\projects\TECAS\Client\src\lib\james-3.0-dev.jar;C:\projects\TECAS\Client\src\lib\mailet-3.0.jar;C:\projects\TECAS\Client\src\lib\mail-1.3.1.jar;C:\projects\TECAS\Webapp\src\lib\jakarta-oro.jar;C:\projects\TECAS\Webapp\src\lib\commons-digester.jar;C:\projects\TECAS\Webapp\src\lib\commons-validator.jar;C:\projects\TECAS\Webapp\src\lib\commons-logging.jar;C:\projects\TECAS\Webapp\src\lib\struts.jar;C:\projects\TECAS\Webapp\src\lib\commons-fileupload.jar;C:\projects\TECAS\Webapp\src\lib\commons-beanutils.jar;C:\projects\TECAS\Webapp\src\lib\mysql-connector-java-3.0.16-ga-bin.jar;C:\projects\TECAS\Webapp\src\lib\spring.jar;C:\Java\jakarta-tomcat-5.0.24\server\lib\catalina.jar;C:\projects\displaytag\target\test-classes;C:\projects\displaytag\target\classes;C:\Documents and Settings\halcy\.maven\repository\commons-beanutils\jars\commons-beanutils-1.7.0.jar;C:\Documents and Settings\halcy\.maven\repository\commons-collections\jars\commons-collections-3.1.jar;C:\Documents and Settings\halcy\.maven\repository\commons-digester\jars\commons-digester-1.4.1.jar;C:\Documents and Settings\halcy\.maven\repository\commons-lang\jars\commons-lang-2.0.jar;C:\Documents and Settings\halcy\.maven\repository\commons-logging\jars\commons-logging-1.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\httpunit\jars\httpunit-1.6.jar;C:\Documents and Settings\halcy\.maven\repository\itext\jars\itext-0.99.jar;C:\Documents and Settings\halcy\.maven\repository\tomcat\jars\jasper-compiler-4.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\tomcat\jars\jasper-runtime-4.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\rhino\jars\js-1.5R4.1.jar;C:\Documents and Settings\halcy\.maven\repository\jstl\jars\jstl-1.0.2.jar;C:\Documents and Settings\halcy\.maven\repository\jtidy\jars\jtidy-4aug2000r7-dev.jar;C:\Documents and Settings\halcy\.maven\repository\log4j\jars\log4j-1.2.8.jar;C:\Documents and Settings\halcy\.maven\repository\nekohtml\jars\nekohtml-0.9.1.jar;C:\Documents and Settings\halcy\.maven\repository\ognl\jars\ognl-2.6.5.jar;C:\Documents and Settings\halcy\.maven\repository\opensymphony\jars\oscore-2.2.4.jar;C:\Documents and Settings\halcy\.maven\repository\servletapi\jars\servletapi-2.3.jar;C:\Documents and Settings\halcy\.maven\repository\springframework\jars\spring-1.1.1.jar;C:\Documents and Settings\halcy\.maven\repository\taglibs\jars\standard-1.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\struts\jars\struts-1.2.4.jar;C:\Java\jdk1.5.0_01\lib\tools.jar;C:\Documents and Settings\halcy\.maven\repository\opensymphony\jars\webwork-2.1.5.jar;C:\Documents and Settings\halcy\.maven\repository\xerces\jars\xerces-2.4.0.jar;C:\Documents and Settings\halcy\.maven\repository\xml-apis\jars\xml-apis-1.0.b2.jar;C:\Documents and Settings\halcy\.maven\repository\opensymphony\jars\xwork-1.0.3.jar;C:\Documents and Settings\halcy\.maven\repository\junit\jars\junit-3.8.1.jar;C:\projects\TECAS\Webapp\src\lib\commons-lang-2.0.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\activation.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\ant.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-collections.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-dbcp-1.1.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-el.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-logging-api.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-logging.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-pool-1.1.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jasper-compiler.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jasper-runtime.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jsp-api.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jta.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\log4j-1.2.8.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\mail.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\mysql-connector-java-3.0.14-production-bin.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-common.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-factory.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-java.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-resources.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\servlet-api.jar;C:\Program Files\IntelliJ-IDEA-4.5\lib\idea_rt.jar, user.name=halcy, hibernate.show_sql=true, java.vm.specification.version=1.0, java.home=C:\Java\jdk1.5.0_01\jre, sun.arch.data.model=32, hibernate.dialect=org.hibernate.dialect.HSQLDialect, user.language=en, java.specification.vendor=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_01, java.ext.dirs=C:\Java\jdk1.5.0_01\jre\lib\ext, sun.boot.class.path=C:\Java\jdk1.5.0_01\jre\lib\rt.jar;C:\Java\jdk1.5.0_01\jre\lib\i18n.jar;C:\Java\jdk1.5.0_01\jre\lib\sunrsasign.jar;C:\Java\jdk1.5.0_01\jre\lib\jsse.jar;C:\Java\jdk1.5.0_01\jre\lib\jce.jar;C:\Java\jdk1.5.0_01\jre\lib\charsets.jar;C:\Java\jdk1.5.0_01\jre\classes, java.vendor=Sun Microsystems Inc., file.separator=\, hibernate.connection.provider_class=org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider, idea.launcher.library=C:\Program Files\IntelliJ-IDEA-4.5\bin\breakgen.dll, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.io.unicode.encoding=UnicodeLittle, sun.cpu.endian=little, hibernate.use_outer_join=true, sun.desktop=windows, sun.cpu.isalist=pentium_pro+mmx pentium_pro pentium+mmx pentium i486 i386 i86} 2005-07-06 14:18:58,046 [INFO ] org.hibernate.tuple.EntityMetamodel - lazy property fetching available for: org.tecas.model.TestClass 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Static SQL for entity: org.tecas.model.TestClass 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Lazy select: select testclass_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass_ where testclass_.ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Version select: select ID from TEST_CLASS where ID =? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Snapshot select: select testclass_.ID, testclass_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass_ where testclass_.ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Insert 0: insert into TEST_CLASS (LAZY_STRING, ID) values (?, ?) 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Update 0: update TEST_CLASS set LAZY_STRING=? where ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Delete 0: delete from TEST_CLASS where ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Identity insert: insert into TEST_CLASS (LAZY_STRING, ID) values (?, null) 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,671 [DEBUG] org.hibernate.impl.SessionFactoryObjectFactory - initializing class SessionFactoryObjectFactory 2005-07-06 14:18:58,671 [DEBUG] org.hibernate.impl.SessionFactoryObjectFactory - registered: 4028808204edcd160104edcd19ef0000 (unnamed) 2005-07-06 14:18:58,671 [INFO ] org.hibernate.impl.SessionFactoryObjectFactory - Not binding factory to JNDI, no JNDI name configured 2005-07-06 14:18:58,671 [DEBUG] org.hibernate.impl.SessionFactoryImpl - instantiated session factory 2005-07-06 14:18:58,671 [INFO ] org.hibernate.impl.SessionFactoryImpl - Checking 2 named queries 2005-07-06 14:18:58,875 [DEBUG] org.hibernate.impl.SessionFactoryImpl - Checking named query: TestClass.By.ids 2005-07-06 14:18:58,875 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - parse() - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.AST - --- HQL AST --- \-[QUERY] 'query' +-[SELECT_FROM] 'SELECT_FROM' | \-[FROM] 'from' | \-[RANGE] 'RANGE' | +-[DOT] '.' | | +-[DOT] '.' | | | +-[DOT] '.' | | | | +-[IDENT] 'org' | | | | \-[IDENT] 'tecas' | | | \-[IDENT] 'model' | | \-[IDENT] 'TestClass' | +-[ALIAS] 'tc' | \-[FETCH] 'fetch' \-[WHERE] 'where' \-[IN] 'in' +-[DOT] '.' | +-[IDENT] 'tc' | \-[IDENT] 'id' \-[IN_LIST] 'inList' \-[COLON] ':' \-[IDENT] 'ids' 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() << begin, level = 1 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.FromElement - FromClause{level=1} : org.tecas.model.TestClass (tc) -> testclass0_ 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc -> testclass0_.ID 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.DotNode - getDataType() : id -> org.hibernate.type.LongType@df83e5 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc.id -> testclass0_.ID 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() : finishing up , level = 1 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - processQuery() : ( SELECT ( FromClause{level=1} TEST_CLASS testclass0_ ) ( where ( in ( testclass0_.ID testclass0_.ID id ) ( inList ? ) ) ) ) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - Derived SELECT clause created. 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.JoinProcessor - Using FROM fragment [TEST_CLASS testclass0_] 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() >> end, level = 1 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.AST - --- SQL AST --- \-[SELECT] QueryNode: 'SELECT' querySpaces (TEST_CLASS) +-[SELECT_CLAUSE] SelectClause: '{derived select clause}' | +-[SELECT_EXPR] SelectExpressionImpl: 'testclass0_.ID as ID' {FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}}} | \-[SQL_TOKEN] SqlFragment: 'testclass0_.LAZY_STRING as LAZY2_4_' +-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[tc], fromElementByTableAlias=[testclass0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]} | \-[FROM_FRAGMENT] FromElement: 'TEST_CLASS testclass0_' FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}} \-[WHERE] SqlNode: 'where' \-[IN] SqlNode: 'in' +-[DOT] DotNode: 'testclass0_.ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=tc.id,tableAlias=testclass0_,className=org.tecas.model.TestClass,classAlias=tc} | +-[ALIAS_REF] IdentNode: 'testclass0_.ID' {alias=tc, className=org.tecas.model.TestClass, tableAlias=testclass0_} | \-[IDENT] IdentNode: 'id' {originalText=id} \-[IN_LIST] SqlNode: 'inList' \-[NAMED_PARAM] SqlNode: '?' 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - SQL: select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID in (?) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.impl.SessionFactoryImpl - Checking named query: TestClass.By.id 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - parse() - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id = :id 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.AST - --- HQL AST --- \-[QUERY] 'query' +-[SELECT_FROM] 'SELECT_FROM' | \-[FROM] 'from' | \-[RANGE] 'RANGE' | +-[DOT] '.' | | +-[DOT] '.' | | | +-[DOT] '.' | | | | +-[IDENT] 'org' | | | | \-[IDENT] 'tecas' | | | \-[IDENT] 'model' | | \-[IDENT] 'TestClass' | +-[ALIAS] 'tc' | \-[FETCH] 'fetch' \-[WHERE] 'where' \-[EQ] '=' +-[DOT] '.' | +-[IDENT] 'tc' | \-[IDENT] 'id' \-[COLON] ':' \-[IDENT] 'id' 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() << begin, level = 1 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.FromElement - FromClause{level=1} : org.tecas.model.TestClass (tc) -> testclass0_ 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc -> testclass0_.ID 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.DotNode - getDataType() : id -> org.hibernate.type.LongType@df83e5 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc.id -> testclass0_.ID 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() : finishing up , level = 1 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - processQuery() : ( SELECT ( FromClause{level=1} TEST_CLASS testclass0_ ) ( where ( = ( testclass0_.ID testclass0_.ID id ) ? ) ) ) 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - Derived SELECT clause created. 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.JoinProcessor - Using FROM fragment [TEST_CLASS testclass0_] 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() >> end, level = 1 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.AST - --- SQL AST --- \-[SELECT] QueryNode: 'SELECT' querySpaces (TEST_CLASS) +-[SELECT_CLAUSE] SelectClause: '{derived select clause}' | +-[SELECT_EXPR] SelectExpressionImpl: 'testclass0_.ID as ID' {FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}}} | \-[SQL_TOKEN] SqlFragment: 'testclass0_.LAZY_STRING as LAZY2_4_' +-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[tc], fromElementByTableAlias=[testclass0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]} | \-[FROM_FRAGMENT] FromElement: 'TEST_CLASS testclass0_' FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}} \-[WHERE] SqlNode: 'where' \-[EQ] SqlNode: '=' +-[DOT] DotNode: 'testclass0_.ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=tc.id,tableAlias=testclass0_,className=org.tecas.model.TestClass,classAlias=tc} | +-[ALIAS_REF] IdentNode: 'testclass0_.ID' {alias=tc, className=org.tecas.model.TestClass, tableAlias=testclass0_} | \-[IDENT] IdentNode: 'id' {originalText=id} \-[NAMED_PARAM] SqlNode: '?' 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id = :id 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - SQL: select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open PreparedStatement (open PreparedStatements: 0, globally: 0) 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.jdbc.ConnectionManager - opening JDBC connection 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.SQL - select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.jdbc.AbstractBatcher - preparing statement 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.loader.hql.QueryLoader - bindNamedParameters() 1 -> id [1] 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.type.LongType - binding '1' to parameter: 1 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open ResultSet (open ResultSets: 0, globally: 0) 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - processing result set 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - result set row: 0 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.type.LongType - returning '1' as column: ID 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - result row: EntityKey[org.tecas.model.TestClass#1] 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - Initializing object from ResultSet: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Hydrating entity: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.type.StringType - returning 'HIHI' as column: LAZY2_4_ 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.loader.Loader - done processing result set (1 rows) 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close ResultSet (open ResultSets: 1, globally: 1) 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close PreparedStatement (open PreparedStatements: 1, globally: 1) 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.AbstractBatcher - closing statement 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.loader.Loader - total objects hydrated: 1 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.engine.TwoPhaseLoad - resolving associations for [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.engine.TwoPhaseLoad - done materializing entity [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.engine.PersistenceContext - initializing non-lazy collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.JDBCContext - after autocommit 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - flushing session 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - processing flush-time cascades 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - dirty checking collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushing entities and processing referenced collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Processing unreferenced collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Scheduling collection removes/(re)creates/updates 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.pretty.Printer - listing entities: 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.pretty.Printer - org.tecas.model.TestClass{lazyString=<lazy>, id=1} 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - executing flush 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - post flush 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.impl.SessionImpl - closing session 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.ConnectionManager - closing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)] 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.JDBCContext - after transaction completion 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,812 [ERROR] org.hibernate.LazyInitializationException - session is not connected org.hibernate.LazyInitializationException: session is not connected at org.hibernate.intercept.FieldInterceptor.intercept(FieldInterceptor.java:54) at org.hibernate.intercept.FieldInterceptor.readObject(FieldInterceptor.java:113) at org.tecas.model.TestClass.$cglib_read_lazyString(TestClass.java) at org.tecas.model.TestClass.getLazyString(TestClass.java:21) at org.tecas.dao.TestClassDaoTest.testGetTestClass(TestClassDaoTest.java:25) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at junit.framework.TestCase.runTest(TestCase.java:154) at junit.framework.TestCase.runBare(TestCase.java:127) at junit.framework.TestResult$1.protect(TestResult.java:106) at junit.framework.TestResult.runProtected(TestResult.java:124) at junit.framework.TestResult.run(TestResult.java:109) at junit.framework.TestCase.run(TestCase.java:118) at junit.framework.TestSuite.runTest(TestSuite.java:208) at junit.framework.TestSuite.run(TestSuite.java:203) at junit.textui.TestRunner.doRun(TestRunner.java:116) at com.intellij.rt.execution.junit2.IdeaJUnitAgent.doRun(IdeaJUnitAgent.java:57) at junit.textui.TestRunner.start(TestRunner.java:172) at com.intellij.rt.execution.junit.TextTestRunner2.startRunnerWithArgs(TextTestRunner2.java:23) at com.intellij.rt.execution.junit2.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:97) at com.intellij.rt.execution.junit2.JUnitStarter.main(JUnitStarter.java:31) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at com.intellij.rt.execution.application.AppMain.main(AppMain.java:78) 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.impl.SessionImpl - opened session at timestamp: 4590309948796928 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.impl.SessionImpl - find: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids0_, :ids1_) 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.engine.QueryParameters - named parameters: {ids0_=2, ids1_=1} 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - parse() - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids0_, :ids1_) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.AST - --- HQL AST --- \-[QUERY] 'query' +-[SELECT_FROM] 'SELECT_FROM' | \-[FROM] 'from' | \-[RANGE] 'RANGE' | +-[DOT] '.' | | +-[DOT] '.' | | | +-[DOT] '.' | | | | +-[IDENT] 'org' | | | | \-[IDENT] 'tecas' | | | \-[IDENT] 'model' | | \-[IDENT] 'TestClass' | +-[ALIAS] 'tc' | \-[FETCH] 'fetch' \-[WHERE] 'where' \-[IN] 'in' +-[DOT] '.' | +-[IDENT] 'tc' | \-[IDENT] 'id' \-[IN_LIST] 'inList' +-[COLON] ':' | \-[IDENT] 'ids0_' \-[COLON] ':' \-[IDENT] 'ids1_' 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() << begin, level = 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.FromElement - FromClause{level=1} : org.tecas.model.TestClass (tc) -> testclass0_ 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc -> testclass0_.ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.DotNode - getDataType() : id -> org.hibernate.type.LongType@df83e5 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc.id -> testclass0_.ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() : finishing up , level = 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - processQuery() : ( SELECT ( FromClause{level=1} TEST_CLASS testclass0_ ) ( where ( in ( testclass0_.ID testclass0_.ID id ) ( inList ? ? ) ) ) ) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - Derived SELECT clause created. 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.JoinProcessor - Using FROM fragment [TEST_CLASS testclass0_] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() >> end, level = 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.AST - --- SQL AST --- \-[SELECT] QueryNode: 'SELECT' querySpaces (TEST_CLASS) +-[SELECT_CLAUSE] SelectClause: '{derived select clause}' | +-[SELECT_EXPR] SelectExpressionImpl: 'testclass0_.ID as ID' {FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}}} | \-[SQL_TOKEN] SqlFragment: 'testclass0_.LAZY_STRING as LAZY2_4_' +-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[tc], fromElementByTableAlias=[testclass0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]} | \-[FROM_FRAGMENT] FromElement: 'TEST_CLASS testclass0_' FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}} \-[WHERE] SqlNode: 'where' \-[IN] SqlNode: 'in' +-[DOT] DotNode: 'testclass0_.ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=tc.id,tableAlias=testclass0_,className=org.tecas.model.TestClass,classAlias=tc} | +-[ALIAS_REF] IdentNode: 'testclass0_.ID' {alias=tc, className=org.tecas.model.TestClass, tableAlias=testclass0_} | \-[IDENT] IdentNode: 'id' {originalText=id} \-[IN_LIST] SqlNode: 'inList' +-[NAMED_PARAM] SqlNode: '?' \-[NAMED_PARAM] SqlNode: '?' 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids0_, :ids1_) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - SQL: select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID in (? , ?) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open PreparedStatement (open PreparedStatements: 0, globally: 0) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.ConnectionManager - opening JDBC connection 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.SQL - select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID in (? , ?) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - preparing statement 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.hql.QueryLoader - bindNamedParameters() 2 -> ids0_ [1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - binding '2' to parameter: 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.hql.QueryLoader - bindNamedParameters() 1 -> ids1_ [2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - binding '1' to parameter: 2 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open ResultSet (open ResultSets: 0, globally: 0) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - processing result set 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result set row: 0 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - returning '1' as column: ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result row: EntityKey[org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - Initializing object from ResultSet: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Hydrating entity: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.StringType - returning 'HIHI' as column: LAZY2_4_ 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result set row: 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - returning '2' as column: ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result row: EntityKey[org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - Initializing object from ResultSet: [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Hydrating entity: [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.StringType - returning 'IHIH' as column: LAZY2_4_ 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - done processing result set (2 rows) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close ResultSet (open ResultSets: 1, globally: 1) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close PreparedStatement (open PreparedStatements: 1, globally: 1) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - closing statement 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - total objects hydrated: 2 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - resolving associations for [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - done materializing entity [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - resolving associations for [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - done materializing entity [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.PersistenceContext - initializing non-lazy collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.JDBCContext - after autocommit 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - flushing session 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - processing flush-time cascades 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - dirty checking collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushing entities and processing referenced collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Processing unreferenced collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Scheduling collection removes/(re)creates/updates 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 insertions, 0 updates, 0 deletions to 2 objects 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.pretty.Printer - listing entities: 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.pretty.Printer - org.tecas.model.TestClass{lazyString=<lazy>, id=2} 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.pretty.Printer - org.tecas.model.TestClass{lazyString=<lazy>, id=1} 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - executing flush 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - post flush 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.impl.SessionImpl - closing session 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.ConnectionManager - closing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.JDBCContext - after transaction completion 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,890 [ERROR] org.hibernate.LazyInitializationException - session is not connected org.hibernate.LazyInitializationException: session is not connected at org.hibernate.intercept.FieldInterceptor.intercept(FieldInterceptor.java:54) at org.hibernate.intercept.FieldInterceptor.readObject(FieldInterceptor.java:113) at org.tecas.model.TestClass.$cglib_read_lazyString(TestClass.java) at org.tecas.model.TestClass.getLazyString(TestClass.java:21) at org.tecas.dao.TestClassDaoTest.testGetTestClasses(TestClassDaoTest.java:37) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at junit.framework.TestCase.runTest(TestCase.java:154) at junit.framework.TestCase.runBare(TestCase.java:127) at junit.framework.TestResult$1.protect(TestResult.java:106) at junit.framework.TestResult.runProtected(TestResult.java:124) at junit.framework.TestResult.run(TestResult.java:109) at junit.framework.TestCase.run(TestCase.java:118) at junit.framework.TestSuite.runTest(TestSuite.java:208) at junit.framework.TestSuite.run(TestSuite.java:203) at junit.textui.TestRunner.doRun(TestRunner.java:116) at com.intellij.rt.execution.junit2.IdeaJUnitAgent.doRun(IdeaJUnitAgent.java:57) at junit.textui.TestRunner.start(TestRunner.java:172) at com.intellij.rt.execution.junit.TextTestRunner2.startRunnerWithArgs(TextTestRunner2.java:23) at com.intellij.rt.execution.junit2.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:97) at com.intellij.rt.execution.junit2.JUnitStarter.main(JUnitStarter.java:31) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at com.intellij.rt.execution.application.AppMain.main(AppMain.java:78)

    Hibernate JIRA | 1 decade ago | David Erickson
    org.hibernate.LazyInitializationException: session is not connected
  2. 0

    ----------------------------------------------------------------- Summary ----------------------------------------------------------------- Using HQL along with "fetch all properties" does not appear to be working in any of the cases I've used it on, where at least one column is marked as lazy="true". I assume if this does not work then lazy loading via criteria does not work either.. that ought to be checked at the same time. Hibernate.initialize(property) works, however if you select a list of objects you would have n+1 selects to call Hibernate.initialize on each of them.. so its critical we get HQL and criteria capable of eagerly fetching these column level lazy props in the initial object select statements. ----------------------------------------------------------------- Class ----------------------------------------------------------------- public class TestClass { private Long id; private String lazyString; public Long getId() { return id; } public void setId(Long id) { this.id = id; } public String getLazyString() { return lazyString; } public void setLazyString(String lazyString) { this.lazyString = lazyString; } } ----------------------------------------------------------------- Mapping ----------------------------------------------------------------- <?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="org.tecas.model.TestClass" table="TEST_CLASS"> <id name="id" column="ID" type="long" unsaved-value="null"> <generator class="native"/> </id> <property name="lazyString" column="LAZY_STRING" lazy="true"/> </class> <query name="TestClass.By.id"><![CDATA[ from org.tecas.model.TestClass tc fetch all properties where tc.id = :id]]></query> <query name="TestClass.By.ids"><![CDATA[ from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids)]]></query> </hibernate-mapping> ----------------------------------------------------------------- DAO Methods (Used in a spring environment extending HibernateDaoSupport) ----------------------------------------------------------------- public TestClass getTestClass(final Long id) { return (TestClass) getHibernateTemplate().execute(new HibernateCallback() { public Object doInHibernate(Session session) throws HibernateException, SQLException { return session.getNamedQuery("TestClass.By.id") .setLong("id", id) .uniqueResult(); } }); } public Set<TestClass> getTestClass(final Set<Long> ids) { Collection results = (Collection) getHibernateTemplate().execute(new HibernateCallback() { public Object doInHibernate(Session session) throws HibernateException, SQLException { return session.getNamedQuery("TestClass.By.ids") .setParameterList("ids", ids) .list(); } }); return new HashSet<TestClass>(results); } ----------------------------------------------------------------- Test Cases ----------------------------------------------------------------- public void testGetTestClass() throws Exception { TestClassDaoImpl testClassDao = getTestClassDaoImpl(); TestClass tc = testClassDao.getTestClass(new Long(1)); String lazyString = tc.getLazyString(); // <-- EXCEPTION } public void testGetTestClasses() throws Exception { TestClassDaoImpl testClassDao = getTestClassDaoImpl(); Set<Long> ids = new HashSet<Long>(); ids.add(new Long(1)); ids.add(new Long(2)); Set<TestClass> tcs = testClassDao.getTestClass(ids); for (Iterator it = tcs.iterator(); it.hasNext(); ) { TestClass tc = (TestClass) it.next(); String lazyString = tc.getLazyString(); // <-- EXCEPTION } } ----------------------------------------------------------------- Debug Log Output + Lazy Exceptions ----------------------------------------------------------------- 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - Hibernate 3.0.5 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - hibernate.properties not found 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - using CGLIB reflection optimizer 2005-07-06 14:18:56,796 [INFO ] org.hibernate.cfg.Environment - using JDK 1.4 java.sql.Timestamp handling 2005-07-06 14:18:57,296 [INFO ] org.hibernate.cfg.Configuration - Mapping file: C:\projects\TECAS\Webapp\target\classes\org\tecas\model\TestClass.hbm.xml 2005-07-06 14:18:57,296 [DEBUG] org.hibernate.util.DTDEntityResolver - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd in classpath under org/hibernate/ 2005-07-06 14:18:57,296 [DEBUG] org.hibernate.util.DTDEntityResolver - found http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd in classpath 2005-07-06 14:18:57,312 [INFO ] org.hibernate.cfg.HbmBinder - Mapping class: org.tecas.model.TestClass -> TEST_CLASS 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Mapped property: id -> ID 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Mapped property: lazyString -> LAZY_STRING 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Named query: TestClass.By.id -> from org.tecas.model.TestClass tc fetch all properties where tc.id = :id 2005-07-06 14:18:57,312 [DEBUG] org.hibernate.cfg.HbmBinder - Named query: TestClass.By.ids -> from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids) 2005-07-06 14:18:57,343 [INFO ] org.hibernate.connection.ConnectionProviderFactory - Initializing connection provider: org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider 2005-07-06 14:18:57,718 [INFO ] org.hibernate.cfg.SettingsFactory - RDBMS: HSQL Database Engine, version: 1.8.0 2005-07-06 14:18:57,718 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC driver: HSQL Database Engine Driver, version: 1.8.0 2005-07-06 14:18:57,734 [INFO ] org.hibernate.dialect.Dialect - Using dialect: org.hibernate.dialect.HSQLDialect 2005-07-06 14:18:57,750 [INFO ] org.hibernate.transaction.TransactionFactoryFactory - Using default transaction strategy (direct JDBC transactions) 2005-07-06 14:18:57,750 [INFO ] org.hibernate.transaction.TransactionManagerLookupFactory - No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended) 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Automatic flush during beforeCompletion(): disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Automatic session close at end of transaction: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC batch size: 15 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC batch updates for versioned data: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Scrollable result sets: enabled 2005-07-06 14:18:57,750 [DEBUG] org.hibernate.cfg.SettingsFactory - Wrap result sets: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - JDBC3 getGeneratedKeys(): disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Connection release mode: null 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Default batch fetch size: 1 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Generate SQL with comments: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Order SQL updates by primary key: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory 2005-07-06 14:18:57,750 [INFO ] org.hibernate.hql.ast.ASTQueryTranslatorFactory - Using ASTQueryTranslatorFactory 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Query language substitutions: {} 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Second-level cache: enabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Query cache: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Cache provider: org.hibernate.cache.EhCacheProvider 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Optimize cache for minimal puts: disabled 2005-07-06 14:18:57,750 [INFO ] org.hibernate.cfg.SettingsFactory - Structured second-level cache entries: disabled 2005-07-06 14:18:57,765 [DEBUG] org.hibernate.exception.SQLExceptionConverterFactory - Using dialect defined converter 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Echoing all SQL to stdout 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Statistics: disabled 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Deleted entity synthetic identifier rollback: disabled 2005-07-06 14:18:57,765 [INFO ] org.hibernate.cfg.SettingsFactory - Default entity-mode: pojo 2005-07-06 14:18:57,890 [INFO ] org.hibernate.impl.SessionFactoryImpl - building session factory 2005-07-06 14:18:57,890 [DEBUG] org.hibernate.impl.SessionFactoryImpl - Session factory constructed with filter configurations : {} 2005-07-06 14:18:57,890 [DEBUG] org.hibernate.impl.SessionFactoryImpl - instantiating session factory with properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=C:\Java\jdk1.5.0_01\jre\bin, java.vm.version=1.5.0_01-b08, java.vm.vendor=Sun Microsystems Inc., java.vendor.url=http://java.sun.com/, path.separator=;, java.vm.name=Java HotSpot(TM) Client VM, file.encoding.pkg=sun.io, idea.launcher.port=7538, user.country=US, sun.os.patch.level=Service Pack 2, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\projects\TECAS\Webapp, java.runtime.version=1.5.0_01-b08, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, basedir=C:\projects\TECAS\Webapp, java.endorsed.dirs=C:\Java\jdk1.5.0_01\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\halcy\LOCALS~1\Temp\, line.separator= , java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows XP, sun.jnu.encoding=Cp1252, java.library.path=C:\Java\jdk1.5.0_01\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\WinSCP3\;C:\Program Files\Apache Software Foundation\Maven 1.0\bin;C:\Java\jdk1.5.0_01\bin;C:\Java\apache-ant-1.6.2\bin;C:\Program Files\Support Tools\;C:\Program Files\OpenSSH\bin;C:\Program Files\ATI Technologies\ATI.ACE\;C:\Program Files\TortoiseCVS\, java.specification.name=Java Platform API Specification, java.class.version=49.0, sun.management.compiler=HotSpot Client Compiler, os.version=5.1, user.home=C:\Documents and Settings\halcy, user.timezone=America/Denver, java.awt.printerjob=sun.awt.windows.WPrinterJob, file.encoding=windows-1252, java.specification.version=1.5, java.class.path=C:\Java\jdk1.5.0_01\jre\lib\charsets.jar;C:\Java\jdk1.5.0_01\jre\lib\deploy.jar;C:\Java\jdk1.5.0_01\jre\lib\javaws.jar;C:\Java\jdk1.5.0_01\jre\lib\jce.jar;C:\Java\jdk1.5.0_01\jre\lib\jsse.jar;C:\Java\jdk1.5.0_01\jre\lib\plugin.jar;C:\Java\jdk1.5.0_01\jre\lib\rt.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\dnsns.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\localedata.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\sunjce_provider.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\sunpkcs11.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\jai_codec.jar;C:\Java\jdk1.5.0_01\jre\lib\ext\jai_core.jar;C:\projects\TECAS\Webapp\target\test;C:\projects\TECAS\Webapp\target\classes;C:\projects\TECAS\Webapp\src\lib\mail-1_3_2.jar;C:\projects\TECAS\Webapp\src\lib\activation-1_0_2.jar;C:\projects\TECAS\Webapp\src\lib\jaxen-1.1-beta-4.jar;C:\projects\TECAS\Webapp\src\lib\junit-3.8.1.jar;C:\projects\TECAS\Webapp\src\lib\dom4j-1.6.jar;C:\projects\TECAS\Webapp\src\lib\jta.jar;C:\projects\TECAS\Webapp\src\lib\antlr-2.7.5H3.jar;C:\projects\TECAS\Webapp\src\lib\hibernate3.jar;C:\projects\TECAS\Webapp\src\lib\jdbc2_0-stdext.jar;C:\projects\TECAS\Webapp\src\lib\commons-collections-2.1.1.jar;C:\projects\TECAS\Webapp\src\lib\cglib-2.1.jar;C:\projects\TECAS\Webapp\src\lib\asm.jar;C:\projects\TECAS\Webapp\src\lib\asm-attrs.jar;C:\projects\TECAS\Webapp\src\lib\xml-apis.jar;C:\projects\TECAS\Webapp\src\lib\commons-logging-1.0.4.jar;C:\projects\TECAS\Webapp\src\lib\log4j-1.2.9.jar;C:\projects\TECAS\Webapp\src\lib\ehcache-1.1.jar;C:\projects\TECAS\Webapp\src\lib\hsqldb.jar;C:\projects\TECAS\Webapp\src\lib\dbunit-2.1.jar;C:\projects\TECAS\Webapp\src\lib\commons-dbcp-1.2.1.jar;C:\projects\TECAS\Webapp\src\lib\commons-pool-1.2.jar;C:\projects\TECAS\Client\target\classes;C:\projects\TECAS\Client\src\lib\mailet-api-3.0.jar;C:\projects\TECAS\Client\src\lib\james-3.0-dev.jar;C:\projects\TECAS\Client\src\lib\mailet-3.0.jar;C:\projects\TECAS\Client\src\lib\mail-1.3.1.jar;C:\projects\TECAS\Webapp\src\lib\jakarta-oro.jar;C:\projects\TECAS\Webapp\src\lib\commons-digester.jar;C:\projects\TECAS\Webapp\src\lib\commons-validator.jar;C:\projects\TECAS\Webapp\src\lib\commons-logging.jar;C:\projects\TECAS\Webapp\src\lib\struts.jar;C:\projects\TECAS\Webapp\src\lib\commons-fileupload.jar;C:\projects\TECAS\Webapp\src\lib\commons-beanutils.jar;C:\projects\TECAS\Webapp\src\lib\mysql-connector-java-3.0.16-ga-bin.jar;C:\projects\TECAS\Webapp\src\lib\spring.jar;C:\Java\jakarta-tomcat-5.0.24\server\lib\catalina.jar;C:\projects\displaytag\target\test-classes;C:\projects\displaytag\target\classes;C:\Documents and Settings\halcy\.maven\repository\commons-beanutils\jars\commons-beanutils-1.7.0.jar;C:\Documents and Settings\halcy\.maven\repository\commons-collections\jars\commons-collections-3.1.jar;C:\Documents and Settings\halcy\.maven\repository\commons-digester\jars\commons-digester-1.4.1.jar;C:\Documents and Settings\halcy\.maven\repository\commons-lang\jars\commons-lang-2.0.jar;C:\Documents and Settings\halcy\.maven\repository\commons-logging\jars\commons-logging-1.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\httpunit\jars\httpunit-1.6.jar;C:\Documents and Settings\halcy\.maven\repository\itext\jars\itext-0.99.jar;C:\Documents and Settings\halcy\.maven\repository\tomcat\jars\jasper-compiler-4.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\tomcat\jars\jasper-runtime-4.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\rhino\jars\js-1.5R4.1.jar;C:\Documents and Settings\halcy\.maven\repository\jstl\jars\jstl-1.0.2.jar;C:\Documents and Settings\halcy\.maven\repository\jtidy\jars\jtidy-4aug2000r7-dev.jar;C:\Documents and Settings\halcy\.maven\repository\log4j\jars\log4j-1.2.8.jar;C:\Documents and Settings\halcy\.maven\repository\nekohtml\jars\nekohtml-0.9.1.jar;C:\Documents and Settings\halcy\.maven\repository\ognl\jars\ognl-2.6.5.jar;C:\Documents and Settings\halcy\.maven\repository\opensymphony\jars\oscore-2.2.4.jar;C:\Documents and Settings\halcy\.maven\repository\servletapi\jars\servletapi-2.3.jar;C:\Documents and Settings\halcy\.maven\repository\springframework\jars\spring-1.1.1.jar;C:\Documents and Settings\halcy\.maven\repository\taglibs\jars\standard-1.0.4.jar;C:\Documents and Settings\halcy\.maven\repository\struts\jars\struts-1.2.4.jar;C:\Java\jdk1.5.0_01\lib\tools.jar;C:\Documents and Settings\halcy\.maven\repository\opensymphony\jars\webwork-2.1.5.jar;C:\Documents and Settings\halcy\.maven\repository\xerces\jars\xerces-2.4.0.jar;C:\Documents and Settings\halcy\.maven\repository\xml-apis\jars\xml-apis-1.0.b2.jar;C:\Documents and Settings\halcy\.maven\repository\opensymphony\jars\xwork-1.0.3.jar;C:\Documents and Settings\halcy\.maven\repository\junit\jars\junit-3.8.1.jar;C:\projects\TECAS\Webapp\src\lib\commons-lang-2.0.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\activation.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\ant.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-collections.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-dbcp-1.1.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-el.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-logging-api.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-logging.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\commons-pool-1.1.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jasper-compiler.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jasper-runtime.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jsp-api.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\jta.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\log4j-1.2.8.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\mail.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\mysql-connector-java-3.0.14-production-bin.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-common.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-factory.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-java.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\naming-resources.jar;C:\Java\jakarta-tomcat-5.0.24\common\lib\servlet-api.jar;C:\Program Files\IntelliJ-IDEA-4.5\lib\idea_rt.jar, user.name=halcy, hibernate.show_sql=true, java.vm.specification.version=1.0, java.home=C:\Java\jdk1.5.0_01\jre, sun.arch.data.model=32, hibernate.dialect=org.hibernate.dialect.HSQLDialect, user.language=en, java.specification.vendor=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_01, java.ext.dirs=C:\Java\jdk1.5.0_01\jre\lib\ext, sun.boot.class.path=C:\Java\jdk1.5.0_01\jre\lib\rt.jar;C:\Java\jdk1.5.0_01\jre\lib\i18n.jar;C:\Java\jdk1.5.0_01\jre\lib\sunrsasign.jar;C:\Java\jdk1.5.0_01\jre\lib\jsse.jar;C:\Java\jdk1.5.0_01\jre\lib\jce.jar;C:\Java\jdk1.5.0_01\jre\lib\charsets.jar;C:\Java\jdk1.5.0_01\jre\classes, java.vendor=Sun Microsystems Inc., file.separator=\, hibernate.connection.provider_class=org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider, idea.launcher.library=C:\Program Files\IntelliJ-IDEA-4.5\bin\breakgen.dll, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.io.unicode.encoding=UnicodeLittle, sun.cpu.endian=little, hibernate.use_outer_join=true, sun.desktop=windows, sun.cpu.isalist=pentium_pro+mmx pentium_pro pentium+mmx pentium i486 i386 i86} 2005-07-06 14:18:58,046 [INFO ] org.hibernate.tuple.EntityMetamodel - lazy property fetching available for: org.tecas.model.TestClass 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Static SQL for entity: org.tecas.model.TestClass 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Lazy select: select testclass_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass_ where testclass_.ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Version select: select ID from TEST_CLASS where ID =? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Snapshot select: select testclass_.ID, testclass_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass_ where testclass_.ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Insert 0: insert into TEST_CLASS (LAZY_STRING, ID) values (?, ?) 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Update 0: update TEST_CLASS set LAZY_STRING=? where ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Delete 0: delete from TEST_CLASS where ID=? 2005-07-06 14:18:58,250 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Identity insert: insert into TEST_CLASS (LAZY_STRING, ID) values (?, null) 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,656 [DEBUG] org.hibernate.loader.entity.EntityLoader - Static select for entity org.tecas.model.TestClass: select testclass0_.ID as ID0_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,671 [DEBUG] org.hibernate.impl.SessionFactoryObjectFactory - initializing class SessionFactoryObjectFactory 2005-07-06 14:18:58,671 [DEBUG] org.hibernate.impl.SessionFactoryObjectFactory - registered: 4028808204edcd160104edcd19ef0000 (unnamed) 2005-07-06 14:18:58,671 [INFO ] org.hibernate.impl.SessionFactoryObjectFactory - Not binding factory to JNDI, no JNDI name configured 2005-07-06 14:18:58,671 [DEBUG] org.hibernate.impl.SessionFactoryImpl - instantiated session factory 2005-07-06 14:18:58,671 [INFO ] org.hibernate.impl.SessionFactoryImpl - Checking 2 named queries 2005-07-06 14:18:58,875 [DEBUG] org.hibernate.impl.SessionFactoryImpl - Checking named query: TestClass.By.ids 2005-07-06 14:18:58,875 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - parse() - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.AST - --- HQL AST --- \-[QUERY] 'query' +-[SELECT_FROM] 'SELECT_FROM' | \-[FROM] 'from' | \-[RANGE] 'RANGE' | +-[DOT] '.' | | +-[DOT] '.' | | | +-[DOT] '.' | | | | +-[IDENT] 'org' | | | | \-[IDENT] 'tecas' | | | \-[IDENT] 'model' | | \-[IDENT] 'TestClass' | +-[ALIAS] 'tc' | \-[FETCH] 'fetch' \-[WHERE] 'where' \-[IN] 'in' +-[DOT] '.' | +-[IDENT] 'tc' | \-[IDENT] 'id' \-[IN_LIST] 'inList' \-[COLON] ':' \-[IDENT] 'ids' 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() << begin, level = 1 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.FromElement - FromClause{level=1} : org.tecas.model.TestClass (tc) -> testclass0_ 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc -> testclass0_.ID 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.DotNode - getDataType() : id -> org.hibernate.type.LongType@df83e5 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc.id -> testclass0_.ID 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() : finishing up , level = 1 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - processQuery() : ( SELECT ( FromClause{level=1} TEST_CLASS testclass0_ ) ( where ( in ( testclass0_.ID testclass0_.ID id ) ( inList ? ) ) ) ) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - Derived SELECT clause created. 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.JoinProcessor - Using FROM fragment [TEST_CLASS testclass0_] 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() >> end, level = 1 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.AST - --- SQL AST --- \-[SELECT] QueryNode: 'SELECT' querySpaces (TEST_CLASS) +-[SELECT_CLAUSE] SelectClause: '{derived select clause}' | +-[SELECT_EXPR] SelectExpressionImpl: 'testclass0_.ID as ID' {FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}}} | \-[SQL_TOKEN] SqlFragment: 'testclass0_.LAZY_STRING as LAZY2_4_' +-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[tc], fromElementByTableAlias=[testclass0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]} | \-[FROM_FRAGMENT] FromElement: 'TEST_CLASS testclass0_' FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}} \-[WHERE] SqlNode: 'where' \-[IN] SqlNode: 'in' +-[DOT] DotNode: 'testclass0_.ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=tc.id,tableAlias=testclass0_,className=org.tecas.model.TestClass,classAlias=tc} | +-[ALIAS_REF] IdentNode: 'testclass0_.ID' {alias=tc, className=org.tecas.model.TestClass, tableAlias=testclass0_} | \-[IDENT] IdentNode: 'id' {originalText=id} \-[IN_LIST] SqlNode: 'inList' \-[NAMED_PARAM] SqlNode: '?' 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - SQL: select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID in (?) 2005-07-06 14:18:58,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.impl.SessionFactoryImpl - Checking named query: TestClass.By.id 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - parse() - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id = :id 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.AST - --- HQL AST --- \-[QUERY] 'query' +-[SELECT_FROM] 'SELECT_FROM' | \-[FROM] 'from' | \-[RANGE] 'RANGE' | +-[DOT] '.' | | +-[DOT] '.' | | | +-[DOT] '.' | | | | +-[IDENT] 'org' | | | | \-[IDENT] 'tecas' | | | \-[IDENT] 'model' | | \-[IDENT] 'TestClass' | +-[ALIAS] 'tc' | \-[FETCH] 'fetch' \-[WHERE] 'where' \-[EQ] '=' +-[DOT] '.' | +-[IDENT] 'tc' | \-[IDENT] 'id' \-[COLON] ':' \-[IDENT] 'id' 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() << begin, level = 1 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.FromElement - FromClause{level=1} : org.tecas.model.TestClass (tc) -> testclass0_ 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc -> testclass0_.ID 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.DotNode - getDataType() : id -> org.hibernate.type.LongType@df83e5 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc.id -> testclass0_.ID 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() : finishing up , level = 1 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - processQuery() : ( SELECT ( FromClause{level=1} TEST_CLASS testclass0_ ) ( where ( = ( testclass0_.ID testclass0_.ID id ) ? ) ) ) 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - Derived SELECT clause created. 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.JoinProcessor - Using FROM fragment [TEST_CLASS testclass0_] 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() >> end, level = 1 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.AST - --- SQL AST --- \-[SELECT] QueryNode: 'SELECT' querySpaces (TEST_CLASS) +-[SELECT_CLAUSE] SelectClause: '{derived select clause}' | +-[SELECT_EXPR] SelectExpressionImpl: 'testclass0_.ID as ID' {FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}}} | \-[SQL_TOKEN] SqlFragment: 'testclass0_.LAZY_STRING as LAZY2_4_' +-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[tc], fromElementByTableAlias=[testclass0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]} | \-[FROM_FRAGMENT] FromElement: 'TEST_CLASS testclass0_' FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}} \-[WHERE] SqlNode: 'where' \-[EQ] SqlNode: '=' +-[DOT] DotNode: 'testclass0_.ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=tc.id,tableAlias=testclass0_,className=org.tecas.model.TestClass,classAlias=tc} | +-[ALIAS_REF] IdentNode: 'testclass0_.ID' {alias=tc, className=org.tecas.model.TestClass, tableAlias=testclass0_} | \-[IDENT] IdentNode: 'id' {originalText=id} \-[NAMED_PARAM] SqlNode: '?' 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id = :id 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - SQL: select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:58,937 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open PreparedStatement (open PreparedStatements: 0, globally: 0) 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.jdbc.ConnectionManager - opening JDBC connection 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.SQL - select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID=? 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.jdbc.AbstractBatcher - preparing statement 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.loader.hql.QueryLoader - bindNamedParameters() 1 -> id [1] 2005-07-06 14:18:59,765 [DEBUG] org.hibernate.type.LongType - binding '1' to parameter: 1 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open ResultSet (open ResultSets: 0, globally: 0) 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - processing result set 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - result set row: 0 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.type.LongType - returning '1' as column: ID 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - result row: EntityKey[org.tecas.model.TestClass#1] 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.loader.Loader - Initializing object from ResultSet: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Hydrating entity: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,781 [DEBUG] org.hibernate.type.StringType - returning 'HIHI' as column: LAZY2_4_ 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.loader.Loader - done processing result set (1 rows) 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close ResultSet (open ResultSets: 1, globally: 1) 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close PreparedStatement (open PreparedStatements: 1, globally: 1) 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.AbstractBatcher - closing statement 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.loader.Loader - total objects hydrated: 1 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.engine.TwoPhaseLoad - resolving associations for [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.engine.TwoPhaseLoad - done materializing entity [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.engine.PersistenceContext - initializing non-lazy collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.JDBCContext - after autocommit 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - flushing session 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - processing flush-time cascades 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - dirty checking collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushing entities and processing referenced collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Processing unreferenced collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Scheduling collection removes/(re)creates/updates 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.pretty.Printer - listing entities: 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.pretty.Printer - org.tecas.model.TestClass{lazyString=<lazy>, id=1} 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - executing flush 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - post flush 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.impl.SessionImpl - closing session 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.ConnectionManager - closing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)] 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.jdbc.JDBCContext - after transaction completion 2005-07-06 14:18:59,796 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,812 [ERROR] org.hibernate.LazyInitializationException - session is not connected org.hibernate.LazyInitializationException: session is not connected at org.hibernate.intercept.FieldInterceptor.intercept(FieldInterceptor.java:54) at org.hibernate.intercept.FieldInterceptor.readObject(FieldInterceptor.java:113) at org.tecas.model.TestClass.$cglib_read_lazyString(TestClass.java) at org.tecas.model.TestClass.getLazyString(TestClass.java:21) at org.tecas.dao.TestClassDaoTest.testGetTestClass(TestClassDaoTest.java:25) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at junit.framework.TestCase.runTest(TestCase.java:154) at junit.framework.TestCase.runBare(TestCase.java:127) at junit.framework.TestResult$1.protect(TestResult.java:106) at junit.framework.TestResult.runProtected(TestResult.java:124) at junit.framework.TestResult.run(TestResult.java:109) at junit.framework.TestCase.run(TestCase.java:118) at junit.framework.TestSuite.runTest(TestSuite.java:208) at junit.framework.TestSuite.run(TestSuite.java:203) at junit.textui.TestRunner.doRun(TestRunner.java:116) at com.intellij.rt.execution.junit2.IdeaJUnitAgent.doRun(IdeaJUnitAgent.java:57) at junit.textui.TestRunner.start(TestRunner.java:172) at com.intellij.rt.execution.junit.TextTestRunner2.startRunnerWithArgs(TextTestRunner2.java:23) at com.intellij.rt.execution.junit2.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:97) at com.intellij.rt.execution.junit2.JUnitStarter.main(JUnitStarter.java:31) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at com.intellij.rt.execution.application.AppMain.main(AppMain.java:78) 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.impl.SessionImpl - opened session at timestamp: 4590309948796928 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.impl.SessionImpl - find: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids0_, :ids1_) 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.engine.QueryParameters - named parameters: {ids0_=2, ids1_=1} 2005-07-06 14:18:59,843 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - parse() - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids0_, :ids1_) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.AST - --- HQL AST --- \-[QUERY] 'query' +-[SELECT_FROM] 'SELECT_FROM' | \-[FROM] 'from' | \-[RANGE] 'RANGE' | +-[DOT] '.' | | +-[DOT] '.' | | | +-[DOT] '.' | | | | +-[IDENT] 'org' | | | | \-[IDENT] 'tecas' | | | \-[IDENT] 'model' | | \-[IDENT] 'TestClass' | +-[ALIAS] 'tc' | \-[FETCH] 'fetch' \-[WHERE] 'where' \-[IN] 'in' +-[DOT] '.' | +-[IDENT] 'tc' | \-[IDENT] 'id' \-[IN_LIST] 'inList' +-[COLON] ':' | \-[IDENT] 'ids0_' \-[COLON] ':' \-[IDENT] 'ids1_' 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() << begin, level = 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.FromElement - FromClause{level=1} : org.tecas.model.TestClass (tc) -> testclass0_ 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc -> testclass0_.ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.DotNode - getDataType() : id -> org.hibernate.type.LongType@df83e5 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.FromReferenceNode - Resolved : tc.id -> testclass0_.ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() : finishing up , level = 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - processQuery() : ( SELECT ( FromClause{level=1} TEST_CLASS testclass0_ ) ( where ( in ( testclass0_.ID testclass0_.ID id ) ( inList ? ? ) ) ) ) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.HqlSqlWalker - Derived SELECT clause created. 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.JoinProcessor - Using FROM fragment [TEST_CLASS testclass0_] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.antlr.HqlSqlBaseWalker - query() >> end, level = 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.AST - --- SQL AST --- \-[SELECT] QueryNode: 'SELECT' querySpaces (TEST_CLASS) +-[SELECT_CLAUSE] SelectClause: '{derived select clause}' | +-[SELECT_EXPR] SelectExpressionImpl: 'testclass0_.ID as ID' {FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}}} | \-[SQL_TOKEN] SqlFragment: 'testclass0_.LAZY_STRING as LAZY2_4_' +-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[tc], fromElementByTableAlias=[testclass0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]} | \-[FROM_FRAGMENT] FromElement: 'TEST_CLASS testclass0_' FromElement{explicit,not a collection join,not a fetch join,fetch all properties,classAlias=tc,role=null,tableName=TEST_CLASS,tableAlias=testclass0_,colums={,className=org.tecas.model.TestClass}} \-[WHERE] SqlNode: 'where' \-[IN] SqlNode: 'in' +-[DOT] DotNode: 'testclass0_.ID' {propertyName=id,dereferenceType=4,propertyPath=id,path=tc.id,tableAlias=testclass0_,className=org.tecas.model.TestClass,classAlias=tc} | +-[ALIAS_REF] IdentNode: 'testclass0_.ID' {alias=tc, className=org.tecas.model.TestClass, tableAlias=testclass0_} | \-[IDENT] IdentNode: 'id' {originalText=id} \-[IN_LIST] SqlNode: 'inList' +-[NAMED_PARAM] SqlNode: '?' \-[NAMED_PARAM] SqlNode: '?' 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - HQL: from org.tecas.model.TestClass tc fetch all properties where tc.id in (:ids0_, :ids1_) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.QueryTranslatorImpl - SQL: select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID in (? , ?) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.hql.ast.ErrorCounter - throwQueryException() : no errors 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open PreparedStatement (open PreparedStatements: 0, globally: 0) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.ConnectionManager - opening JDBC connection 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.SQL - select testclass0_.ID as ID, testclass0_.LAZY_STRING as LAZY2_4_ from TEST_CLASS testclass0_ where testclass0_.ID in (? , ?) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - preparing statement 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.hql.QueryLoader - bindNamedParameters() 2 -> ids0_ [1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - binding '2' to parameter: 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.hql.QueryLoader - bindNamedParameters() 1 -> ids1_ [2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - binding '1' to parameter: 2 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to open ResultSet (open ResultSets: 0, globally: 0) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - processing result set 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result set row: 0 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - returning '1' as column: ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result row: EntityKey[org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - Initializing object from ResultSet: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Hydrating entity: [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.StringType - returning 'HIHI' as column: LAZY2_4_ 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result set row: 1 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.LongType - returning '2' as column: ID 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - result row: EntityKey[org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - Initializing object from ResultSet: [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.persister.entity.BasicEntityPersister - Hydrating entity: [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.type.StringType - returning 'IHIH' as column: LAZY2_4_ 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - done processing result set (2 rows) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close ResultSet (open ResultSets: 1, globally: 1) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - about to close PreparedStatement (open PreparedStatements: 1, globally: 1) 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.AbstractBatcher - closing statement 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.loader.Loader - total objects hydrated: 2 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - resolving associations for [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - done materializing entity [org.tecas.model.TestClass#1] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - resolving associations for [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.TwoPhaseLoad - done materializing entity [org.tecas.model.TestClass#2] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.engine.PersistenceContext - initializing non-lazy collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.JDBCContext - after autocommit 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - flushing session 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - processing flush-time cascades 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - dirty checking collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushing entities and processing referenced collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Processing unreferenced collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Scheduling collection removes/(re)creates/updates 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 insertions, 0 updates, 0 deletions to 2 objects 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.pretty.Printer - listing entities: 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.pretty.Printer - org.tecas.model.TestClass{lazyString=<lazy>, id=2} 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.pretty.Printer - org.tecas.model.TestClass{lazyString=<lazy>, id=1} 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - executing flush 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.event.def.AbstractFlushingEventListener - post flush 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.impl.SessionImpl - closing session 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.ConnectionManager - closing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)] 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.jdbc.JDBCContext - after transaction completion 2005-07-06 14:18:59,890 [DEBUG] org.hibernate.impl.SessionImpl - after transaction completion 2005-07-06 14:18:59,890 [ERROR] org.hibernate.LazyInitializationException - session is not connected org.hibernate.LazyInitializationException: session is not connected at org.hibernate.intercept.FieldInterceptor.intercept(FieldInterceptor.java:54) at org.hibernate.intercept.FieldInterceptor.readObject(FieldInterceptor.java:113) at org.tecas.model.TestClass.$cglib_read_lazyString(TestClass.java) at org.tecas.model.TestClass.getLazyString(TestClass.java:21) at org.tecas.dao.TestClassDaoTest.testGetTestClasses(TestClassDaoTest.java:37) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at junit.framework.TestCase.runTest(TestCase.java:154) at junit.framework.TestCase.runBare(TestCase.java:127) at junit.framework.TestResult$1.protect(TestResult.java:106) at junit.framework.TestResult.runProtected(TestResult.java:124) at junit.framework.TestResult.run(TestResult.java:109) at junit.framework.TestCase.run(TestCase.java:118) at junit.framework.TestSuite.runTest(TestSuite.java:208) at junit.framework.TestSuite.run(TestSuite.java:203) at junit.textui.TestRunner.doRun(TestRunner.java:116) at com.intellij.rt.execution.junit2.IdeaJUnitAgent.doRun(IdeaJUnitAgent.java:57) at junit.textui.TestRunner.start(TestRunner.java:172) at com.intellij.rt.execution.junit.TextTestRunner2.startRunnerWithArgs(TextTestRunner2.java:23) at com.intellij.rt.execution.junit2.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:97) at com.intellij.rt.execution.junit2.JUnitStarter.main(JUnitStarter.java:31) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:585) at com.intellij.rt.execution.application.AppMain.main(AppMain.java:78)

    Hibernate JIRA | 1 decade ago | David Erickson
    org.hibernate.LazyInitializationException: session is not connected
  3. 0

    Does StatelessSession support lazy loading?

    Stack Overflow | 11 months ago | Bogdan Calmac
    org.hibernate.LazyInitializationException: could not initialize proxy - the owning Session is disconnected
  4. Speed up your debug routine!

    Automated exception search integrated into your IDE

  5. 0

    RequestFactory persist() error with hibernate

    Google Groups | 6 years ago | Emanuele Righetto
    org.hibernate.LazyInitializationException: could not initialize proxy - no Session
  6. 0

    Illegal attempt to associate a collection with two open sessions_IT知识问答_希赛网

    educity.cn | 11 months ago
    org.hibernate.LazyInitializationException: could not initialize proxy - no Session

    Not finding the right solution?
    Take a tour to get the most out of Samebug.

    Tired of useless tips?

    Automated exception search integrated into your IDE

    Root Cause Analysis

    1. org.hibernate.LazyInitializationException

      session is not connected

      at org.hibernate.intercept.FieldInterceptor.intercept()
    2. Hibernate
      FieldInterceptor.readObject
      1. org.hibernate.intercept.FieldInterceptor.intercept(FieldInterceptor.java:54)
      2. org.hibernate.intercept.FieldInterceptor.readObject(FieldInterceptor.java:113)
      2 frames
    3. org.tecas.model
      TestClass.getLazyString
      1. org.tecas.model.TestClass.$cglib_read_lazyString(TestClass.java)
      2. org.tecas.model.TestClass.getLazyString(TestClass.java:21)
      2 frames
    4. org.tecas.dao
      TestClassDaoTest.testGetTestClasses
      1. org.tecas.dao.TestClassDaoTest.testGetTestClasses(TestClassDaoTest.java:37)
      1 frame
    5. Java RT
      Method.invoke
      1. sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      2. sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      3. sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      4. java.lang.reflect.Method.invoke(Method.java:585)
      4 frames
    6. JUnit
      TestRunner.doRun
      1. junit.framework.TestCase.runTest(TestCase.java:154)
      2. junit.framework.TestCase.runBare(TestCase.java:127)
      3. junit.framework.TestResult$1.protect(TestResult.java:106)
      4. junit.framework.TestResult.runProtected(TestResult.java:124)
      5. junit.framework.TestResult.run(TestResult.java:109)
      6. junit.framework.TestCase.run(TestCase.java:118)
      7. junit.framework.TestSuite.runTest(TestSuite.java:208)
      8. junit.framework.TestSuite.run(TestSuite.java:203)
      9. junit.textui.TestRunner.doRun(TestRunner.java:116)
      9 frames
    7. com.intellij.rt
      IdeaJUnitAgent.doRun
      1. com.intellij.rt.execution.junit2.IdeaJUnitAgent.doRun(IdeaJUnitAgent.java:57)
      1 frame
    8. JUnit
      TestRunner.start
      1. junit.textui.TestRunner.start(TestRunner.java:172)
      1 frame
    9. IDEA
      TextTestRunner2.startRunnerWithArgs
      1. com.intellij.rt.execution.junit.TextTestRunner2.startRunnerWithArgs(TextTestRunner2.java:23)
      1 frame
    10. com.intellij.rt
      JUnitStarter.main
      1. com.intellij.rt.execution.junit2.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:97)
      2. com.intellij.rt.execution.junit2.JUnitStarter.main(JUnitStarter.java:31)
      2 frames
    11. Java RT
      Method.invoke
      1. sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      2. sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      3. sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      4. java.lang.reflect.Method.invoke(Method.java:585)
      4 frames
    12. IDEA
      AppMain.main
      1. com.intellij.rt.execution.application.AppMain.main(AppMain.java:78)
      1 frame