Hi (sorry for my english in advance),

I'm trying to test Hibernate with e simple example

I'm using hibernate 2.1.3
Oracle 8.1.6

My probleme is that i can retrieve and print data from my database but when i try to insert or update an object everything seems to be good but nothing is inserted in Database.

hibernate.cfg.xml

<session-factory>

<!-- local connection properties -->
<property name="hibernate.connection.url">jdbc:oracle:thin:@aqtpcip231:1521:ORCL</property>
<property name="hibernate.connection.driver_class">oracle.jdbc.driver.OracleDriver</property>
<property name="hibernate.connection.username">gsp</property>
<property name="hibernate.connection.password">gsp</property>
<!-- property name="hibernate.connection.pool_size"></property -->

<!-- dialect for Oracle (any version) -->
<property name="dialect">net.sf.hibernate.dialect.OracleDialect</property>

<property name="hibernate.show_sql">false</property>
<property name="hibernate.use_outer_join">true</property>
<property name="hibernate.transaction.factory_class">net.sf.hibernate.transaction.JTATransactionFactory</property>
<property name="jta.UserTransaction">java:comp/UserTransaction</property>

<property name="hibernate.transaction.factory_class">net.sf.hibernate.transaction.JTATransactionFactory</property>
<property name="hibernate.transaction.manager_lookup_class">net.sf.hibernate.transaction.JBossTransactionManagerLookup</property>

<!-- Mapping files -->
<mapping resource="User.hbm.xml"/>

</session-factory>

User.hbm.xml
<class name="hibernate.User" table="MIGUSER">

<!-- A 32 hex character is our surrogate key. It's automatically
generated by Hibernate with the UUID pattern. -->
<id name="id" type="long" unsaved-value="null" >
<column name="ID"
sql-type="number"
not-null="true"/>
<generator class="sequence">
<param name="sequence">seq_miguser</param>
</generator>
</id>


<property name="name" type="string">
<column name="NOM" sql-type="string" length="50"/>
</property>
<property name="email" type="string">
<column name="EMAIL" sql-type="string" length="50"/>
</property>


</class>

My Servlet

Session session;
try {
session = HibernateUtil.currentSession();
Transaction tx = session.beginTransaction();

System.err.println("J'ECRIS");
User princess = new User();
princess.setName("ZXDREAM.com");
princess.setEmail("admin@zxdream.com");
princess.setDateNaissance(new Date());

out.println("Identifiant: " + princess.getId());

session.save(princess);


//session.flush();
tx.commit();
//session.flush();

HibernateUtil.closeSession();

The trace
[net.sf.hibernate.impl.BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
[net.sf.hibernate.connection.DriverManagerConnectionProvider] total checked-out connections: 0
[net.sf.hibernate.connection.DriverManagerConnectionProvider] using pooled JDBC connection, pool size: 0
[net.sf.hibernate.SQL] select seq_miguser.nextval from dual
[net.sf.hibernate.impl.BatcherImpl] preparing statement
[net.sf.hibernate.id.SequenceGenerator] Sequence identifier generated: 14
[net.sf.hibernate.impl.BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
[net.sf.hibernate.impl.BatcherImpl] closing statement
[net.sf.hibernate.impl.SessionImpl] generated identifier: 14
[net.sf.hibernate.impl.SessionImpl] saving [hibernate.User#14]
[net.sf.hibernate.impl.SessionImpl] flushing session
[net.sf.hibernate.impl.SessionImpl] Flushing entities and processing referenced collections
[net.sf.hibernate.impl.SessionImpl] Processing unreferenced collections
[net.sf.hibernate.impl.SessionImpl] Scheduling collection removes/(re)creates/updates
[net.sf.hibernate.impl.SessionImpl] Flushed: 1 insertions, 0 updates, 0 deletions to 1 objects
[net.sf.hibernate.impl.SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
[net.sf.hibernate.impl.Printer] listing entities:
[net.sf.hibernate.impl.Printer] hibernate.User{email=admin@zxdream.com, name=ZXDREAM.com, id=14}
[net.sf.hibernate.impl.SessionImpl] executing flush
[net.sf.hibernate.persister.EntityPersister] Inserting entity: [hibernate.User#14]
[net.sf.hibernate.impl.BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
[net.sf.hibernate.SQL] insert into MIGUSER (NOM, EMAIL, ID) values (?, ?, ?)
[net.sf.hibernate.impl.BatcherImpl] preparing statement
[net.sf.hibernate.persister.EntityPersister] Dehydrating entity: [hibernate.User#14]
[net.sf.hibernate.type.StringType] binding 'ZXDREAM.com' to parameter: 1
[net.sf.hibernate.type.StringType] binding 'admin@zxdream.com' to parameter: 2
[net.sf.hibernate.type.LongType] binding '14' to parameter: 3
[net.sf.hibernate.impl.BatcherImpl] Adding to batch
[net.sf.hibernate.impl.BatcherImpl] Executing batch size: 1
[net.sf.hibernate.impl.BatcherImpl] success of batch update unknown: 0
[net.sf.hibernate.impl.BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
[net.sf.hibernate.impl.BatcherImpl] closing statement
[net.sf.hibernate.impl.SessionImpl] post flush
[net.sf.hibernate.transaction.JTATransaction] commit
[net.sf.hibernate.impl.SessionImpl] flushing session
[net.sf.hibernate.impl.SessionImpl] Flushing entities and processing referenced collections
[net.sf.hibernate.impl.SessionImpl] Processing unreferenced collections
[net.sf.hibernate.impl.SessionImpl] Scheduling collection removes/(re)creates/updates
[net.sf.hibernate.impl.SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
[net.sf.hibernate.impl.SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
[net.sf.hibernate.impl.Printer] listing entities:
[net.sf.hibernate.impl.Printer] hibernate.User{email=admin@zxdream.com, name=ZXDREAM.com, id=14}
[net.sf.hibernate.impl.SessionImpl] executing flush
[net.sf.hibernate.impl.SessionImpl] post flush
[net.sf.hibernate.impl.SessionImpl] transaction completion
[net.sf.hibernate.impl.SessionImpl] flushing session
[net.sf.hibernate.impl.SessionImpl] Flushing entities and processing referenced collections
[net.sf.hibernate.impl.SessionImpl] Processing unreferenced collections
[net.sf.hibernate.impl.SessionImpl] Scheduling collection removes/(re)creates/updates
[net.sf.hibernate.impl.SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
[net.sf.hibernate.impl.SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
If somebody could help me it would be so nice.
Thanks in advance for your help

There should be a pb with your Tx
Do you have an exception thrown (or do you swallow an exception)?

No I have no exception in my log and i don't swallow any in my code.

It's a bit strange

thx for your reply and I hope someone will solve my problem

i know my reply is stupid but one of my society developer made this mistake: are you sure you're working on the same db with hibernate AND the db client you use to check rows?

Yes I've only one DB...

I'm having a problem similiar with this.I'm new to hibernate and jboss. My application says that i'm commiting truly but nothing happens in db. I'm using JBoss4 and hibernate 2.1.6 .

the problem is when i want to commit a transaction the application goes into JTATransaction class and then commit() function. when doing the if (newTransaction) operation it gets an newTransaction = false value and it goes directly to else case and don't do the ut.commit();. thats why the code does not throw any exception because there is no exception.

why this could be happening?

What you describe may not actually be wrong. In the case where Hibernate isn't actually the orginator of a transaction it won't actually commit the transaction either. Instead it basically just joins the transaction, does whatever it needs to do, then leaves.

In a lot of J2EE apps that I've worked with transaction as started and ended as you enter and leave a session bean. So the container starts a transaction as you enter the session bean. Then you do some hibernate stuff and tell it to commit the transaction. The TX manager doesn't do it because you're not the "owner" of the transaction. On the way out of the session bean the TX manager will commit the transaction.

This is one possible case, I'm not sure if it's what is happening in your case or not.

I have the same problem.... Hibernate 2.1.6 & Websphere & Oracle 9i. (But I tried same code under JBoss and lived the same problem)

Here is my method in the facade(session bean):



and some of the log is:

2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] opened session
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] flushing session
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushing entities and processing referenced collections
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] Processing unreferenced collections
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] Scheduling collection removes/(re)creates/updates
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.SessionImpl] Dont need to execute flush
2004-12-15 18:04:03,656 DEBUG [net.sf.hibernate.impl.BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.SQL] select this.USER_ID as USER_ID0_, this.USER_NAME as USER_NAME0_, this.USER_EMPNO as USER_EMPNO0_ from SECURITY.TESTUSER this where this.USER_ID=?
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.BatcherImpl] preparing statement
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.type.IntegerType] binding '1' to parameter: 1
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.loader.Loader] processing result set
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.type.IntegerType] returning '1' as column: USER_ID0_
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.loader.Loader] result row: 1
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.loader.Loader] Initializing object from ResultSet: 1
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.loader.Loader] Hydrating entity: com.isbank.hibernate.test.User#1
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.type.StringType] returning 'test' as column: USER_NAME0_
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.type.LongType] returning '44444' as column: USER_EMPNO0_
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.loader.Loader] done processing result set (1 rows)
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.BatcherImpl] closing statement
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.loader.Loader] total objects hydrated: 1
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] resolving associations for [com.isbank.hibernate.test.User#1]
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] done materializing entity [com.isbank.hibernate.test.User#1]
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] initializing non-lazy collections
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] flushing session
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushing entities and processing referenced collections
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] Processing unreferenced collections
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] Scheduling collection removes/(re)creates/updates
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.Printer] listing entities:
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.Printer] com.isbank.hibernate.test.User{userID=1, UserName=test, userEmpNo=44444}
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] executing flush
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] post flush
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] closing session
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] disconnecting session
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.engine.CacheSynchronization] transaction before completion callback
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.engine.CacheSynchronization] transaction after completion callback, status: 3
2004-12-15 18:04:03,671 DEBUG [net.sf.hibernate.impl.SessionImpl] transaction completion
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] opened session
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] immutable instance passed to doUpdate(), locking
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] reassociating transient instance: [com.isbank.hibernate.test.User#1]
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] flushing session
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushing entities and processing referenced collections
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Processing unreferenced collections
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Scheduling collection removes/(re)creates/updates
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.Printer] listing entities:
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.Printer] com.isbank.hibernate.test.User{userID=1, UserName=merty, userEmpNo=44444}
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] executing flush
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] post flush
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] flushing session
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushing entities and processing referenced collections
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Processing unreferenced collections
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Scheduling collection removes/(re)creates/updates
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.Printer] listing entities:
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.Printer] com.isbank.hibernate.test.User{userID=1, UserName=merty, userEmpNo=44444}
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] executing flush
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] post flush
2004-12-15 18:04:05,265 DEBUG [net.sf.hibernate.impl.SessionImpl] closing session

0 insertions, 0 updates, 0 deletions to 1 objects

When I debug, in JTATransaction class of Hibernate code runs into the else where Gavin commented as

// this one only really needed for badly-behaved applications!
// (if the TransactionManager has a Sychronization registered,
// its a noop)
// (actually we do need it for downgrading locks)


right config for :
hibernate.jndi.url
hibernate.jndi.class
jta.UserTransaction

I've read nearly all the posts about this subjects. At the end no exceptions but no updates.... Is the anybody solved this kind of problem?

We were thinking that was the problem of our code could be. All the select operations are OK but when it comes to commit needed operations the resulting state is a bit confusing for me.



yes merty;again thats what i'm facing. as clajoine said the problem could be in the session beans.

the properties i set to jboss about transaction manager are:

hibernate.transaction.manager_lookup_class net.sf.hibernate.transaction.JBossTransactionManagerLookup
hibernate.transaction.factory_class = net.sf.hibernate.transaction.JTATransactionFactory
hibernate.query.substitutions true 1, false 0, yes 'Y', no 'N'
hibernate.jdbc.batch_size 0
jta.UserTransaction = java:/comp/UserTransaction
jndi.class = org.jnp.interfaces.NamingContextFactory
jndi.url = jnp://localhost:1099

is there anything i forget about this?

PS: and can anyone help me finding any small example how could i do this correctly?

You might want to verify that the JNDI location of the UserTransaction object is correct. For some reason I thought it was different than that. But the rest of the properties look right at first blush.

thanks chad; for your quick reply.

jta.UserTransaction = java:/comp/UserTransaction is a valid address for my case. I'm just tring to give more information about the problem that i'm facing. You said you've seen some cases like my case. What are the solutions you've seen during these problems? How did you solved the problem you've told me about the sessşon beans?

Hi again...

I've moved my project to WSAD for testing that if I'm making something wrong with JBoss. No change happened again. And then I've tried to build a test case with JUnit...Then I've created a simple project for testing update and insert functions of my project. The result I've got is : I can insert but I can't update... I really don't understad why this is happening; but this is really confusing for me. I'm sending my sample code and log values.The og is a bit long but i think it will help to understand the situation better...

the HibernateUtil class is from caveatemptor example of hibernate. All helps are really appresiated; I really need this...

Thanks and best regards...

LOG:

2004-12-17 11:58:05,466 INFO - Hibernate 2.1.6
2004-12-17 11:58:05,466 INFO - Hibernate 2.1.6
2004-12-17 11:58:05,466 INFO - hibernate.properties not found
2004-12-17 11:58:05,466 INFO - hibernate.properties not found
2004-12-17 11:58:05,482 INFO - using CGLIB reflection optimizer
2004-12-17 11:58:05,482 INFO - using CGLIB reflection optimizer
2004-12-17 11:58:05,482 INFO - configuring from resource: /hibernate.cfg.xml
2004-12-17 11:58:05,482 INFO - configuring from resource: /hibernate.cfg.xml
2004-12-17 11:58:05,482 INFO - Configuration resource: /hibernate.cfg.xml
2004-12-17 11:58:05,482 INFO - Configuration resource: /hibernate.cfg.xml
2004-12-17 11:58:05,560 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath under net/sf/hibernate/
2004-12-17 11:58:05,560 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath under net/sf/hibernate/
2004-12-17 11:58:05,560 DEBUG - found http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath
2004-12-17 11:58:05,560 DEBUG - found http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath
2004-12-17 11:58:05,622 DEBUG - dialect=net.sf.hibernate.dialect.Oracle9Dialect
2004-12-17 11:58:05,622 DEBUG - dialect=net.sf.hibernate.dialect.Oracle9Dialect
2004-12-17 11:58:05,622 DEBUG - connection.driver_class=oracle.jdbc.driver.OracleDriver
2004-12-17 11:58:05,622 DEBUG - connection.driver_class=oracle.jdbc.driver.OracleDriver
2004-12-17 11:58:05,622 DEBUG - connection.url=jdbc:oracle:thin:@xx.xx.xxx.xx:xxxx:XXXXX
2004-12-17 11:58:05,622 DEBUG - connection.url=jdbc:oracle:thin:@xx.xx.xxx.xx:xxxx:XXXXX
2004-12-17 11:58:05,622 DEBUG - connection.username=SECURITY
2004-12-17 11:58:05,622 DEBUG - connection.username=SECURITY
2004-12-17 11:58:05,622 DEBUG - connection.password=secur
2004-12-17 11:58:05,622 DEBUG - connection.password=secur
2004-12-17 11:58:05,622 DEBUG - connection.pool_size=1
2004-12-17 11:58:05,622 DEBUG - connection.pool_size=1
2004-12-17 11:58:05,622 DEBUG - show_sql=false
2004-12-17 11:58:05,622 DEBUG - show_sql=false
2004-12-17 11:58:05,622 DEBUG - dialect=net.sf.hibernate.dialect.Oracle9Dialect
2004-12-17 11:58:05,622 DEBUG - dialect=net.sf.hibernate.dialect.Oracle9Dialect
2004-12-17 11:58:05,622 DEBUG - null<-org.dom4j.tree.DefaultAttribute@19b1de [Attribute: name resource value "User.hbm.xml"]
2004-12-17 11:58:05,622 DEBUG - null<-org.dom4j.tree.DefaultAttribute@19b1de [Attribute: name resource value "User.hbm.xml"]
2004-12-17 11:58:05,622 INFO - Mapping resource: User.hbm.xml
2004-12-17 11:58:05,622 INFO - Mapping resource: User.hbm.xml
2004-12-17 11:58:05,638 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
2004-12-17 11:58:05,638 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/
2004-12-17 11:58:05,638 DEBUG - found http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
2004-12-17 11:58:05,638 DEBUG - found http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath
2004-12-17 11:58:05,763 INFO - Mapping class: com.isbank.User -> TESTUSER
2004-12-17 11:58:05,763 INFO - Mapping class: com.isbank.User -> TESTUSER
2004-12-17 11:58:05,872 DEBUG - Mapped property: userID -> USER_ID, type: integer
2004-12-17 11:58:05,872 DEBUG - Mapped property: userID -> USER_ID, type: integer
2004-12-17 11:58:05,888 DEBUG - Mapped property: UserName -> USER_NAME, type: string
2004-12-17 11:58:05,888 DEBUG - Mapped property: UserName -> USER_NAME, type: string
2004-12-17 11:58:05,888 DEBUG - Mapped property: userEmpNo -> USER_EMPNO, type: long
2004-12-17 11:58:05,888 DEBUG - Mapped property: userEmpNo -> USER_EMPNO, type: long
2004-12-17 11:58:05,888 INFO - Configured SessionFactory: null
2004-12-17 11:58:05,888 INFO - Configured SessionFactory: null
2004-12-17 11:58:05,888 DEBUG - properties: {hibernate.connection.password=secur, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=C:\OpenSource\j2sdk1.4.2_04\jre\bin, java.vm.version=1.4.2_04-b05, hibernate.connection.username=SECURITY, 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=US, sun.os.patch.level=Service Pack 4, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\hib\NoContainer, java.runtime.version=1.4.2_04-b05, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\Home\LOCALS~1\Temp\, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows 2000, sun.java2d.fontpath=, java.library.path=C:\OpenSource\j2sdk1.4.2_04\bin;.;C:\WINNT\system32;C:\WINNT;D:\Oracle\product\10.1.0\Client_1\bin;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin\client;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\Program Files\IBM\Trace Facility;C:\Program Files\Personal Communications;C:\MSSQL7\BINN;C:\Program Files\Rational\ClearCase\bin;C:\Program Files\Rational\common;D:\IBM\SQLLIB\BIN;D:\IBM\SQLLIB\FUNCTION;D:\IBM\SQLLIB\SAMPLES\REPL;C:\OpenSource\Maven 1.0\bin;C:\Program Files\SSH Communications Security\SSH Secure Shell, 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.0, connection.password=secur, user.home=C:\Documents and Settings\CK42671, user.timezone=Europe/Athens, connection.username=SECURITY, 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=false, user.name=CK42671, java.class.path=/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit_3.0.1/junitsupport.jar;/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit.runtime_3.0.0/junitruntime.jar;C:\hib\NoContainer\bin;C:\OpenSource\repository\junit\jars\junit-3.8.1.jar;C:\OpenSource\repository\oracle\jars\ojdbc14.jar;C:\OpenSource\repository\j2ee\jars\j2ee-1.3.jar;C:\hib\NoContainer\lib\c3p0-0.8.4.5.jar;C:\hib\NoContainer\lib\cglib-full-2.0.1.jar;C:\hib\NoContainer\lib\commons-collections-2.1.1.jar;C:\hib\NoContainer\lib\dom4j-1.4.jar;C:\hib\NoContainer\lib\ehcache-0.9.jar;C:\hib\NoContainer\lib\ejb-api.jar;C:\hib\NoContainer\lib\hibernate-2.1.6.jar;C:\hib\NoContainer\lib\hsqldb.jar;C:\hib\NoContainer\lib\jsdk23.jar;C:\hib\NoContainer\lib\jta-api.jar;C:\hib\NoContainer\lib\junit-3.8.1.jar;C:\hib\NoContainer\lib\odmg-3.0.jar;C:\OpenSource\repository\log4j\jars\log4j-1.2.8.jar;C:\OpenSource\repository\commons-logging\jars\commons-logging-1.0.3.jar, hibernate.show_sql=false, java.vm.specification.version=1.0, java.home=C:\OpenSource\j2sdk1.4.2_04\jre, sun.arch.data.model=32, hibernate.connection.url=jdbc:oracle:thin:@10.50.104.46:1521:RACTS2, hibernate.dialect=net.sf.hibernate.dialect.Oracle9Dialect, connection.pool_size=1, user.language=en, java.specification.vendor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, hibernate.cglib.use_reflection_optimizer=true, java.vm.info=mixed mode, java.version=1.4.2_04, java.ext.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\ext, sun.boot.class.path=C:\OpenSource\j2sdk1.4.2_04\jre\lib\rt.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\i18n.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\sunrsasign.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jsse.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jce.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\charsets.jar;C:\OpenSource\j2sdk1.4.2_04\jre\classes;C:\hib\NoContainer, 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:@10.50.104.46:1521:RACTS2, dialect=net.sf.hibernate.dialect.Oracle9Dialect, sun.cpu.isalist=pentium i486 i386}
2004-12-17 11:58:05,888 DEBUG - properties: {hibernate.connection.password=secur, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=C:\OpenSource\j2sdk1.4.2_04\jre\bin, java.vm.version=1.4.2_04-b05, hibernate.connection.username=SECURITY, 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=US, sun.os.patch.level=Service Pack 4, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\hib\NoContainer, java.runtime.version=1.4.2_04-b05, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\Home\LOCALS~1\Temp\, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows 2000, sun.java2d.fontpath=, java.library.path=C:\OpenSource\j2sdk1.4.2_04\bin;.;C:\WINNT\system32;C:\WINNT;D:\Oracle\product\10.1.0\Client_1\bin;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin\client;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\Program Files\IBM\Trace Facility;C:\Program Files\Personal Communications;C:\MSSQL7\BINN;C:\Program Files\Rational\ClearCase\bin;C:\Program Files\Rational\common;D:\IBM\SQLLIB\BIN;D:\IBM\SQLLIB\FUNCTION;D:\IBM\SQLLIB\SAMPLES\REPL;C:\OpenSource\Maven 1.0\bin;C:\Program Files\SSH Communications Security\SSH Secure Shell, 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.0, connection.password=secur, user.home=C:\Documents and Settings\CK42671, user.timezone=Europe/Athens, connection.username=SECURITY, 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=false, user.name=CK42671, java.class.path=/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit_3.0.1/junitsupport.jar;/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit.runtime_3.0.0/junitruntime.jar;C:\hib\NoContainer\bin;C:\OpenSource\repository\junit\jars\junit-3.8.1.jar;C:\OpenSource\repository\oracle\jars\ojdbc14.jar;C:\OpenSource\repository\j2ee\jars\j2ee-1.3.jar;C:\hib\NoContainer\lib\c3p0-0.8.4.5.jar;C:\hib\NoContainer\lib\cglib-full-2.0.1.jar;C:\hib\NoContainer\lib\commons-collections-2.1.1.jar;C:\hib\NoContainer\lib\dom4j-1.4.jar;C:\hib\NoContainer\lib\ehcache-0.9.jar;C:\hib\NoContainer\lib\ejb-api.jar;C:\hib\NoContainer\lib\hibernate-2.1.6.jar;C:\hib\NoContainer\lib\hsqldb.jar;C:\hib\NoContainer\lib\jsdk23.jar;C:\hib\NoContainer\lib\jta-api.jar;C:\hib\NoContainer\lib\junit-3.8.1.jar;C:\hib\NoContainer\lib\odmg-3.0.jar;C:\OpenSource\repository\log4j\jars\log4j-1.2.8.jar;C:\OpenSource\repository\commons-logging\jars\commons-logging-1.0.3.jar, hibernate.show_sql=false, java.vm.specification.version=1.0, java.home=C:\OpenSource\j2sdk1.4.2_04\jre, sun.arch.data.model=32, hibernate.connection.url=jdbc:oracle:thin:@10.50.104.46:1521:RACTS2, hibernate.dialect=net.sf.hibernate.dialect.Oracle9Dialect, connection.pool_size=1, user.language=en, java.specification.vendor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, hibernate.cglib.use_reflection_optimizer=true, java.vm.info=mixed mode, java.version=1.4.2_04, java.ext.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\ext, sun.boot.class.path=C:\OpenSource\j2sdk1.4.2_04\jre\lib\rt.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\i18n.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\sunrsasign.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jsse.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jce.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\charsets.jar;C:\OpenSource\j2sdk1.4.2_04\jre\classes;C:\hib\NoContainer, 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:@10.50.104.46:1521:RACTS2, dialect=net.sf.hibernate.dialect.Oracle9Dialect, sun.cpu.isalist=pentium i486 i386}
2004-12-17 11:58:05,888 INFO - processing one-to-many association mappings
2004-12-17 11:58:05,888 INFO - processing one-to-many association mappings
2004-12-17 11:58:05,888 INFO - processing one-to-one association property references
2004-12-17 11:58:05,888 INFO - processing one-to-one association property references
2004-12-17 11:58:05,888 INFO - processing foreign key constraints
2004-12-17 11:58:05,888 INFO - processing foreign key constraints
2004-12-17 11:58:05,935 INFO - Using dialect: net.sf.hibernate.dialect.Oracle9Dialect
2004-12-17 11:58:05,935 INFO - Using dialect: net.sf.hibernate.dialect.Oracle9Dialect
2004-12-17 11:58:05,935 INFO - Use outer join fetching: true
2004-12-17 11:58:05,935 INFO - Use outer join fetching: true
2004-12-17 11:58:05,935 INFO - Using Hibernate built-in connection pool (not for production use!)
2004-12-17 11:58:05,935 INFO - Using Hibernate built-in connection pool (not for production use!)
2004-12-17 11:58:05,935 INFO - Hibernate connection pool size: 1
2004-12-17 11:58:05,935 INFO - Hibernate connection pool size: 1
2004-12-17 11:58:05,951 INFO - using driver: oracle.jdbc.driver.OracleDriver at URL: jdbc:oracle:thin:@10.50.104.46:1521:RACTS2
2004-12-17 11:58:05,951 INFO - using driver: oracle.jdbc.driver.OracleDriver at URL: jdbc:oracle:thin:@10.50.104.46:1521:RACTS2
2004-12-17 11:58:05,951 INFO - connection properties: {user=SECURITY, password=secur}
2004-12-17 11:58:05,951 INFO - connection properties: {user=SECURITY, password=secur}
2004-12-17 11:58:05,966 INFO - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended)
2004-12-17 11:58:05,966 INFO - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended)
2004-12-17 11:58:05,966 DEBUG - total checked-out connections: 0
2004-12-17 11:58:05,966 DEBUG - total checked-out connections: 0
2004-12-17 11:58:05,966 DEBUG - opening new JDBC connection
2004-12-17 11:58:05,966 DEBUG - opening new JDBC connection
2004-12-17 11:58:06,404 DEBUG - created connection to: jdbc:oracle:thin:@xx.xx.xxx.xx:xxxx:XXXXX, Isolation Level: 2
2004-12-17 11:58:06,404 DEBUG - created connection to: jdbc:oracle:thin:@xx.xx.xxx.xx:xxxx:XXXXX, Isolation Level: 2
2004-12-17 11:58:06,419 DEBUG - returning connection to pool, pool size: 1
2004-12-17 11:58:06,419 DEBUG - returning connection to pool, pool size: 1
2004-12-17 11:58:06,419 INFO - Use scrollable result sets: true
2004-12-17 11:58:06,419 INFO - Use scrollable result sets: true
2004-12-17 11:58:06,419 INFO - Use JDBC3 getGeneratedKeys(): false
2004-12-17 11:58:06,419 INFO - Use JDBC3 getGeneratedKeys(): false
2004-12-17 11:58:06,419 INFO - Optimize cache for minimal puts: false
2004-12-17 11:58:06,419 INFO - Optimize cache for minimal puts: false
2004-12-17 11:58:06,419 INFO - Query language substitutions: {}
2004-12-17 11:58:06,419 INFO - Query language substitutions: {}
2004-12-17 11:58:06,419 INFO - cache provider: net.sf.hibernate.cache.EhCacheProvider
2004-12-17 11:58:06,419 INFO - cache provider: net.sf.hibernate.cache.EhCacheProvider
2004-12-17 11:58:06,419 INFO - instantiating and configuring caches
2004-12-17 11:58:06,419 INFO - instantiating and configuring caches
2004-12-17 11:58:06,607 INFO - building session factory
2004-12-17 11:58:06,607 INFO - building session factory
2004-12-17 11:58:06,607 DEBUG - instantiating session factory with properties: {hibernate.connection.password=secur, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=C:\OpenSource\j2sdk1.4.2_04\jre\bin, java.vm.version=1.4.2_04-b05, hibernate.connection.username=SECURITY, 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=US, sun.os.patch.level=Service Pack 4, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\hib\NoContainer, java.runtime.version=1.4.2_04-b05, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\CK42671\LOCALS~1\Temp\, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows 2000, sun.java2d.fontpath=, java.library.path=C:\OpenSource\j2sdk1.4.2_04\bin;.;C:\WINNT\system32;C:\WINNT;D:\Oracle\product\10.1.0\Client_1\bin;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin\client;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\Program Files\IBM\Trace Facility;C:\Program Files\Personal Communications;C:\MSSQL7\BINN;C:\Program Files\Rational\ClearCase\bin;C:\Program Files\Rational\common;D:\IBM\SQLLIB\BIN;D:\IBM\SQLLIB\FUNCTION;D:\IBM\SQLLIB\SAMPLES\REPL;C:\OpenSource\Maven 1.0\bin;C:\Program Files\SSH Communications Security\SSH Secure Shell, 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.0, connection.password=secur, user.home=C:\Documents and Settings\CK42671, user.timezone=Europe/Athens, connection.username=SECURITY, 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=false, user.name=CK42671, java.class.path=/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit_3.0.1/junitsupport.jar;/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit.runtime_3.0.0/junitruntime.jar;C:\hib\NoContainer\bin;C:\OpenSource\repository\junit\jars\junit-3.8.1.jar;C:\OpenSource\repository\oracle\jars\ojdbc14.jar;C:\OpenSource\repository\j2ee\jars\j2ee-1.3.jar;C:\hib\NoContainer\lib\c3p0-0.8.4.5.jar;C:\hib\NoContainer\lib\cglib-full-2.0.1.jar;C:\hib\NoContainer\lib\commons-collections-2.1.1.jar;C:\hib\NoContainer\lib\dom4j-1.4.jar;C:\hib\NoContainer\lib\ehcache-0.9.jar;C:\hib\NoContainer\lib\ejb-api.jar;C:\hib\NoContainer\lib\hibernate-2.1.6.jar;C:\hib\NoContainer\lib\hsqldb.jar;C:\hib\NoContainer\lib\jsdk23.jar;C:\hib\NoContainer\lib\jta-api.jar;C:\hib\NoContainer\lib\junit-3.8.1.jar;C:\hib\NoContainer\lib\odmg-3.0.jar;C:\OpenSource\repository\log4j\jars\log4j-1.2.8.jar;C:\OpenSource\repository\commons-logging\jars\commons-logging-1.0.3.jar, hibernate.show_sql=false, java.vm.specification.version=1.0, java.home=C:\OpenSource\j2sdk1.4.2_04\jre, sun.arch.data.model=32, hibernate.connection.url=jdbc:oracle:thin:@10.50.104.46:1521:RACTS2, hibernate.dialect=net.sf.hibernate.dialect.Oracle9Dialect, connection.pool_size=1, user.language=en, java.specification.vendor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, hibernate.cglib.use_reflection_optimizer=true, java.vm.info=mixed mode, java.version=1.4.2_04, java.ext.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\ext, sun.boot.class.path=C:\OpenSource\j2sdk1.4.2_04\jre\lib\rt.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\i18n.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\sunrsasign.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jsse.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jce.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\charsets.jar;C:\OpenSource\j2sdk1.4.2_04\jre\classes;C:\hib\NoContainer, 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:@10.50.104.46:1521:RACTS2, dialect=net.sf.hibernate.dialect.Oracle9Dialect, sun.cpu.isalist=pentium i486 i386}
2004-12-17 11:58:06,607 DEBUG - instantiating session factory with properties: {hibernate.connection.password=secur, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, sun.boot.library.path=C:\OpenSource\j2sdk1.4.2_04\jre\bin, java.vm.version=1.4.2_04-b05, hibernate.connection.username=SECURITY, 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=US, sun.os.patch.level=Service Pack 4, java.vm.specification.name=Java Virtual Machine Specification, user.dir=C:\hib\NoContainer, java.runtime.version=1.4.2_04-b05, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.endorsed.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\endorsed, os.arch=x86, java.io.tmpdir=C:\DOCUME~1\CK42671\LOCALS~1\Temp\, line.separator=
, java.vm.specification.vendor=Sun Microsystems Inc., user.variant=, os.name=Windows 2000, sun.java2d.fontpath=, java.library.path=C:\OpenSource\j2sdk1.4.2_04\bin;.;C:\WINNT\system32;C:\WINNT;D:\Oracle\product\10.1.0\Client_1\bin;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin\client;D:\Oracle\product\10.1.0\Client_1\jre\1.4.2\bin;C:\WINNT\system32;C:\WINNT;C:\WINNT\System32\Wbem;C:\Program Files\IBM\Trace Facility;C:\Program Files\Personal Communications;C:\MSSQL7\BINN;C:\Program Files\Rational\ClearCase\bin;C:\Program Files\Rational\common;D:\IBM\SQLLIB\BIN;D:\IBM\SQLLIB\FUNCTION;D:\IBM\SQLLIB\SAMPLES\REPL;C:\OpenSource\Maven 1.0\bin;C:\Program Files\SSH Communications Security\SSH Secure Shell, 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.0, connection.password=secur, user.home=C:\Documents and Settings\CK42671, user.timezone=Europe/Athens, connection.username=SECURITY, 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=false, user.name=CK42671, java.class.path=/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit_3.0.1/junitsupport.jar;/c:/OpenSource/eclipse-3.0/plugins/org.eclipse.jdt.junit.runtime_3.0.0/junitruntime.jar;C:\hib\NoContainer\bin;C:\OpenSource\repository\junit\jars\junit-3.8.1.jar;C:\OpenSource\repository\oracle\jars\ojdbc14.jar;C:\OpenSource\repository\j2ee\jars\j2ee-1.3.jar;C:\hib\NoContainer\lib\c3p0-0.8.4.5.jar;C:\hib\NoContainer\lib\cglib-full-2.0.1.jar;C:\hib\NoContainer\lib\commons-collections-2.1.1.jar;C:\hib\NoContainer\lib\dom4j-1.4.jar;C:\hib\NoContainer\lib\ehcache-0.9.jar;C:\hib\NoContainer\lib\ejb-api.jar;C:\hib\NoContainer\lib\hibernate-2.1.6.jar;C:\hib\NoContainer\lib\hsqldb.jar;C:\hib\NoContainer\lib\jsdk23.jar;C:\hib\NoContainer\lib\jta-api.jar;C:\hib\NoContainer\lib\junit-3.8.1.jar;C:\hib\NoContainer\lib\odmg-3.0.jar;C:\OpenSource\repository\log4j\jars\log4j-1.2.8.jar;C:\OpenSource\repository\commons-logging\jars\commons-logging-1.0.3.jar, hibernate.show_sql=false, java.vm.specification.version=1.0, java.home=C:\OpenSource\j2sdk1.4.2_04\jre, sun.arch.data.model=32, hibernate.connection.url=jdbc:oracle:thin:@10.50.104.46:1521:RACTS2, hibernate.dialect=net.sf.hibernate.dialect.Oracle9Dialect, connection.pool_size=1, user.language=en, java.specification.vendor=Sun Microsystems Inc., awt.toolkit=sun.awt.windows.WToolkit, hibernate.cglib.use_reflection_optimizer=true, java.vm.info=mixed mode, java.version=1.4.2_04, java.ext.dirs=C:\OpenSource\j2sdk1.4.2_04\jre\lib\ext, sun.boot.class.path=C:\OpenSource\j2sdk1.4.2_04\jre\lib\rt.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\i18n.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\sunrsasign.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jsse.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\jce.jar;C:\OpenSource\j2sdk1.4.2_04\jre\lib\charsets.jar;C:\OpenSource\j2sdk1.4.2_04\jre\classes;C:\hib\NoContainer, 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:@10.50.104.46:1521:RACTS2, dialect=net.sf.hibernate.dialect.Oracle9Dialect, sun.cpu.isalist=pentium i486 i386}
2004-12-17 11:58:07,029 DEBUG - initializing class SessionFactoryObjectFactory
2004-12-17 11:58:07,029 DEBUG - initializing class SessionFactoryObjectFactory
2004-12-17 11:58:07,044 DEBUG - registered: 8a948bf000e076710100e07673b50000 (unnamed)
2004-12-17 11:58:07,044 DEBUG - registered: 8a948bf000e076710100e07673b50000 (unnamed)
2004-12-17 11:58:07,044 INFO - Not binding factory to JNDI, no JNDI name configured
2004-12-17 11:58:07,044 INFO - Not binding factory to JNDI, no JNDI name configured
2004-12-17 11:58:07,044 DEBUG - instantiated session factory
2004-12-17 11:58:07,044 DEBUG - instantiated session factory
2004-12-17 11:58:07,044 DEBUG - Starting new database transaction in this thread.
2004-12-17 11:58:07,044 DEBUG - Starting new database transaction in this thread.
2004-12-17 11:58:07,044 DEBUG - Opening new Session for this thread.
2004-12-17 11:58:07,044 DEBUG - Opening new Session for this thread.
2004-12-17 11:58:07,107 DEBUG - opened session
2004-12-17 11:58:07,107 DEBUG - opened session
2004-12-17 11:58:07,107 DEBUG - begin
2004-12-17 11:58:07,107 DEBUG - begin
2004-12-17 11:58:07,107 DEBUG - total checked-out connections: 0
2004-12-17 11:58:07,107 DEBUG - total checked-out connections: 0
2004-12-17 11:58:07,107 DEBUG - using pooled JDBC connection, pool size: 0
2004-12-17 11:58:07,107 DEBUG - using pooled JDBC connection, pool size: 0
2004-12-17 11:58:07,107 DEBUG - current autocommit status:false
2004-12-17 11:58:07,107 DEBUG - current autocommit status:false
Running test...
2004-12-17 11:58:07,138 DEBUG - attempt to find user
2004-12-17 11:58:07,138 DEBUG - attempt to find user
2004-12-17 11:58:07,138 DEBUG - loading [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - loading [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - attempting to resolve [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - attempting to resolve [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - object not resolved in any cache [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - object not resolved in any cache [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - Materializing entity: [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - Materializing entity: [com.x.User#1]
2004-12-17 11:58:07,138 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,138 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,138 DEBUG - select user0_.USER_ID as USER_ID0_, user0_.USER_NAME as USER_NAME0_, user0_.USER_EMPNO as USER_EMPNO0_ from SECURITY.TESTUSER user0_ where user0_.USER_ID=?
2004-12-17 11:58:07,138 DEBUG - select user0_.USER_ID as USER_ID0_, user0_.USER_NAME as USER_NAME0_, user0_.USER_EMPNO as USER_EMPNO0_ from SECURITY.TESTUSER user0_ where user0_.USER_ID=?
2004-12-17 11:58:07,138 DEBUG - preparing statement
2004-12-17 11:58:07,138 DEBUG - preparing statement
2004-12-17 11:58:07,435 DEBUG - binding '1' to parameter: 1
2004-12-17 11:58:07,435 DEBUG - binding '1' to parameter: 1
2004-12-17 11:58:07,529 DEBUG - processing result set
2004-12-17 11:58:07,529 DEBUG - processing result set
2004-12-17 11:58:07,529 DEBUG - result row: 1
2004-12-17 11:58:07,529 DEBUG - result row: 1
2004-12-17 11:58:07,529 DEBUG - Initializing object from ResultSet: 1
2004-12-17 11:58:07,529 DEBUG - Initializing object from ResultSet: 1
2004-12-17 11:58:07,529 DEBUG - Hydrating entity: com.x.User#1
2004-12-17 11:58:07,529 DEBUG - Hydrating entity: com.x.User#1
2004-12-17 11:58:07,529 DEBUG - returning 'TheName' as column: USER_NAME0_
2004-12-17 11:58:07,529 DEBUG - returning 'TheName' as column: USER_NAME0_
2004-12-17 11:58:07,529 DEBUG - returning '55555' as column: USER_EMPNO0_
2004-12-17 11:58:07,529 DEBUG - returning '55555' as column: USER_EMPNO0_
2004-12-17 11:58:07,544 DEBUG - done processing result set (1 rows)
2004-12-17 11:58:07,544 DEBUG - done processing result set (1 rows)
2004-12-17 11:58:07,544 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,544 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,544 DEBUG - closing statement
2004-12-17 11:58:07,544 DEBUG - closing statement
2004-12-17 11:58:07,544 DEBUG - total objects hydrated: 1
2004-12-17 11:58:07,544 DEBUG - total objects hydrated: 1
2004-12-17 11:58:07,544 DEBUG - resolving associations for [com.x.User#1]
2004-12-17 11:58:07,544 DEBUG - resolving associations for [com.x.User#1]
2004-12-17 11:58:07,544 DEBUG - done materializing entity [com.x.User#1]
2004-12-17 11:58:07,544 DEBUG - done materializing entity [com.x.User#1]
2004-12-17 11:58:07,544 DEBUG - initializing non-lazy collections
2004-12-17 11:58:07,544 DEBUG - initializing non-lazy collections
2004-12-17 11:58:07,544 DEBUG - TheName55555
2004-12-17 11:58:07,544 DEBUG - TheName55555
2004-12-17 11:58:07,544 DEBUG - Committing database transaction of this thread.
2004-12-17 11:58:07,544 DEBUG - Committing database transaction of this thread.
2004-12-17 11:58:07,544 DEBUG - commit
2004-12-17 11:58:07,544 DEBUG - commit
2004-12-17 11:58:07,544 DEBUG - flushing session
2004-12-17 11:58:07,544 DEBUG - flushing session
2004-12-17 11:58:07,544 DEBUG - Flushing entities and processing referenced collections
2004-12-17 11:58:07,544 DEBUG - Flushing entities and processing referenced collections
2004-12-17 11:58:07,544 DEBUG - Processing unreferenced collections
2004-12-17 11:58:07,544 DEBUG - Processing unreferenced collections
2004-12-17 11:58:07,544 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 11:58:07,544 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 11:58:07,544 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 11:58:07,544 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 11:58:07,544 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 11:58:07,544 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 11:58:07,560 DEBUG - listing entities:
2004-12-17 11:58:07,560 DEBUG - listing entities:
2004-12-17 11:58:07,560 DEBUG - com.x.User{userID=1, UserName=TheName, userEmpNo=55555}
2004-12-17 11:58:07,560 DEBUG - com.x.User{userID=1, UserName=TheName, userEmpNo=55555}
2004-12-17 11:58:07,560 DEBUG - executing flush
2004-12-17 11:58:07,560 DEBUG - executing flush
2004-12-17 11:58:07,560 DEBUG - post flush
2004-12-17 11:58:07,560 DEBUG - post flush
2004-12-17 11:58:07,560 DEBUG - transaction completion
2004-12-17 11:58:07,560 DEBUG - transaction completion
2004-12-17 11:58:07,560 DEBUG - Closing Session of this thread.
2004-12-17 11:58:07,560 DEBUG - Closing Session of this thread.
2004-12-17 11:58:07,560 DEBUG - closing session
2004-12-17 11:58:07,560 DEBUG - closing session
2004-12-17 11:58:07,560 DEBUG - disconnecting session
2004-12-17 11:58:07,560 DEBUG - disconnecting session
2004-12-17 11:58:07,560 DEBUG - returning connection to pool, pool size: 1
2004-12-17 11:58:07,560 DEBUG - returning connection to pool, pool size: 1
2004-12-17 11:58:07,560 DEBUG - transaction completion
2004-12-17 11:58:07,560 DEBUG - transaction completion
Running test...
2004-12-17 11:58:07,560 DEBUG - Starting new database transaction in this thread.
2004-12-17 11:58:07,560 DEBUG - Starting new database transaction in this thread.
2004-12-17 11:58:07,560 DEBUG - Opening new Session for this thread.
2004-12-17 11:58:07,560 DEBUG - Opening new Session for this thread.
2004-12-17 11:58:07,560 DEBUG - opened session
2004-12-17 11:58:07,560 DEBUG - opened session
2004-12-17 11:58:07,560 DEBUG - begin
2004-12-17 11:58:07,560 DEBUG - begin
2004-12-17 11:58:07,560 DEBUG - total checked-out connections: 0
2004-12-17 11:58:07,560 DEBUG - total checked-out connections: 0
2004-12-17 11:58:07,560 DEBUG - using pooled JDBC connection, pool size: 0
2004-12-17 11:58:07,560 DEBUG - using pooled JDBC connection, pool size: 0
2004-12-17 11:58:07,560 DEBUG - current autocommit status:false
2004-12-17 11:58:07,560 DEBUG - current autocommit status:false
2004-12-17 11:58:07,560 DEBUG - attempt to find user
2004-12-17 11:58:07,560 DEBUG - attempt to find user
2004-12-17 11:58:07,560 DEBUG - loading [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - loading [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - attempting to resolve [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - attempting to resolve [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - object not resolved in any cache [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - object not resolved in any cache [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - Materializing entity: [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - Materializing entity: [com.x.User#1]
2004-12-17 11:58:07,560 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,560 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,560 DEBUG - select user0_.USER_ID as USER_ID0_, user0_.USER_NAME as USER_NAME0_, user0_.USER_EMPNO as USER_EMPNO0_ from SECURITY.TESTUSER user0_ where user0_.USER_ID=?
2004-12-17 11:58:07,560 DEBUG - select user0_.USER_ID as USER_ID0_, user0_.USER_NAME as USER_NAME0_, user0_.USER_EMPNO as USER_EMPNO0_ from SECURITY.TESTUSER user0_ where user0_.USER_ID=?
2004-12-17 11:58:07,560 DEBUG - preparing statement
2004-12-17 11:58:07,560 DEBUG - preparing statement
2004-12-17 11:58:07,560 DEBUG - binding '1' to parameter: 1
2004-12-17 11:58:07,560 DEBUG - binding '1' to parameter: 1
2004-12-17 11:58:07,576 DEBUG - processing result set
2004-12-17 11:58:07,576 DEBUG - processing result set
2004-12-17 11:58:07,576 DEBUG - result row: 1
2004-12-17 11:58:07,576 DEBUG - result row: 1
2004-12-17 11:58:07,576 DEBUG - Initializing object from ResultSet: 1
2004-12-17 11:58:07,576 DEBUG - Initializing object from ResultSet: 1
2004-12-17 11:58:07,576 DEBUG - Hydrating entity: com.x.User#1
2004-12-17 11:58:07,576 DEBUG - Hydrating entity: com.x.User#1
2004-12-17 11:58:07,576 DEBUG - returning 'TheName' as column: USER_NAME0_
2004-12-17 11:58:07,576 DEBUG - returning 'TheName' as column: USER_NAME0_
2004-12-17 11:58:07,576 DEBUG - returning '55555' as column: USER_EMPNO0_
2004-12-17 11:58:07,576 DEBUG - returning '55555' as column: USER_EMPNO0_
2004-12-17 11:58:07,576 DEBUG - done processing result set (1 rows)
2004-12-17 11:58:07,576 DEBUG - done processing result set (1 rows)
2004-12-17 11:58:07,576 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,576 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 11:58:07,576 DEBUG - closing statement
2004-12-17 11:58:07,576 DEBUG - closing statement
2004-12-17 11:58:07,576 DEBUG - total objects hydrated: 1
2004-12-17 11:58:07,576 DEBUG - total objects hydrated: 1
2004-12-17 11:58:07,576 DEBUG - resolving associations for [com.x.User#1]
2004-12-17 11:58:07,576 DEBUG - resolving associations for [com.x.User#1]
2004-12-17 11:58:07,576 DEBUG - done materializing entity [com.x.User#1]
2004-12-17 11:58:07,576 DEBUG - done materializing entity [com.x.User#1]
2004-12-17 11:58:07,576 DEBUG - initializing non-lazy collections
2004-12-17 11:58:07,576 DEBUG - initializing non-lazy collections
2004-12-17 11:58:07,576 DEBUG - TheName55555
2004-12-17 11:58:07,576 DEBUG - TheName55555
2004-12-17 12:02:36,388 DEBUG - object already associated with session
2004-12-17 12:02:36,388 DEBUG - object already associated with session
2004-12-17 12:02:36,388 DEBUG - attempt to find user
2004-12-17 12:02:36,388 DEBUG - attempt to find user
2004-12-17 12:02:36,388 DEBUG - loading [com.x.User#1]
2004-12-17 12:02:36,388 DEBUG - loading [com.x.User#1]
2004-12-17 12:02:36,388 DEBUG - attempting to resolve [com.x.User#1]
2004-12-17 12:02:36,388 DEBUG - attempting to resolve [com.x.User#1]
2004-12-17 12:02:36,388 DEBUG - resolved object in session cache [com.x.User#1]
2004-12-17 12:02:36,388 DEBUG - resolved object in session cache [com.x.User#1]
2004-12-17 12:02:36,388 DEBUG - degisti44444
2004-12-17 12:02:36,388 DEBUG - degisti44444
2004-12-17 12:02:36,388 DEBUG - flushing session
2004-12-17 12:02:36,388 DEBUG - flushing session
2004-12-17 12:02:36,404 DEBUG - Flushing entities and processing referenced collections
2004-12-17 12:02:36,404 DEBUG - Flushing entities and processing referenced collections
2004-12-17 12:02:36,404 DEBUG - com.x.User.UserName is dirty
2004-12-17 12:02:36,404 DEBUG - com.x.User.UserName is dirty
2004-12-17 12:02:36,404 DEBUG - com.x.User.userEmpNo is dirty
2004-12-17 12:02:36,404 DEBUG - com.x.User.userEmpNo is dirty
2004-12-17 12:02:36,404 DEBUG - Processing unreferenced collections
2004-12-17 12:02:36,404 DEBUG - Processing unreferenced collections
2004-12-17 12:02:36,404 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 12:02:36,404 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 12:02:36,404 DEBUG - listing entities:
2004-12-17 12:02:36,404 DEBUG - listing entities:
2004-12-17 12:02:36,404 DEBUG - com.x.User{userID=1, UserName=degisti, userEmpNo=44444}
2004-12-17 12:02:36,404 DEBUG - com.x.User{userID=1, UserName=degisti, userEmpNo=44444}
2004-12-17 12:02:36,404 DEBUG - executing flush
2004-12-17 12:02:36,404 DEBUG - executing flush
2004-12-17 12:02:36,404 DEBUG - post flush
2004-12-17 12:02:36,404 DEBUG - post flush
2004-12-17 12:02:36,404 DEBUG - Committing database transaction of this thread.
2004-12-17 12:02:36,404 DEBUG - Committing database transaction of this thread.
2004-12-17 12:02:36,404 DEBUG - commit
2004-12-17 12:02:36,404 DEBUG - commit
2004-12-17 12:02:36,404 DEBUG - flushing session
2004-12-17 12:02:36,404 DEBUG - flushing session
2004-12-17 12:02:36,404 DEBUG - Flushing entities and processing referenced collections
2004-12-17 12:02:36,404 DEBUG - Flushing entities and processing referenced collections
2004-12-17 12:02:36,404 DEBUG - com.x.User.UserName is dirty
2004-12-17 12:02:36,404 DEBUG - com.x.User.UserName is dirty
2004-12-17 12:02:36,404 DEBUG - com.x.User.userEmpNo is dirty
2004-12-17 12:02:36,404 DEBUG - com.x.User.userEmpNo is dirty
2004-12-17 12:02:36,404 DEBUG - Processing unreferenced collections
2004-12-17 12:02:36,404 DEBUG - Processing unreferenced collections
2004-12-17 12:02:36,404 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 12:02:36,404 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 12:02:36,404 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 12:02:36,404 DEBUG - listing entities:
2004-12-17 12:02:36,404 DEBUG - listing entities:
2004-12-17 12:02:36,404 DEBUG - com.x.User{userID=1, UserName=degisti, userEmpNo=44444}
2004-12-17 12:02:36,404 DEBUG - com.x.User{userID=1, UserName=degisti, userEmpNo=44444}
2004-12-17 12:02:36,404 DEBUG - executing flush
2004-12-17 12:02:36,404 DEBUG - executing flush
2004-12-17 12:02:36,404 DEBUG - post flush
2004-12-17 12:02:36,404 DEBUG - post flush
2004-12-17 12:02:36,419 DEBUG - transaction completion
2004-12-17 12:02:36,419 DEBUG - transaction completion
2004-12-17 12:02:36,419 DEBUG - Closing Session of this thread.
2004-12-17 12:02:36,419 DEBUG - Closing Session of this thread.
2004-12-17 12:02:36,419 DEBUG - closing session
2004-12-17 12:02:36,419 DEBUG - closing session
2004-12-17 12:02:36,419 DEBUG - disconnecting session
2004-12-17 12:02:36,419 DEBUG - disconnecting session
2004-12-17 12:02:36,419 DEBUG - returning connection to pool, pool size: 1
2004-12-17 12:02:36,419 DEBUG - returning connection to pool, pool size: 1
2004-12-17 12:02:36,419 DEBUG - transaction completion
2004-12-17 12:02:36,419 DEBUG - transaction completion
Running test...
2004-12-17 12:02:36,997 DEBUG - Opening new Session for this thread.
2004-12-17 12:02:36,997 DEBUG - Opening new Session for this thread.
2004-12-17 12:02:36,997 DEBUG - opened session
2004-12-17 12:02:36,997 DEBUG - opened session
2004-12-17 12:02:36,997 DEBUG - generated identifier: 2
2004-12-17 12:02:36,997 DEBUG - generated identifier: 2
2004-12-17 12:02:36,997 DEBUG - saving [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - saving [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - attempt to find user
2004-12-17 12:02:36,997 DEBUG - attempt to find user
2004-12-17 12:02:36,997 DEBUG - loading [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - loading [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - attempting to resolve [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - attempting to resolve [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - resolved object in session cache [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - resolved object in session cache [com.x.User#2]
2004-12-17 12:02:36,997 DEBUG - yeni user99999
2004-12-17 12:02:36,997 DEBUG - yeni user99999
2004-12-17 12:02:36,997 DEBUG - flushing session
2004-12-17 12:02:36,997 DEBUG - flushing session
2004-12-17 12:02:36,997 DEBUG - Flushing entities and processing referenced collections
2004-12-17 12:02:36,997 DEBUG - Flushing entities and processing referenced collections
2004-12-17 12:02:37,013 DEBUG - Processing unreferenced collections
2004-12-17 12:02:37,013 DEBUG - Processing unreferenced collections
2004-12-17 12:02:37,013 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 12:02:37,013 DEBUG - Scheduling collection removes/(re)creates/updates
2004-12-17 12:02:37,013 DEBUG - Flushed: 1 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 12:02:37,013 DEBUG - Flushed: 1 insertions, 0 updates, 0 deletions to 1 objects
2004-12-17 12:02:37,013 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 12:02:37,013 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2004-12-17 12:02:37,013 DEBUG - listing entities:
2004-12-17 12:02:37,013 DEBUG - listing entities:
2004-12-17 12:02:37,013 DEBUG - com.x.User{userID=2, UserName=yeni user, userEmpNo=99999}
2004-12-17 12:02:37,013 DEBUG - com.x.User{userID=2, UserName=yeni user, userEmpNo=99999}
2004-12-17 12:02:37,013 DEBUG - executing flush
2004-12-17 12:02:37,013 DEBUG - executing flush
2004-12-17 12:02:37,013 DEBUG - Inserting entity: [com.x.User#2]
2004-12-17 12:02:37,013 DEBUG - Inserting entity: [com.x.User#2]
2004-12-17 12:02:37,013 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 12:02:37,013 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 12:02:37,013 DEBUG - total checked-out connections: 0
2004-12-17 12:02:37,013 DEBUG - total checked-out connections: 0
2004-12-17 12:02:37,013 DEBUG - using pooled JDBC connection, pool size: 0
2004-12-17 12:02:37,013 DEBUG - using pooled JDBC connection, pool size: 0
2004-12-17 12:02:37,013 DEBUG - insert into SECURITY.TESTUSER (USER_NAME, USER_EMPNO, USER_ID) values (?, ?, ?)
2004-12-17 12:02:37,013 DEBUG - insert into SECURITY.TESTUSER (USER_NAME, USER_EMPNO, USER_ID) values (?, ?, ?)
2004-12-17 12:02:37,013 DEBUG - preparing statement
2004-12-17 12:02:37,013 DEBUG - preparing statement
2004-12-17 12:02:37,013 DEBUG - Dehydrating entity: [com.x.User#2]
2004-12-17 12:02:37,013 DEBUG - Dehydrating entity: [com.x.User#2]
2004-12-17 12:02:37,013 DEBUG - binding 'yeni user' to parameter: 1
2004-12-17 12:02:37,013 DEBUG - binding 'yeni user' to parameter: 1
2004-12-17 12:02:37,013 DEBUG - binding '99999' to parameter: 2
2004-12-17 12:02:37,013 DEBUG - binding '99999' to parameter: 2
2004-12-17 12:02:37,013 DEBUG - binding '2' to parameter: 3
2004-12-17 12:02:37,013 DEBUG - binding '2' to parameter: 3
2004-12-17 12:02:37,013 DEBUG - Adding to batch
2004-12-17 12:02:37,013 DEBUG - Adding to batch
2004-12-17 12:02:37,013 DEBUG - Executing batch size: 1
2004-12-17 12:02:37,013 DEBUG - Executing batch size: 1
2004-12-17 12:02:37,013 DEBUG - success of batch update unknown: 0
2004-12-17 12:02:37,013 DEBUG - success of batch update unknown: 0
2004-12-17 12:02:37,013 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 12:02:37,013 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets
2004-12-17 12:02:37,013 DEBUG - closing statement
2004-12-17 12:02:37,013 DEBUG - closing statement
2004-12-17 12:02:37,013 DEBUG - post flush
2004-12-17 12:02:37,013 DEBUG - post flush
2004-12-17 12:02:37,013 DEBUG - Closing Session of this thread.
2004-12-17 12:02:37,013 DEBUG - Closing Session of this thread.
2004-12-17 12:02:37,013 DEBUG - closing session
2004-12-17 12:02:37,013 DEBUG - closing session
2004-12-17 12:02:37,013 DEBUG - disconnecting session
2004-12-17 12:02:37,013 DEBUG - disconnecting session
2004-12-17 12:02:37,013 DEBUG - returning connection to pool, pool size: 1
2004-12-17 12:02:37,013 DEBUG - returning connection to pool, pool size: 1
2004-12-17 12:02:37,013 DEBUG - transaction completion
2004-12-17 12:02:37,013 DEBUG - transaction completion




-------------------------------------------------------------------------



TestCase:

package com.x;

import junit.framework.Test;
import junit.framework.TestSuite;
import junit.textui.TestRunner;

public class UserTest extends TestCase {
UserDAO userDAO = new UserDAO();

User user = null;

// UserDAOSimple userDAOsimple = new UserDAOSimple();
// UserDAO2 userDAO2 = new UserDAO2();

Integer i = new Integer(1);

/*
* (non-Javadoc)
*
* @see com.x.TestCase#setUp()
*/
protected void setUp() throws Exception {
super.setUp();
}

// ********************************************************** //
public void testFind() throws Exception {
try {
user = userDAO.getUserById(i, false);
}
catch (Exception success) {
}
HibernateUtil.commitTransaction();
HibernateUtil.closeSession();
assertEquals( user.getUserName(), "TheName");
}

// ********************************************************** //
public void testUpdate() throws Exception {
HibernateUtil.beginTransaction();
//User user = new User(new Integer(1),"degisti", 44444);
try {

user = userDAO.getUserById(i, false);

user.setUserName("degisti");
user.setUserEmpNo(44444);
userDAO.setUserById(user);

user = userDAO.getUserById(i, false);
}
catch (Exception success) {
}
HibernateUtil.getSession().flush();
HibernateUtil.commitTransaction();
HibernateUtil.closeSession();
assertEquals(
user.getUserName(), "degisti");
}

// ********************************************************** //
public void testInsert() throws Exception {
try {
i = new Integer(2);
user = new User(i, "yeni user", 99999);
userDAO.makePersistent(user);
user = userDAO.getUserById(i, false);
}
catch (Exception success) {
}

HibernateUtil.getSession().flush();
HibernateUtil.commitTransaction();
HibernateUtil.closeSession();
assertEquals(user.getUserName(), "yeni user");
}

// ********************************************************** //
public UserTest(String x)
{
super(x);
}

public static Test suite() {
return new TestSuite(UserTest.class);
}

public static void main(String[] args) throws Exception {
TestRunner.run(suite());
}
}





-------------------------------------------------------------------------



UserDAO:


/*
* Created on Dec 17, 2004
*
*/
package com.X;
import java.sql.SQLException;
import java.util.Collection;

import net.sf.hibernate.HibernateException;
import net.sf.hibernate.LockMode;
import net.sf.hibernate.Session;

import org.apache.commons.logging.Log;
import org.apache.commons.logging.LogFactory;
/**
* @author
*
*/
public class UserDAO
{
public static Log log = LogFactory.getLog(UserDAO.class);

public UserDAO()
{
HibernateUtil.beginTransaction();
}

public User getUserById(Integer userId, boolean lock) throws InfrastructureException, HibernateException
{

Session session = HibernateUtil.getSession();

User user = null;
try
{

log.debug("attempt to find user");


if (lock)
{
user = (User) session.load(User.class, userId, LockMode.UPGRADE);
}
else
{
user = (User) session.load(User.class, userId);
}

log.debug(user.getUserName() + user.getUserEmpNo());

}
catch (HibernateException ex)
{
throw new InfrastructureException(ex);
}
return user;
}
// ********************************************************** //
public Collection findAll() throws InfrastructureException
{
Collection users;
try
{
users = HibernateUtil.getSession().createCriteria(User.class).list();
}
catch (HibernateException ex)
{
throw new InfrastructureException(ex);
}
return users;
}
// ********************************************************** //
public void makePersistent(User user) throws InfrastructureException
{
try
{
HibernateUtil.getSession().save(user);
//HibernateUtil.getSession().flush();
}
catch (HibernateException ex)
{
throw new InfrastructureException(ex);
}
}
// ********************************************************** //
public void makeTransient(User user) throws InfrastructureException
{
try
{
HibernateUtil.getSession().delete(user);
}
catch (HibernateException ex)
{
throw new InfrastructureException(ex);
}
}

/**
* @param user
* @return
*/
public void setUserById(User user) throws SQLException
{
Session session = HibernateUtil.getSession();
try
{

session.update(user);
// session.flush();
}
catch (HibernateException ex)
{
throw new InfrastructureException(ex);
}
}
}





-------------------------------------------------------------------------

I've found what the problem is... The problem is I was setting mutable="false" in the mapping file.

But I think that there something missing here. OK, it was my mistake, it was my fault. But I think hibernate shoud make me know about this situation. Maybe in LOG file programmer should be notified like "mutable=false -- no update operation allowed". Getting no exception or no warning in log file but having a non-working operation is very confusing.

Thanks everybody for you help.