java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396)

Hibernate JIRA | Marko Balabanovic | 1 decade ago
  1. 0

    I posted this to the forums but was asked to put it in JIRA instead: Hi, Can anyone help explain this behaviour with the Informix dialect? We're trying to get it to pass the unit tests (currently at about 32%). Specifically looking at MasterDetailTest.testMixNativeAssigned, where it tries to do a deletion. As a reminder, the method looks like this: public void testMixNativeAssigned() throws Exception { if (getDialect() instanceof HSQLDialect) return; System.out.println("testMixNativeAssigned: Start"); Session s = openSession(); Category c = new Category(); c.setName("NAME"); Assignable assn = new Assignable(); assn.setId("i.d."); List l = new ArrayList(); l.add(c); assn.setCategories(l); c.setAssignable(assn); s.save(assn); s.flush(); s.connection().commit(); s.close(); System.out.println("testMixNativeAssigned: Saved, deleting"); s = openSession(); s.delete(assn); s.flush(); s.connection().commit(); s.close(); System.out.println("testMixNativeAssigned: Deleted"); } In Informix, this fails at the delete stage, because of java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. (full trace at bottom of message). In other words, it cannot do the deletion because it would violate a foreign key constraint. We're trying the same thing with MySQL 4.0.20a and JDBC 3.0.14, which passes the test fine. In the MySQL version, there are two SQL delete statements generated for the above code: Hibernate: delete from category where category_key_col=? Hibernate: delete from `assign able` where id=? Whereas in Informix only the second of these is generated. Tracing it through, the difference is in ACTION_DELETE defined in net.sf.hibernate.engine.Cascades. For the Informix version we get session.isSaved(child) = false, but for MySQL session.isSaved(child) = true. The Informix version, going a little deeper into the SessionImpl.isSaved method, gets that value because getPersister(object).isUnsaved(object) = true. Any pointers on what kind of problem this is? Thanks a lot, Marko Here is the full trace from the Informix version, where it fails: Testsuite: org.hibernate.test.MasterDetailTest Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 6.993 sec ------------- Standard Output --------------- 16:24:46,782 INFO Environment:462 - Hibernate 2.1.4 16:24:46,854 INFO Environment:496 - loaded properties from resource hibernate.properties: {hibernate.connection.driver_class=com.informix.jdbc.IfxDriver, hibernate.cglib.use_reflection_optimizer=true, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, hibernate.cache.use_query_cache=true, hibernate.max_fetch_depth=1, hibernate.dialect=net.sf.hibernate.dialect.Informix9Dialect, hibernate.jdbc.use_streams_for_binary=true, hibernate.jdbc.batch_size=0, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.proxool.pool_alias=pool1, hibernate.connection.username=informix, hibernate.cache.region_prefix=hibernate.test, hibernate.connection.url=jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, hibernate.show_sql=true, hibernate.connection.password=informix, hibernate.connection.pool_size=1} 16:24:46,859 INFO Environment:521 - using java.io streams to persist binary types 16:24:46,859 INFO Environment:522 - using CGLIB reflection optimizer 16:24:46,864 INFO Configuration:311 - Mapping resource: org/hibernate/test/MasterDetail.hbm.xml 16:24:47,182 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,183 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,673 INFO Binder:229 - Mapping class: org.hibernate.test.Master -> Master 16:24:47,816 DEBUG Binder:475 - Mapped property: version -> version, type: integer 16:24:47,862 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:47,864 DEBUG Binder:475 - Mapped property: x -> x, type: integer 16:24:47,864 DEBUG Binder:475 - Mapped property: bigDecimal -> big_dec, type: big_decimal 16:24:47,900 DEBUG Binder:475 - Mapped property: details, type: java.util.Set 16:24:47,900 DEBUG Binder:475 - Mapped property: moreDetails, type: java.util.Set 16:24:47,900 INFO Binder:560 - Mapping collection: org.hibernate.test.Master.incoming -> mtm 16:24:47,901 DEBUG Binder:475 - Mapped property: incoming, type: java.util.Set 16:24:47,901 INFO Binder:560 - Mapping collection: org.hibernate.test.Master.outgoing -> mtm 16:24:47,901 DEBUG Binder:475 - Mapped property: outgoing, type: java.util.Set 16:24:47,911 DEBUG Binder:475 - Mapped property: otherMaster -> otherMaster, type: org.hibernate.test.Master 16:24:47,912 INFO Binder:229 - Mapping class: org.hibernate.test.Detail -> Detail 16:24:47,915 DEBUG Binder:475 - Mapped property: x -> x, type: integer 16:24:47,917 DEBUG Binder:475 - Mapped property: i -> i, type: integer 16:24:47,917 DEBUG Binder:475 - Mapped property: master -> master_key, type: org.hibernate.test.Master 16:24:47,919 DEBUG Binder:475 - Mapped property: subDetails, type: java.util.Set 16:24:47,919 INFO Binder:229 - Mapping class: org.hibernate.test.SubDetail -> SubDetail 16:24:47,919 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:47,921 DEBUG Binder:1267 - Named query: all_details -> from d in class Detail 16:24:47,923 INFO Configuration:311 - Mapping resource: org/hibernate/test/Custom.hbm.xml 16:24:47,928 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,929 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,937 INFO Binder:229 - Mapping class: org.hibernate.test.Custom -> Custom 16:24:47,937 DEBUG Binder:475 - Mapped property: key -> id_, type: string 16:24:47,938 INFO Configuration:311 - Mapping resource: org/hibernate/test/Category.hbm.xml 16:24:47,943 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,945 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,950 INFO Binder:229 - Mapping class: org.hibernate.test.Category -> category 16:24:47,951 DEBUG Binder:475 - Mapped property: id -> category_key_col, type: long 16:24:47,958 DEBUG Binder:475 - Mapped property: subcategories, type: java.util.List 16:24:47,958 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:47,959 DEBUG Binder:475 - Mapped property: assignable -> assign able id, type: org.hibernate.test.Assignable 16:24:47,959 INFO Binder:229 - Mapping class: org.hibernate.test.Assignable -> assign able 16:24:47,959 DEBUG Binder:475 - Mapped property: id -> id, type: string 16:24:47,965 DEBUG Binder:475 - Mapped property: categories, type: java.util.Collection 16:24:47,966 DEBUG Binder:1298 - Named sql query: namedsql -> select {category.*}, {assignable.*} from Category {category}, "assign able" {assignable} 16:24:47,967 INFO Configuration:311 - Mapping resource: org/hibernate/test/Nameable.hbm.xml 16:24:47,971 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,972 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,976 INFO Binder:229 - Mapping class: org.hibernate.test.Nameable -> Nameable 16:24:47,977 DEBUG Binder:475 - Mapped property: key -> key_, type: long 16:24:47,977 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:48,023 INFO Binder:169 - Mapping subclass: org.hibernate.test.BasicNameable -> Nameable 16:24:48,025 INFO Configuration:311 - Mapping resource: org/hibernate/test/SingleSeveral.hbm.xml 16:24:48,029 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,031 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,035 INFO Binder:229 - Mapping class: org.hibernate.test.Single -> Single 16:24:48,052 DEBUG Binder:475 - Mapped property: id -> id, type: string 16:24:48,053 DEBUG Binder:475 - Mapped property: string -> string_, type: string 16:24:48,507 DEBUG Binder:475 - Mapped property: prop -> prop, type: string 16:24:48,509 DEBUG Binder:475 - Mapped property: several, type: java.util.Collection 16:24:48,509 INFO Binder:229 - Mapping class: org.hibernate.test.Several -> Several 16:24:48,509 DEBUG Binder:475 - Mapped property: id -> id, type: string 16:24:48,510 DEBUG Binder:475 - Mapped property: string -> string_, type: string 16:24:48,517 DEBUG Binder:475 - Mapped property: single -> single_id, single_string, type: org.hibernate.test.Single 16:24:48,518 INFO Configuration:311 - Mapping resource: org/hibernate/test/WZ.hbm.xml 16:24:48,522 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,523 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,527 INFO Binder:229 - Mapping class: org.hibernate.test.Z -> Z 16:24:48,529 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,529 DEBUG Binder:475 - Mapped property: w -> w, type: org.hibernate.test.W 16:24:48,530 INFO Binder:229 - Mapping class: org.hibernate.test.W -> W 16:24:48,530 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,530 INFO Configuration:311 - Mapping resource: org/hibernate/test/UpDown.hbm.xml 16:24:48,536 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,537 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,542 INFO Binder:229 - Mapping class: org.hibernate.test.Up -> Up 16:24:48,542 DEBUG Binder:475 - Mapped property: id1 -> id1, type: string 16:24:48,543 DEBUG Binder:475 - Mapped property: id2 -> id2, type: long 16:24:48,551 INFO Binder:169 - Mapping subclass: org.hibernate.test.Down -> Up 16:24:48,551 DEBUG Binder:475 - Mapped property: value -> value_, type: long 16:24:48,552 INFO Configuration:311 - Mapping resource: org/hibernate/test/Eye.hbm.xml 16:24:48,556 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,557 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,562 INFO Binder:229 - Mapping class: org.hibernate.test.Eye -> Eye 16:24:48,563 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,564 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:48,564 DEBUG Binder:475 - Mapped property: jays, type: java.util.Set 16:24:48,565 DEBUG Binder:475 - Mapped property: jay -> jay, type: org.hibernate.test.Jay 16:24:48,565 INFO Binder:229 - Mapping class: org.hibernate.test.Jay -> Jay 16:24:48,565 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,565 DEBUG Binder:475 - Mapped property: eye -> eye, type: org.hibernate.test.Eye 16:24:48,566 INFO Configuration:311 - Mapping resource: org/hibernate/test/MN.hbm.xml 16:24:48,570 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,571 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,575 INFO Binder:229 - Mapping class: org.hibernate.test.M -> M 16:24:48,576 DEBUG Binder:475 - Mapped property: uniqueSequence -> uniqueSequence, type: long 16:24:48,577 DEBUG Binder:475 - Mapped property: Children, type: java.util.Set 16:24:48,578 INFO Binder:229 - Mapping class: org.hibernate.test.N -> N 16:24:48,578 DEBUG Binder:475 - Mapped property: uniqueSequence -> uniqueSequence, type: long 16:24:48,578 DEBUG Binder:475 - Mapped property: string -> String, type: string 16:24:48,579 DEBUG Binder:475 - Mapped property: Parent -> fkParent, type: org.hibernate.test.M 16:24:48,607 INFO Dialect:82 - Using dialect: net.sf.hibernate.dialect.Informix9Dialect 16:24:48,619 INFO Configuration:613 - processing one-to-many association mappings 16:24:48,623 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.details 16:24:48,631 INFO Binder:1168 - Mapping collection: org.hibernate.test.Master.details -> Detail 16:24:48,635 DEBUG Binder:1355 - Mapped collection key: master_key, one-to-many: org.hibernate.test.Detail 16:24:48,635 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.moreDetails 16:24:48,636 INFO Binder:1168 - Mapping collection: org.hibernate.test.Master.moreDetails -> Detail 16:24:48,636 DEBUG Binder:1355 - Mapped collection key: more_master_key, one-to-many: org.hibernate.test.Detail 16:24:48,636 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.incoming 16:24:48,639 DEBUG Binder:1355 - Mapped collection key: outgoingabcdef, element: incomingabcdef, type: org.hibernate.test.Master 16:24:48,639 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.outgoing 16:24:48,640 DEBUG Binder:1355 - Mapped collection key: incomingabcdef, element: outgoingabcdef, type: org.hibernate.test.Master 16:24:48,640 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Detail.subDetails 16:24:48,640 INFO Binder:1168 - Mapping collection: org.hibernate.test.Detail.subDetails -> SubDetail 16:24:48,640 DEBUG Binder:1355 - Mapped collection key: detail_key, one-to-many: org.hibernate.test.SubDetail 16:24:48,641 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Category.subcategories 16:24:48,642 INFO Binder:1168 - Mapping collection: org.hibernate.test.Category.subcategories -> category 16:24:48,644 DEBUG Binder:1355 - Mapped collection key: parent, index: ord, one-to-many: org.hibernate.test.Category 16:24:48,644 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Assignable.categories 16:24:48,644 INFO Binder:1168 - Mapping collection: org.hibernate.test.Assignable.categories -> category 16:24:48,645 DEBUG Binder:1355 - Mapped collection key: assign able id, one-to-many: org.hibernate.test.Category 16:24:48,645 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Single.several 16:24:48,645 INFO Binder:1168 - Mapping collection: org.hibernate.test.Single.several -> Several 16:24:48,646 DEBUG Binder:1355 - Mapped collection key: single_id, single_string, one-to-many: org.hibernate.test.Several 16:24:48,646 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Eye.jays 16:24:48,646 INFO Binder:1168 - Mapping collection: org.hibernate.test.Eye.jays -> Jay 16:24:48,647 DEBUG Binder:1355 - Mapped collection key: eye, one-to-many: org.hibernate.test.Jay 16:24:48,647 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.M.Children 16:24:48,647 INFO Binder:1168 - Mapping collection: org.hibernate.test.M.Children -> N 16:24:48,647 DEBUG Binder:1355 - Mapped collection key: fkParent, one-to-many: org.hibernate.test.N 16:24:48,647 INFO Configuration:622 - processing one-to-one association property references 16:24:48,648 INFO Configuration:647 - processing foreign key constraints 16:24:48,649 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.W 16:24:48,652 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,652 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Eye 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Category 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Assignable 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Single 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Jay 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Detail 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.M 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,655 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,699 INFO Dialect:82 - Using dialect: net.sf.hibernate.dialect.Informix9Dialect 16:24:48,701 INFO SettingsFactory:58 - Maximim outer join fetch depth: 1 16:24:48,702 INFO SettingsFactory:62 - Use outer join fetching: false 16:24:48,720 INFO DriverManagerConnectionProvider:42 - Using Hibernate built-in connection pool (not for production use!) 16:24:48,721 INFO DriverManagerConnectionProvider:43 - Hibernate connection pool size: 1 16:24:48,741 INFO DriverManagerConnectionProvider:77 - using driver: com.informix.jdbc.IfxDriver at URL: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:48,742 INFO DriverManagerConnectionProvider:78 - connection properties: {user=informix, password=informix} 16:24:48,753 INFO TransactionManagerLookupFactory:33 - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended) 16:24:48,757 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:48,758 DEBUG DriverManagerConnectionProvider:100 - opening new JDBC connection 16:24:49,595 DEBUG DriverManagerConnectionProvider:106 - created connection to: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, Isolation Level: 2 16:24:49,652 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1 16:24:49,653 INFO SettingsFactory:102 - Use scrollable result sets: true 16:24:49,653 INFO SettingsFactory:105 - Use JDBC3 getGeneratedKeys(): false 16:24:49,654 INFO SettingsFactory:108 - Optimize cache for minimal puts: false 16:24:49,654 INFO SettingsFactory:114 - echoing all SQL to stdout 16:24:49,657 INFO SettingsFactory:117 - Query language substitutions: {no='N', true=1, yes='Y', false=0} 16:24:49,657 INFO SettingsFactory:128 - cache provider: net.sf.ehcache.hibernate.Provider 16:24:49,663 INFO Configuration:1093 - instantiating and configuring caches 16:24:49,663 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Assignable 16:24:49,760 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Assignable. Configuring using the defaultCache settings. 16:24:49,763 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Nameable 16:24:49,763 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Nameable. Configuring using the defaultCache settings. 16:24:49,764 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.N 16:24:49,764 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.N. Configuring using the defaultCache settings. 16:24:49,765 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Category 16:24:49,765 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Category. Configuring using the defaultCache settings. 16:24:49,766 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.outgoing 16:24:49,766 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.outgoing. Configuring using the defaultCache settings. 16:24:49,767 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Detail 16:24:49,767 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Detail. Configuring using the defaultCache settings. 16:24:49,768 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Up 16:24:49,768 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Up. Configuring using the defaultCache settings. 16:24:49,768 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.incoming 16:24:49,769 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.incoming. Configuring using the defaultCache settings. 16:24:49,769 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Detail.subDetails 16:24:49,770 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Detail.subDetails. Configuring using the defaultCache settings. 16:24:49,771 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.SubDetail 16:24:49,771 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.SubDetail. Configuring using the defaultCache settings. 16:24:49,772 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.details 16:24:49,772 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.details. Configuring using the defaultCache settings. 16:24:49,773 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Eye 16:24:49,773 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Eye. Configuring using the defaultCache settings. 16:24:49,774 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.moreDetails 16:24:49,774 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.moreDetails. Configuring using the defaultCache settings. 16:24:49,775 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Eye.jays 16:24:49,775 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Eye.jays. Configuring using the defaultCache settings. 16:24:49,776 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.M 16:24:49,776 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.M. Configuring using the defaultCache settings. 16:24:49,777 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master 16:24:49,777 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master. Configuring using the defaultCache settings. 16:24:49,777 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Jay 16:24:49,778 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Jay. Configuring using the defaultCache settings. 16:24:49,778 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Single 16:24:49,779 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Single. Configuring using the defaultCache settings. 16:24:49,779 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.W 16:24:49,779 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.W. Configuring using the defaultCache settings. 16:24:49,780 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Assignable.categories 16:24:49,780 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Assignable.categories. Configuring using the defaultCache settings. 16:24:49,781 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.M.Children 16:24:49,781 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.M.Children. Configuring using the defaultCache settings. 16:24:49,781 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Single.several 16:24:49,782 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Single.several. Configuring using the defaultCache settings. 16:24:49,782 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Several 16:24:49,783 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Several. Configuring using the defaultCache settings. 16:24:49,784 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Category.subcategories 16:24:49,784 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Category.subcategories. Configuring using the defaultCache settings. 16:24:49,785 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Z 16:24:49,785 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Z. Configuring using the defaultCache settings. 16:24:49,785 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Custom 16:24:49,786 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Custom. Configuring using the defaultCache settings. 16:24:49,859 INFO SessionFactoryImpl:119 - building session factory 16:24:49,860 DEBUG SessionFactoryImpl:125 - instantiating session factory with properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, hibernate.connection.password=informix, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, sun.boot.library.path=/usr/java/bea/jdk/1.4.2/jre/lib/i386, java.vm.version=ari-29212-20040415-1332-linux-ia32, hibernate.proxool.pool_alias=pool1, hibernate.connection.username=informix, java.vm.vendor=BEA Systems, Inc., java.vendor.url=http://www.bea.com/, path.separator=:, hibernate.cache.use_query_cache=true, java.vm.name=BEA WebLogic JRockit(TM) 1.4.2_04 JVM , file.encoding.pkg=sun.io, user.country=GB, java.vm.vendor.url=http://www.bea.com/, java.io.filesystem=java.io.UnixFileSystem, java.vm.specification.name=Java Virtual Machine Specification, user.dir=/home/mbalaban/dev/p4/products/hibernate/main, java.runtime.version=1.4.2_04, java.awt.graphicsenv=sun.awt.X11GraphicsEnvironment, java.endorsed.dirs=/usr/java/bea/jdk/1.4.2/jre/lib/endorsed, os.arch=i386, java.io.tmpdir=/tmp, line.separator= , java.vm.specification.vendor=Sun Microsystems Inc., os.name=Linux, sun.java2d.fontpath=, hibernate.cache.region_prefix=hibernate.test, java.library.path=/usr/java/bea/jdk/1.4.2/jre/lib/i386/jrockit:/usr/java/bea/jdk/1.4.2/jre/lib/i386:/usr/java/bea/jdk/1.4.2/jre/../lib/i386, java.specification.name=Java Platform API Specification, java.class.version=48.0, hibernate.connection.pool_size=1, java.util.prefs.PreferencesFactory=java.util.prefs.FileSystemPreferencesFactory, os.version=2.4.22ow1np-ht, user.home=/home/mbalaban, user.timezone=GMT, java.awt.printerjob=sun.print.PSPrinterJob, jrockit.version=ari-29212-20040415-1332-linux-ia32, file.encoding=ISO-8859-1, java.specification.version=1.4, hibernate.connection.driver_class=com.informix.jdbc.IfxDriver, jrockit.vm=/usr/java/bea/jdk/1.4.2/jre/lib/i386/jrockit/libjvm.so, java.class.path=/home/mbalaban/dev/p4/products/hibernate/main/lib/ant-1.5.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ant-optional-1.5.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/c3p0-0.8.4.5.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/cglib-full-2.0.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-collections-2.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-dbcp-1.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-lang-1.0.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-logging-1.0.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-pool-1.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/concurrent-1.3.2.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/connector.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/dom4j-1.4.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ehcache-0.7.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jaas.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-cache.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-common.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-jmx.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-system.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jcs-1.0-dev.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jdbc2_0-stdext.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jgroups-2.2.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jta.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/junit-3.8.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/log4j-1.2.8.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/odmg-3.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/oscache-2.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/proxool-0.8.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/swarmcache-1.0rc2.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/xalan-2.4.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/xerces-2.4.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/xml-apis.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/hsqldb.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ifxjdbc-g.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ifxjdbc.jar:/home/mbalaban/dev/p4/products/hibernate/main/build:/home/mbalaban/dev/p4/products/hibernate/main/src:/home/mbalaban/dev/p4/products/hibernate/main/test:/home/mbalaban/dev/p4/products/hibernate/main:/lmn/tools/java/tools/apache-ant-1.5.3-1/lib/junit.jar:/lmn/tools/java/tools/apache-ant-1.5.3-1/lib/ant.jar:/lmn/tools/java/tools/apache-ant-1.5.3-1/lib/optional.jar, os.real.arch=IA32, user.name=mbalaban, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.show_sql=true, java.vm.specification.version=1.0, java.home=/usr/java/bea/jdk/1.4.2/jre, hibernate.dialect=net.sf.hibernate.dialect.Informix9Dialect, hibernate.connection.url=jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, user.language=en, java.specification.vendor=Sun Microsystems Inc., java.lang.process=java.lang.UnixProcess, hibernate.cglib.use_reflection_optimizer=true, java.vm.info=Native Threads, GC strategy: parallel, hibernate.jdbc.use_streams_for_binary=true, java.version=1.4.2_04, java.ext.dirs=/usr/java/bea/jdk/1.4.2/jre/lib/ext, sun.boot.class.path=/usr/java/bea/jdk/1.4.2/jre/lib/rt.jar:/usr/java/bea/jdk/1.4.2/jre/lib/i18n.jar:/usr/java/bea/jdk/1.4.2/jre/lib/sunrsasign.jar:/usr/java/bea/jdk/1.4.2/jre/lib/jsse.jar:/usr/java/bea/jdk/1.4.2/jre/lib/jce.jar:/usr/java/bea/jdk/1.4.2/jre/lib/charsets.jar:/usr/java/bea/jdk/1.4.2/jre/classes:/usr/java/bea/jdk/1.4.2/jre/lib/managementapi.jar, java.vendor=BEA Systems, Inc., hibernate.jdbc.batch_size=0, file.separator=/, hibernate.hbm2ddl.auto=create, sun.io.unicode.encoding=UnicodeLittle, hibernate.max_fetch_depth=1} 16:24:51,056 DEBUG SessionFactoryObjectFactory:39 - initializing class SessionFactoryObjectFactory 16:24:51,061 DEBUG SessionFactoryObjectFactory:76 - registered: 40288b0ffdd8383b00fdd83840680000 (unnamed) 16:24:51,064 INFO SessionFactoryObjectFactory:82 - no JNDI name configured 16:24:51,067 DEBUG SessionFactoryImpl:196 - instantiated session factory 16:24:51,071 INFO Dialect:82 - Using dialect: net.sf.hibernate.dialect.Informix9Dialect 16:24:51,074 INFO Configuration:613 - processing one-to-many association mappings 16:24:51,075 INFO Configuration:622 - processing one-to-one association property references 16:24:51,075 INFO Configuration:647 - processing foreign key constraints 16:24:51,084 INFO Configuration:613 - processing one-to-many association mappings 16:24:51,084 INFO Configuration:622 - processing one-to-one association property references 16:24:51,084 INFO Configuration:647 - processing foreign key constraints 16:24:51,127 INFO SchemaExport:98 - Running hbm2ddl schema export 16:24:51,127 INFO SchemaExport:117 - exporting generated schema to database 16:24:51,127 INFO DriverManagerConnectionProvider:42 - Using Hibernate built-in connection pool (not for production use!) 16:24:51,128 INFO DriverManagerConnectionProvider:43 - Hibernate connection pool size: 1 16:24:51,128 INFO DriverManagerConnectionProvider:77 - using driver: com.informix.jdbc.IfxDriver at URL: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:51,128 INFO DriverManagerConnectionProvider:78 - connection properties: {user=informix, password=informix} 16:24:51,129 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:51,129 DEBUG DriverManagerConnectionProvider:100 - opening new JDBC connection 16:24:51,396 DEBUG DriverManagerConnectionProvider:106 - created connection to: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, Isolation Level: 2 16:24:51,398 DEBUG SchemaExport:132 - alter table Z drop constraint FK5A77 16:24:51,427 DEBUG SchemaExport:132 - alter table mtm drop constraint AA 16:24:51,437 DEBUG SchemaExport:132 - alter table mtm drop constraint BB 16:24:51,446 DEBUG SchemaExport:132 - alter table Jay drop constraint FK1220218A31 16:24:51,474 DEBUG SchemaExport:132 - alter table category drop constraint FK302BCFEC4AB08AA 16:24:51,477 DEBUG SchemaExport:132 - alter table category drop constraint FK302BCFEF4317770 16:24:51,486 DEBUG SchemaExport:132 - alter table Several drop constraint FKD9AD23DC2C70205A 16:24:51,497 DEBUG SchemaExport:132 - alter table Eye drop constraint FK1121119A22 16:24:51,507 DEBUG SchemaExport:132 - alter table SubDetail drop constraint FK460B3291C2405571 16:24:51,518 DEBUG SchemaExport:132 - alter table N drop constraint FK4EE0299CF 16:24:51,521 DEBUG SchemaExport:132 - alter table Master drop constraint FK88F216828F8D0992 16:24:51,524 DEBUG SchemaExport:132 - alter table Detail drop constraint CC 16:24:51,534 DEBUG SchemaExport:132 - alter table Detail drop constraint FK79CF0471385E1A2C 16:24:51,545 DEBUG SchemaExport:132 - drop table Single 16:24:51,556 DEBUG SchemaExport:132 - drop table Z 16:24:51,566 DEBUG SchemaExport:132 - drop table mtm 16:24:51,577 DEBUG SchemaExport:132 - drop table Custom 16:24:51,586 DEBUG SchemaExport:132 - drop table Jay 16:24:51,605 DEBUG SchemaExport:132 - drop table "assign able" 16:24:51,614 DEBUG SchemaExport:132 - drop table W 16:24:51,617 DEBUG SchemaExport:132 - drop table category 16:24:51,644 DEBUG SchemaExport:132 - drop table Up 16:24:51,654 DEBUG SchemaExport:132 - drop table Several 16:24:51,664 DEBUG SchemaExport:132 - drop table M 16:24:51,667 DEBUG SchemaExport:132 - drop table Eye 16:24:51,676 DEBUG SchemaExport:132 - drop table SubDetail 16:24:51,686 DEBUG SchemaExport:132 - drop table Nameable 16:24:51,704 DEBUG SchemaExport:132 - drop table N 16:24:51,707 DEBUG SchemaExport:132 - drop table Master 16:24:51,717 DEBUG SchemaExport:132 - drop table Detail 16:24:51,737 DEBUG SchemaExport:132 - drop table hibernate_unique_key 16:24:51,747 DEBUG SchemaExport:149 - create table Single ( id VARCHAR(32) not null, string_ VARCHAR(32) not null, prop VARCHAR(255), primary key (id, string_) ) 16:24:51,758 DEBUG SchemaExport:149 - create table Z ( id INT8 not null, w INT8 not null, primary key (id) ) 16:24:51,760 DEBUG SchemaExport:149 - create table mtm ( outgoingabcdef INT8 not null, incomingabcdef INT8 not null, primary key (incomingabcdef, outgoingabcdef) ) 16:24:51,763 DEBUG SchemaExport:149 - create table Custom ( id_ VARCHAR(64) not null, primary key (id_) ) 16:24:51,765 DEBUG SchemaExport:149 - create table Jay ( id INT8 not null, eye INT8, primary key (id) ) 16:24:51,775 DEBUG SchemaExport:149 - create table "assign able" (id VARCHAR(255) not null, primary key (id)) 16:24:51,777 DEBUG SchemaExport:149 - create table W ( id INT8 not null, primary key (id) ) 16:24:51,786 DEBUG SchemaExport:149 - create table category (category_key_col SERIAL8 NOT NULL, name VARCHAR(255), "assign able id" VARCHAR(255), parent INT8, ord INTEGER, primary key (category_key_col)) 16:24:51,795 DEBUG SchemaExport:149 - create table Up ( id1 VARCHAR(255) not null, id2 INT8 not null, value_ INT8, primary key (id1, id2) ) 16:24:51,807 DEBUG SchemaExport:149 - create table Several ( id VARCHAR(32) not null, string_ VARCHAR(32) not null, single_id VARCHAR(32), single_string VARCHAR(32), primary key (id, string_) ) 16:24:51,817 DEBUG SchemaExport:149 - create table M ( uniqueSequence SERIAL8 NOT NULL, primary key (uniqueSequence) ) 16:24:51,826 DEBUG SchemaExport:149 - create table Eye ( id INT8 not null, name VARCHAR(255), jay INT8, primary key (id) ) 16:24:51,835 DEBUG SchemaExport:149 - create table SubDetail ( subdetail_key_col SERIAL8 NOT NULL, name VARCHAR(255), detail_key INT8, primary key (subdetail_key_col) ) 16:24:51,845 DEBUG SchemaExport:149 - create table Nameable ( key_ SERIAL8 NOT NULL, clazz VARCHAR(255) not null, name VARCHAR(255), primary key (key_) ) 16:24:51,854 DEBUG SchemaExport:149 - create table N ( uniqueSequence SERIAL8 NOT NULL, String VARCHAR(255), fkParent INT8 not null, primary key (uniqueSequence) ) 16:24:51,857 DEBUG SchemaExport:149 - create table Master ( master_key_column SERIAL8 NOT NULL, version INTEGER not null, name VARCHAR(255), x INTEGER, big_dec DECIMAL, otherMaster INT8, primary key (master_key_column) ) 16:24:51,885 DEBUG SchemaExport:149 - create table Detail ( detail_key_column SERIAL8 NOT NULL, x INTEGER not null, i INTEGER not null, master_key INT8 not null, more_master_key INT8, primary key (detail_key_column), unique (x, i, master_key) ) 16:24:51,895 DEBUG SchemaExport:149 - alter table Z add constraint foreign key (w) references W constraint FK5A77 16:24:51,905 DEBUG SchemaExport:149 - create index IBB on mtm (incomingabcdef) 16:24:51,915 DEBUG SchemaExport:149 - alter table mtm add constraint foreign key (outgoingabcdef) references Master constraint AA 16:24:51,925 DEBUG SchemaExport:149 - alter table mtm add constraint foreign key (incomingabcdef) references Master constraint BB 16:24:51,936 DEBUG SchemaExport:149 - alter table Jay add constraint foreign key (eye) references Eye constraint FK1220218A31 16:24:51,946 DEBUG SchemaExport:149 - alter table category add constraint foreign key (parent) references category constraint FK302BCFEC4AB08AA 16:24:51,956 DEBUG SchemaExport:149 - alter table category add constraint foreign key ("assign able id") references "assign able" constraint FK302BCFEF4317770 16:24:51,975 DEBUG SchemaExport:149 - alter table Several add constraint foreign key (single_id, single_string) references Single constraint FKD9AD23DC2C70205A 16:24:51,985 DEBUG SchemaExport:149 - alter table Eye add constraint foreign key (jay) references Jay constraint FK1121119A22 16:24:51,997 DEBUG SchemaExport:149 - alter table SubDetail add constraint foreign key (detail_key) references Detail constraint FK460B3291C2405571 16:24:52,007 DEBUG SchemaExport:149 - alter table N add constraint foreign key (fkParent) references M constraint FK4EE0299CF 16:24:52,017 DEBUG SchemaExport:149 - alter table Master add constraint foreign key (otherMaster) references Master constraint FK88F216828F8D0992 16:24:52,026 DEBUG SchemaExport:149 - alter table Detail add constraint foreign key (master_key) references Master constraint CC 16:24:52,037 DEBUG SchemaExport:149 - alter table Detail add constraint foreign key (more_master_key) references Master constraint FK79CF0471385E1A2C 16:24:52,048 DEBUG SchemaExport:149 - create table hibernate_unique_key ( next_hi INTEGER ) 16:24:52,057 DEBUG SchemaExport:149 - insert into hibernate_unique_key values ( 0 ) 16:24:52,072 INFO SchemaExport:160 - schema export complete 16:24:52,089 DEBUG JDBCExceptionReporter:18 - SQL Warning java.sql.SQLWarning: Database has transactions at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Ljava.lang.String;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:125) at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Lcom.informix.jdbc.IfxConnection;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:149) at com.informix.jdbc.IfxSqliConnect.addWarning(Ljava.sql.SQLWarning;Ljava.lang.String;)V(IfxSqliConnect.java:1817) at com.informix.jdbc.IfxSqliConnect.setWarnings()V(IfxSqliConnect.java:3935) at com.informix.jdbc.IfxSqliConnect.OpenDbInit()V(IfxSqliConnect.java:2591) at com.informix.jdbc.IfxSqliConnect.setDatabaseOpen(ZS)V(IfxSqliConnect.java:2465) at com.informix.jdbc.IfxSqli.callsetDatabaseOpen(Ljava.lang.String;)V(IfxSqli.java:2496) at com.informix.jdbc.IfxSqli.executeOpenDatabase(Ljava.lang.String;I)V(IfxSqli.java:1712) at com.informix.jdbc.IfxSqliConnect.<init>(Ljava.lang.String;Ljava.util.Properties;)V(IfxSqliConnect.java:1242) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeConstructorInvoker.newInstance([Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Constructor.newInstance([Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at com.informix.jdbc.IfxDriver.connect(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(IfxDriver.java:243) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;Ljava.lang.ClassLoader;)Ljava.sql.Connection;(Unknown Source) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(Unknown Source) at net.sf.hibernate.connection.DriverManagerConnectionProvider.getConnection()Ljava.sql.Connection;(DriverManagerConnectionProvider.java:101) at net.sf.hibernate.tool.hbm2ddl.SchemaExport.execute(ZZZZ)V(SchemaExport.java:119) at net.sf.hibernate.tool.hbm2ddl.SchemaExport.create(ZZ)V(SchemaExport.java:84) at net.sf.hibernate.impl.SessionFactoryImpl.<init>(Lnet.sf.hibernate.cfg.Configuration;Lnet.sf.hibernate.cfg.Settings;)V(SessionFactoryImpl.java:198) at net.sf.hibernate.cfg.Configuration.buildSessionFactory()Lnet.sf.hibernate.SessionFactory;(Configuration.java:768) at org.hibernate.test.TestCase.buildSessionFactory([Ljava.lang.String;)V(TestCase.java:64) at org.hibernate.test.TestCase.setUp()V(TestCase.java:76) at junit.framework.TestCase.runBare()V(TestCase.java:125) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,093 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I01 16:24:52,093 WARN JDBCExceptionReporter:28 - Database has transactions 16:24:52,094 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I04 16:24:52,095 WARN JDBCExceptionReporter:28 - Database selected 16:24:52,095 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1 16:24:52,096 INFO DriverManagerConnectionProvider:143 - cleaning up connection pool: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:52,110 INFO UpdateTimestampsCache:35 - starting update timestamps cache at region: net.sf.hibernate.cache.UpdateTimestampsCache 16:24:52,110 WARN Plugin:95 - Could not find configuration for net.sf.hibernate.cache.UpdateTimestampsCache. Configuring using the defaultCache settings. 16:24:52,114 INFO QueryCache:39 - starting query cache at region: net.sf.hibernate.cache.QueryCache 16:24:52,114 WARN Plugin:95 - Could not find configuration for net.sf.hibernate.cache.QueryCache. Configuring using the defaultCache settings. testMixNativeAssigned: Start 16:24:52,194 DEBUG SessionImpl:555 - opened session 16:24:52,215 DEBUG SessionImpl:778 - generated identifier: i.d. 16:24:52,223 DEBUG SessionImpl:825 - saving [org.hibernate.test.Assignable#i.d.] 16:24:52,251 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,261 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,279 DEBUG WrapVisitor:81 - Wrapped collection in role: org.hibernate.test.Assignable.categories 16:24:52,290 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,294 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Assignable.categories 16:24:52,309 DEBUG Cascades:114 - cascading to saveOrUpdate() 16:24:52,317 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,318 DEBUG SessionImpl:1387 - saveOrUpdate() unsaved instance 16:24:52,318 DEBUG SessionImpl:825 - saving [org.hibernate.test.Category#<null>] 16:24:52,319 DEBUG SessionImpl:2306 - executing insertions 16:24:52,342 DEBUG EntityPersister:453 - Inserting entity: [org.hibernate.test.Assignable#i.d.] 16:24:52,345 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,350 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:52,351 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0 16:24:52,354 DEBUG SQL:237 - insert into "assign able" (id) values (?) Hibernate: insert into "assign able" (id) values (?) 16:24:52,355 DEBUG BatcherImpl:241 - preparing statement 16:24:52,390 DEBUG EntityPersister:388 - Dehydrating entity: [org.hibernate.test.Assignable#i.d.] 16:24:52,440 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,440 DEBUG BatcherImpl:261 - closing statement 16:24:52,445 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Category 16:24:52,446 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Category 16:24:52,449 DEBUG WrapVisitor:81 - Wrapped collection in role: org.hibernate.test.Category.subcategories 16:24:52,460 DEBUG EntityPersister:490 - Inserting entity: org.hibernate.test.Category (native id) 16:24:52,461 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,461 DEBUG SQL:237 - insert into category (name, "assign able id") values (?, ?) Hibernate: insert into category (name, "assign able id") values (?, ?) 16:24:52,462 DEBUG BatcherImpl:241 - preparing statement 16:24:52,465 DEBUG EntityPersister:388 - Dehydrating entity: [org.hibernate.test.Category#<null>] 16:24:52,476 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,477 DEBUG BatcherImpl:261 - closing statement 16:24:52,485 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,485 DEBUG SQL:237 - select first 1 dbinfo('sqlca.sqlerrd1') from systables Hibernate: select first 1 dbinfo('sqlca.sqlerrd1') from systables 16:24:52,486 DEBUG BatcherImpl:241 - preparing statement 16:24:52,505 DEBUG AbstractEntityPersister:1229 - Natively generated identity: 0 16:24:52,505 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,506 DEBUG BatcherImpl:261 - closing statement 16:24:52,508 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Category 16:24:52,508 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Category.subcategories 16:24:52,509 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Category 16:24:52,510 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,515 DEBUG SessionImpl:2243 - flushing session 16:24:52,520 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,521 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Assignable.categories 16:24:52,521 DEBUG Cascades:114 - cascading to saveOrUpdate() 16:24:52,521 DEBUG SessionImpl:1372 - saveOrUpdate() persistent instance 16:24:52,521 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,522 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Category 16:24:52,522 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Category.subcategories 16:24:52,522 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Category 16:24:52,571 DEBUG SessionImpl:2436 - Flushing entities and processing referenced collections 16:24:52,583 INFO DriverManagerConnectionProvider:143 - cleaning up connection pool: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:52,595 DEBUG SessionImpl:2885 - Collection found: [org.hibernate.test.Assignable.categories#i.d.], was: [<unreferenced>] 16:24:52,601 DEBUG SessionImpl:2885 - Collection found: [org.hibernate.test.Category.subcategories#0], was: [<unreferenced>] 16:24:52,610 DEBUG SessionImpl:2781 - Processing unreferenced collections 16:24:52,610 DEBUG SessionImpl:2795 - Scheduling collection removes/(re)creates/updates 16:24:52,612 DEBUG SessionImpl:2267 - Flushed: 0 insertions, 0 updates, 0 deletions to 2 objects 16:24:52,612 DEBUG SessionImpl:2272 - Flushed: 2 (re)creations, 0 updates, 0 removals to 2 collections 16:24:52,615 DEBUG Printer:75 - listing entities: 16:24:52,624 DEBUG Printer:82 - org.hibernate.test.Assignable{categories=[Category#0], id=i.d.} 16:24:52,625 DEBUG Printer:82 - org.hibernate.test.Category{assignable=Assignable#i.d., subcategories=[], name=NAME, id=0} 16:24:52,626 DEBUG SessionImpl:2356 - executing flush 16:24:52,635 DEBUG ReadWriteCache:95 - Invalidating: i.d. 16:24:52,642 DEBUG BasicCollectionPersister:508 - Inserting collection: [org.hibernate.test.Category.subcategories#0] 16:24:52,642 DEBUG BasicCollectionPersister:539 - collection was empty 16:24:52,643 DEBUG ReadWriteCache:95 - Invalidating: 0 16:24:52,648 DEBUG SessionImpl:2825 - post flush 16:24:52,659 DEBUG SessionImpl:573 - closing session 16:24:52,661 DEBUG SessionImpl:3337 - disconnecting session 16:24:52,664 DEBUG JDBCExceptionReporter:18 - SQL Warning java.sql.SQLWarning: Database has transactions at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Ljava.lang.String;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:125) at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Lcom.informix.jdbc.IfxConnection;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:149) at com.informix.jdbc.IfxSqliConnect.addWarning(Ljava.sql.SQLWarning;Ljava.lang.String;)V(IfxSqliConnect.java:1817) at com.informix.jdbc.IfxSqliConnect.setWarnings()V(IfxSqliConnect.java:3935) at com.informix.jdbc.IfxSqliConnect.OpenDbInit()V(IfxSqliConnect.java:2591) at com.informix.jdbc.IfxSqliConnect.setDatabaseOpen(ZS)V(IfxSqliConnect.java:2465) at com.informix.jdbc.IfxSqli.callsetDatabaseOpen(Ljava.lang.String;)V(IfxSqli.java:2496) at com.informix.jdbc.IfxSqli.executeOpenDatabase(Ljava.lang.String;I)V(IfxSqli.java:1712) at com.informix.jdbc.IfxSqliConnect.<init>(Ljava.lang.String;Ljava.util.Properties;)V(IfxSqliConnect.java:1242) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeConstructorInvoker.newInstance([Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Constructor.newInstance([Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at com.informix.jdbc.IfxDriver.connect(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(IfxDriver.java:243) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;Ljava.lang.ClassLoader;)Ljava.sql.Connection;(Unknown Source) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(Unknown Source) at net.sf.hibernate.connection.DriverManagerConnectionProvider.getConnection()Ljava.sql.Connection;(DriverManagerConnectionProvider.java:101) at net.sf.hibernate.cfg.SettingsFactory.buildSettings(Ljava.util.Properties;)Lnet.sf.hibernate.cfg.Settings;(SettingsFactory.java:72) at net.sf.hibernate.cfg.Configuration.buildSettings()Lnet.sf.hibernate.cfg.Settings;(Configuration.java:1132) at net.sf.hibernate.cfg.Configuration.buildSessionFactory()Lnet.sf.hibernate.SessionFactory;(Configuration.java:766) at org.hibernate.test.TestCase.buildSessionFactory([Ljava.lang.String;)V(TestCase.java:64) at org.hibernate.test.TestCase.setUp()V(TestCase.java:76) at junit.framework.TestCase.runBare()V(TestCase.java:125) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,664 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I01 16:24:52,665 WARN JDBCExceptionReporter:28 - Database has transactions 16:24:52,665 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I04 16:24:52,665 WARN JDBCExceptionReporter:28 - Database selected 16:24:52,666 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1 16:24:52,669 DEBUG SessionImpl:585 - transaction completion 16:24:52,672 DEBUG ReadWriteCache:117 - Invalidating (again): i.d. 16:24:52,672 DEBUG ReadWriteCache:117 - Invalidating (again): 0 testMixNativeAssigned: Saved, deleting 16:24:52,674 DEBUG SessionImpl:555 - opened session SessionImpl: Deleting org.hibernate.test.Assignable@8b80590 Found entry = null 16:24:52,678 DEBUG SessionImpl:1132 - deleting a transient instance 16:24:52,694 DEBUG SessionImpl:1179 - deleting [org.hibernate.test.Assignable#i.d.] 16:24:52,694 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,695 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Assignable.categories 16:24:52,697 DEBUG Cascades:60 - cascading to delete() 16:24:52,699 DEBUG SessionImpl:2726 - object is HibProx false 16:24:52,699 DEBUG SessionImpl:2729 - Object entry = null 16:24:52,699 DEBUG SessionImpl:2732 - isunsaved = null 16:24:52,700 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,700 DEBUG SessionImpl:2734 - pers uns true 16:24:52,700 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,701 DEBUG Cascades:61 - Child = org.hibernate.test.Category@8b80582 Session saved = false 16:24:52,701 DEBUG SessionImpl:2726 - object is HibProx false 16:24:52,701 DEBUG SessionImpl:2729 - Object entry = null 16:24:52,701 DEBUG SessionImpl:2732 - isunsaved = null 16:24:52,702 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,702 DEBUG SessionImpl:2734 - pers uns true 16:24:52,702 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,703 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,704 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,704 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,704 DEBUG SessionImpl:2243 - flushing session 16:24:52,708 DEBUG SessionImpl:2436 - Flushing entities and processing referenced collections 16:24:52,709 DEBUG SessionImpl:2781 - Processing unreferenced collections 16:24:52,711 DEBUG SessionImpl:2902 - Collection dereferenced: [org.hibernate.test.Assignable.categories#i.d.] 16:24:52,711 DEBUG SessionImpl:2795 - Scheduling collection removes/(re)creates/updates 16:24:52,713 DEBUG SessionImpl:2267 - Flushed: 0 insertions, 0 updates, 1 deletions to 1 objects 16:24:52,713 DEBUG SessionImpl:2272 - Flushed: 0 (re)creations, 0 updates, 1 removals to 1 collections 16:24:52,713 DEBUG Printer:75 - listing entities: 16:24:52,714 DEBUG Printer:82 - org.hibernate.test.Assignable{categories=[Category#0], id=i.d.} 16:24:52,714 DEBUG SessionImpl:2356 - executing flush 16:24:52,716 DEBUG ReadWriteCache:95 - Invalidating: i.d. 16:24:52,722 DEBUG EntityPersister:570 - Deleting entity: [org.hibernate.test.Assignable#i.d.] 16:24:52,722 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,722 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:52,723 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0 16:24:52,723 DEBUG SQL:237 - delete from "assign able" where id=? Hibernate: delete from "assign able" where id=? 16:24:52,723 DEBUG BatcherImpl:241 - preparing statement 16:24:52,784 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,784 DEBUG BatcherImpl:261 - closing statement 16:24:52,792 DEBUG JDBCExceptionReporter:36 - SQL Exception java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396) at com.informix.jdbc.IfxSqli.dispatchMsg(I)Z(IfxSqli.java:2259) at com.informix.jdbc.IfxSqli.receiveMessage()V(IfxSqli.java:2179) at com.informix.jdbc.IfxSqli.executeCommand(Ljava.sql.Statement;)V(IfxSqli.java:721) at com.informix.jdbc.IfxResultSet.executeUpdate()I(IfxResultSet.java:305) at com.informix.jdbc.IfxStatement.executeUpdateImpl()I(IfxStatement.java:882) at com.informix.jdbc.IfxPreparedStatement.executeUpdate()I(IfxPreparedStatement.java:281) at net.sf.hibernate.impl.NonBatchingBatcher.addToBatch(I)V(NonBatchingBatcher.java:22) at net.sf.hibernate.persister.EntityPersister.delete(Ljava.io.Serializable;Ljava.lang.Object;Ljava.lang.Object;Lnet.sf.hibernate.engine.SessionImplementor;)V(EntityPersister.java:599) at net.sf.hibernate.impl.ScheduledDeletion.execute()V(ScheduledDeletion.java:29) at net.sf.hibernate.impl.SessionImpl.executeAll(Ljava.util.List;)V(SessionImpl.java:2415) at net.sf.hibernate.impl.SessionImpl.execute()V(SessionImpl.java:2373) at net.sf.hibernate.impl.SessionImpl.flush()V(SessionImpl.java:2237) at org.hibernate.test.MasterDetailTest.testMixNativeAssigned()V(MasterDetailTest.java:756) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.VirtualNativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Method.invoke(Ljava.lang.Object;[Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at junit.framework.TestCase.runTest()V(TestCase.java:154) at org.hibernate.test.TestCase.runTest()V(TestCase.java:83) at junit.framework.TestCase.runBare()V(TestCase.java:127) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,792 WARN JDBCExceptionReporter:38 - SQL Error: -692, SQLState: 23000 16:24:52,793 ERROR JDBCExceptionReporter:46 - Key value for constraint (informix.u15739_64314) is still being referenced. 16:24:52,794 ERROR JDBCExceptionReporter:38 - could not delete: [org.hibernate.test.Assignable#i.d.] java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396) at com.informix.jdbc.IfxSqli.dispatchMsg(I)Z(IfxSqli.java:2259) at com.informix.jdbc.IfxSqli.receiveMessage()V(IfxSqli.java:2179) at com.informix.jdbc.IfxSqli.executeCommand(Ljava.sql.Statement;)V(IfxSqli.java:721) at com.informix.jdbc.IfxResultSet.executeUpdate()I(IfxResultSet.java:305) at com.informix.jdbc.IfxStatement.executeUpdateImpl()I(IfxStatement.java:882) at com.informix.jdbc.IfxPreparedStatement.executeUpdate()I(IfxPreparedStatement.java:281) at net.sf.hibernate.impl.NonBatchingBatcher.addToBatch(I)V(NonBatchingBatcher.java:22) at net.sf.hibernate.persister.EntityPersister.delete(Ljava.io.Serializable;Ljava.lang.Object;Ljava.lang.Object;Lnet.sf.hibernate.engine.SessionImplementor;)V(EntityPersister.java:599) at net.sf.hibernate.impl.ScheduledDeletion.execute()V(ScheduledDeletion.java:29) at net.sf.hibernate.impl.SessionImpl.executeAll(Ljava.util.List;)V(SessionImpl.java:2415) at net.sf.hibernate.impl.SessionImpl.execute()V(SessionImpl.java:2373) at net.sf.hibernate.impl.SessionImpl.flush()V(SessionImpl.java:2237) at org.hibernate.test.MasterDetailTest.testMixNativeAssigned()V(MasterDetailTest.java:756) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.VirtualNativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Method.invoke(Ljava.lang.Object;[Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at junit.framework.TestCase.runTest()V(TestCase.java:154) at org.hibernate.test.TestCase.runTest()V(TestCase.java:83) at junit.framework.TestCase.runBare()V(TestCase.java:127) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,795 ERROR SessionImpl:2376 - Could not sync

    Hibernate JIRA | 1 decade ago | Marko Balabanovic
    java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396)
  2. 0

    I posted this to the forums but was asked to put it in JIRA instead: Hi, Can anyone help explain this behaviour with the Informix dialect? We're trying to get it to pass the unit tests (currently at about 32%). Specifically looking at MasterDetailTest.testMixNativeAssigned, where it tries to do a deletion. As a reminder, the method looks like this: public void testMixNativeAssigned() throws Exception { if (getDialect() instanceof HSQLDialect) return; System.out.println("testMixNativeAssigned: Start"); Session s = openSession(); Category c = new Category(); c.setName("NAME"); Assignable assn = new Assignable(); assn.setId("i.d."); List l = new ArrayList(); l.add(c); assn.setCategories(l); c.setAssignable(assn); s.save(assn); s.flush(); s.connection().commit(); s.close(); System.out.println("testMixNativeAssigned: Saved, deleting"); s = openSession(); s.delete(assn); s.flush(); s.connection().commit(); s.close(); System.out.println("testMixNativeAssigned: Deleted"); } In Informix, this fails at the delete stage, because of java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. (full trace at bottom of message). In other words, it cannot do the deletion because it would violate a foreign key constraint. We're trying the same thing with MySQL 4.0.20a and JDBC 3.0.14, which passes the test fine. In the MySQL version, there are two SQL delete statements generated for the above code: Hibernate: delete from category where category_key_col=? Hibernate: delete from `assign able` where id=? Whereas in Informix only the second of these is generated. Tracing it through, the difference is in ACTION_DELETE defined in net.sf.hibernate.engine.Cascades. For the Informix version we get session.isSaved(child) = false, but for MySQL session.isSaved(child) = true. The Informix version, going a little deeper into the SessionImpl.isSaved method, gets that value because getPersister(object).isUnsaved(object) = true. Any pointers on what kind of problem this is? Thanks a lot, Marko Here is the full trace from the Informix version, where it fails: Testsuite: org.hibernate.test.MasterDetailTest Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 6.993 sec ------------- Standard Output --------------- 16:24:46,782 INFO Environment:462 - Hibernate 2.1.4 16:24:46,854 INFO Environment:496 - loaded properties from resource hibernate.properties: {hibernate.connection.driver_class=com.informix.jdbc.IfxDriver, hibernate.cglib.use_reflection_optimizer=true, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, hibernate.cache.use_query_cache=true, hibernate.max_fetch_depth=1, hibernate.dialect=net.sf.hibernate.dialect.Informix9Dialect, hibernate.jdbc.use_streams_for_binary=true, hibernate.jdbc.batch_size=0, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.proxool.pool_alias=pool1, hibernate.connection.username=informix, hibernate.cache.region_prefix=hibernate.test, hibernate.connection.url=jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, hibernate.show_sql=true, hibernate.connection.password=informix, hibernate.connection.pool_size=1} 16:24:46,859 INFO Environment:521 - using java.io streams to persist binary types 16:24:46,859 INFO Environment:522 - using CGLIB reflection optimizer 16:24:46,864 INFO Configuration:311 - Mapping resource: org/hibernate/test/MasterDetail.hbm.xml 16:24:47,182 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,183 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,673 INFO Binder:229 - Mapping class: org.hibernate.test.Master -> Master 16:24:47,816 DEBUG Binder:475 - Mapped property: version -> version, type: integer 16:24:47,862 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:47,864 DEBUG Binder:475 - Mapped property: x -> x, type: integer 16:24:47,864 DEBUG Binder:475 - Mapped property: bigDecimal -> big_dec, type: big_decimal 16:24:47,900 DEBUG Binder:475 - Mapped property: details, type: java.util.Set 16:24:47,900 DEBUG Binder:475 - Mapped property: moreDetails, type: java.util.Set 16:24:47,900 INFO Binder:560 - Mapping collection: org.hibernate.test.Master.incoming -> mtm 16:24:47,901 DEBUG Binder:475 - Mapped property: incoming, type: java.util.Set 16:24:47,901 INFO Binder:560 - Mapping collection: org.hibernate.test.Master.outgoing -> mtm 16:24:47,901 DEBUG Binder:475 - Mapped property: outgoing, type: java.util.Set 16:24:47,911 DEBUG Binder:475 - Mapped property: otherMaster -> otherMaster, type: org.hibernate.test.Master 16:24:47,912 INFO Binder:229 - Mapping class: org.hibernate.test.Detail -> Detail 16:24:47,915 DEBUG Binder:475 - Mapped property: x -> x, type: integer 16:24:47,917 DEBUG Binder:475 - Mapped property: i -> i, type: integer 16:24:47,917 DEBUG Binder:475 - Mapped property: master -> master_key, type: org.hibernate.test.Master 16:24:47,919 DEBUG Binder:475 - Mapped property: subDetails, type: java.util.Set 16:24:47,919 INFO Binder:229 - Mapping class: org.hibernate.test.SubDetail -> SubDetail 16:24:47,919 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:47,921 DEBUG Binder:1267 - Named query: all_details -> from d in class Detail 16:24:47,923 INFO Configuration:311 - Mapping resource: org/hibernate/test/Custom.hbm.xml 16:24:47,928 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,929 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,937 INFO Binder:229 - Mapping class: org.hibernate.test.Custom -> Custom 16:24:47,937 DEBUG Binder:475 - Mapped property: key -> id_, type: string 16:24:47,938 INFO Configuration:311 - Mapping resource: org/hibernate/test/Category.hbm.xml 16:24:47,943 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,945 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,950 INFO Binder:229 - Mapping class: org.hibernate.test.Category -> category 16:24:47,951 DEBUG Binder:475 - Mapped property: id -> category_key_col, type: long 16:24:47,958 DEBUG Binder:475 - Mapped property: subcategories, type: java.util.List 16:24:47,958 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:47,959 DEBUG Binder:475 - Mapped property: assignable -> assign able id, type: org.hibernate.test.Assignable 16:24:47,959 INFO Binder:229 - Mapping class: org.hibernate.test.Assignable -> assign able 16:24:47,959 DEBUG Binder:475 - Mapped property: id -> id, type: string 16:24:47,965 DEBUG Binder:475 - Mapped property: categories, type: java.util.Collection 16:24:47,966 DEBUG Binder:1298 - Named sql query: namedsql -> select {category.*}, {assignable.*} from Category {category}, "assign able" {assignable} 16:24:47,967 INFO Configuration:311 - Mapping resource: org/hibernate/test/Nameable.hbm.xml 16:24:47,971 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:47,972 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:47,976 INFO Binder:229 - Mapping class: org.hibernate.test.Nameable -> Nameable 16:24:47,977 DEBUG Binder:475 - Mapped property: key -> key_, type: long 16:24:47,977 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:48,023 INFO Binder:169 - Mapping subclass: org.hibernate.test.BasicNameable -> Nameable 16:24:48,025 INFO Configuration:311 - Mapping resource: org/hibernate/test/SingleSeveral.hbm.xml 16:24:48,029 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,031 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,035 INFO Binder:229 - Mapping class: org.hibernate.test.Single -> Single 16:24:48,052 DEBUG Binder:475 - Mapped property: id -> id, type: string 16:24:48,053 DEBUG Binder:475 - Mapped property: string -> string_, type: string 16:24:48,507 DEBUG Binder:475 - Mapped property: prop -> prop, type: string 16:24:48,509 DEBUG Binder:475 - Mapped property: several, type: java.util.Collection 16:24:48,509 INFO Binder:229 - Mapping class: org.hibernate.test.Several -> Several 16:24:48,509 DEBUG Binder:475 - Mapped property: id -> id, type: string 16:24:48,510 DEBUG Binder:475 - Mapped property: string -> string_, type: string 16:24:48,517 DEBUG Binder:475 - Mapped property: single -> single_id, single_string, type: org.hibernate.test.Single 16:24:48,518 INFO Configuration:311 - Mapping resource: org/hibernate/test/WZ.hbm.xml 16:24:48,522 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,523 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,527 INFO Binder:229 - Mapping class: org.hibernate.test.Z -> Z 16:24:48,529 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,529 DEBUG Binder:475 - Mapped property: w -> w, type: org.hibernate.test.W 16:24:48,530 INFO Binder:229 - Mapping class: org.hibernate.test.W -> W 16:24:48,530 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,530 INFO Configuration:311 - Mapping resource: org/hibernate/test/UpDown.hbm.xml 16:24:48,536 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,537 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,542 INFO Binder:229 - Mapping class: org.hibernate.test.Up -> Up 16:24:48,542 DEBUG Binder:475 - Mapped property: id1 -> id1, type: string 16:24:48,543 DEBUG Binder:475 - Mapped property: id2 -> id2, type: long 16:24:48,551 INFO Binder:169 - Mapping subclass: org.hibernate.test.Down -> Up 16:24:48,551 DEBUG Binder:475 - Mapped property: value -> value_, type: long 16:24:48,552 INFO Configuration:311 - Mapping resource: org/hibernate/test/Eye.hbm.xml 16:24:48,556 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,557 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,562 INFO Binder:229 - Mapping class: org.hibernate.test.Eye -> Eye 16:24:48,563 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,564 DEBUG Binder:475 - Mapped property: name -> name, type: string 16:24:48,564 DEBUG Binder:475 - Mapped property: jays, type: java.util.Set 16:24:48,565 DEBUG Binder:475 - Mapped property: jay -> jay, type: org.hibernate.test.Jay 16:24:48,565 INFO Binder:229 - Mapping class: org.hibernate.test.Jay -> Jay 16:24:48,565 DEBUG Binder:475 - Mapped property: id -> id, type: long 16:24:48,565 DEBUG Binder:475 - Mapped property: eye -> eye, type: org.hibernate.test.Eye 16:24:48,566 INFO Configuration:311 - Mapping resource: org/hibernate/test/MN.hbm.xml 16:24:48,570 DEBUG DTDEntityResolver:20 - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ 16:24:48,571 DEBUG DTDEntityResolver:29 - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath 16:24:48,575 INFO Binder:229 - Mapping class: org.hibernate.test.M -> M 16:24:48,576 DEBUG Binder:475 - Mapped property: uniqueSequence -> uniqueSequence, type: long 16:24:48,577 DEBUG Binder:475 - Mapped property: Children, type: java.util.Set 16:24:48,578 INFO Binder:229 - Mapping class: org.hibernate.test.N -> N 16:24:48,578 DEBUG Binder:475 - Mapped property: uniqueSequence -> uniqueSequence, type: long 16:24:48,578 DEBUG Binder:475 - Mapped property: string -> String, type: string 16:24:48,579 DEBUG Binder:475 - Mapped property: Parent -> fkParent, type: org.hibernate.test.M 16:24:48,607 INFO Dialect:82 - Using dialect: net.sf.hibernate.dialect.Informix9Dialect 16:24:48,619 INFO Configuration:613 - processing one-to-many association mappings 16:24:48,623 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.details 16:24:48,631 INFO Binder:1168 - Mapping collection: org.hibernate.test.Master.details -> Detail 16:24:48,635 DEBUG Binder:1355 - Mapped collection key: master_key, one-to-many: org.hibernate.test.Detail 16:24:48,635 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.moreDetails 16:24:48,636 INFO Binder:1168 - Mapping collection: org.hibernate.test.Master.moreDetails -> Detail 16:24:48,636 DEBUG Binder:1355 - Mapped collection key: more_master_key, one-to-many: org.hibernate.test.Detail 16:24:48,636 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.incoming 16:24:48,639 DEBUG Binder:1355 - Mapped collection key: outgoingabcdef, element: incomingabcdef, type: org.hibernate.test.Master 16:24:48,639 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Master.outgoing 16:24:48,640 DEBUG Binder:1355 - Mapped collection key: incomingabcdef, element: outgoingabcdef, type: org.hibernate.test.Master 16:24:48,640 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Detail.subDetails 16:24:48,640 INFO Binder:1168 - Mapping collection: org.hibernate.test.Detail.subDetails -> SubDetail 16:24:48,640 DEBUG Binder:1355 - Mapped collection key: detail_key, one-to-many: org.hibernate.test.SubDetail 16:24:48,641 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Category.subcategories 16:24:48,642 INFO Binder:1168 - Mapping collection: org.hibernate.test.Category.subcategories -> category 16:24:48,644 DEBUG Binder:1355 - Mapped collection key: parent, index: ord, one-to-many: org.hibernate.test.Category 16:24:48,644 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Assignable.categories 16:24:48,644 INFO Binder:1168 - Mapping collection: org.hibernate.test.Assignable.categories -> category 16:24:48,645 DEBUG Binder:1355 - Mapped collection key: assign able id, one-to-many: org.hibernate.test.Category 16:24:48,645 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Single.several 16:24:48,645 INFO Binder:1168 - Mapping collection: org.hibernate.test.Single.several -> Several 16:24:48,646 DEBUG Binder:1355 - Mapped collection key: single_id, single_string, one-to-many: org.hibernate.test.Several 16:24:48,646 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.Eye.jays 16:24:48,646 INFO Binder:1168 - Mapping collection: org.hibernate.test.Eye.jays -> Jay 16:24:48,647 DEBUG Binder:1355 - Mapped collection key: eye, one-to-many: org.hibernate.test.Jay 16:24:48,647 DEBUG Binder:1340 - Second pass for collection: org.hibernate.test.M.Children 16:24:48,647 INFO Binder:1168 - Mapping collection: org.hibernate.test.M.Children -> N 16:24:48,647 DEBUG Binder:1355 - Mapped collection key: fkParent, one-to-many: org.hibernate.test.N 16:24:48,647 INFO Configuration:622 - processing one-to-one association property references 16:24:48,648 INFO Configuration:647 - processing foreign key constraints 16:24:48,649 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.W 16:24:48,652 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,652 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Eye 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Category 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Assignable 16:24:48,653 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Single 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Jay 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Detail 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.M 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,654 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,655 DEBUG Configuration:657 - resolving reference to class: org.hibernate.test.Master 16:24:48,699 INFO Dialect:82 - Using dialect: net.sf.hibernate.dialect.Informix9Dialect 16:24:48,701 INFO SettingsFactory:58 - Maximim outer join fetch depth: 1 16:24:48,702 INFO SettingsFactory:62 - Use outer join fetching: false 16:24:48,720 INFO DriverManagerConnectionProvider:42 - Using Hibernate built-in connection pool (not for production use!) 16:24:48,721 INFO DriverManagerConnectionProvider:43 - Hibernate connection pool size: 1 16:24:48,741 INFO DriverManagerConnectionProvider:77 - using driver: com.informix.jdbc.IfxDriver at URL: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:48,742 INFO DriverManagerConnectionProvider:78 - connection properties: {user=informix, password=informix} 16:24:48,753 INFO TransactionManagerLookupFactory:33 - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended) 16:24:48,757 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:48,758 DEBUG DriverManagerConnectionProvider:100 - opening new JDBC connection 16:24:49,595 DEBUG DriverManagerConnectionProvider:106 - created connection to: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, Isolation Level: 2 16:24:49,652 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1 16:24:49,653 INFO SettingsFactory:102 - Use scrollable result sets: true 16:24:49,653 INFO SettingsFactory:105 - Use JDBC3 getGeneratedKeys(): false 16:24:49,654 INFO SettingsFactory:108 - Optimize cache for minimal puts: false 16:24:49,654 INFO SettingsFactory:114 - echoing all SQL to stdout 16:24:49,657 INFO SettingsFactory:117 - Query language substitutions: {no='N', true=1, yes='Y', false=0} 16:24:49,657 INFO SettingsFactory:128 - cache provider: net.sf.ehcache.hibernate.Provider 16:24:49,663 INFO Configuration:1093 - instantiating and configuring caches 16:24:49,663 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Assignable 16:24:49,760 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Assignable. Configuring using the defaultCache settings. 16:24:49,763 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Nameable 16:24:49,763 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Nameable. Configuring using the defaultCache settings. 16:24:49,764 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.N 16:24:49,764 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.N. Configuring using the defaultCache settings. 16:24:49,765 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Category 16:24:49,765 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Category. Configuring using the defaultCache settings. 16:24:49,766 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.outgoing 16:24:49,766 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.outgoing. Configuring using the defaultCache settings. 16:24:49,767 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Detail 16:24:49,767 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Detail. Configuring using the defaultCache settings. 16:24:49,768 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Up 16:24:49,768 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Up. Configuring using the defaultCache settings. 16:24:49,768 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.incoming 16:24:49,769 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.incoming. Configuring using the defaultCache settings. 16:24:49,769 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Detail.subDetails 16:24:49,770 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Detail.subDetails. Configuring using the defaultCache settings. 16:24:49,771 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.SubDetail 16:24:49,771 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.SubDetail. Configuring using the defaultCache settings. 16:24:49,772 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.details 16:24:49,772 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.details. Configuring using the defaultCache settings. 16:24:49,773 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Eye 16:24:49,773 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Eye. Configuring using the defaultCache settings. 16:24:49,774 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master.moreDetails 16:24:49,774 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master.moreDetails. Configuring using the defaultCache settings. 16:24:49,775 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Eye.jays 16:24:49,775 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Eye.jays. Configuring using the defaultCache settings. 16:24:49,776 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.M 16:24:49,776 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.M. Configuring using the defaultCache settings. 16:24:49,777 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Master 16:24:49,777 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Master. Configuring using the defaultCache settings. 16:24:49,777 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Jay 16:24:49,778 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Jay. Configuring using the defaultCache settings. 16:24:49,778 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Single 16:24:49,779 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Single. Configuring using the defaultCache settings. 16:24:49,779 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.W 16:24:49,779 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.W. Configuring using the defaultCache settings. 16:24:49,780 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Assignable.categories 16:24:49,780 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Assignable.categories. Configuring using the defaultCache settings. 16:24:49,781 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.M.Children 16:24:49,781 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.M.Children. Configuring using the defaultCache settings. 16:24:49,781 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Single.several 16:24:49,782 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Single.several. Configuring using the defaultCache settings. 16:24:49,782 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Several 16:24:49,783 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Several. Configuring using the defaultCache settings. 16:24:49,784 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Category.subcategories 16:24:49,784 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Category.subcategories. Configuring using the defaultCache settings. 16:24:49,785 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Z 16:24:49,785 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Z. Configuring using the defaultCache settings. 16:24:49,785 DEBUG Configuration:1104 - instantiating cache hibernate.test.org.hibernate.test.Custom 16:24:49,786 WARN Plugin:95 - Could not find configuration for hibernate.test.org.hibernate.test.Custom. Configuring using the defaultCache settings. 16:24:49,859 INFO SessionFactoryImpl:119 - building session factory 16:24:49,860 DEBUG SessionFactoryImpl:125 - instantiating session factory with properties: {java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, hibernate.connection.password=informix, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, sun.boot.library.path=/usr/java/bea/jdk/1.4.2/jre/lib/i386, java.vm.version=ari-29212-20040415-1332-linux-ia32, hibernate.proxool.pool_alias=pool1, hibernate.connection.username=informix, java.vm.vendor=BEA Systems, Inc., java.vendor.url=http://www.bea.com/, path.separator=:, hibernate.cache.use_query_cache=true, java.vm.name=BEA WebLogic JRockit(TM) 1.4.2_04 JVM , file.encoding.pkg=sun.io, user.country=GB, java.vm.vendor.url=http://www.bea.com/, java.io.filesystem=java.io.UnixFileSystem, java.vm.specification.name=Java Virtual Machine Specification, user.dir=/home/mbalaban/dev/p4/products/hibernate/main, java.runtime.version=1.4.2_04, java.awt.graphicsenv=sun.awt.X11GraphicsEnvironment, java.endorsed.dirs=/usr/java/bea/jdk/1.4.2/jre/lib/endorsed, os.arch=i386, java.io.tmpdir=/tmp, line.separator= , java.vm.specification.vendor=Sun Microsystems Inc., os.name=Linux, sun.java2d.fontpath=, hibernate.cache.region_prefix=hibernate.test, java.library.path=/usr/java/bea/jdk/1.4.2/jre/lib/i386/jrockit:/usr/java/bea/jdk/1.4.2/jre/lib/i386:/usr/java/bea/jdk/1.4.2/jre/../lib/i386, java.specification.name=Java Platform API Specification, java.class.version=48.0, hibernate.connection.pool_size=1, java.util.prefs.PreferencesFactory=java.util.prefs.FileSystemPreferencesFactory, os.version=2.4.22ow1np-ht, user.home=/home/mbalaban, user.timezone=GMT, java.awt.printerjob=sun.print.PSPrinterJob, jrockit.version=ari-29212-20040415-1332-linux-ia32, file.encoding=ISO-8859-1, java.specification.version=1.4, hibernate.connection.driver_class=com.informix.jdbc.IfxDriver, jrockit.vm=/usr/java/bea/jdk/1.4.2/jre/lib/i386/jrockit/libjvm.so, java.class.path=/home/mbalaban/dev/p4/products/hibernate/main/lib/ant-1.5.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ant-optional-1.5.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/c3p0-0.8.4.5.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/cglib-full-2.0.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-collections-2.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-dbcp-1.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-lang-1.0.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-logging-1.0.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/commons-pool-1.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/concurrent-1.3.2.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/connector.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/dom4j-1.4.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ehcache-0.7.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jaas.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-cache.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-common.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-jmx.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jboss-system.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jcs-1.0-dev.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jdbc2_0-stdext.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jgroups-2.2.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/jta.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/junit-3.8.1.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/log4j-1.2.8.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/odmg-3.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/oscache-2.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/proxool-0.8.3.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/swarmcache-1.0rc2.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/xalan-2.4.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/xerces-2.4.0.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/xml-apis.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/hsqldb.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ifxjdbc-g.jar:/home/mbalaban/dev/p4/products/hibernate/main/lib/ifxjdbc.jar:/home/mbalaban/dev/p4/products/hibernate/main/build:/home/mbalaban/dev/p4/products/hibernate/main/src:/home/mbalaban/dev/p4/products/hibernate/main/test:/home/mbalaban/dev/p4/products/hibernate/main:/lmn/tools/java/tools/apache-ant-1.5.3-1/lib/junit.jar:/lmn/tools/java/tools/apache-ant-1.5.3-1/lib/ant.jar:/lmn/tools/java/tools/apache-ant-1.5.3-1/lib/optional.jar, os.real.arch=IA32, user.name=mbalaban, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.show_sql=true, java.vm.specification.version=1.0, java.home=/usr/java/bea/jdk/1.4.2/jre, hibernate.dialect=net.sf.hibernate.dialect.Informix9Dialect, hibernate.connection.url=jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, user.language=en, java.specification.vendor=Sun Microsystems Inc., java.lang.process=java.lang.UnixProcess, hibernate.cglib.use_reflection_optimizer=true, java.vm.info=Native Threads, GC strategy: parallel, hibernate.jdbc.use_streams_for_binary=true, java.version=1.4.2_04, java.ext.dirs=/usr/java/bea/jdk/1.4.2/jre/lib/ext, sun.boot.class.path=/usr/java/bea/jdk/1.4.2/jre/lib/rt.jar:/usr/java/bea/jdk/1.4.2/jre/lib/i18n.jar:/usr/java/bea/jdk/1.4.2/jre/lib/sunrsasign.jar:/usr/java/bea/jdk/1.4.2/jre/lib/jsse.jar:/usr/java/bea/jdk/1.4.2/jre/lib/jce.jar:/usr/java/bea/jdk/1.4.2/jre/lib/charsets.jar:/usr/java/bea/jdk/1.4.2/jre/classes:/usr/java/bea/jdk/1.4.2/jre/lib/managementapi.jar, java.vendor=BEA Systems, Inc., hibernate.jdbc.batch_size=0, file.separator=/, hibernate.hbm2ddl.auto=create, sun.io.unicode.encoding=UnicodeLittle, hibernate.max_fetch_depth=1} 16:24:51,056 DEBUG SessionFactoryObjectFactory:39 - initializing class SessionFactoryObjectFactory 16:24:51,061 DEBUG SessionFactoryObjectFactory:76 - registered: 40288b0ffdd8383b00fdd83840680000 (unnamed) 16:24:51,064 INFO SessionFactoryObjectFactory:82 - no JNDI name configured 16:24:51,067 DEBUG SessionFactoryImpl:196 - instantiated session factory 16:24:51,071 INFO Dialect:82 - Using dialect: net.sf.hibernate.dialect.Informix9Dialect 16:24:51,074 INFO Configuration:613 - processing one-to-many association mappings 16:24:51,075 INFO Configuration:622 - processing one-to-one association property references 16:24:51,075 INFO Configuration:647 - processing foreign key constraints 16:24:51,084 INFO Configuration:613 - processing one-to-many association mappings 16:24:51,084 INFO Configuration:622 - processing one-to-one association property references 16:24:51,084 INFO Configuration:647 - processing foreign key constraints 16:24:51,127 INFO SchemaExport:98 - Running hbm2ddl schema export 16:24:51,127 INFO SchemaExport:117 - exporting generated schema to database 16:24:51,127 INFO DriverManagerConnectionProvider:42 - Using Hibernate built-in connection pool (not for production use!) 16:24:51,128 INFO DriverManagerConnectionProvider:43 - Hibernate connection pool size: 1 16:24:51,128 INFO DriverManagerConnectionProvider:77 - using driver: com.informix.jdbc.IfxDriver at URL: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:51,128 INFO DriverManagerConnectionProvider:78 - connection properties: {user=informix, password=informix} 16:24:51,129 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:51,129 DEBUG DriverManagerConnectionProvider:100 - opening new JDBC connection 16:24:51,396 DEBUG DriverManagerConnectionProvider:106 - created connection to: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1, Isolation Level: 2 16:24:51,398 DEBUG SchemaExport:132 - alter table Z drop constraint FK5A77 16:24:51,427 DEBUG SchemaExport:132 - alter table mtm drop constraint AA 16:24:51,437 DEBUG SchemaExport:132 - alter table mtm drop constraint BB 16:24:51,446 DEBUG SchemaExport:132 - alter table Jay drop constraint FK1220218A31 16:24:51,474 DEBUG SchemaExport:132 - alter table category drop constraint FK302BCFEC4AB08AA 16:24:51,477 DEBUG SchemaExport:132 - alter table category drop constraint FK302BCFEF4317770 16:24:51,486 DEBUG SchemaExport:132 - alter table Several drop constraint FKD9AD23DC2C70205A 16:24:51,497 DEBUG SchemaExport:132 - alter table Eye drop constraint FK1121119A22 16:24:51,507 DEBUG SchemaExport:132 - alter table SubDetail drop constraint FK460B3291C2405571 16:24:51,518 DEBUG SchemaExport:132 - alter table N drop constraint FK4EE0299CF 16:24:51,521 DEBUG SchemaExport:132 - alter table Master drop constraint FK88F216828F8D0992 16:24:51,524 DEBUG SchemaExport:132 - alter table Detail drop constraint CC 16:24:51,534 DEBUG SchemaExport:132 - alter table Detail drop constraint FK79CF0471385E1A2C 16:24:51,545 DEBUG SchemaExport:132 - drop table Single 16:24:51,556 DEBUG SchemaExport:132 - drop table Z 16:24:51,566 DEBUG SchemaExport:132 - drop table mtm 16:24:51,577 DEBUG SchemaExport:132 - drop table Custom 16:24:51,586 DEBUG SchemaExport:132 - drop table Jay 16:24:51,605 DEBUG SchemaExport:132 - drop table "assign able" 16:24:51,614 DEBUG SchemaExport:132 - drop table W 16:24:51,617 DEBUG SchemaExport:132 - drop table category 16:24:51,644 DEBUG SchemaExport:132 - drop table Up 16:24:51,654 DEBUG SchemaExport:132 - drop table Several 16:24:51,664 DEBUG SchemaExport:132 - drop table M 16:24:51,667 DEBUG SchemaExport:132 - drop table Eye 16:24:51,676 DEBUG SchemaExport:132 - drop table SubDetail 16:24:51,686 DEBUG SchemaExport:132 - drop table Nameable 16:24:51,704 DEBUG SchemaExport:132 - drop table N 16:24:51,707 DEBUG SchemaExport:132 - drop table Master 16:24:51,717 DEBUG SchemaExport:132 - drop table Detail 16:24:51,737 DEBUG SchemaExport:132 - drop table hibernate_unique_key 16:24:51,747 DEBUG SchemaExport:149 - create table Single ( id VARCHAR(32) not null, string_ VARCHAR(32) not null, prop VARCHAR(255), primary key (id, string_) ) 16:24:51,758 DEBUG SchemaExport:149 - create table Z ( id INT8 not null, w INT8 not null, primary key (id) ) 16:24:51,760 DEBUG SchemaExport:149 - create table mtm ( outgoingabcdef INT8 not null, incomingabcdef INT8 not null, primary key (incomingabcdef, outgoingabcdef) ) 16:24:51,763 DEBUG SchemaExport:149 - create table Custom ( id_ VARCHAR(64) not null, primary key (id_) ) 16:24:51,765 DEBUG SchemaExport:149 - create table Jay ( id INT8 not null, eye INT8, primary key (id) ) 16:24:51,775 DEBUG SchemaExport:149 - create table "assign able" (id VARCHAR(255) not null, primary key (id)) 16:24:51,777 DEBUG SchemaExport:149 - create table W ( id INT8 not null, primary key (id) ) 16:24:51,786 DEBUG SchemaExport:149 - create table category (category_key_col SERIAL8 NOT NULL, name VARCHAR(255), "assign able id" VARCHAR(255), parent INT8, ord INTEGER, primary key (category_key_col)) 16:24:51,795 DEBUG SchemaExport:149 - create table Up ( id1 VARCHAR(255) not null, id2 INT8 not null, value_ INT8, primary key (id1, id2) ) 16:24:51,807 DEBUG SchemaExport:149 - create table Several ( id VARCHAR(32) not null, string_ VARCHAR(32) not null, single_id VARCHAR(32), single_string VARCHAR(32), primary key (id, string_) ) 16:24:51,817 DEBUG SchemaExport:149 - create table M ( uniqueSequence SERIAL8 NOT NULL, primary key (uniqueSequence) ) 16:24:51,826 DEBUG SchemaExport:149 - create table Eye ( id INT8 not null, name VARCHAR(255), jay INT8, primary key (id) ) 16:24:51,835 DEBUG SchemaExport:149 - create table SubDetail ( subdetail_key_col SERIAL8 NOT NULL, name VARCHAR(255), detail_key INT8, primary key (subdetail_key_col) ) 16:24:51,845 DEBUG SchemaExport:149 - create table Nameable ( key_ SERIAL8 NOT NULL, clazz VARCHAR(255) not null, name VARCHAR(255), primary key (key_) ) 16:24:51,854 DEBUG SchemaExport:149 - create table N ( uniqueSequence SERIAL8 NOT NULL, String VARCHAR(255), fkParent INT8 not null, primary key (uniqueSequence) ) 16:24:51,857 DEBUG SchemaExport:149 - create table Master ( master_key_column SERIAL8 NOT NULL, version INTEGER not null, name VARCHAR(255), x INTEGER, big_dec DECIMAL, otherMaster INT8, primary key (master_key_column) ) 16:24:51,885 DEBUG SchemaExport:149 - create table Detail ( detail_key_column SERIAL8 NOT NULL, x INTEGER not null, i INTEGER not null, master_key INT8 not null, more_master_key INT8, primary key (detail_key_column), unique (x, i, master_key) ) 16:24:51,895 DEBUG SchemaExport:149 - alter table Z add constraint foreign key (w) references W constraint FK5A77 16:24:51,905 DEBUG SchemaExport:149 - create index IBB on mtm (incomingabcdef) 16:24:51,915 DEBUG SchemaExport:149 - alter table mtm add constraint foreign key (outgoingabcdef) references Master constraint AA 16:24:51,925 DEBUG SchemaExport:149 - alter table mtm add constraint foreign key (incomingabcdef) references Master constraint BB 16:24:51,936 DEBUG SchemaExport:149 - alter table Jay add constraint foreign key (eye) references Eye constraint FK1220218A31 16:24:51,946 DEBUG SchemaExport:149 - alter table category add constraint foreign key (parent) references category constraint FK302BCFEC4AB08AA 16:24:51,956 DEBUG SchemaExport:149 - alter table category add constraint foreign key ("assign able id") references "assign able" constraint FK302BCFEF4317770 16:24:51,975 DEBUG SchemaExport:149 - alter table Several add constraint foreign key (single_id, single_string) references Single constraint FKD9AD23DC2C70205A 16:24:51,985 DEBUG SchemaExport:149 - alter table Eye add constraint foreign key (jay) references Jay constraint FK1121119A22 16:24:51,997 DEBUG SchemaExport:149 - alter table SubDetail add constraint foreign key (detail_key) references Detail constraint FK460B3291C2405571 16:24:52,007 DEBUG SchemaExport:149 - alter table N add constraint foreign key (fkParent) references M constraint FK4EE0299CF 16:24:52,017 DEBUG SchemaExport:149 - alter table Master add constraint foreign key (otherMaster) references Master constraint FK88F216828F8D0992 16:24:52,026 DEBUG SchemaExport:149 - alter table Detail add constraint foreign key (master_key) references Master constraint CC 16:24:52,037 DEBUG SchemaExport:149 - alter table Detail add constraint foreign key (more_master_key) references Master constraint FK79CF0471385E1A2C 16:24:52,048 DEBUG SchemaExport:149 - create table hibernate_unique_key ( next_hi INTEGER ) 16:24:52,057 DEBUG SchemaExport:149 - insert into hibernate_unique_key values ( 0 ) 16:24:52,072 INFO SchemaExport:160 - schema export complete 16:24:52,089 DEBUG JDBCExceptionReporter:18 - SQL Warning java.sql.SQLWarning: Database has transactions at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Ljava.lang.String;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:125) at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Lcom.informix.jdbc.IfxConnection;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:149) at com.informix.jdbc.IfxSqliConnect.addWarning(Ljava.sql.SQLWarning;Ljava.lang.String;)V(IfxSqliConnect.java:1817) at com.informix.jdbc.IfxSqliConnect.setWarnings()V(IfxSqliConnect.java:3935) at com.informix.jdbc.IfxSqliConnect.OpenDbInit()V(IfxSqliConnect.java:2591) at com.informix.jdbc.IfxSqliConnect.setDatabaseOpen(ZS)V(IfxSqliConnect.java:2465) at com.informix.jdbc.IfxSqli.callsetDatabaseOpen(Ljava.lang.String;)V(IfxSqli.java:2496) at com.informix.jdbc.IfxSqli.executeOpenDatabase(Ljava.lang.String;I)V(IfxSqli.java:1712) at com.informix.jdbc.IfxSqliConnect.<init>(Ljava.lang.String;Ljava.util.Properties;)V(IfxSqliConnect.java:1242) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeConstructorInvoker.newInstance([Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Constructor.newInstance([Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at com.informix.jdbc.IfxDriver.connect(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(IfxDriver.java:243) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;Ljava.lang.ClassLoader;)Ljava.sql.Connection;(Unknown Source) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(Unknown Source) at net.sf.hibernate.connection.DriverManagerConnectionProvider.getConnection()Ljava.sql.Connection;(DriverManagerConnectionProvider.java:101) at net.sf.hibernate.tool.hbm2ddl.SchemaExport.execute(ZZZZ)V(SchemaExport.java:119) at net.sf.hibernate.tool.hbm2ddl.SchemaExport.create(ZZ)V(SchemaExport.java:84) at net.sf.hibernate.impl.SessionFactoryImpl.<init>(Lnet.sf.hibernate.cfg.Configuration;Lnet.sf.hibernate.cfg.Settings;)V(SessionFactoryImpl.java:198) at net.sf.hibernate.cfg.Configuration.buildSessionFactory()Lnet.sf.hibernate.SessionFactory;(Configuration.java:768) at org.hibernate.test.TestCase.buildSessionFactory([Ljava.lang.String;)V(TestCase.java:64) at org.hibernate.test.TestCase.setUp()V(TestCase.java:76) at junit.framework.TestCase.runBare()V(TestCase.java:125) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,093 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I01 16:24:52,093 WARN JDBCExceptionReporter:28 - Database has transactions 16:24:52,094 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I04 16:24:52,095 WARN JDBCExceptionReporter:28 - Database selected 16:24:52,095 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1 16:24:52,096 INFO DriverManagerConnectionProvider:143 - cleaning up connection pool: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:52,110 INFO UpdateTimestampsCache:35 - starting update timestamps cache at region: net.sf.hibernate.cache.UpdateTimestampsCache 16:24:52,110 WARN Plugin:95 - Could not find configuration for net.sf.hibernate.cache.UpdateTimestampsCache. Configuring using the defaultCache settings. 16:24:52,114 INFO QueryCache:39 - starting query cache at region: net.sf.hibernate.cache.QueryCache 16:24:52,114 WARN Plugin:95 - Could not find configuration for net.sf.hibernate.cache.QueryCache. Configuring using the defaultCache settings. testMixNativeAssigned: Start 16:24:52,194 DEBUG SessionImpl:555 - opened session 16:24:52,215 DEBUG SessionImpl:778 - generated identifier: i.d. 16:24:52,223 DEBUG SessionImpl:825 - saving [org.hibernate.test.Assignable#i.d.] 16:24:52,251 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,261 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,279 DEBUG WrapVisitor:81 - Wrapped collection in role: org.hibernate.test.Assignable.categories 16:24:52,290 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,294 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Assignable.categories 16:24:52,309 DEBUG Cascades:114 - cascading to saveOrUpdate() 16:24:52,317 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,318 DEBUG SessionImpl:1387 - saveOrUpdate() unsaved instance 16:24:52,318 DEBUG SessionImpl:825 - saving [org.hibernate.test.Category#<null>] 16:24:52,319 DEBUG SessionImpl:2306 - executing insertions 16:24:52,342 DEBUG EntityPersister:453 - Inserting entity: [org.hibernate.test.Assignable#i.d.] 16:24:52,345 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,350 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:52,351 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0 16:24:52,354 DEBUG SQL:237 - insert into "assign able" (id) values (?) Hibernate: insert into "assign able" (id) values (?) 16:24:52,355 DEBUG BatcherImpl:241 - preparing statement 16:24:52,390 DEBUG EntityPersister:388 - Dehydrating entity: [org.hibernate.test.Assignable#i.d.] 16:24:52,440 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,440 DEBUG BatcherImpl:261 - closing statement 16:24:52,445 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Category 16:24:52,446 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Category 16:24:52,449 DEBUG WrapVisitor:81 - Wrapped collection in role: org.hibernate.test.Category.subcategories 16:24:52,460 DEBUG EntityPersister:490 - Inserting entity: org.hibernate.test.Category (native id) 16:24:52,461 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,461 DEBUG SQL:237 - insert into category (name, "assign able id") values (?, ?) Hibernate: insert into category (name, "assign able id") values (?, ?) 16:24:52,462 DEBUG BatcherImpl:241 - preparing statement 16:24:52,465 DEBUG EntityPersister:388 - Dehydrating entity: [org.hibernate.test.Category#<null>] 16:24:52,476 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,477 DEBUG BatcherImpl:261 - closing statement 16:24:52,485 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,485 DEBUG SQL:237 - select first 1 dbinfo('sqlca.sqlerrd1') from systables Hibernate: select first 1 dbinfo('sqlca.sqlerrd1') from systables 16:24:52,486 DEBUG BatcherImpl:241 - preparing statement 16:24:52,505 DEBUG AbstractEntityPersister:1229 - Natively generated identity: 0 16:24:52,505 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,506 DEBUG BatcherImpl:261 - closing statement 16:24:52,508 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Category 16:24:52,508 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Category.subcategories 16:24:52,509 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Category 16:24:52,510 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,515 DEBUG SessionImpl:2243 - flushing session 16:24:52,520 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,521 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Assignable.categories 16:24:52,521 DEBUG Cascades:114 - cascading to saveOrUpdate() 16:24:52,521 DEBUG SessionImpl:1372 - saveOrUpdate() persistent instance 16:24:52,521 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,522 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Category 16:24:52,522 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Category.subcategories 16:24:52,522 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Category 16:24:52,571 DEBUG SessionImpl:2436 - Flushing entities and processing referenced collections 16:24:52,583 INFO DriverManagerConnectionProvider:143 - cleaning up connection pool: jdbc:informix-sqli://192.168.12.173:1526/marko:INFORMIXSERVER=net940;DELIMIDENT=1 16:24:52,595 DEBUG SessionImpl:2885 - Collection found: [org.hibernate.test.Assignable.categories#i.d.], was: [<unreferenced>] 16:24:52,601 DEBUG SessionImpl:2885 - Collection found: [org.hibernate.test.Category.subcategories#0], was: [<unreferenced>] 16:24:52,610 DEBUG SessionImpl:2781 - Processing unreferenced collections 16:24:52,610 DEBUG SessionImpl:2795 - Scheduling collection removes/(re)creates/updates 16:24:52,612 DEBUG SessionImpl:2267 - Flushed: 0 insertions, 0 updates, 0 deletions to 2 objects 16:24:52,612 DEBUG SessionImpl:2272 - Flushed: 2 (re)creations, 0 updates, 0 removals to 2 collections 16:24:52,615 DEBUG Printer:75 - listing entities: 16:24:52,624 DEBUG Printer:82 - org.hibernate.test.Assignable{categories=[Category#0], id=i.d.} 16:24:52,625 DEBUG Printer:82 - org.hibernate.test.Category{assignable=Assignable#i.d., subcategories=[], name=NAME, id=0} 16:24:52,626 DEBUG SessionImpl:2356 - executing flush 16:24:52,635 DEBUG ReadWriteCache:95 - Invalidating: i.d. 16:24:52,642 DEBUG BasicCollectionPersister:508 - Inserting collection: [org.hibernate.test.Category.subcategories#0] 16:24:52,642 DEBUG BasicCollectionPersister:539 - collection was empty 16:24:52,643 DEBUG ReadWriteCache:95 - Invalidating: 0 16:24:52,648 DEBUG SessionImpl:2825 - post flush 16:24:52,659 DEBUG SessionImpl:573 - closing session 16:24:52,661 DEBUG SessionImpl:3337 - disconnecting session 16:24:52,664 DEBUG JDBCExceptionReporter:18 - SQL Warning java.sql.SQLWarning: Database has transactions at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Ljava.lang.String;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:125) at com.informix.util.IfxWarnMsg.getSQLWarning(Ljava.lang.String;Ljava.lang.String;Lcom.informix.jdbc.IfxConnection;)Ljava.sql.SQLWarning;(IfxWarnMsg.java:149) at com.informix.jdbc.IfxSqliConnect.addWarning(Ljava.sql.SQLWarning;Ljava.lang.String;)V(IfxSqliConnect.java:1817) at com.informix.jdbc.IfxSqliConnect.setWarnings()V(IfxSqliConnect.java:3935) at com.informix.jdbc.IfxSqliConnect.OpenDbInit()V(IfxSqliConnect.java:2591) at com.informix.jdbc.IfxSqliConnect.setDatabaseOpen(ZS)V(IfxSqliConnect.java:2465) at com.informix.jdbc.IfxSqli.callsetDatabaseOpen(Ljava.lang.String;)V(IfxSqli.java:2496) at com.informix.jdbc.IfxSqli.executeOpenDatabase(Ljava.lang.String;I)V(IfxSqli.java:1712) at com.informix.jdbc.IfxSqliConnect.<init>(Ljava.lang.String;Ljava.util.Properties;)V(IfxSqliConnect.java:1242) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeConstructorInvoker.newInstance([Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Constructor.newInstance([Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at com.informix.jdbc.IfxDriver.connect(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(IfxDriver.java:243) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;Ljava.lang.ClassLoader;)Ljava.sql.Connection;(Unknown Source) at java.sql.DriverManager.getConnection(Ljava.lang.String;Ljava.util.Properties;)Ljava.sql.Connection;(Unknown Source) at net.sf.hibernate.connection.DriverManagerConnectionProvider.getConnection()Ljava.sql.Connection;(DriverManagerConnectionProvider.java:101) at net.sf.hibernate.cfg.SettingsFactory.buildSettings(Ljava.util.Properties;)Lnet.sf.hibernate.cfg.Settings;(SettingsFactory.java:72) at net.sf.hibernate.cfg.Configuration.buildSettings()Lnet.sf.hibernate.cfg.Settings;(Configuration.java:1132) at net.sf.hibernate.cfg.Configuration.buildSessionFactory()Lnet.sf.hibernate.SessionFactory;(Configuration.java:766) at org.hibernate.test.TestCase.buildSessionFactory([Ljava.lang.String;)V(TestCase.java:64) at org.hibernate.test.TestCase.setUp()V(TestCase.java:76) at junit.framework.TestCase.runBare()V(TestCase.java:125) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,664 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I01 16:24:52,665 WARN JDBCExceptionReporter:28 - Database has transactions 16:24:52,665 WARN JDBCExceptionReporter:20 - SQL Warning: 0, SQLState: 01I04 16:24:52,665 WARN JDBCExceptionReporter:28 - Database selected 16:24:52,666 DEBUG DriverManagerConnectionProvider:120 - returning connection to pool, pool size: 1 16:24:52,669 DEBUG SessionImpl:585 - transaction completion 16:24:52,672 DEBUG ReadWriteCache:117 - Invalidating (again): i.d. 16:24:52,672 DEBUG ReadWriteCache:117 - Invalidating (again): 0 testMixNativeAssigned: Saved, deleting 16:24:52,674 DEBUG SessionImpl:555 - opened session SessionImpl: Deleting org.hibernate.test.Assignable@8b80590 Found entry = null 16:24:52,678 DEBUG SessionImpl:1132 - deleting a transient instance 16:24:52,694 DEBUG SessionImpl:1179 - deleting [org.hibernate.test.Assignable#i.d.] 16:24:52,694 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,695 DEBUG Cascades:525 - cascading to collection: org.hibernate.test.Assignable.categories 16:24:52,697 DEBUG Cascades:60 - cascading to delete() 16:24:52,699 DEBUG SessionImpl:2726 - object is HibProx false 16:24:52,699 DEBUG SessionImpl:2729 - Object entry = null 16:24:52,699 DEBUG SessionImpl:2732 - isunsaved = null 16:24:52,700 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,700 DEBUG SessionImpl:2734 - pers uns true 16:24:52,700 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,701 DEBUG Cascades:61 - Child = org.hibernate.test.Category@8b80582 Session saved = false 16:24:52,701 DEBUG SessionImpl:2726 - object is HibProx false 16:24:52,701 DEBUG SessionImpl:2729 - Object entry = null 16:24:52,701 DEBUG SessionImpl:2732 - isunsaved = null 16:24:52,702 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,702 DEBUG SessionImpl:2734 - pers uns true 16:24:52,702 DEBUG Cascades:313 - id unsaved-value: 0 16:24:52,703 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,704 DEBUG Cascades:498 - processing cascades for: org.hibernate.test.Assignable 16:24:52,704 DEBUG Cascades:507 - done processing cascades for: org.hibernate.test.Assignable 16:24:52,704 DEBUG SessionImpl:2243 - flushing session 16:24:52,708 DEBUG SessionImpl:2436 - Flushing entities and processing referenced collections 16:24:52,709 DEBUG SessionImpl:2781 - Processing unreferenced collections 16:24:52,711 DEBUG SessionImpl:2902 - Collection dereferenced: [org.hibernate.test.Assignable.categories#i.d.] 16:24:52,711 DEBUG SessionImpl:2795 - Scheduling collection removes/(re)creates/updates 16:24:52,713 DEBUG SessionImpl:2267 - Flushed: 0 insertions, 0 updates, 1 deletions to 1 objects 16:24:52,713 DEBUG SessionImpl:2272 - Flushed: 0 (re)creations, 0 updates, 1 removals to 1 collections 16:24:52,713 DEBUG Printer:75 - listing entities: 16:24:52,714 DEBUG Printer:82 - org.hibernate.test.Assignable{categories=[Category#0], id=i.d.} 16:24:52,714 DEBUG SessionImpl:2356 - executing flush 16:24:52,716 DEBUG ReadWriteCache:95 - Invalidating: i.d. 16:24:52,722 DEBUG EntityPersister:570 - Deleting entity: [org.hibernate.test.Assignable#i.d.] 16:24:52,722 DEBUG BatcherImpl:196 - about to open: 0 open PreparedStatements, 0 open ResultSets 16:24:52,722 DEBUG DriverManagerConnectionProvider:84 - total checked-out connections: 0 16:24:52,723 DEBUG DriverManagerConnectionProvider:90 - using pooled JDBC connection, pool size: 0 16:24:52,723 DEBUG SQL:237 - delete from "assign able" where id=? Hibernate: delete from "assign able" where id=? 16:24:52,723 DEBUG BatcherImpl:241 - preparing statement 16:24:52,784 DEBUG BatcherImpl:203 - done closing: 0 open PreparedStatements, 0 open ResultSets 16:24:52,784 DEBUG BatcherImpl:261 - closing statement 16:24:52,792 DEBUG JDBCExceptionReporter:36 - SQL Exception java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396) at com.informix.jdbc.IfxSqli.dispatchMsg(I)Z(IfxSqli.java:2259) at com.informix.jdbc.IfxSqli.receiveMessage()V(IfxSqli.java:2179) at com.informix.jdbc.IfxSqli.executeCommand(Ljava.sql.Statement;)V(IfxSqli.java:721) at com.informix.jdbc.IfxResultSet.executeUpdate()I(IfxResultSet.java:305) at com.informix.jdbc.IfxStatement.executeUpdateImpl()I(IfxStatement.java:882) at com.informix.jdbc.IfxPreparedStatement.executeUpdate()I(IfxPreparedStatement.java:281) at net.sf.hibernate.impl.NonBatchingBatcher.addToBatch(I)V(NonBatchingBatcher.java:22) at net.sf.hibernate.persister.EntityPersister.delete(Ljava.io.Serializable;Ljava.lang.Object;Ljava.lang.Object;Lnet.sf.hibernate.engine.SessionImplementor;)V(EntityPersister.java:599) at net.sf.hibernate.impl.ScheduledDeletion.execute()V(ScheduledDeletion.java:29) at net.sf.hibernate.impl.SessionImpl.executeAll(Ljava.util.List;)V(SessionImpl.java:2415) at net.sf.hibernate.impl.SessionImpl.execute()V(SessionImpl.java:2373) at net.sf.hibernate.impl.SessionImpl.flush()V(SessionImpl.java:2237) at org.hibernate.test.MasterDetailTest.testMixNativeAssigned()V(MasterDetailTest.java:756) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.VirtualNativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Method.invoke(Ljava.lang.Object;[Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at junit.framework.TestCase.runTest()V(TestCase.java:154) at org.hibernate.test.TestCase.runTest()V(TestCase.java:83) at junit.framework.TestCase.runBare()V(TestCase.java:127) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,792 WARN JDBCExceptionReporter:38 - SQL Error: -692, SQLState: 23000 16:24:52,793 ERROR JDBCExceptionReporter:46 - Key value for constraint (informix.u15739_64314) is still being referenced. 16:24:52,794 ERROR JDBCExceptionReporter:38 - could not delete: [org.hibernate.test.Assignable#i.d.] java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396) at com.informix.jdbc.IfxSqli.dispatchMsg(I)Z(IfxSqli.java:2259) at com.informix.jdbc.IfxSqli.receiveMessage()V(IfxSqli.java:2179) at com.informix.jdbc.IfxSqli.executeCommand(Ljava.sql.Statement;)V(IfxSqli.java:721) at com.informix.jdbc.IfxResultSet.executeUpdate()I(IfxResultSet.java:305) at com.informix.jdbc.IfxStatement.executeUpdateImpl()I(IfxStatement.java:882) at com.informix.jdbc.IfxPreparedStatement.executeUpdate()I(IfxPreparedStatement.java:281) at net.sf.hibernate.impl.NonBatchingBatcher.addToBatch(I)V(NonBatchingBatcher.java:22) at net.sf.hibernate.persister.EntityPersister.delete(Ljava.io.Serializable;Ljava.lang.Object;Ljava.lang.Object;Lnet.sf.hibernate.engine.SessionImplementor;)V(EntityPersister.java:599) at net.sf.hibernate.impl.ScheduledDeletion.execute()V(ScheduledDeletion.java:29) at net.sf.hibernate.impl.SessionImpl.executeAll(Ljava.util.List;)V(SessionImpl.java:2415) at net.sf.hibernate.impl.SessionImpl.execute()V(SessionImpl.java:2373) at net.sf.hibernate.impl.SessionImpl.flush()V(SessionImpl.java:2237) at org.hibernate.test.MasterDetailTest.testMixNativeAssigned()V(MasterDetailTest.java:756) at jrockit.reflect.NativeMethodInvoker.invoke0(Ljava.lang.Object;ILjava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.NativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at jrockit.reflect.VirtualNativeMethodInvoker.invoke(Ljava.lang.Object;[Ljava.lang.Object;)Ljava.lang.Object;(Unknown Source) at java.lang.reflect.Method.invoke(Ljava.lang.Object;[Ljava.lang.Object;I)Ljava.lang.Object;(Unknown Source) at junit.framework.TestCase.runTest()V(TestCase.java:154) at org.hibernate.test.TestCase.runTest()V(TestCase.java:83) at junit.framework.TestCase.runBare()V(TestCase.java:127) at junit.framework.TestResult$1.protect()V(TestResult.java:106) at junit.framework.TestResult.runProtected(Ljunit.framework.Test;Ljunit.framework.Protectable;)V(TestResult.java:124) at junit.framework.TestResult.run(Ljunit.framework.TestCase;)V(TestResult.java:109) at junit.framework.TestCase.run(Ljunit.framework.TestResult;)V(TestCase.java:118) at junit.framework.TestSuite.runTest(Ljunit.framework.Test;Ljunit.framework.TestResult;)V(TestSuite.java:208) at junit.framework.TestSuite.run(Ljunit.framework.TestResult;)V(TestSuite.java:203) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run()V(JUnitTestRunner.java:325) at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main([Ljava.lang.String;)V(JUnitTestRunner.java:536) 16:24:52,795 ERROR SessionImpl:2376 - Could not sync

    Hibernate JIRA | 1 decade ago | Marko Balabanovic
    java.sql.SQLException: Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396)
  3. 0

    apache.openjpa.user - Question about org.apache.openjpa.jdbc.sql.DBDictionary.toNativeJoin(Join join) method - msg#00024 - Recent Discussion OSDir.com

    osdir.com | 12 months ago
    java.sql.SQLException: Missing key in referenced table for > > > > referential constraint (ins.fkappli_applicantid_identity).
  4. Speed up your debug routine!

    Automated exception search integrated into your IDE

  5. 0

    Re: Does anybody know how to configure a datasource for informix

    geronimo-user | 3 years ago | Zhi Xie
    java.sql.SQLException: Database does not have logging. at > com.informix.util.IfxErrMsg.getSQLException(IfxErrMsg.java:412)
  6. 0

    Informix: Error while trying to set up start or end key for index read

    Oracle Community | 1 decade ago | 666705
    java.sql.SQLException: [Internal] Error while trying to set up start or end key for index read [fmstopset_release]

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

    Tired of useless tips?

    Automated exception search integrated into your IDE

    Root Cause Analysis

    1. java.sql.SQLException

      Key value for constraint (informix.u15739_64314) is still being referenced. at com.informix.jdbc.IfxSqli.addException(ILjava.lang.String;)V(IfxSqli.java:3082) at com.informix.jdbc.IfxSqli.receiveError()V(IfxSqli.java:3396)

      at com.informix.jdbc.IfxSqli.dispatchMsg()
    2. com.informix.jdbc
      IfxSqli.dispatchMsg
      1. com.informix.jdbc.IfxSqli.dispatchMsg(I)
      1 frame