Here is the output that I get. I see no errors.
Even if I remove ArtPub.class from the array that initialize Hibernate it doesn't work. ART_PUB table has it's own primary key ART_PUB_ID and two foreign keys ARTICLE_ID and PUBLICATION_ID. If I don't map this table how will Hibernate generate set the primary key ART_PUB_ID?
Or how can i make him do it? I'm really newby to hibernate and I could use some pointers. Thanks!
Code:
Oct 9, 2003 3:40:26 PM net.sf.hibernate.cfg.Environment <clinit>
INFO: Hibernate 2.0.3
Oct 9, 2003 3:40:26 PM net.sf.hibernate.cfg.Environment <clinit>
INFO: loaded properties from resource hibernate.properties: {hibernate.connection.driver_class=oracle.jdbc.driver.OracleDriver, hibernate.cglib.use_reflection_optimizer=true, hibernate.dialect=net.sf.hibernate.dialect.OracleDialect, hibernate.jdbc.use_streams_for_binary=true, hibernate.jdbc.batch_size=0, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.query.imports=net.sf.hibernate.test, net.sf.hibernate.eg, hibernate.proxool.pool_alias=pool1, hibernate.connection.username=cmsd, hibernate.connection.url=jdbc:oracle:thin:@10.0.0.131:1521:CMS, hibernate.show_sql=true, hibernate.connection.password=cmsd, hibernate.statement_cache.size=25, hibernate.connection.pool_size=1}
Oct 9, 2003 3:40:26 PM net.sf.hibernate.cfg.Environment <clinit>
INFO: using java.io streams to persist binary types
Oct 9, 2003 3:40:26 PM net.sf.hibernate.cfg.Environment <clinit>
INFO: using CGLIB reflection optimizer
Oct 9, 2003 3:40:26 PM net.sf.hibernate.cfg.Environment <clinit>
INFO: JVM proxy support: true
Oct 9, 2003 3:40:26 PM net.sf.hibernate.cfg.Configuration addClass
INFO: Mapping resource: de/ems/cms/beans/Article.hbm.xml
Oct 9, 2003 3:40:27 PM net.sf.hibernate.util.DTDEntityResolver resolveEntity
FINE: trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
Oct 9, 2003 3:40:27 PM net.sf.hibernate.util.DTDEntityResolver resolveEntity
FINE: found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindRootClass
INFO: Mapping class: de.ems.cms.beans.Article -> ARTICLE
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: articleId -> ARTICLE_ID, type: integer
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: name -> NAME, type: string
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: description -> DESCRIPTION, type: clob
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindCollection
INFO: Mapping collection: de.ems.cms.beans.Article.publications -> ART_PUB
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: publications, type: java.util.Set
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Configuration addClass
INFO: Mapping resource: de/ems/cms/beans/Publication.hbm.xml
Oct 9, 2003 3:40:28 PM net.sf.hibernate.util.DTDEntityResolver resolveEntity
FINE: trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
Oct 9, 2003 3:40:28 PM net.sf.hibernate.util.DTDEntityResolver resolveEntity
FINE: found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindRootClass
INFO: Mapping class: de.ems.cms.beans.Publication -> PUBLICATION
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: publicationId -> PUBLICATION_ID, type: integer
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: name -> NAME, type: string
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: description -> DESCRIPTION, type: clob
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindCollection
INFO: Mapping collection: de.ems.cms.beans.Publication.articles -> ART_PUB
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: articles, type: java.util.Set
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Configuration addClass
INFO: Mapping resource: de/ems/cms/beans/ArtPub.hbm.xml
Oct 9, 2003 3:40:28 PM net.sf.hibernate.util.DTDEntityResolver resolveEntity
FINE: trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/
Oct 9, 2003 3:40:28 PM net.sf.hibernate.util.DTDEntityResolver resolveEntity
FINE: found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindRootClass
INFO: Mapping class: de.ems.cms.beans.ArtPub -> ART_PUB
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: artPubId -> ART_PUB_ID, type: integer
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: publication -> PUBLICATION_ID, type: de.ems.cms.beans.Publication
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder bindProperty
FINE: Mapped property: article -> ARTICLE_ID, type: de.ems.cms.beans.Article
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Configuration secondPassCompile
INFO: processing one-to-many association mappings
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder$SecondPass doSecondPass
FINE: Second pass for collection: de.ems.cms.beans.Article.publications
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder$SecondPass doSecondPass
FINE: Mapped collection key: ARTICLE_ID, element: PUBLICATION_ID, type: de.ems.cms.beans.Publication
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder$SecondPass doSecondPass
FINE: Second pass for collection: de.ems.cms.beans.Publication.articles
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Binder$SecondPass doSecondPass
FINE: Mapped collection key: PUBLICATION_ID, element: ARTICLE_ID, type: de.ems.cms.beans.Article
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Configuration secondPassCompile
INFO: processing foreign key constraints
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Configuration secondPassCompile
FINE: resolving reference to class: de.ems.cms.beans.Article
Oct 9, 2003 3:40:28 PM net.sf.hibernate.cfg.Configuration secondPassCompile
FINE: resolving reference to class: de.ems.cms.beans.Publication
Oct 9, 2003 3:40:29 PM net.sf.hibernate.impl.SessionFactoryImpl <init>
INFO: building session factory
Oct 9, 2003 3:40:29 PM net.sf.hibernate.impl.SessionFactoryImpl <init>
FINE: instantiating session factory with properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, hibernate.connection.password=cmsd, sun.boot.library.path=C:\jdk1.4.2\jre\bin, java.vm.version=1.4.2-b28, hibernate.proxool.pool_alias=pool1, hibernate.connection.username=cmsd, java.vm.vendor=Sun Microsystems Inc., java.vendor.url=http://java.sun.com/, path.separator=;, java.vm.name=Java HotSpot(TM) Client VM, file.encoding.pkg=sun.io, idea.launcher.port=7550, user.country=US, sun.os.patch.level=, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\work\l7db, java.runtime.version=1.4.2-b28, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=C:\jdk1.4.2\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\daniel\LOCALS~1\Temp\, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows XP, sun.java2d.fontpath=, java.library.path=C:\jdk1.4.2\bin;.;C:\WINDOWS\System32;C:\WINDOWS;C:\ant-1.5.3-1\bin;C:\oracle\ora81\bin;C:\Program Files\Oracle\jre\1.1.7\bin;c:\jdk1.4.1\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem, java.specification.name=Java Platform API Specification, java.class.version=48.0, hibernate.connection.pool_size=1, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, os.version=5.1, user.home=C:\Documents and Settings\daniel, user.timezone=Europe/Bucharest, java.awt.printerjob=sun.awt.windows.WPrinterJob, java.specification.version=1.4, file.encoding=windows-1252, hibernate.connection.driver_class=oracle.jdbc.driver.OracleDriver, user.name=daniel, java.class.path=C:\jdk1.4.2\jre\lib\charsets.jar;C:\jdk1.4.2\jre\lib\jce.jar;C:\jdk1.4.2\jre\lib\jsse.jar;C:\jdk1.4.2\jre\lib\plugin.jar;C:\jdk1.4.2\jre\lib\rt.jar;C:\jdk1.4.2\jre\lib\sunrsasign.jar;C:\jdk1.4.2\jre\lib\ext\dnsns.jar;C:\jdk1.4.2\jre\lib\ext\ldapsec.jar;C:\jdk1.4.2\jre\lib\ext\localedata.jar;C:\jdk1.4.2\jre\lib\ext\sunjce_provider.jar;C:\work\l7db\classes;C:\work\l7db\lib\ant.jar;C:\work\l7db\lib\c3p0.jar;C:\work\l7db\lib\cglib-asm.jar;C:\work\l7db\lib\commons-beanutils.jar;C:\work\l7db\lib\commons-collections.jar;C:\work\l7db\lib\commons-dbcp.jar;C:\work\l7db\lib\commons-lang.jar;C:\work\l7db\lib\commons-logging.jar;C:\work\l7db\lib\commons-pool.jar;C:\work\l7db\lib\connector.jar;C:\work\l7db\lib\dom4j.jar;C:\work\l7db\lib\hibernate2.jar;C:\work\l7db\lib\jaas.jar;C:\work\l7db\lib\jcs.jar;C:\work\l7db\lib\jdbc2_0-stdext.jar;C:\work\l7db\lib\jta.jar;C:\work\l7db\lib\junit.jar;C:\work\l7db\lib\odmg.jar;C:\work\l7db\lib\optional.jar;C:\work\l7db\lib\proxool.jar;C:\work\l7db\lib\xalan.jar;C:\work\l7db\lib\xerces.jar;C:\work\l7db\lib\xml-apis.jar;C:\work\l7db\lib\hsqldb-1.7.1.jar;C:\work\l7db\lib\classes12.jar;C:\work\l7db\lib\hibern8ide.jar;C:\IntelliJ-IDEA\lib\idea_rt.jar, hibernate.show_sql=true, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', java.vm.specification.version=1.0, sun.arch.data.model=32, java.home=C:\jdk1.4.2\jre, hibernate.connection.url=jdbc:oracle:thin:@10.0.0.131:1521:CMS, hibernate.dialect=net.sf.hibernate.dialect.OracleDialect, java.specification.vendor=Sun Microsystems Inc., user.language=en, awt.toolkit=sun.awt.windows.WToolkit, java.vm.info=mixed mode, hibernate.cglib.use_reflection_optimizer=true, java.version=1.4.2, hibernate.jdbc.use_streams_for_binary=true, java.ext.dirs=C:\jdk1.4.2\jre\lib\ext, sun.boot.class.path=C:\jdk1.4.2\jre\lib\rt.jar;C:\jdk1.4.2\jre\lib\i18n.jar;C:\jdk1.4.2\jre\lib\sunrsasign.jar;C:\jdk1.4.2\jre\lib\jsse.jar;C:\jdk1.4.2\jre\lib\jce.jar;C:\jdk1.4.2\jre\lib\charsets.jar;C:\jdk1.4.2\jre\classes, java.vendor=Sun Microsystems Inc., hibernate.jdbc.batch_size=0, file.separator=\, hibernate.query.imports=net.sf.hibernate.test, net.sf.hibernate.eg, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, idea.launcher.library=C:\IntelliJ-IDEA\bin\breakgen.dll, hibernate.statement_cache.size=25, sun.cpu.endian=little, sun.io.unicode.encoding=UnicodeLittle, sun.cpu.isalist=pentium i486 i386}
Oct 9, 2003 3:40:29 PM net.sf.hibernate.dialect.Dialect <init>
INFO: Using dialect: net.sf.hibernate.dialect.OracleDialect
Oct 9, 2003 3:40:29 PM net.sf.hibernate.connection.DriverManagerConnectionProvider configure
INFO: Hibernate connection pool size: 1
Oct 9, 2003 3:40:29 PM net.sf.hibernate.connection.DriverManagerConnectionProvider configure
INFO: using driver: oracle.jdbc.driver.OracleDriver at URL: jdbc:oracle:thin:@10.0.0.131:1521:CMS
Oct 9, 2003 3:40:29 PM net.sf.hibernate.connection.DriverManagerConnectionProvider configure
INFO: connection properties: {user=cmsd, password=cmsd}
Oct 9, 2003 3:40:29 PM net.sf.hibernate.ps.PreparedStatementCache <init>
INFO: prepared statement cache size: 25
Oct 9, 2003 3:40:29 PM net.sf.hibernate.impl.SessionFactoryImpl <init>
INFO: Use outer join fetching: true
Oct 9, 2003 3:40:29 PM net.sf.hibernate.connection.DriverManagerConnectionProvider getConnection
FINEST: total checked-out connections: 0
Oct 9, 2003 3:40:29 PM net.sf.hibernate.connection.DriverManagerConnectionProvider getConnection
FINE: opening new JDBC connection
Oct 9, 2003 3:40:30 PM net.sf.hibernate.connection.DriverManagerConnectionProvider getConnection
FINE: created connection to: jdbc:oracle:thin:@10.0.0.131:1521:CMS, Isolation Level: 2
Oct 9, 2003 3:40:30 PM net.sf.hibernate.connection.DriverManagerConnectionProvider closeConnection
FINEST: returning connection to pool, pool size: 1
Oct 9, 2003 3:40:30 PM net.sf.hibernate.impl.SessionFactoryImpl <init>
INFO: Use scrollable result sets: true
Oct 9, 2003 3:40:30 PM net.sf.hibernate.impl.SessionFactoryImpl <init>
INFO: echoing all SQL to stdout
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionFactoryObjectFactory <clinit>
FINE: initializing class SessionFactoryObjectFactory
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionFactoryObjectFactory addInstance
FINE: registered: 8a808001f820dcc500f820dccefd0000 (unnamed)
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionFactoryObjectFactory addInstance
INFO: no JDNI name configured
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionFactoryImpl <init>
INFO: Query language substitutions: {no='N', true=1, yes='Y', false=0}
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionFactoryImpl <init>
FINE: instantiated session factory
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl <init>
FINE: opened session
Oct 9, 2003 3:40:31 PM net.sf.hibernate.transaction.JDBCTransaction begin
FINE: begin
Oct 9, 2003 3:40:31 PM net.sf.hibernate.connection.DriverManagerConnectionProvider getConnection
FINEST: total checked-out connections: 0
Oct 9, 2003 3:40:31 PM net.sf.hibernate.connection.DriverManagerConnectionProvider getConnection
FINEST: using pooled JDBC connection, pool size: 0
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl find
FINEST: find: from Publication as p where p.name like 'Publication 0'
Oct 9, 2003 3:40:31 PM net.sf.hibernate.hql.QueryTranslator compile
FINEST: compiling query
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINEST: flushing session
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEntities
FINEST: Flushing entities and processing referenced collections
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushCollections
FINEST: Processing unreferenced collections
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushCollections
FINEST: Scheduling collection removes/(re)creates/updates
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINE: Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINE: Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl autoFlushIfRequired
FINEST: Dont need to execute flush
Oct 9, 2003 3:40:31 PM net.sf.hibernate.hql.QueryTranslator logQuery
FINE: HQL: from de.ems.cms.beans.Publication as p where p.name like 'Publication 0'
Oct 9, 2003 3:40:31 PM net.sf.hibernate.hql.QueryTranslator logQuery
FINE: SQL: select publicat0_.PUBLICATION_ID as PUBLICATION_ID, publicat0_.NAME as NAME, publicat0_.DESCRIPTION as DESCRIPT3_ from CMSD.PUBLICATION publicat0_ where (publicat0_.NAME like 'Publication 0' )
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.BatcherImpl logOpenPreparedStatement
FINEST: about to open: 0 open PreparedStatements, 0 open ResultSets
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionFactoryImpl getPreparedStatement
FINE: prepared statement get: select publicat0_.PUBLICATION_ID as PUBLICATION_ID, publicat0_.NAME as NAME, publicat0_.DESCRIPTION as DESCRIPT3_ from CMSD.PUBLICATION publicat0_ where (publicat0_.NAME like 'Publication 0' )
Hibernate: select publicat0_.PUBLICATION_ID as PUBLICATION_ID, publicat0_.NAME as NAME, publicat0_.DESCRIPTION as DESCRIPT3_ from CMSD.PUBLICATION publicat0_ where (publicat0_.NAME like 'Publication 0' )
Oct 9, 2003 3:40:31 PM net.sf.hibernate.ps.PreparedStatementCache getPreparedStatement
FINEST: preparing statement: select publicat0_.PUBLICATION_ID as PUBLICATION_ID, publicat0_.NAME as NAME, publicat0_.DESCRIPTION as DESCRIPT3_ from CMSD.PUBLICATION publicat0_ where (publicat0_.NAME like 'Publication 0' )
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader doFind
FINEST: processing result set
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '31' as column: PUBLICATION_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 31
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 31
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Publication#31
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'Publication 0' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@8a548b' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader doFind
FINEST: done processing result set (1 rows)
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.BatcherImpl logClosePreparedStatement
FINEST: done closing: 0 open PreparedStatements, 0 open ResultSets
Oct 9, 2003 3:40:31 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: recaching
Oct 9, 2003 3:40:31 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: total checked-out statements: 0
Oct 9, 2003 3:40:31 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: checked out: []
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader doFind
FINEST: total objects hydrated: 1
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Publication#31]
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Publication#31]
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl find
FINEST: find: from Article
Oct 9, 2003 3:40:31 PM net.sf.hibernate.hql.QueryTranslator compile
FINEST: compiling query
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINEST: flushing session
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEntities
FINEST: Flushing entities and processing referenced collections
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Publication.articles#31], was: [de.ems.cms.beans.Publication.articles#31]
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushCollections
FINEST: Processing unreferenced collections
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushCollections
FINEST: Scheduling collection removes/(re)creates/updates
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINE: Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINE: Flushed: 0 (re)creations, 0 updates, 0 removals to 1 collections
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionImpl autoFlushIfRequired
FINEST: Dont need to execute flush
Oct 9, 2003 3:40:31 PM net.sf.hibernate.hql.QueryTranslator logQuery
FINE: HQL: from de.ems.cms.beans.Article
Oct 9, 2003 3:40:31 PM net.sf.hibernate.hql.QueryTranslator logQuery
FINE: SQL: select article0_.ARTICLE_ID as ARTICLE_ID, article0_.NAME as NAME, article0_.DESCRIPTION as DESCRIPT3_ from CMSD.ARTICLE article0_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.BatcherImpl logOpenPreparedStatement
FINEST: about to open: 0 open PreparedStatements, 0 open ResultSets
Oct 9, 2003 3:40:31 PM net.sf.hibernate.impl.SessionFactoryImpl getPreparedStatement
FINE: prepared statement get: select article0_.ARTICLE_ID as ARTICLE_ID, article0_.NAME as NAME, article0_.DESCRIPTION as DESCRIPT3_ from CMSD.ARTICLE article0_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.ps.PreparedStatementCache getPreparedStatement
FINEST: preparing statement: select article0_.ARTICLE_ID as ARTICLE_ID, article0_.NAME as NAME, article0_.DESCRIPTION as DESCRIPT3_ from CMSD.ARTICLE article0_
Hibernate: select article0_.ARTICLE_ID as ARTICLE_ID, article0_.NAME as NAME, article0_.DESCRIPTION as DESCRIPT3_ from CMSD.ARTICLE article0_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader doFind
FINEST: processing result set
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '21' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 21
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 21
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#21
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 0' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@b6548' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '22' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 22
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 22
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#22
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 1' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@2db19d' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '23' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 23
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 23
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#23
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 2' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@16a9b9c' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '24' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 24
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 24
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#24
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 3' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@1ff92f5' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '25' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 25
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 25
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#25
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 4' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@17ba38f' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '26' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 26
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 26
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#26
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 5' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@1142196' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '27' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 27
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 27
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#27
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 6' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@d3c6a3' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '28' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 28
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 28
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#28
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 7' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@5ddb6e' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '29' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 29
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 29
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#29
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 8' as column: NAME
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@4865ce' as column: DESCRIPT3_
Oct 9, 2003 3:40:31 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning '30' as column: ARTICLE_ID
Oct 9, 2003 3:40:31 PM net.sf.hibernate.loader.Loader getRow
FINE: result row: 30
Oct 9, 2003 3:40:32 PM net.sf.hibernate.loader.Loader loadFromResultSet
FINEST: Initializing object from ResultSet: 30
Oct 9, 2003 3:40:32 PM net.sf.hibernate.loader.Loader hydrate
FINEST: Hydrating entity: de.ems.cms.beans.Article#30
Oct 9, 2003 3:40:32 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'article 9' as column: NAME
Oct 9, 2003 3:40:32 PM net.sf.hibernate.type.NullableType nullSafeGet
FINEST: returning 'oracle.sql.CLOB@14d7745' as column: DESCRIPT3_
Oct 9, 2003 3:40:32 PM net.sf.hibernate.loader.Loader doFind
FINEST: done processing result set (10 rows)
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.BatcherImpl logClosePreparedStatement
FINEST: done closing: 0 open PreparedStatements, 0 open ResultSets
Oct 9, 2003 3:40:32 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: recaching
Oct 9, 2003 3:40:32 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: total checked-out statements: 0
Oct 9, 2003 3:40:32 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: checked out: []
Oct 9, 2003 3:40:32 PM net.sf.hibernate.loader.Loader doFind
FINEST: total objects hydrated: 10
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#21]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#21]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#22]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#22]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#23]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#23]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#24]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#24]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#25]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#25]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#26]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#26]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#27]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#27]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#28]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#28]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#29]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#29]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: resolving associations for [de.ems.cms.beans.Article#30]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initializeEntity
FINE: done materializing entity [de.ems.cms.beans.Article#30]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl initialize
FINEST: initializing collection [de.ems.cms.beans.Publication.articles#31]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.BatcherImpl logOpenPreparedStatement
FINEST: about to open: 0 open PreparedStatements, 0 open ResultSets
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionFactoryImpl getPreparedStatement
FINE: prepared statement get: select art_pub0_.ARTICLE_ID as ARTICLE_ID__, article1_.ARTICLE_ID as ARTICLE_ID0_, article1_.NAME as NAME0_, article1_.DESCRIPTION as DESCRIPT3_0_ from ART_PUB art_pub0_, CMSD.ARTICLE article1_ where art_pub0_.PUBLICATION_ID=? and art_pub0_.ARTICLE_ID=article1_.ARTICLE_ID(+)
Oct 9, 2003 3:40:32 PM net.sf.hibernate.ps.PreparedStatementCache getPreparedStatement
FINEST: preparing statement: select art_pub0_.ARTICLE_ID as ARTICLE_ID__, article1_.ARTICLE_ID as ARTICLE_ID0_, article1_.NAME as NAME0_, article1_.DESCRIPTION as DESCRIPT3_0_ from ART_PUB art_pub0_, CMSD.ARTICLE article1_ where art_pub0_.PUBLICATION_ID=? and art_pub0_.ARTICLE_ID=article1_.ARTICLE_ID(+)
Hibernate: select art_pub0_.ARTICLE_ID as ARTICLE_ID__, article1_.ARTICLE_ID as ARTICLE_ID0_, article1_.NAME as NAME0_, article1_.DESCRIPTION as DESCRIPT3_0_ from ART_PUB art_pub0_, CMSD.ARTICLE article1_ where art_pub0_.PUBLICATION_ID=? and art_pub0_.ARTICLE_ID=article1_.ARTICLE_ID(+)
Oct 9, 2003 3:40:32 PM net.sf.hibernate.type.NullableType nullSafeSet
FINEST: binding '31' to parameter: 1
Oct 9, 2003 3:40:32 PM net.sf.hibernate.loader.Loader doFind
FINEST: processing result set
Oct 9, 2003 3:40:32 PM net.sf.hibernate.loader.Loader doFind
FINEST: done processing result set (0 rows)
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.BatcherImpl logClosePreparedStatement
FINEST: done closing: 0 open PreparedStatements, 0 open ResultSets
Oct 9, 2003 3:40:32 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: recaching
Oct 9, 2003 3:40:32 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: total checked-out statements: 0
Oct 9, 2003 3:40:32 PM net.sf.hibernate.ps.PreparedStatementCache closePreparedStatement
FINEST: checked out: []
Oct 9, 2003 3:40:32 PM net.sf.hibernate.loader.Loader doFind
FINEST: total objects hydrated: 0
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl saveOrUpdate
FINEST: saveOrUpdate() persistent instance
Oct 9, 2003 3:40:32 PM net.sf.hibernate.transaction.JDBCTransaction commit
FINE: commit
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINEST: flushing session
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl$CollectionEntry preFlush
FINE: Collection dirty: [de.ems.cms.beans.Publication.articles#31]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl flushEntities
FINEST: Flushing entities and processing referenced collections
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Publication.articles#31], was: [de.ems.cms.beans.Publication.articles#31]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#21], was: [de.ems.cms.beans.Article.publications#21]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#22], was: [de.ems.cms.beans.Article.publications#22]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#23], was: [de.ems.cms.beans.Article.publications#23]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#24], was: [de.ems.cms.beans.Article.publications#24]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#25], was: [de.ems.cms.beans.Article.publications#25]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#26], was: [de.ems.cms.beans.Article.publications#26]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#27], was: [de.ems.cms.beans.Article.publications#27]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#28], was: [de.ems.cms.beans.Article.publications#28]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#29], was: [de.ems.cms.beans.Article.publications#29]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl updateReachableCollection
FINE: Collection found: [de.ems.cms.beans.Article.publications#30], was: [de.ems.cms.beans.Article.publications#30]
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl flushCollections
FINEST: Processing unreferenced collections
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl flushCollections
FINEST: Scheduling collection removes/(re)creates/updates
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINE: Flushed: 0 insertions, 0 updates, 0 deletions to 11 objects
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl flushEverything
FINE: Flushed: 0 (re)creations, 1 updates, 0 removals to 11 collections
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl execute
FINEST: executing flush
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl postFlush
FINEST: post flush
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl afterTransactionCompletion
FINEST: transaction completion
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl close
FINEST: closing session
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl disconnect
FINE: disconnecting session
Oct 9, 2003 3:40:32 PM net.sf.hibernate.connection.DriverManagerConnectionProvider closeConnection
FINEST: returning connection to pool, pool size: 1
Oct 9, 2003 3:40:32 PM net.sf.hibernate.impl.SessionImpl afterTransactionCompletion
FINEST: transaction completion