Attached is the log output. As far as the code, I pretty much used the CAT example listed in the tutorial:
Appreciate your input.
BTW my setup works in non-JTA mode in websphere. I am having issues with JTA mode. Thanks.,
[2/14/05 17:33:54:175 PST] 607d6307 SystemOut O log4j: Trying to find [log4j.xml] using context classloader
com.ibm.ws.classloader.CompoundClassLoader@5365e307
Local ClassPath: C:\IBMWorkspace\wsad512\hibernate\HibernateEJB\ejbModule;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\cglib-full-2.0.2.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\commons-collections-2.1.1.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\dom4j-1.4.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\ehcache-0.9.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\hibernate2.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\odmg-3.0.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\log4j-1.2.8.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\commons-logging-1.0.4.jar;
Delegation Mode: PARENT_LAST.
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Trying to find [log4j.xml] using
com.ibm.ws.classloader.CompoundClassLoader@5365e307
Local ClassPath: C:\IBMWorkspace\wsad512\hibernate\HibernateEJB\ejbModule;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\cglib-full-2.0.2.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\commons-collections-2.1.1.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\dom4j-1.4.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\ehcache-0.9.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\hibernate2.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\odmg-3.0.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\log4j-1.2.8.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\commons-logging-1.0.4.jar;
Delegation Mode: PARENT_LAST class loader.
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Trying to find [log4j.xml] using ClassLoader.getSystemResource().
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Trying to find [log4j.properties] using context classloader
com.ibm.ws.classloader.CompoundClassLoader@5365e307
Local ClassPath: C:\IBMWorkspace\wsad512\hibernate\HibernateEJB\ejbModule;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\cglib-full-2.0.2.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\commons-collections-2.1.1.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\dom4j-1.4.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\ehcache-0.9.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\hibernate2.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\odmg-3.0.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\log4j-1.2.8.jar;C:\IBMWorkspace\wsad512\hibernate\Hibernate\lib\commons-logging-1.0.4.jar;
Delegation Mode: PARENT_LAST.
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Using URL [file:/C:/IBMWorkspace/wsad512/hibernate/HibernateEJB/ejbModule/log4j.properties] for automatic log4j configuration.
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Reading configuration from URL file:/C:/IBMWorkspace/wsad512/hibernate/HibernateEJB/ejbModule/log4j.properties
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Parsing for [root] with value=[debug, stdout, file].
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Category root set to DEBUG
[2/14/05 17:33:54:191 PST] 607d6307 SystemOut O log4j: Parsing appender named "stdout".
[2/14/05 17:33:54:284 PST] 607d6307 SystemOut O log4j: Parsing layout options for "stdout".
[2/14/05 17:33:54:316 PST] 607d6307 SystemOut O log4j: Setting property [conversionPattern] to [%d{ABSOLUTE} %5p %c{1}:%L - %m%n].
[2/14/05 17:33:54:316 PST] 607d6307 SystemOut O log4j: End of parsing for "stdout".
[2/14/05 17:33:54:409 PST] 607d6307 SystemOut O log4j: Setting property [target] to [System.out].
[2/14/05 17:33:54:425 PST] 607d6307 SystemOut O log4j: Parsed "stdout" options.
[2/14/05 17:33:54:425 PST] 607d6307 SystemOut O log4j: Parsing appender named "file".
[2/14/05 17:33:54:425 PST] 607d6307 SystemOut O log4j: Parsing layout options for "file".
[2/14/05 17:33:54:425 PST] 607d6307 SystemOut O log4j: Setting property [conversionPattern] to [%d{ABSOLUTE} %5p %c{1}:%L - %m%n].
[2/14/05 17:33:54:441 PST] 607d6307 SystemOut O log4j: End of parsing for "file".
[2/14/05 17:33:54:441 PST] 607d6307 SystemOut O log4j: Setting property [file] to [c:/hibernate.log].
[2/14/05 17:33:54:441 PST] 607d6307 SystemOut O log4j: setFile called: c:/hibernate.log, true
[2/14/05 17:33:54:441 PST] 607d6307 SystemOut O log4j: setFile ended
[2/14/05 17:33:54:441 PST] 607d6307 SystemOut O log4j: Parsed "file" options.
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.impl.BatcherImpl] with value=[debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.impl.BatcherImpl set to DEBUG
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.impl.BatcherImpl=[null]
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.SQL] with value=[debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.SQL set to DEBUG
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.SQL=[null]
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.connection.DriverManagerConnectionProvider] with value=[trace].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Level token is [trace].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.connection.DriverManagerConnectionProvider set to DEBUG
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.connection.DriverManagerConnectionProvider=[null]
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.type] with value=[debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.type set to DEBUG
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.type=[null]
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.cache] with value=[debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.cache set to DEBUG
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.cache=[null]
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate] with value=[debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate set to DEBUG
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate=[null]
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.tool.hbm2ddl] with value=[debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:456 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.tool.hbm2ddl set to DEBUG
[2/14/05 17:33:54:472 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.tool.hbm2ddl=[null]
[2/14/05 17:33:54:472 PST] 607d6307 SystemOut O log4j: Finished configuring.
[2/14/05 17:33:54:472 PST] 607d6307 SystemOut O log4j: Parsing for [root] with value=[debug, stdout, file].
[2/14/05 17:33:54:472 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:472 PST] 607d6307 SystemOut O log4j: Category root set to DEBUG
[2/14/05 17:33:54:488 PST] 607d6307 SystemOut O log4j: Parsing appender named "stdout".
[2/14/05 17:33:54:488 PST] 607d6307 SystemOut O log4j: Parsing layout options for "stdout".
[2/14/05 17:33:54:488 PST] 607d6307 SystemOut O log4j: Setting property [conversionPattern] to [%d{ABSOLUTE} %5p %c{1}:%L - %m%n].
[2/14/05 17:33:54:488 PST] 607d6307 SystemOut O log4j: End of parsing for "stdout".
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: Setting property [target] to [System.out].
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: Parsed "stdout" options.
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: Parsing appender named "file".
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: Parsing layout options for "file".
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: Setting property [conversionPattern] to [%d{ABSOLUTE} %5p %c{1}:%L - %m%n].
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: End of parsing for "file".
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: Setting property [file] to [c:/hibernate.log].
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: setFile called: c:/hibernate.log, true
[2/14/05 17:33:54:519 PST] 607d6307 SystemOut O log4j: setFile ended
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Parsed "file" options.
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.impl.BatcherImpl] with value=[debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.impl.BatcherImpl set to DEBUG
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.impl.BatcherImpl=[null]
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.SQL] with value=[debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.SQL set to DEBUG
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.SQL=[null]
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.connection.DriverManagerConnectionProvider] with value=[trace].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Level token is [trace].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.connection.DriverManagerConnectionProvider set to DEBUG
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.connection.DriverManagerConnectionProvider=[null]
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.type] with value=[debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.type set to DEBUG
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.type=[null]
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.cache] with value=[debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.cache set to DEBUG
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.cache=[null]
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate] with value=[debug].
[2/14/05 17:33:54:534 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate set to DEBUG
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate=[null]
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O log4j: Parsing for [net.sf.hibernate.tool.hbm2ddl] with value=[debug].
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O log4j: Category net.sf.hibernate.tool.hbm2ddl set to DEBUG
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.tool.hbm2ddl=[null]
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O log4j: Finished configuring.
[2/14/05 17:33:54:550 PST] 607d6307 SystemOut O It is simple test
[2/14/05 17:33:54:800 PST] 607d6307 SystemOut O 17:33:54,800 INFO Environment:483).null(Unknown Source - Hibernate 2.1.8
17:33:54,800 INFO Environment:517).null(Unknown Source - loaded properties from resource hibernate.properties: {hibernate.cglib.use_reflection_optimizer=true, hibernate.transaction.factory_class=net.sf.hibernate.transaction.JTATransactionFactory}
17:33:54,831 INFO Environment:543).null(Unknown Source - using CGLIB reflection optimizer
17:33:54,847 INFO Environment:572).null(Unknown Source - using JDK 1.4 java.sql.Timestamp handling
17:33:54,863 INFO Configuration:909 - configuring from resource: /hibernate.cfg.xml
17:33:54,863 INFO Configuration:881 - Configuration resource: /hibernate.cfg.xml
17:33:55,003 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath under net/sf/hibernate/
17:33:55,019 DEBUG DTDEntityResolver:32 - found
http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath
17:33:55,144 DEBUG Configuration:867 - hibernate.connection.datasource=java:comp/env/OracleDatasource1
17:33:55,144 DEBUG Configuration:867 - show_sql=true
17:33:55,144 DEBUG Configuration:867 - dialect=net.sf.hibernate.dialect.Oracle9Dialect
17:33:55,159 DEBUG Configuration:867 - jdbc.use_streams_for_binary=true
17:33:55,159 DEBUG Configuration:867 - max_fetch_depth=1
17:33:55,159 DEBUG Configuration:867 - transaction.manager_lookup_class=net.sf.hibernate.transaction.WebSphereTransactionManagerLookup
17:33:55,175 DEBUG Configuration:1026 - null<-org.dom4j.tree.DefaultAttribute@1883e300 [Attribute: name resource value "Cat.hbm.xml"]
17:33:55,175 INFO Configuration:332 - Mapping resource: Cat.hbm.xml
17:33:55,175 DEBUG DTDEntityResolver:20 - trying to locate
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
17:33:55,191 DEBUG DTDEntityResolver:32 - found
http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
17:33:55,378 INFO Binder:229 - Mapping class: net.sf.hibernate.examples.quickstart.Cat -> CAT
17:33:55,503 DEBUG Binder:486 - Mapped property: id -> CAT_ID, type: string
17:33:55,534 DEBUG Binder:486 - Mapped property: name -> NAME, type: string
17:33:55,534 DEBUG Binder:486 - Mapped property: sex -> sex, type: character
17:33:55,534 DEBUG Binder:486 - Mapped property: weight -> weight, type: float
17:33:55,534 INFO Configuration:1067 - Configured SessionFactory: null
17:33:55,534 DEBUG Configuration:1068 - properties: {show_sql=true, java.vendor=IBM Corporation, com.ibm.SOAP.requestTimeout=600, com.ibm.ejs.jts.processType=server, os.name=Windows XP, sun.boot.class.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/jre/lib/ext/ibmorb.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/jre/lib/ext/ibmext.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\core.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\graphics.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\security.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\server.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\xml.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\charsets.jar, sun.java2d.fontpath=, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.4.1, user.name=mrr, java.compiler=jitc, was.install.root=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51, db2j.system.home=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/databases, was.loose.config=file:C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/looseconfig.xmi, workspace.root=C:/IBMWorkspace/wsad512/hibernate/Servers/TestServerHibernate.wsc, user.language=en, was.repository.temp=C:\IBMWorkspace\wsad512\hibernate\.metadata\.plugins\com.ibm.etools.server.core\tmp0\repository\temp\, sun.boot.library.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\bin, workspace.repository.adapter=com.ibm.ws.sm.workspace.impl.WorkSpaceSelfRepositoryAdapter, dialect=net.sf.hibernate.dialect.Oracle9Dialect, com.ibm.ws.tools.trace.traceFile=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/logs/startServer.log, max_fetch_depth=1, java.version=1.4.1, user.timezone=America/Los_Angeles, server.root=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51, sun.arch.data.model=32, javax.rmi.CORBA.UtilClass=com.ibm.ws.orb.WSUtilDelegateImpl, java.endorsed.dirs=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\endorsed, file.encoding.pkg=sun.io, file.separator=\, java.specification.name=Java Platform API Specification, log4j.debug=true, hibernate.cglib.use_reflection_optimizer=true, java.class.version=48.0, user.country=US, java.home=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre, java.vm.info=J2RE 1.4.1 IBM Windows 32 build cn1411-20031011 (JIT enabled: jitc), os.version=5.1, hibernate.connection.datasource=java:comp/env/OracleDatasource1, hibernate.transaction.factory_class=net.sf.hibernate.transaction.JTATransactionFactory, java.awt.fonts=, was.variable.map=C:\IBMWorkspace\wsad512\hibernate\.metadata\.plugins\com.ibm.etools.server.core\tmp0\pathMaps.properties, path.separator=;, java.vm.version=1.4.1, hibernate.max_fetch_depth=1, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, user.variant=, java.protocol.handler.pkgs=com.ibm.net.ssl.internal.www.protocol, java.awt.printerjob=sun.awt.windows.WPrinterJob, java.security.policy=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties/server.policy, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, was.repository.root=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/repository, java.assistive=ON, jdbc.use_streams_for_binary=true, transaction.manager_lookup_class=net.sf.hibernate.transaction.WebSphereTransactionManagerLookup, java.naming.factory.url.pkgs=com.ibm.ws.runtime, user.home=C:\Documents and Settings\mrr, java.specification.vendor=Sun Microsystems Inc., invokedviajava=, java.library.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/bin;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/bin;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/jre/bin;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\eclipse\jre\bin;.;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\eclipse\jre\bin;C:\j2sdk1.4.2_04\bin;C:\IBM\WebSphereMQ\Java\lib;C:\jad158;C:\oracle\ora92\bin;C:\Program Files\Oracle\jre\1.3.1\bin;C:\Program Files\Oracle\jre\1.1.8\bin;C:\gers\tools;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Microsoft SQL Server\80\Tools\BINN;C:\Program Files\Microsoft BizTalk Server 2004\;C:\Program Files\Microsoft BizTalk Server 2004\EDI\Subsystem\;C:\Program Files\Common Files\Microsoft Shared\Enterprise Servers\Commerce\;C:\IBM\WebSphere5\ProdMQ\WEMPS\bin;;;C:\Program Files\Rational\common;C:\IBM\WebSphereMQ\bin;C:\j2sdk1.4.2_04\bin;C:\apache-ant-1.6.2\bin, java.vendor.url=http://www.ibm.com/, java.vm.vendor=IBM Corporation, hibernate.dialect=net.sf.hibernate.dialect.Oracle9Dialect, hibernate.jdbc.use_streams_for_binary=true, java.fullversion=J2RE 1.4.1 IBM Windows 32 build cn1411-20031011 (JIT enabled: jitc), java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/bootstrap.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/j2ee.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/lmproxy.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/urlprotocols.jar;C:/IBM/WebSphereStudio/ApplicationDeveloper/v5.1.2/wstools/eclipse/plugins/com.ibm.etools.websphere.tools.common_5.1.1.1/runtime/wteServers.jar;C:/IBM/WebSphereStudio/ApplicationDeveloper/v5.1.2/wstools/eclipse/plugins/com.ibm.etools.websphere.tools.common_5.1.1.1/runtime/wasToolsCommon.jar, MQJMS_TRACE_DIR=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/logs, ws.ext.dirs=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/lib;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/classes;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/classes;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/ext;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/web/help;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/deploytool/itp/plugins/com.ibm.etools.ejbdeploy/runtime;C:/IBM/WebSphereStudio/ApplicationDeveloper/v5.1.2/wstools/eclipse/plugins/com.ibm.etools.webservice_5.1.2/runtime/worf.jar, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, sun.os.patch.level=Service Pack 1, user.install.root=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51, java.io.tmpdir=C:\DOCUME~1\mrr\LOCALS~1\Temp\, java.vendor.url.bug=, ibm.system.encoding=Cp1252, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\ext, user.dir=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2, com.ibm.ws.messaging.JMSProvider=com.ibm.ws.messaging.JMSMQJDProviderImpl, com.ibm.itp.location=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/bin, line.separator=
, java.vm.name=Classic VM, java.security.auth.login.config=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties/wsjaas.conf, was.repository.config=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/repository, java.naming.provider.url=corbaloc:rir:/NameServiceServerRoot, file.encoding=Cp1252, PD_DT_ENABLED=true, was.repository.backup=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/repository/backup, hibernate.transaction.manager_lookup_class=net.sf.hibernate.transaction.WebSphereTransactionManagerLookup, java.specification.version=1.4, com.ibm.websphere.servlet.temp.dir=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/cache, workspace.user.root=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/wstemp, hibernate.show_sql=true}
17:33:55,550 INFO Configuration:641 - processing one-to-many association mappings
17:33:55,550 INFO Configuration:650 - processing one-to-one association property references
17:33:55,550 INFO Configuration:675 - processing foreign key constraints
17:33:55,613 INFO Dialect:86 - Using dialect: net.sf.hibernate.dialect.Oracle9Dialect
17:33:55,613 DEBUG SQLExceptionConverterFactory:49 - Using dialect defined converter
17:33:55,628 INFO SettingsFactory:70 - Maximim outer join fetch depth: 1
17:33:55,628 INFO SettingsFactory:74 - Use outer join fetching: true
17:33:55,644 INFO NamingHelper:26 - JNDI InitialContext properties:{}
17:33:55,706 INFO DatasourceConnectionProvider:51 - Using datasource: java:comp/env/OracleDatasource1
17:33:55,738 INFO TransactionFactoryFactory:31 - Transaction strategy: net.sf.hibernate.transaction.JTATransactionFactory
17:33:55,753 INFO NamingHelper:26 - JNDI InitialContext properties:{}
17:33:55,753 INFO TransactionManagerLookupFactory:38 - instantiating TransactionManagerLookup: net.sf.hibernate.transaction.WebSphereTransactionManagerLookup
17:33:55,753 INFO TransactionManagerLookupFactory:42 - instantiated TransactionManagerLookup
17:33:55,753 INFO WebSphereTransactionManagerLookup:31 - WebSphere 5.1
17:33:55,753 INFO TransactionManagerLookupFactory:38 - instantiating TransactionManagerLookup: net.sf.hibernate.transaction.WebSphereTransactionManagerLookup
17:33:55,753 INFO TransactionManagerLookupFactory:42 - instantiated TransactionManagerLookup
[2/14/05 17:33:57:441 PST] 607d6307 WSRdbDataSour I DSRA8203I: Database product name : Oracle
[2/14/05 17:33:57:456 PST] 607d6307 WSRdbDataSour I DSRA8204I: Database product version : Oracle8i Enterprise Edition Release 8.1.7.0.0 - Production
With the Partitioning option
JServer Release 8.1.7.0.0 - Production
[2/14/05 17:33:57:456 PST] 607d6307 WSRdbDataSour I DSRA8205I: JDBC driver name : Oracle JDBC driver
[2/14/05 17:33:57:456 PST] 607d6307 WSRdbDataSour I DSRA8206I: JDBC driver version : 9.2.0.1.0
17:33:58,300 INFO SettingsFactory:114 - Use scrollable result sets: true
17:33:58,316 INFO SettingsFactory:117 - Use JDBC3 getGeneratedKeys(): false
17:33:58,316 INFO SettingsFactory:120 - Optimize cache for minimal puts: false
17:33:58,316 INFO SettingsFactory:126 - echoing all SQL to stdout
17:33:58,316 INFO SettingsFactory:129 - Query language substitutions: {}
17:33:58,316 INFO SettingsFactory:140 - cache provider: net.sf.hibernate.cache.EhCacheProvider
17:33:58,331 DEBUG SettingsFactory:173 - Wrap result sets enabled? : false
17:33:58,331 INFO Configuration:1130 - instantiating and configuring caches
17:33:58,331 DEBUG CacheManager:178 - Creating new CacheManager with default config
17:33:58,347 DEBUG CacheManager:152 - Configuring ehcache from classpath.
17:33:58,363 WARN Configurator:125 - No configuration found. Configuring ehcache from ehcache-failsafe.xml found in the classpath: wsjar:file:/C:/IBMWorkspace/wsad512/hibernate/Hibernate/lib/ehcache-0.9.jar!/ehcache-failsafe.xml
17:33:58,394 DEBUG Configuration$DiskStore:182 - Disk Store Path: C:\DOCUME~1\mrr\LOCALS~1\Temp\
17:33:58,675 INFO SessionFactoryImpl:119 - building session factory
17:33:58,675 DEBUG SessionFactoryImpl:125 - instantiating session factory with properties: {show_sql=true, java.vendor=IBM Corporation, com.ibm.SOAP.requestTimeout=600, com.ibm.ejs.jts.processType=server, os.name=Windows XP, sun.boot.class.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/jre/lib/ext/ibmorb.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/jre/lib/ext/ibmext.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\core.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\graphics.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\security.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\server.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\xml.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\charsets.jar, sun.java2d.fontpath=, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.4.1, user.name=mrr, java.compiler=jitc, was.install.root=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51, db2j.system.home=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/databases, was.loose.config=file:C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/looseconfig.xmi, workspace.root=C:/IBMWorkspace/wsad512/hibernate/Servers/TestServerHibernate.wsc, user.language=en, was.repository.temp=C:\IBMWorkspace\wsad512\hibernate\.metadata\.plugins\com.ibm.etools.server.core\tmp0\repository\temp\, sun.boot.library.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\bin, workspace.repository.adapter=com.ibm.ws.sm.workspace.impl.WorkSpaceSelfRepositoryAdapter, dialect=net.sf.hibernate.dialect.Oracle9Dialect, com.ibm.ws.tools.trace.traceFile=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/logs/startServer.log, max_fetch_depth=1, java.version=1.4.1, user.timezone=America/Los_Angeles, server.root=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51, sun.arch.data.model=32, javax.rmi.CORBA.UtilClass=com.ibm.ws.orb.WSUtilDelegateImpl, java.endorsed.dirs=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\endorsed, file.encoding.pkg=sun.io, file.separator=\, java.specification.name=Java Platform API Specification, log4j.debug=true, hibernate.cglib.use_reflection_optimizer=true, java.class.version=48.0, user.country=US, java.home=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre, java.vm.info=J2RE 1.4.1 IBM Windows 32 build cn1411-20031011 (JIT enabled: jitc), os.version=5.1, hibernate.connection.datasource=java:comp/env/OracleDatasource1, hibernate.transaction.factory_class=net.sf.hibernate.transaction.JTATransactionFactory, java.awt.fonts=, was.variable.map=C:\IBMWorkspace\wsad512\hibernate\.metadata\.plugins\com.ibm.etools.server.core\tmp0\pathMaps.properties, path.separator=;, java.vm.version=1.4.1, hibernate.max_fetch_depth=1, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, user.variant=, java.protocol.handler.pkgs=com.ibm.net.ssl.internal.www.protocol, java.awt.printerjob=sun.awt.windows.WPrinterJob, java.security.policy=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties/server.policy, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, was.repository.root=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/repository, java.assistive=ON, jdbc.use_streams_for_binary=true, transaction.manager_lookup_class=net.sf.hibernate.transaction.WebSphereTransactionManagerLookup, java.naming.factory.url.pkgs=com.ibm.ws.runtime, user.home=C:\Documents and Settings\mrr, java.specification.vendor=Sun Microsystems Inc., invokedviajava=, java.library.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/bin;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/bin;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/jre/bin;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\eclipse\jre\bin;.;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\eclipse\jre\bin;C:\j2sdk1.4.2_04\bin;C:\IBM\WebSphereMQ\Java\lib;C:\jad158;C:\oracle\ora92\bin;C:\Program Files\Oracle\jre\1.3.1\bin;C:\Program Files\Oracle\jre\1.1.8\bin;C:\gers\tools;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Microsoft SQL Server\80\Tools\BINN;C:\Program Files\Microsoft BizTalk Server 2004\;C:\Program Files\Microsoft BizTalk Server 2004\EDI\Subsystem\;C:\Program Files\Common Files\Microsoft Shared\Enterprise Servers\Commerce\;C:\IBM\WebSphere5\ProdMQ\WEMPS\bin;;;C:\Program Files\Rational\common;C:\IBM\WebSphereMQ\bin;C:\j2sdk1.4.2_04\bin;C:\apache-ant-1.6.2\bin, java.vendor.url=http://www.ibm.com/, java.vm.vendor=IBM Corporation, hibernate.dialect=net.sf.hibernate.dialect.Oracle9Dialect, hibernate.jdbc.use_streams_for_binary=true, java.fullversion=J2RE 1.4.1 IBM Windows 32 build cn1411-20031011 (JIT enabled: jitc), java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/bootstrap.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/j2ee.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/lmproxy.jar;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/urlprotocols.jar;C:/IBM/WebSphereStudio/ApplicationDeveloper/v5.1.2/wstools/eclipse/plugins/com.ibm.etools.websphere.tools.common_5.1.1.1/runtime/wteServers.jar;C:/IBM/WebSphereStudio/ApplicationDeveloper/v5.1.2/wstools/eclipse/plugins/com.ibm.etools.websphere.tools.common_5.1.1.1/runtime/wasToolsCommon.jar, MQJMS_TRACE_DIR=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/logs, ws.ext.dirs=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/java/lib;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/classes;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/classes;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/lib/ext;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/web/help;C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/deploytool/itp/plugins/com.ibm.etools.ejbdeploy/runtime;C:/IBM/WebSphereStudio/ApplicationDeveloper/v5.1.2/wstools/eclipse/plugins/com.ibm.etools.webservice_5.1.2/runtime/worf.jar, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, sun.os.patch.level=Service Pack 1, user.install.root=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51, java.io.tmpdir=C:\DOCUME~1\mrr\LOCALS~1\Temp\, java.vendor.url.bug=, ibm.system.encoding=Cp1252, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51\java\jre\lib\ext, user.dir=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2, com.ibm.ws.messaging.JMSProvider=com.ibm.ws.messaging.JMSMQJDProviderImpl, com.ibm.itp.location=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/bin, line.separator=
, java.vm.name=Classic VM, java.security.auth.login.config=C:\IBM\WebSphereStudio\ApplicationDeveloper\v5.1.2\runtimes\base_v51/properties/wsjaas.conf, was.repository.config=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/repository, java.naming.provider.url=corbaloc:rir:/NameServiceServerRoot, file.encoding=Cp1252, PD_DT_ENABLED=true, was.repository.backup=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/repository/backup, hibernate.transaction.manager_lookup_class=net.sf.hibernate.transaction.WebSphereTransactionManagerLookup, java.specification.version=1.4, com.ibm.websphere.servlet.temp.dir=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/cache, workspace.user.root=C:/IBMWorkspace/wsad512/hibernate/.metadata/.plugins/com.ibm.etools.server.core/tmp0/wstemp, hibernate.show_sql=true}
17:33:59,597 DEBUG SessionFactoryObjectFactory:39).null(Unknown Source - initializing class SessionFactoryObjectFactory
17:33:59,612 DEBUG SessionFactoryObjectFactory:76 - registered: 8aad9e360213a675010213a679ad0000 (unnamed)
17:33:59,612 INFO SessionFactoryObjectFactory:82 - Not binding factory to JNDI, no JNDI name configured
17:33:59,612 DEBUG SessionFactoryImpl:196 - instantiated session factory
17:33:59,612 DEBUG SessionFactoryImpl:203 - obtaining JTA TransactionManager
17:33:59,612 INFO WebSphereTransactionManagerLookup:31 - WebSphere 5.1
17:33:59,784 DEBUG SessionImpl:560 - opened session
17:33:59,784 DEBUG SessionImpl:789 - generated identifier: 8aad9e360213a675010213a67a680001
17:33:59,800 DEBUG SessionImpl:836 - saving [net.sf.hibernate.examples.quickstart.Cat#8aad9e360213a675010213a67a680001]
17:33:59,800 DEBUG SessionImpl:2267 - flushing session
17:33:59,800 DEBUG SessionImpl:2467 - Flushing entities and processing referenced collections
17:33:59,816 DEBUG SessionImpl:2808 - Processing unreferenced collections
17:33:59,816 DEBUG SessionImpl:2822 - Scheduling collection removes/(re)creates/updates
17:33:59,831 DEBUG SessionImpl:2291 - Flushed: 1 insertions, 0 updates, 0 deletions to 1 objects
17:33:59,831 DEBUG SessionImpl:2296 - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
17:33:59,831 DEBUG Printer:75 - listing entities:
17:33:59,831 DEBUG Printer:82 - net.sf.hibernate.examples.quickstart.Cat{sex=F, name=Princess, weight=7.0, id=8aad9e360213a675010213a67a680001}
17:33:59,831 DEBUG SessionImpl:2380 - executing flush
17:33:59,831 DEBUG EntityPersister:447 - Inserting entity: [net.sf.hibernate.examples.quickstart.Cat#8aad9e360213a675010213a67a680001]
17:33:59,831 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
17:33:59,847 DEBUG SQL:230 - insert into CAT (NAME, sex, weight, CAT_ID) values (?, ?, ?, ?)
Hibernate: insert into CAT (NAME, sex, weight, CAT_ID) values (?, ?, ?, ?)
[2/14/05 17:33:59:847 PST] 607d6307 SystemOut O 17:33:59,847 DEBUG BatcherImpl:253 - preparing statement
17:33:59,909 DEBUG EntityPersister:382 - Dehydrating entity: [net.sf.hibernate.examples.quickstart.Cat#8aad9e360213a675010213a67a680001]
17:33:59,909 DEBUG StringType:46 - binding 'Princess' to parameter: 1
17:33:59,909 DEBUG CharacterType:46 - binding 'F' to parameter: 2
17:33:59,909 DEBUG FloatType:46 - binding '7.0' to parameter: 3
17:34:00,097 DEBUG StringType:46 - binding '8aad9e360213a675010213a67a680001' to parameter: 4
17:34:00,097 DEBUG BatcherImpl:28 - Adding to batch
17:34:00,097 DEBUG BatcherImpl:50 - Executing batch size: 1
17:34:00,112 DEBUG BatcherImpl:58 - success of batch update unknown: 0
17:34:00,112 DEBUG BatcherImpl:211 - done closing: 0 open PreparedStatements, 0 open ResultSets
17:34:00,112 DEBUG BatcherImpl:275 - closing statement
17:34:00,112 DEBUG SessionImpl:2852 - post flush
17:34:00,112 DEBUG SessionImpl:578 - closing session
17:34:00,128 DEBUG SessionImpl:3383 - disconnecting session
after the test call
[2/14/05 17:34:00:144 PST] 607d6307 SystemOut O 17:34:00,144 DEBUG CacheSynchronization:24 - transaction before completion callback
17:34:00,159 DEBUG CacheSynchronization:28 - transaction after completion callback, status: 3
17:34:00,159 DEBUG SessionImpl:596 - transaction completion
log4j: Parsing for [root] with value=[debug, stdout, file].
[2/14/05 17:34:10:128 PST] 7a95e307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:34:10:128 PST] 7a95e307 SystemOut O log4j: Category root set to DEBUG
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Parsing appender named "stdout".
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Parsing layout options for "stdout".
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Setting property [conversionPattern] to [%d{ABSOLUTE} %5p %c{1}:%L - %m%n].
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: End of parsing for "stdout".
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Setting property [target] to [System.out].
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Parsed "stdout" options.
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Parsing appender named "file".
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Parsing layout options for "file".
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Setting property [conversionPattern] to [%d{ABSOLUTE} %5p %c{1}:%L - %m%n].
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: End of parsing for "file".
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: Setting property [file] to [c:/hibernate.log].
[2/14/05 17:34:10:159 PST] 7a95e307 SystemOut O log4j: setFile called: c:/hibernate.log, true
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: setFile ended
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsed "file" options.
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsing for [net.sf.hibernate.impl.BatcherImpl] with value=[debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Category net.sf.hibernate.impl.BatcherImpl set to DEBUG
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.impl.BatcherImpl=[null]
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsing for [net.sf.hibernate.SQL] with value=[debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Category net.sf.hibernate.SQL set to DEBUG
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.SQL=[null]
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsing for [net.sf.hibernate.connection.DriverManagerConnectionProvider] with value=[trace].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Level token is [trace].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Category net.sf.hibernate.connection.DriverManagerConnectionProvider set to DEBUG
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.connection.DriverManagerConnectionProvider=[null]
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsing for [net.sf.hibernate.type] with value=[debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Category net.sf.hibernate.type set to DEBUG
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.type=[null]
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsing for [net.sf.hibernate.cache] with value=[debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Category net.sf.hibernate.cache set to DEBUG
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.cache=[null]
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsing for [net.sf.hibernate] with value=[debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Category net.sf.hibernate set to DEBUG
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate=[null]
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Parsing for [net.sf.hibernate.tool.hbm2ddl] with value=[debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Level token is [debug].
[2/14/05 17:34:10:175 PST] 7a95e307 SystemOut O log4j: Category net.sf.hibernate.tool.hbm2ddl set to DEBUG
[2/14/05 17:34:10:190 PST] 7a95e307 SystemOut O log4j: Handling log4j.additivity.net.sf.hibernate.tool.hbm2ddl=[null]
[2/14/05 17:34:10:190 PST] 7a95e307 SystemOut O log4j: Finished configuring.
[2/14/05 17:34:10:190 PST] 7a95e307 SystemOut O It is simple test
[2/14/05 17:34:10:190 PST] 7a95e307 SystemOut O 17:34:10,190 DEBUG SessionImpl:560 - opened session
17:34:10,190 DEBUG SessionImpl:789 - generated identifier: 8aad9e360213a675010213a6a30e0002
17:34:10,190 DEBUG SessionImpl:836 - saving [net.sf.hibernate.examples.quickstart.Cat#8aad9e360213a675010213a6a30e0002]
17:34:10,190 DEBUG SessionImpl:2267 - flushing session
17:34:10,190 DEBUG SessionImpl:2467 - Flushing entities and processing referenced collections
17:34:10,190 DEBUG SessionImpl:2808 - Processing unreferenced collections
17:34:10,190 DEBUG SessionImpl:2822 - Scheduling collection removes/(re)creates/updates
17:34:10,190 DEBUG SessionImpl:2291 - Flushed: 1 insertions, 0 updates, 0 deletions to 1 objects
17:34:10,190 DEBUG SessionImpl:2296 - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
17:34:10,206 DEBUG Printer:75 - listing entities:
17:34:10,206 DEBUG Printer:82 - net.sf.hibernate.examples.quickstart.Cat{sex=F, name=Princess, weight=7.0, id=8aad9e360213a675010213a6a30e0002}
17:34:10,206 DEBUG SessionImpl:2380 - executing flush
17:34:10,206 DEBUG EntityPersister:447 - Inserting entity: [net.sf.hibernate.examples.quickstart.Cat#8aad9e360213a675010213a6a30e0002]
17:34:10,206 DEBUG BatcherImpl:204 - about to open: 0 open PreparedStatements, 0 open ResultSets
[2/14/05 17:34:10:206 PST] 7a95e307 SystemErr R java.lang.NullPointerException
[2/14/05 17:34:10:206 PST] 7a95e307 SystemErr R at oracle.jdbc.dbaccess.DBData.clearItem(DBData.java:431)
[2/14/05 17:34:10:206 PST] 7a95e307 SystemErr R at oracle.jdbc.dbaccess.DBDataSetImpl.clearItem(DBDataSetImpl.java:3528)
[2/14/05 17:34:10:206 PST] 7a95e307 SystemErr R at oracle.jdbc.driver.OraclePreparedStatement.clearParameters(OraclePreparedStatement.java:3401)
17:34:10,206 DEBUG SQL:230 - insert into CAT (NAME, sex, weight, CAT_ID) values (?, ?, ?, ?)
Hibernate: insert into CAT (NAME, sex, weight, CAT_ID) values (?, ?, ?, ?)
[2/14/05 17:34:10:206 PST] 7a95e307 SystemOut O 17:34:10,206 DEBUG BatcherImpl:253 - preparing statement
[2/14/05 17:34:10:206 PST] 7a95e307 SystemErr R at com.ibm.ws.rsadapter.jdbc.WSJdbcConnection.resetStatement(WSJdbcConnection.java:1762)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at com.ibm.ws.rsadapter.jdbc.WSJdbcConnection.prepareStatement(WSJdbcConnection.java:1458)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at com.ibm.ws.rsadapter.jdbc.WSJdbcConnection.prepareStatement(WSJdbcConnection.java:1424)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.BatcherImpl.getPreparedStatement(BatcherImpl.java:263)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.BatcherImpl.prepareStatement(BatcherImpl.java:63)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.BatcherImpl.prepareStatement(BatcherImpl.java:58)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.BatcherImpl.prepareBatchStatement(BatcherImpl.java:111)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.persister.EntityPersister.insert(EntityPersister.java:454)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.persister.EntityPersister.insert(EntityPersister.java:436)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.ScheduledInsertion.execute(ScheduledInsertion.java:37)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.SessionImpl.execute(SessionImpl.java:2449)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.SessionImpl.executeAll(SessionImpl.java:2435)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.SessionImpl.execute(SessionImpl.java:2392)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at net.sf.hibernate.impl.SessionImpl.flush(SessionImpl.java:2261)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at com.gers.hibernate.SimpleBean.callCat(SimpleBean.java:101)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at com.gers.hibernate.EJSRemoteStatelessSimple_6bef4430.callCat(EJSRemoteStatelessSimple_6bef4430.java:22)
[2/14/05 17:34:10:253 PST] 7a95e307 SystemErr R at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:41)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at java.lang.reflect.Method.invoke(Method.java:386)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at com.ibm.rmi.util.ProxyUtil$4.run(ProxyUtil.java:703)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at java.security.AccessController.doPrivileged(Native Method)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at com.ibm.rmi.util.ProxyUtil.invokeWithClassLoaders(ProxyUtil.java:701)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at com.ibm.CORBA.iiop.ClientDelegate.invoke(ClientDelegate.java:1084)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at $Proxy1.callCat(Unknown Source)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at com.gers.hibernate._Simple_Stub.callCat(_Simple_Stub.java:254)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:79)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:41)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at java.lang.reflect.Method.invoke(Method.java:386)
[2/14/05 17:34:10:269 PST] 7a95e307 SystemErr R at com.ibm.etools.utc.model.ReflectionMethodModel.invoke(ReflectionMethodModel.java:68)
[2/14/05 17:34:10:284 PST] 7a95e307 SystemErr R at com.ibm.etools.utc.servlet.InvokeServlet.invoke(InvokeServlet.java:110)
[2/14/05 17:34:10:284 PST] 7a95e307 SystemErr R at com.ibm.etools.utc.servlet.InvokeServlet.doPost(InvokeServlet.java:366)
[2/14/05 17:34:10:284 PST] 7a95e307 SystemErr R at javax.servlet.http.HttpServlet.service(HttpServlet.java:760)
[2/14/05 17:34:10:284 PST] 7a95e307 SystemErr R at javax.servlet.http.HttpServlet.service(HttpServlet.java:853)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.servlet.StrictServletInstance.doService(StrictServletInstance.java:110)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.servlet.StrictLifecycleServlet._service(StrictLifecycleServlet.java:174)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.servlet.IdleServletState.service(StrictLifecycleServlet.java:313)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.servlet.StrictLifecycleServlet.service(StrictLifecycleServlet.java:116)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.servlet.ServletInstance.service(ServletInstance.java:283)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.servlet.ValidServletReferenceState.dispatch(ValidServletReferenceState.java:42)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.servlet.ServletInstanceReference.dispatch(ServletInstanceReference.java:40)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.webapp.WebAppRequestDispatcher.handleWebAppDispatch(WebAppRequestDispatcher.java:983)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.webapp.WebAppRequestDispatcher.dispatch(WebAppRequestDispatcher.java:564)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.webapp.WebAppRequestDispatcher.forward(WebAppRequestDispatcher.java:200)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.srt.WebAppInvoker.doForward(WebAppInvoker.java:119)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.srt.WebAppInvoker.handleInvocationHook(WebAppInvoker.java:276)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.cache.invocation.CachedInvocation.handleInvocation(CachedInvocation.java:71)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.cache.invocation.CacheableInvocationContext.invoke(CacheableInvocationContext.java:116)17:34:10,440 DEBUG CacheSynchronization:24 - transaction before completion callback
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.srp.ServletRequestProcessor.dispatchByURI(ServletRequestProcessor.java:186)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.oselistener.OSEListenerDispatcher.service(OSEListener.java:334)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.webcontainer.http.HttpConnection.handleRequest(HttpConnection.java:56)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.http.HttpConnection.readAndHandleRequest(HttpConnection.java:618)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.http.HttpConnection.run(HttpConnection.java:439)
[2/14/05 17:34:10:440 PST] 7a95e307 SystemErr R at com.ibm.ws.util.ThreadPool$Worker.run(ThreadPool.java:672)
17:34:10,440 DEBUG CacheSynchronization:28 - transaction after completion callback, status: 3
17:34:10,440 DEBUG SessionImpl:596 - transaction completion