One-to-One Lazy it does not run !!

Kenobi · **Posted:** Fri Mar 02, 2007 2:57 pm

Need help with Hibernate? Read this first:
http://www.hibernate.org/ForumMailingli ... AskForHelp

Hibernate version: 3.2.2

Mapping documents:

Code:

 

<?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="testes.testeTO"
      table="TESTE"
      dynamic-update="true"
      dynamic-insert="true">

      <id name="id" type="java.lang.Long" column="ID_TESTE">
         <generator
            class="native" />
      </id>

      <property
         name="name"
         column="NM_NAME"
         type="java.lang.String"
         update="true"
         insert="true"
      />

      <one-to-one name="sup" class="testes.suplementoTO"  lazy="proxy"  outer-join="false" constrained="true"/>

   </class>

</hibernate-mapping>

Code:

<?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="testes.suplementoTO"
      table="TESTESUP"
      dynamic-update="true"
      dynamic-insert="true"
      lazy="true">

      <id name="id"  type="java.lang.Long" column="ID_SUP">
         <generator class="foreign">
            <param name="property" >teste</param>
         </generator>
      </id>

      <one-to-one name="teste" class="testes.testeTO" lazy="proxy" outer-join="false"   constrained="true"/>

      <property
         name="name"
         column="NM_SUP"
         type="java.lang.String"
         update="true"
         insert="true"
      />

   </class>

</hibernate-mapping>

Code between sessionFactory.openSession() and session.close():

Code:

 String query = "from testeTO";
      
      Collection teste = session.createQuery(query).list();
      System.out.println("Teste :" + teste.size());

Full stack trace of any exception that occurs:

Name and version of the database you are using: Oracle 9.0.2

The generated SQL (show_sql=true):

Code:

 Hibernate: select testeto0_.ID_TESTE as ID1_0_, testeto0_.NM_NAME as NM2_0_ from TESTE testeto0_
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Teste :5 

Debug level Hibernate log excerpt:

Code:

 
INFO [main] (Environment.java:509) - Hibernate 3.2.2
 INFO [main] (Environment.java:542) - hibernate.properties not found
 INFO [main] (Environment.java:676) - Bytecode provider name : cglib
 INFO [main] (Environment.java:593) - using JDK 1.4 java.sql.Timestamp handling
 INFO [main] (Configuration.java:1426) - configuring from resource: /hibernate.cfg.xml
 INFO [main] (Configuration.java:1403) - Configuration resource: /hibernate.cfg.xml
DEBUG [main] (DTDEntityResolver.java:38) - trying to resolve system-id [http://hibernate.sourceforge.net/hibernate-configuration-3.0.dtd]
DEBUG [main] (DTDEntityResolver.java:40) - recognized hibernate namespace; attempting to resolve on classpath under org/hibernate/
DEBUG [main] (DTDEntityResolver.java:50) - located [http://hibernate.sourceforge.net/hibernate-configuration-3.0.dtd] in classpath
DEBUG [main] (Configuration.java:1387) - connection.driver_class=oracle.jdbc.driver.OracleDriver
DEBUG [main] (Configuration.java:1387) - connection.url=jdbc:oracle:thin:@//172.16.1.13:1521/ORALNX01
DEBUG [main] (Configuration.java:1387) - connection.username=amplis_dv
DEBUG [main] (Configuration.java:1387) - connection.password=amp0677
DEBUG [main] (Configuration.java:1387) - show_sql=true
DEBUG [main] (Configuration.java:1387) - dialect=org.hibernate.dialect.Oracle9Dialect
DEBUG [main] (Configuration.java:1586) - null<-org.dom4j.tree.DefaultAttribute@704baa [Attribute: name resource value "testes/testeTO.hbm.xml"]
 INFO [main] (Configuration.java:553) - Reading mappings from resource : testes/testeTO.hbm.xml
DEBUG [main] (DTDEntityResolver.java:38) - trying to resolve system-id [http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd]
DEBUG [main] (DTDEntityResolver.java:40) - recognized hibernate namespace; attempting to resolve on classpath under org/hibernate/
DEBUG [main] (DTDEntityResolver.java:50) - located [http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd] in classpath
 INFO [main] (HbmBinder.java:300) - Mapping class: testes.testeTO -> TESTE
DEBUG [main] (HbmBinder.java:1270) - Mapped property: id -> ID_TESTE
DEBUG [main] (HbmBinder.java:1270) - Mapped property: name -> NM_NAME
DEBUG [main] (HbmBinder.java:1270) - Mapped property: sup
DEBUG [main] (Configuration.java:1586) - null<-org.dom4j.tree.DefaultAttribute@1865b28 [Attribute: name resource value "testes/suplementoTO.hbm.xml"]
 INFO [main] (Configuration.java:553) - Reading mappings from resource : testes/suplementoTO.hbm.xml
DEBUG [main] (DTDEntityResolver.java:38) - trying to resolve system-id [http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd]
DEBUG [main] (DTDEntityResolver.java:40) - recognized hibernate namespace; attempting to resolve on classpath under org/hibernate/
DEBUG [main] (DTDEntityResolver.java:50) - located [http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd] in classpath
 INFO [main] (HbmBinder.java:300) - Mapping class: testes.suplementoTO -> TESTESUP
DEBUG [main] (HbmBinder.java:1270) - Mapped property: id -> ID_SUP
DEBUG [main] (HbmBinder.java:1270) - Mapped property: teste
DEBUG [main] (HbmBinder.java:1270) - Mapped property: name -> NM_SUP
 INFO [main] (Configuration.java:1541) - Configured SessionFactory: null
DEBUG [main] (Configuration.java:1542) - properties: {hibernate.connection.password=amp0677, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=C:\AmbienteJava\J2SDK\jre\bin, java.vm.version=1.4.2_03-b02, hibernate.connection.username=amplis_dv, 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, user.country=BR, sun.os.patch.level=Service Pack 2, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\Temp\teste-Hiber, java.runtime.version=1.4.2_03-b02, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=C:\AmbienteJava\J2SDK\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\F3C37~1.OLI\CONFIG~1\Temp\, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows XP, sun.java2d.fontpath=, java.library.path=C:\AmbienteJava\J2SDK\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\oracle\Forms6i\bin;C:\oracle\ora92\bin;C:\Arquivos de programas\Oracle\jre\1.1.8\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Arquivos de programas\Microsoft SQL Server\80\Tools\BINN;C:\Sybase\DLL;C:\Sybase\BIN;C:\AmbienteJava\Tools\maven-2.0.4\bin;C:\oracle\Forms6i\jdk\bin;C:\Arquivos de programas\Oracle\jre\1.3.1\bin;;C:\Arquivos de programas\Arquivos comuns\GTK\2.0\bin;C:\Arquivos de programas\jEdit;C:\Arquivos de programas\QuickTime\QTSystem\, java.specification.name=Java Platform API Specification, java.class.version=48.0, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, os.version=5.1, connection.password=amp0677, user.home=C:\Documents and Settings\f.oliveira, user.timezone=, connection.username=amplis_dv, java.awt.printerjob=sun.awt.windows.WPrinterJob, file.encoding=Cp1252, java.specification.version=1.4, hibernate.connection.driver_class=oracle.jdbc.driver.OracleDriver, show_sql=true, user.name=F.Oliveira, java.class.path=C:\Temp\teste-Hiber\bin;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\antlr-2.7.6rc1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\asm-1.5.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\aspectjrt-1.2.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-chart-engine-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-core-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-dte-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-engine-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-model-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-oda-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-scriptapi-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\cactus-13-1.7.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\cglib-2.1_3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-beanutils-1.6.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-cli-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-codec-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-collections-2.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-dbcp-1.2.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-digester-1.6.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-fileupload-1.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-httpclient-2.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-io-1.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-lang-2.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-logging-1.0.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-pool-1.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\dom4j-1.6.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\ehcache-1.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\flute-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\gwt-servlet-1.1.10.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\gwt-user-1.1.10.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\gwt-widgets-0.1.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\itext-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\j2ee-1.3.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jboss-backport-concurrent-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jbossretro-rt-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jbossws14-client-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jdom-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\js-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jta-1.0.1B.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\junit-3.8.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\log4j-1.2.9.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\oda-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\odaconsumer-helper-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\ojdbc14-9.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\org.eclipse.emf.common-2.1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\org.eclipse.emf.ecore.xmi-2.1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\org.eclipse.emf.ecore-2.1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\sac-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\saxpath-1.0-FCS.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\spring-1.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\Tidy-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\xercesImpl-2.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\xml-apis-1.0.b2.jar;C:\Temp\hibernate3.2.jar, hibernate.bytecode.use_reflection_optimizer=false, hibernate.show_sql=true, java.vm.specification.version=1.0, java.home=C:\AmbienteJava\J2SDK\jre, sun.arch.data.model=32, hibernate.dialect=org.hibernate.dialect.Oracle9Dialect, hibernate.connection.url=jdbc:oracle:thin:@//172.16.1.13:1521/ORALNX01, user.language=pt, java.specification.vendor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, java.vm.info=mixed mode, java.version=1.4.2_03, java.ext.dirs=C:\AmbienteJava\J2SDK\jre\lib\ext, sun.boot.class.path=C:\AmbienteJava\J2SDK\jre\lib\endorsed\xalan.jar;C:\AmbienteJava\J2SDK\jre\lib\endorsed\xercesImpl.jar;C:\AmbienteJava\J2SDK\jre\lib\endorsed\xml-apis.jar;C:\AmbienteJava\J2SDK\jre\lib\rt.jar;C:\AmbienteJava\J2SDK\jre\lib\i18n.jar;C:\AmbienteJava\J2SDK\jre\lib\sunrsasign.jar;C:\AmbienteJava\J2SDK\jre\lib\jsse.jar;C:\AmbienteJava\J2SDK\jre\lib\jce.jar;C:\AmbienteJava\J2SDK\jre\lib\charsets.jar;C:\AmbienteJava\J2SDK\jre\classes, java.vendor=Sun Microsystems Inc., connection.driver_class=oracle.jdbc.driver.OracleDriver, file.separator=\, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.io.unicode.encoding=UnicodeLittle, sun.cpu.endian=little, connection.url=jdbc:oracle:thin:@//172.16.1.13:1521/ORALNX01, dialect=org.hibernate.dialect.Oracle9Dialect, sun.cpu.isalist=pentium i486 i386}
DEBUG [main] (Configuration.java:1285) - Preparing to build session factory with filters : {}
DEBUG [main] (Configuration.java:1120) - processing extends queue
DEBUG [main] (Configuration.java:1124) - processing collection mappings
DEBUG [main] (Configuration.java:1135) - processing native query and ResultSetMapping mappings
DEBUG [main] (Configuration.java:1143) - processing association property references
DEBUG [main] (Configuration.java:1165) - processing foreign key constraints
DEBUG [main] (Configuration.java:1248) - resolving reference to class: testes.suplementoTO
DEBUG [main] (Configuration.java:1248) - resolving reference to class: testes.testeTO
 INFO [main] (DriverManagerConnectionProvider.java:41) - Using Hibernate built-in connection pool (not for production use!)
 INFO [main] (DriverManagerConnectionProvider.java:42) - Hibernate connection pool size: 20
 INFO [main] (DriverManagerConnectionProvider.java:45) - autocommit mode: false
 INFO [main] (DriverManagerConnectionProvider.java:80) - using driver: oracle.jdbc.driver.OracleDriver at URL: jdbc:oracle:thin:@//172.16.1.13:1521/ORALNX01
 INFO [main] (DriverManagerConnectionProvider.java:83) - connection properties: {user=amplis_dv, password=amp0677}
DEBUG [main] (DriverManagerConnectionProvider.java:93) - total checked-out connections: 0
DEBUG [main] (DriverManagerConnectionProvider.java:109) - opening new JDBC connection
DEBUG [main] (DriverManagerConnectionProvider.java:115) - created connection to: jdbc:oracle:thin:@//172.16.1.13:1521/ORALNX01, Isolation Level: 2
DEBUG [main] (SettingsFactory.java:343) - could not get database version from JDBC metadata
 INFO [main] (SettingsFactory.java:89) - RDBMS: Oracle, version: Oracle9i Enterprise Edition Release 9.2.0.6.0 - Production
JServer Release 9.2.0.6.0 - Production
 INFO [main] (SettingsFactory.java:90) - JDBC driver: Oracle JDBC driver, version: 9.2.0.1.0
DEBUG [main] (DriverManagerConnectionProvider.java:129) - returning connection to pool, pool size: 1
 INFO [main] (Dialect.java:152) - Using dialect: org.hibernate.dialect.Oracle9Dialect
 INFO [main] (TransactionFactoryFactory.java:31) - Using default transaction strategy (direct JDBC transactions)
 INFO [main] (TransactionManagerLookupFactory.java:33) - No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended)
 INFO [main] (SettingsFactory.java:143) - Automatic flush during beforeCompletion(): disabled
 INFO [main] (SettingsFactory.java:147) - Automatic session close at end of transaction: disabled
 INFO [main] (SettingsFactory.java:154) - JDBC batch size: 15
 INFO [main] (SettingsFactory.java:157) - JDBC batch updates for versioned data: disabled
 INFO [main] (SettingsFactory.java:162) - Scrollable result sets: enabled
DEBUG [main] (SettingsFactory.java:166) - Wrap result sets: disabled
 INFO [main] (SettingsFactory.java:170) - JDBC3 getGeneratedKeys(): disabled
 INFO [main] (SettingsFactory.java:178) - Connection release mode: auto
 INFO [main] (SettingsFactory.java:205) - Default batch fetch size: 1
 INFO [main] (SettingsFactory.java:209) - Generate SQL with comments: disabled
 INFO [main] (SettingsFactory.java:213) - Order SQL updates by primary key: disabled
 INFO [main] (SettingsFactory.java:382) - Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
 INFO [main] (ASTQueryTranslatorFactory.java:24) - Using ASTQueryTranslatorFactory
 INFO [main] (SettingsFactory.java:221) - Query language substitutions: {}
 INFO [main] (SettingsFactory.java:226) - JPA-QL strict compliance: disabled
 INFO [main] (SettingsFactory.java:231) - Second-level cache: enabled
 INFO [main] (SettingsFactory.java:235) - Query cache: disabled
 INFO [main] (SettingsFactory.java:369) - Cache provider: org.hibernate.cache.NoCacheProvider
 INFO [main] (SettingsFactory.java:250) - Optimize cache for minimal puts: disabled
 INFO [main] (SettingsFactory.java:259) - Structured second-level cache entries: disabled
DEBUG [main] (SQLExceptionConverterFactory.java:52) - Using dialect defined converter
 INFO [main] (SettingsFactory.java:279) - Echoing all SQL to stdout
 INFO [main] (SettingsFactory.java:286) - Statistics: disabled
 INFO [main] (SettingsFactory.java:290) - Deleted entity synthetic identifier rollback: disabled
 INFO [main] (SettingsFactory.java:305) - Default entity-mode: pojo
 INFO [main] (SettingsFactory.java:309) - Named query checking : enabled
 INFO [main] (SessionFactoryImpl.java:161) - building session factory
DEBUG [main] (SessionFactoryImpl.java:173) - Session factory constructed with filter configurations : {}
DEBUG [main] (SessionFactoryImpl.java:177) - instantiating session factory with properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, hibernate.connection.password=amp0677, sun.boot.library.path=C:\AmbienteJava\J2SDK\jre\bin, java.vm.version=1.4.2_03-b02, hibernate.connection.username=amplis_dv, 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, user.country=BR, sun.os.patch.level=Service Pack 2, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\Temp\teste-Hiber, java.runtime.version=1.4.2_03-b02, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=C:\AmbienteJava\J2SDK\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\F3C37~1.OLI\CONFIG~1\Temp\, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows XP, sun.java2d.fontpath=, java.library.path=C:\AmbienteJava\J2SDK\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\oracle\Forms6i\bin;C:\oracle\ora92\bin;C:\Arquivos de programas\Oracle\jre\1.1.8\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Arquivos de programas\Microsoft SQL Server\80\Tools\BINN;C:\Sybase\DLL;C:\Sybase\BIN;C:\AmbienteJava\Tools\maven-2.0.4\bin;C:\oracle\Forms6i\jdk\bin;C:\Arquivos de programas\Oracle\jre\1.3.1\bin;;C:\Arquivos de programas\Arquivos comuns\GTK\2.0\bin;C:\Arquivos de programas\jEdit;C:\Arquivos de programas\QuickTime\QTSystem\, java.specification.name=Java Platform API Specification, java.class.version=48.0, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, os.version=5.1, user.home=C:\Documents and Settings\f.oliveira, connection.password=amp0677, user.timezone=, java.awt.printerjob=sun.awt.windows.WPrinterJob, connection.username=amplis_dv, java.specification.version=1.4, file.encoding=Cp1252, hibernate.connection.driver_class=oracle.jdbc.driver.OracleDriver, show_sql=true, java.class.path=C:\Temp\teste-Hiber\bin;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\antlr-2.7.6rc1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\asm-1.5.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\aspectjrt-1.2.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-chart-engine-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-core-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-dte-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-engine-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-model-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-oda-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\birt-scriptapi-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\cactus-13-1.7.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\cglib-2.1_3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-beanutils-1.6.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-cli-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-codec-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-collections-2.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-dbcp-1.2.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-digester-1.6.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-fileupload-1.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-httpclient-2.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-io-1.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-lang-2.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-logging-1.0.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\commons-pool-1.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\dom4j-1.6.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\ehcache-1.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\flute-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\gwt-servlet-1.1.10.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\gwt-user-1.1.10.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\gwt-widgets-0.1.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\itext-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\j2ee-1.3.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jboss-backport-concurrent-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jbossretro-rt-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jbossws14-client-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jdom-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\js-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\jta-1.0.1B.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\junit-3.8.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\log4j-1.2.9.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\oda-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\odaconsumer-helper-2.0.1.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\ojdbc14-9.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\org.eclipse.emf.common-2.1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\org.eclipse.emf.ecore.xmi-2.1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\org.eclipse.emf.ecore-2.1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\sac-1.3.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\saxpath-1.0-FCS.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\spring-1.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\Tidy-1.0.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\xercesImpl-2.0.2.jar;C:\AmbienteJava\workspace\ymf-library\target\ymf-library-core\xml-apis-1.0.b2.jar;C:\Temp\hibernate3.2.jar, user.name=F.Oliveira, hibernate.bytecode.use_reflection_optimizer=false, hibernate.show_sql=true, java.vm.specification.version=1.0, sun.arch.data.model=32, java.home=C:\AmbienteJava\J2SDK\jre, hibernate.connection.url=jdbc:oracle:thin:@//172.16.1.13:1521/ORALNX01, hibernate.dialect=org.hibernate.dialect.Oracle9Dialect, java.specification.vendor=Sun Microsystems Inc., user.language=pt, awt.toolkit=sun.awt.windows.WToolkit, java.vm.info=mixed mode, java.version=1.4.2_03, java.ext.dirs=C:\AmbienteJava\J2SDK\jre\lib\ext, sun.boot.class.path=C:\AmbienteJava\J2SDK\jre\lib\endorsed\xalan.jar;C:\AmbienteJava\J2SDK\jre\lib\endorsed\xercesImpl.jar;C:\AmbienteJava\J2SDK\jre\lib\endorsed\xml-apis.jar;C:\AmbienteJava\J2SDK\jre\lib\rt.jar;C:\AmbienteJava\J2SDK\jre\lib\i18n.jar;C:\AmbienteJava\J2SDK\jre\lib\sunrsasign.jar;C:\AmbienteJava\J2SDK\jre\lib\jsse.jar;C:\AmbienteJava\J2SDK\jre\lib\jce.jar;C:\AmbienteJava\J2SDK\jre\lib\charsets.jar;C:\AmbienteJava\J2SDK\jre\classes, java.vendor=Sun Microsystems Inc., file.separator=\, connection.driver_class=oracle.jdbc.driver.OracleDriver, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, sun.cpu.endian=little, sun.io.unicode.encoding=UnicodeLittle, connection.url=jdbc:oracle:thin:@//172.16.1.13:1521/ORALNX01, sun.cpu.isalist=pentium i486 i386, dialect=org.hibernate.dialect.Oracle9Dialect}
DEBUG [main] (AbstractEntityPersister.java:2734) - Static SQL for entity: testes.testeTO
DEBUG [main] (AbstractEntityPersister.java:2739) -  Version select: select ID_TESTE from TESTE where ID_TESTE =?
DEBUG [main] (AbstractEntityPersister.java:2742) -  Snapshot select: select testeto_.ID_TESTE, testeto_.NM_NAME as NM2_0_ from TESTE testeto_ where testeto_.ID_TESTE=?
DEBUG [main] (AbstractEntityPersister.java:2745) -  Insert 0: insert into TESTE (NM_NAME, ID_TESTE) values (?, ?)
DEBUG [main] (AbstractEntityPersister.java:2746) -  Update 0: update TESTE set NM_NAME=? where ID_TESTE=?
DEBUG [main] (AbstractEntityPersister.java:2747) -  Delete 0: delete from TESTE where ID_TESTE=?
DEBUG [main] (AbstractEntityPersister.java:2734) - Static SQL for entity: testes.suplementoTO
DEBUG [main] (AbstractEntityPersister.java:2739) -  Version select: select ID_SUP from TESTESUP where ID_SUP =?
DEBUG [main] (AbstractEntityPersister.java:2742) -  Snapshot select: select suplemento_.ID_SUP, suplemento_.NM_SUP as NM2_1_ from TESTESUP suplemento_ where suplemento_.ID_SUP=?
DEBUG [main] (AbstractEntityPersister.java:2745) -  Insert 0: insert into TESTESUP (NM_SUP, ID_SUP) values (?, ?)
DEBUG [main] (AbstractEntityPersister.java:2746) -  Update 0: update TESTESUP set NM_SUP=? where ID_SUP=?
DEBUG [main] (AbstractEntityPersister.java:2747) -  Delete 0: delete from TESTESUP where ID_SUP=?
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.testeTO: select testeto0_.ID_TESTE as ID1_0_0_, testeto0_.NM_NAME as NM2_0_0_ from TESTE testeto0_ where testeto0_.ID_TESTE=?
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.testeTO: select testeto0_.ID_TESTE as ID1_0_0_, testeto0_.NM_NAME as NM2_0_0_ from TESTE testeto0_ where testeto0_.ID_TESTE=?
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.testeTO: select testeto0_.ID_TESTE as ID1_0_0_, testeto0_.NM_NAME as NM2_0_0_ from TESTE testeto0_ where testeto0_.ID_TESTE=? for update
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.testeTO: select testeto0_.ID_TESTE as ID1_0_0_, testeto0_.NM_NAME as NM2_0_0_ from TESTE testeto0_ where testeto0_.ID_TESTE=? for update nowait
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.testeTO: select testeto0_.ID_TESTE as ID1_0_0_, testeto0_.NM_NAME as NM2_0_0_ from TESTE testeto0_ where testeto0_.ID_TESTE=? for update nowait
DEBUG [main] (CascadeEntityLoader.java:34) - Static select for action ACTION_MERGE on entity testes.testeTO: select testeto0_.ID_TESTE as ID1_0_0_, testeto0_.NM_NAME as NM2_0_0_ from TESTE testeto0_ where testeto0_.ID_TESTE=?
DEBUG [main] (CascadeEntityLoader.java:34) - Static select for action ACTION_REFRESH on entity testes.testeTO: select testeto0_.ID_TESTE as ID1_0_0_, testeto0_.NM_NAME as NM2_0_0_ from TESTE testeto0_ where testeto0_.ID_TESTE=?
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.suplementoTO: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.suplementoTO: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.suplementoTO: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=? for update
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.suplementoTO: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=? for update nowait
DEBUG [main] (EntityLoader.java:79) - Static select for entity testes.suplementoTO: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=? for update nowait
DEBUG [main] (CascadeEntityLoader.java:34) - Static select for action ACTION_MERGE on entity testes.suplementoTO: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (CascadeEntityLoader.java:34) - Static select for action ACTION_REFRESH on entity testes.suplementoTO: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (SessionFactoryObjectFactory.java:39) - initializing class SessionFactoryObjectFactory
DEBUG [main] (SessionFactoryObjectFactory.java:76) - registered: 2c90970c1113f7cb011113f7cd5e0000 (unnamed)
 INFO [main] (SessionFactoryObjectFactory.java:82) - Not binding factory to JNDI, no JNDI name configured
DEBUG [main] (SessionFactoryImpl.java:308) - instantiated session factory
DEBUG [main] (SessionFactoryImpl.java:392) - Checking 0 named HQL queries
DEBUG [main] (SessionFactoryImpl.java:412) - Checking 0 named SQL queries
DEBUG [main] (SessionImpl.java:220) - opened session at timestamp: 11728610788
DEBUG [main] (QueryPlanCache.java:70) - unable to locate HQL query plan in cache; generating (from testeTO)
DEBUG [main] (QueryTranslatorImpl.java:246) - parse() - HQL: from testes.testeTO
DEBUG [main] (QueryTranslatorImpl.java:266) - --- HQL AST ---
 \-[QUERY] 'query'
    \-[SELECT_FROM] 'SELECT_FROM'
       \-[FROM] 'from'
          \-[RANGE] 'RANGE'
             \-[DOT] '.'
                +-[IDENT] 'testes'
                \-[IDENT] 'testeTO'

DEBUG [main] (ErrorCounter.java:68) - throwQueryException() : no errors
DEBUG [main] (HqlSqlBaseWalker.java:111) - select << begin [level=1, statement=select]
DEBUG [main] (FromElement.java:108) - FromClause{level=1} :  testes.testeTO (no alias) -> testeto0_
DEBUG [main] (HqlSqlBaseWalker.java:117) - select : finishing up [level=1, statement=select]
DEBUG [main] (HqlSqlWalker.java:509) - processQuery() :  ( SELECT ( FromClause{level=1} TESTE testeto0_ ) )
DEBUG [main] (HqlSqlWalker.java:716) - Derived SELECT clause created.
DEBUG [main] (JoinProcessor.java:148) - Using FROM fragment [TESTE testeto0_]
DEBUG [main] (HqlSqlBaseWalker.java:123) - select >> end [level=1, statement=select]
DEBUG [main] (QueryTranslatorImpl.java:232) - --- SQL AST ---
 \-[SELECT] QueryNode: 'SELECT'  querySpaces (TESTE)
    +-[SELECT_CLAUSE] SelectClause: '{derived select clause}'
    |  +-[SELECT_EXPR] SelectExpressionImpl: 'testeto0_.ID_TESTE as ID1_0_' {FromElement{explicit,not a collection join,not a fetch join,fetch non-lazy properties,classAlias=null,role=null,tableName=TESTE,tableAlias=testeto0_,origin=null,colums={,className=testes.testeTO}}}
    |  \-[SQL_TOKEN] SqlFragment: 'testeto0_.NM_NAME as NM2_0_'
    \-[FROM] FromClause: 'from' FromClause{level=1, fromElementCounter=1, fromElements=1, fromElementByClassAlias=[], fromElementByTableAlias=[testeto0_], fromElementsByPath=[], collectionJoinFromElementsByPath=[], impliedElements=[]}
       \-[FROM_FRAGMENT] FromElement: 'TESTE testeto0_' FromElement{explicit,not a collection join,not a fetch join,fetch non-lazy properties,classAlias=null,role=null,tableName=TESTE,tableAlias=testeto0_,origin=null,colums={,className=testes.testeTO}}

DEBUG [main] (ErrorCounter.java:68) - throwQueryException() : no errors
DEBUG [main] (QueryTranslatorImpl.java:216) - HQL: from testes.testeTO
DEBUG [main] (QueryTranslatorImpl.java:217) - SQL: select testeto0_.ID_TESTE as ID1_0_, testeto0_.NM_NAME as NM2_0_ from TESTE testeto0_
DEBUG [main] (ErrorCounter.java:68) - throwQueryException() : no errors
DEBUG [main] (HQLQueryPlan.java:269) - HQL param location recognition took 0 mills (from testeTO)
DEBUG [main] (QueryPlanCache.java:76) - located HQL query plan in cache (from testeTO)
DEBUG [main] (HQLQueryPlan.java:150) - find: from testeTO
DEBUG [main] (QueryParameters.java:277) - named parameters: {}
DEBUG [main] (AbstractBatcher.java:358) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG [main] (ConnectionManager.java:419) - opening JDBC connection
DEBUG [main] (DriverManagerConnectionProvider.java:93) - total checked-out connections: 0
DEBUG [main] (DriverManagerConnectionProvider.java:99) - using pooled JDBC connection, pool size: 0
DEBUG [main] (AbstractBatcher.java:393) - select testeto0_.ID_TESTE as ID1_0_, testeto0_.NM_NAME as NM2_0_ from TESTE testeto0_
Hibernate: select testeto0_.ID_TESTE as ID1_0_, testeto0_.NM_NAME as NM2_0_ from TESTE testeto0_
DEBUG [main] (AbstractBatcher.java:476) - preparing statement
DEBUG [main] (AbstractBatcher.java:374) - about to open ResultSet (open ResultSets: 0, globally: 0)
DEBUG [main] (Loader.java:682) - processing result set
DEBUG [main] (Loader.java:687) - result set row: 0
DEBUG [main] (NullableType.java:172) - returning '15' as column: ID1_0_
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.testeTO#15]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.testeTO#15]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.testeTO#15]
DEBUG [main] (NullableType.java:172) - returning 'Apple' as column: NM2_0_
DEBUG [main] (Loader.java:687) - result set row: 1
DEBUG [main] (NullableType.java:172) - returning '14' as column: ID1_0_
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.testeTO#14]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.testeTO#14]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.testeTO#14]
DEBUG [main] (NullableType.java:172) - returning 'Borland' as column: NM2_0_
DEBUG [main] (Loader.java:687) - result set row: 2
DEBUG [main] (NullableType.java:172) - returning '12' as column: ID1_0_
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.testeTO#12]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.testeTO#12]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.testeTO#12]
DEBUG [main] (NullableType.java:172) - returning 'Oracle' as column: NM2_0_
DEBUG [main] (Loader.java:687) - result set row: 3
DEBUG [main] (NullableType.java:172) - returning '11' as column: ID1_0_
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.testeTO#11]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.testeTO#11]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.testeTO#11]
DEBUG [main] (NullableType.java:172) - returning 'IBM' as column: NM2_0_
DEBUG [main] (Loader.java:687) - result set row: 4
DEBUG [main] (NullableType.java:172) - returning '10' as column: ID1_0_
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.testeTO#10]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.testeTO#10]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.testeTO#10]
DEBUG [main] (NullableType.java:172) - returning 'SunMicrosystems' as column: NM2_0_
DEBUG [main] (Loader.java:709) - done processing result set (5 rows)
DEBUG [main] (AbstractBatcher.java:381) - about to close ResultSet (open ResultSets: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:366) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:525) - closing statement
DEBUG [main] (Loader.java:839) - total objects hydrated: 5
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.testeTO#15]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.suplementoTO#15]
DEBUG [main] (DefaultLoadEventListener.java:255) - creating new proxy for entity
DEBUG [main] (SessionImpl.java:832) - initializing proxy: [testes.suplementoTO#15]
DEBUG [main] (DefaultLoadEventListener.java:332) - attempting to resolve: [testes.suplementoTO#15]
DEBUG [main] (DefaultLoadEventListener.java:369) - object not resolved in any cache: [testes.suplementoTO#15]
DEBUG [main] (AbstractEntityPersister.java:3031) - Fetching entity: [testes.suplementoTO#15]
DEBUG [main] (Loader.java:1843) - loading entity: [testes.suplementoTO#15]
DEBUG [main] (AbstractBatcher.java:358) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG [main] (AbstractBatcher.java:393) - select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (AbstractBatcher.java:476) - preparing statement
DEBUG [main] (NullableType.java:133) - binding '15' to parameter: 1
DEBUG [main] (AbstractBatcher.java:374) - about to open ResultSet (open ResultSets: 0, globally: 0)
DEBUG [main] (Loader.java:682) - processing result set
DEBUG [main] (Loader.java:687) - result set row: 0
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.suplementoTO#15]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.suplementoTO#15]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.suplementoTO#15]
DEBUG [main] (NullableType.java:172) - returning 'MacOSX' as column: NM2_1_0_
DEBUG [main] (Loader.java:709) - done processing result set (1 rows)
DEBUG [main] (AbstractBatcher.java:381) - about to close ResultSet (open ResultSets: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:366) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:525) - closing statement
DEBUG [main] (Loader.java:839) - total objects hydrated: 1
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.suplementoTO#15]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.testeTO#15]
DEBUG [main] (DefaultLoadEventListener.java:244) - entity found in session cache
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.suplementoTO#15]
DEBUG [main] (Loader.java:1874) - done entity load
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.testeTO#15]
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.testeTO#14]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.suplementoTO#14]
DEBUG [main] (DefaultLoadEventListener.java:255) - creating new proxy for entity
DEBUG [main] (SessionImpl.java:832) - initializing proxy: [testes.suplementoTO#14]
DEBUG [main] (DefaultLoadEventListener.java:332) - attempting to resolve: [testes.suplementoTO#14]
DEBUG [main] (DefaultLoadEventListener.java:369) - object not resolved in any cache: [testes.suplementoTO#14]
DEBUG [main] (AbstractEntityPersister.java:3031) - Fetching entity: [testes.suplementoTO#14]
DEBUG [main] (Loader.java:1843) - loading entity: [testes.suplementoTO#14]
DEBUG [main] (AbstractBatcher.java:358) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG [main] (AbstractBatcher.java:393) - select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (AbstractBatcher.java:476) - preparing statement
DEBUG [main] (NullableType.java:133) - binding '14' to parameter: 1
DEBUG [main] (AbstractBatcher.java:374) - about to open ResultSet (open ResultSets: 0, globally: 0)
DEBUG [main] (Loader.java:682) - processing result set
DEBUG [main] (Loader.java:687) - result set row: 0
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.suplementoTO#14]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.suplementoTO#14]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.suplementoTO#14]
DEBUG [main] (NullableType.java:172) - returning 'JBuilder' as column: NM2_1_0_
DEBUG [main] (Loader.java:709) - done processing result set (1 rows)
DEBUG [main] (AbstractBatcher.java:381) - about to close ResultSet (open ResultSets: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:366) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:525) - closing statement
DEBUG [main] (Loader.java:839) - total objects hydrated: 1
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.suplementoTO#14]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.testeTO#14]
DEBUG [main] (DefaultLoadEventListener.java:244) - entity found in session cache
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.suplementoTO#14]
DEBUG [main] (Loader.java:1874) - done entity load
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.testeTO#14]
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.testeTO#12]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.suplementoTO#12]
DEBUG [main] (DefaultLoadEventListener.java:255) - creating new proxy for entity
DEBUG [main] (SessionImpl.java:832) - initializing proxy: [testes.suplementoTO#12]
DEBUG [main] (DefaultLoadEventListener.java:332) - attempting to resolve: [testes.suplementoTO#12]
DEBUG [main] (DefaultLoadEventListener.java:369) - object not resolved in any cache: [testes.suplementoTO#12]
DEBUG [main] (AbstractEntityPersister.java:3031) - Fetching entity: [testes.suplementoTO#12]
DEBUG [main] (Loader.java:1843) - loading entity: [testes.suplementoTO#12]
DEBUG [main] (AbstractBatcher.java:358) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG [main] (AbstractBatcher.java:393) - select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (AbstractBatcher.java:476) - preparing statement
DEBUG [main] (NullableType.java:133) - binding '12' to parameter: 1
DEBUG [main] (AbstractBatcher.java:374) - about to open ResultSet (open ResultSets: 0, globally: 0)
DEBUG [main] (Loader.java:682) - processing result set
DEBUG [main] (Loader.java:687) - result set row: 0
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.suplementoTO#12]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.suplementoTO#12]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.suplementoTO#12]
DEBUG [main] (NullableType.java:172) - returning 'Oracle 9i' as column: NM2_1_0_
DEBUG [main] (Loader.java:709) - done processing result set (1 rows)
DEBUG [main] (AbstractBatcher.java:381) - about to close ResultSet (open ResultSets: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:366) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:525) - closing statement
DEBUG [main] (Loader.java:839) - total objects hydrated: 1
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.suplementoTO#12]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.testeTO#12]
DEBUG [main] (DefaultLoadEventListener.java:244) - entity found in session cache
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.suplementoTO#12]
DEBUG [main] (Loader.java:1874) - done entity load
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.testeTO#12]
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.testeTO#11]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.suplementoTO#11]
DEBUG [main] (DefaultLoadEventListener.java:255) - creating new proxy for entity
DEBUG [main] (SessionImpl.java:832) - initializing proxy: [testes.suplementoTO#11]
DEBUG [main] (DefaultLoadEventListener.java:332) - attempting to resolve: [testes.suplementoTO#11]
DEBUG [main] (DefaultLoadEventListener.java:369) - object not resolved in any cache: [testes.suplementoTO#11]
DEBUG [main] (AbstractEntityPersister.java:3031) - Fetching entity: [testes.suplementoTO#11]
DEBUG [main] (Loader.java:1843) - loading entity: [testes.suplementoTO#11]
DEBUG [main] (AbstractBatcher.java:358) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG [main] (AbstractBatcher.java:393) - select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (AbstractBatcher.java:476) - preparing statement
DEBUG [main] (NullableType.java:133) - binding '11' to parameter: 1
DEBUG [main] (AbstractBatcher.java:374) - about to open ResultSet (open ResultSets: 0, globally: 0)
DEBUG [main] (Loader.java:682) - processing result set
DEBUG [main] (Loader.java:687) - result set row: 0
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.suplementoTO#11]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.suplementoTO#11]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.suplementoTO#11]
DEBUG [main] (NullableType.java:172) - returning 'Websphere' as column: NM2_1_0_
DEBUG [main] (Loader.java:709) - done processing result set (1 rows)
DEBUG [main] (AbstractBatcher.java:381) - about to close ResultSet (open ResultSets: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:366) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:525) - closing statement
DEBUG [main] (Loader.java:839) - total objects hydrated: 1
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.suplementoTO#11]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.testeTO#11]
DEBUG [main] (DefaultLoadEventListener.java:244) - entity found in session cache
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.suplementoTO#11]
DEBUG [main] (Loader.java:1874) - done entity load
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.testeTO#11]
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.testeTO#10]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.suplementoTO#10]
DEBUG [main] (DefaultLoadEventListener.java:255) - creating new proxy for entity
DEBUG [main] (SessionImpl.java:832) - initializing proxy: [testes.suplementoTO#10]
DEBUG [main] (DefaultLoadEventListener.java:332) - attempting to resolve: [testes.suplementoTO#10]
DEBUG [main] (DefaultLoadEventListener.java:369) - object not resolved in any cache: [testes.suplementoTO#10]
DEBUG [main] (AbstractEntityPersister.java:3031) - Fetching entity: [testes.suplementoTO#10]
DEBUG [main] (Loader.java:1843) - loading entity: [testes.suplementoTO#10]
DEBUG [main] (AbstractBatcher.java:358) - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
DEBUG [main] (AbstractBatcher.java:393) - select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
Hibernate: select suplemento0_.ID_SUP as ID1_1_0_, suplemento0_.NM_SUP as NM2_1_0_ from TESTESUP suplemento0_ where suplemento0_.ID_SUP=?
DEBUG [main] (AbstractBatcher.java:476) - preparing statement
DEBUG [main] (NullableType.java:133) - binding '10' to parameter: 1
DEBUG [main] (AbstractBatcher.java:374) - about to open ResultSet (open ResultSets: 0, globally: 0)
DEBUG [main] (Loader.java:682) - processing result set
DEBUG [main] (Loader.java:687) - result set row: 0
DEBUG [main] (Loader.java:1164) - result row: EntityKey[testes.suplementoTO#10]
DEBUG [main] (Loader.java:1346) - Initializing object from ResultSet: [testes.suplementoTO#10]
DEBUG [main] (AbstractEntityPersister.java:2027) - Hydrating entity: [testes.suplementoTO#10]
DEBUG [main] (NullableType.java:172) - returning 'Java' as column: NM2_1_0_
DEBUG [main] (Loader.java:709) - done processing result set (1 rows)
DEBUG [main] (AbstractBatcher.java:381) - about to close ResultSet (open ResultSets: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:366) - about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
DEBUG [main] (AbstractBatcher.java:525) - closing statement
DEBUG [main] (Loader.java:839) - total objects hydrated: 1
DEBUG [main] (TwoPhaseLoad.java:107) - resolving associations for [testes.suplementoTO#10]
DEBUG [main] (DefaultLoadEventListener.java:171) - loading entity: [testes.testeTO#10]
DEBUG [main] (DefaultLoadEventListener.java:244) - entity found in session cache
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.suplementoTO#10]
DEBUG [main] (Loader.java:1874) - done entity load
DEBUG [main] (TwoPhaseLoad.java:206) - done materializing entity [testes.testeTO#10]
DEBUG [main] (StatefulPersistenceContext.java:777) - initializing non-lazy collections
DEBUG [main] (JDBCContext.java:233) - after autocommit
DEBUG [main] (ConnectionManager.java:402) - aggressively releasing JDBC connection
DEBUG [main] (ConnectionManager.java:439) - releasing JDBC connection [ (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)]
DEBUG [main] (DriverManagerConnectionProvider.java:129) - returning connection to pool, pool size: 1
Teste :5
testado

Hi guys,

I read for many times the documentation of Hibernate that instruct how to solve questions about relation one-one-one with lazy feature activated.

I can´t make lazyload feature run as expected. The proxies are created but the application generates SQLs for each relation one-to-one.

I am not understanding and someone it will be able to help...

Thanks,

Kenobi

kleene · **Joined:** Sun Jun 17, 2007 7:32 am **Posts:** 1

Hi,
I have the same problem in a one-to-one relation.
Could you resolve it?

elaroche · **Joined:** Sat Apr 29, 2006 9:52 am **Posts:** 8

Same problem here as well.

Does anybody got a solution ? please ?

jits_1998 · **Posted:** Wed Jun 20, 2007 3:29 pm

Double sql is being generated because you have marked outer-join="false" and since both sides have one-to-one mapping there is no column on any table with FK constraint.

Kindly review my post with code here:
http://forum.hibernate.org/viewtopic.php?t=976257

*Please do rate if this helps*

Regards,
Jitendra