Anscheinend kein commit

Ronin77 · **Joined:** Sat Feb 16, 2008 1:36 pm **Posts:** 3

aktuelle Hibernate Version

Code:

<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
  "-//Hibernate/Hibernate Mapping DTD 3.0//EN"
  "http://hibernate.sourceforge.net/hibernate-mapping-3.0.dtd">
<hibernate-mapping>
  <class name="film.Dvd" table="DVDS">
    <id name="id" column="ID" type="integer">
      <generator class="native"/>
    </id>
    <property name="name"  column="NAME"  type="string" not-null="true"/>
    <property name="genre"   column="GENRE"   type="string"/>
    <property name="kommentar"   column="KOMMENTAR"   type="string"/>
    <property name="aufnahme" column="AUFNAHME" type="string" not-null="true"/>    
  </class>
</hibernate-mapping>

Code:

         sess = sessionFactory.openSession();
         trx  = sess.beginTransaction();
         Dvd dvd = new Dvd();         
         dvd.setName( name );
         dvd.setGenre( genre );
         dvd.setKommentar(kommentar);
         dvd.setAufnahme(aufnahme);                          
         trx.commit();
         sess.close();

Name and version of the database you are using:
HSQLDB

The generated SQL (show_sql=true):

Code:

Finished Initializing Hibernate
------------------------------------------------------
Hibernate: select dvd0_.ID as ID0_, dvd0_.NAME as NAME0_, dvd0_.GENRE as GENRE0_, dvd0_.KOMMENTAR as KOMMENTAR0_, dvd0_.AUFNAHME as AUFNAHME0_ from DVDS dvd0_

------------------------------------------------------
Hibernate: select dvd0_.ID as ID0_, dvd0_.NAME as NAME0_, dvd0_.GENRE as GENRE0_, dvd0_.KOMMENTAR as KOMMENTAR0_, dvd0_.AUFNAHME as AUFNAHME0_ from DVDS dvd0_

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

Hallo,

irgendwie wird nichts in die DB geschrieben. Kann mir das nicht erklären. Weiß von euch jemand Rat?

Danke

schauder · **Joined:** Thu Jul 05, 2007 9:38 am **Posts:** 287

Wie wäre es wenn du Hibernate sagst, das es etwas speichern soll:

session.persist(dvd);

oder

session.save(dvd);

oder

session.saveOrUpdate(dvd);

Jens

msfox · **Joined:** Thu Apr 24, 2008 9:06 am **Posts:** 1

Hi,

ich hatte heute ähliches Problem .
Im Debugger habe ich gesehe, dass ein sauberes commit nur dann gemacht wird, wenn in der Klasse JTATransaction das flag newTransaction auf true steht.
Das flag wird unter anderem dann wieder false, wenn man sich in der session eine weitere Transaktion geben läßt, ohne die vorherige zu zu schließen oder ähnliches.
Jedenfalls halte ich mir bei JTA die Session in der Beispielklasse HibernateUtil und prüfe, ob diese Session zum einen vorhanden ist, offen ist und ob die dortige Transaction aktiv ist, bevor ich eine neue Transaction beginne.
Das Log ist hier etwas trügerisch. Der Eintrag "commit" wird zwar gemacht, die Prüfung auf newTransaction geschieht erst danach. Dieser Eintrag kennzeichnet nur das die Methode gerufe wurde, aber nicht, dass diese erfolgreich war.

Gruß
Maik

qxmk · **Joined:** Thu Apr 03, 2008 11:14 am **Posts:** 10

Hi! Ich hab ein Problem was zumindest zum Thema "anscheinend kein commit" passt... (Englischer Original-Thread)

Hibernate version:
Hibernate 3.2.5
Hibernate Annotations 3.3.0.GA
Bytecode provider name: cglib

Mapping documents:
Ich nutze Annotationen, aber dies ist der Inhalt der hibernate.cfg.xml:

Code:

<?xml version='1.0' encoding='utf-8'?>
<!DOCTYPE hibernate-configuration PUBLIC
"-//Hibernate/Hibernate Configuration DTD 3.0//EN"
"http://hibernate.sourceforge.net/hibernate-configuration-3.0.dtd">
<hibernate-configuration>
    <session-factory>

        <property name="connection.driver_class">com.mysql.jdbc.Driver</property>
        <property name="connection.url">jdbc:mysql://server/database</property>
        <property name="connection.username">***</property>
        <property name="connection.password">***</property>
        <property name="connection.pool_size">1</property>
        <property name="connection.autocommit">true</property>

        <property name="dialect">org.hibernate.dialect.MySQLDialect</property>
        <property name="current_session_context_class">thread</property>
        <property name="cache.provider_class">org.hibernate.cache.NoCacheProvider</property>
        <property name="show_sql">true</property>
        <property name="format_sql">false</property>
        <property name="use_sql_comments">false</property>
        <property name="hbm2ddl.auto">update</property>
        
        <property name="hibernate.validator.autoregister_listeners">false</property>

        <mapping class="path.to.package.ClassName" /><!-- Für jede @Entity-markierte Klasse -->

    </session-factory>
</hibernate-configuration>

Code between sessionFactory.openSession() and session.close():
Der Quelltext ist etwas komplex... es gibt eine HibernateUtils-Klasse (ähnlich der in der Manual) mit einer speziellen Methode

Code:

frame()

, welche die Sessionverwaltung übernimmt. Um rekursive Aufrufe von frame() zu erlauben, wird intern ein Zähler

Code:

private static int frameLevel

als Zähler verwendet.
Lediglich der erste (äußere) Aufruf ruft openSession() und abschließend close() auf. Es folgt eine entrümpelte frame()-Methode:

Code:

    private static int frameLevel = 0; // der Zähler
    public static boolean frame(HibernateFramedMethod p) {
        // HibernateFramedMethod ist ein Interface mit einer Methode
        //   public boolean process(Session s);
        frameLevel++;
        try {
            Session s;
            if (frameLevel <= 1) {
                s = getSessionFactory().openSession();
                s.createSQLQuery("SET SESSION sql_mode='NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION'").executeUpdate(); // kann weggelassen werden (?!)
                s.createSQLQuery("SET NAMES utf8").executeUpdate(); // kann weggelassen werden (?!)
                s.createSQLQuery("SELECT @@SQL_MODE").uniqueResult(); // kann weggelassen werden (?!)
            } else {
                s = getSessionFactory().getCurrentSession();
            }
            Transaction tx;
            boolean ok;
            try {
                if (frameLevel <= 1)
                    tx = s.beginTransaction();
                else
                    tx = s.getTransaction();

                if (!tx.isActive()) // kann weggelassen werden (?!), nur manchmal ist tx.isActive()==false ...warum!?
                    try { tx.begin(); }
                    catch(HibernateException e) {}

                try { ok = p.process(s); } // ruft eine Callback-Methode auf
                catch(Exception e) { ok = false; }

                if (frameLevel <= 1) {
                    if (ok) {
                        tx.commit();
                    }
                    else {
                        tx.rollback();
                    }
                }
                
            } finally {
                tx = null;
                if ((frameLevel <= 1) && (s.isOpen())) {
                    s.close();
                }
            }
            return Log.leave(ok);

        } catch(Throwable t) {
            t.printStackTrace();
            return Log.leave(false);
        }
    }

Full stack trace of any exception that occurs:
Es tritt keine Exception auf, aber Hibernate verhält sich irgendwie komisch

Name and version of the database you are using:
MySQL 5 (Server version: 5.0.41-community-nt-log MySQL Community Edition (GPL))
Zur Administration nutze ich den MySQL Administrator und den MySQL Query Browser (QB)

Auszug aus der Java Konsole:

Code:

JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-5.0.7 ( $Date: 2007-03-09 22:13:57 +0100 (Fri, 09 Mar 2007) $, $Revision: 6341 $ )

Ein Auszug aus der mysqlqueries.log (MySQL-Variable log):

Code:

15:41:39
Connect      ***@server on database
SHOW VARIABLES
SHOW WARNINGS
SHOW COLLATION
SET character_set_results = NULL
SET autocommit=1
SET SESSION sql_mode='STRICT_TRANS_TABLES,NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION'
SET autocommit=0
15:41:41
Connect     ***@server on database
SHOW VARIABLES
SHOW WARNINGS
SHOW COLLATION
SET character_set_results = NULL
SET autocommit=1
SET autocommit=0
select count(*) as col_0_0_ from tableX x0_, tableY y_ where ... and y_.property=0
select x0_.id as id1_6_, x0_.s as s6_, ... from tableX x0_, tableY y_ where ... limit 3
commit
SET autocommit=1
SHOW FULL TABLES FROM `database` LIKE 'tableX'
SHOW FULL TABLES FROM `database` LIKE 'tableX'
SHOW FULL COLUMNS FROM `tableX` FROM `database` LIKE '%'
SHOW CREATE TABLE `database`.`tableX`
SHOW INDEX FROM `tableX` FROM `database`
...//for each entity
SET SESSION sql_mode='NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION'
SET NAMES utf8
SELECT @@SQL_MODE
SHOW CHARACTER SET
SET autocommit=0
insert into tableX (s, ...) values ('test', ...)
//4 weitere insert's; je erstelltem Objekt eine Zeile
commit
SET autocommit=1
SET SESSION sql_mode='NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION'
SET NAMES utf8
SELECT @@SQL_MODE
SET autocommit=0
select count(*) as col_0_0_ from tableX x0_, tableY y_ where ... and y_.property=0
select x0_.id as id1_6_, x0_.s as s6_, ... from tableX x0_, tableY y_ where ... limit 3
commit
SET autocommit=1
SET SESSION sql_mode='NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION'
SET NAMES utf8
SELECT @@SQL_MODE
SET autocommit=0
select x0_.id as id1_6_, x0_.s as s6_, ... from tableX x0_, tableY y_ where ... limit 3
commit
SET autocommit=1

The generated SQL (show_sql=true):
siehe nächster Abschnitt

Debug level Hibernate log excerpt:
[code]
19:34:07,790 INFO [Version] Hibernate Annotations 3.3.0.GA
19:34:07,810 INFO [Environment] Hibernate 3.2.5
19:34:07,814 INFO [Environment] hibernate.properties not found
19:34:07,818 INFO [Environment] Bytecode provider name : cglib
19:34:07,824 INFO [Environment] using JDK 1.4 java.sql.Timestamp handling
19:34:07,941 INFO [Configuration] configuring from resource: /hibernate.cfg.xml
19:34:07,941 INFO [Configuration] Configuration resource: /hibernate.cfg.xml
19:34:08,044 DEBUG [DTDEntityResolver] trying to resolve system-id [http://hibernate.sourceforge.net/hibernate-configuration-3.0.dtd]
19:34:08,044 DEBUG [DTDEntityResolver] recognized hibernate namespace; attempting to resolve on classpath under org/hibernate/
19:34:08,045 DEBUG [DTDEntityResolver] located [http://hibernate.sourceforge.net/hibernate-configuration-3.0.dtd] in classpath
19:34:08,108 DEBUG [Configuration] connection.driver_class=com.mysql.jdbc.Driver
19:34:08,108 DEBUG [Configuration] connection.url=jdbc:mysql://localhost/crm
19:34:08,108 DEBUG [Configuration] connection.username=root
19:34:08,108 DEBUG [Configuration] connection.password=uniadmin
19:34:08,112 DEBUG [Configuration] connection.pool_size=1
19:34:08,113 DEBUG [Configuration] connection.autocommit=true
19:34:08,113 DEBUG [Configuration] jdbc.batch_size=10
19:34:08,113 DEBUG [Configuration] dialect=org.hibernate.dialect.MySQL5InnoDBDialect
19:34:08,113 DEBUG [Configuration] current_session_context_class=thread
19:34:08,113 DEBUG [Configuration] cache.provider_class=org.hibernate.cache.NoCacheProvider
19:34:08,113 DEBUG [Configuration] show_sql=true
19:34:08,113 DEBUG [Configuration] format_sql=false
19:34:08,115 DEBUG [Configuration] use_sql_comments=false
19:34:08,115 DEBUG [Configuration] hbm2ddl.auto=update
19:34:08,115 DEBUG [Configuration] hibernate.validator.autoregister_listeners=false
19:34:08,115 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@fd54d6 [Attribute: name class value "tuc_d_k.crm.database.entities.Address"]
19:34:08,132 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@15a3d6b [Attribute: name class value "tuc_d_k.crm.database.entities.Attribute"]
19:34:08,134 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@1ef9f1d [Attribute: name class value "tuc_d_k.crm.database.entities.Authority"]
19:34:08,137 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@1b16e52 [Attribute: name class value "tuc_d_k.crm.database.entities.Change"]
19:34:08,138 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@4413ee [Attribute: name class value "tuc_d_k.crm.database.entities.Company"]
19:34:08,138 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@197a37c [Attribute: name class value "tuc_d_k.crm.database.entities.Employee"]
19:34:08,142 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@17fa65e [Attribute: name class value "tuc_d_k.crm.database.entities.ForwardingAgency"]
19:34:08,143 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@2808b3 [Attribute: name class value "tuc_d_k.crm.database.entities.Person"]
19:34:08,143 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@922804 [Attribute: name class value "tuc_d_k.crm.database.entities.PrivateClient"]
19:34:08,144 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@b1c260 [Attribute: name class value "tuc_d_k.crm.database.entities.Task"]
19:34:08,146 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@100ab23 [Attribute: name class value "tuc_d_k.crm.database.entities.TaskInvitation"]
19:34:08,148 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@1dd46f7 [Attribute: name class value "tuc_d_k.crm.database.entities.User"]
19:34:08,148 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@df503 [Attribute: name class value "tuc_d_k.crm.database.entities.UserGroup"]
19:34:08,150 DEBUG [AnnotationConfiguration] null<-org.dom4j.tree.DefaultAttribute@d70d7a [Attribute: name class value "tuc_d_k.crm.database.entities.Vendor"]
19:34:08,151 INFO [Configuration] Configured SessionFactory: null
19:34:08,154 DEBUG [Configuration] properties: {show_sql=true, java.vendor=Sun Microsystems Inc., sun.java.launcher=SUN_STANDARD, hibernate.connection.url=jdbc:mysql://localhost/crm, sun.management.compiler=HotSpot Client Compiler, use_sql_comments=false, hbm2ddl.auto=update, os.name=Windows Vista, sun.boot.class.path=C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\resources.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\rt.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\sunrsasign.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\jsse.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\jce.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\charsets.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\classes, hibernate.current_session_context_class=thread, sun.desktop=windows, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.6.0_04-b12, hibernate.connection.autocommit=true, hibernate.cache.provider_class=org.hibernate.cache.NoCacheProvider, user.name=Matthias, connection.driver_class=com.mysql.jdbc.Driver, current_session_context_class=thread, idea.launcher.bin.path=C:\Program Files (x86)\JetBrains\IntelliJ IDEA 7.0.2\bin, user.language=de, sun.boot.library.path=C:\Program Files (x86)\Java\jdk1.6.0_04\jre\bin, dialect=org.hibernate.dialect.MySQL5InnoDBDialect, java.version=1.6.0_04, user.timezone=Europe/Berlin, jdbc.batch_size=10, sun.arch.data.model=32, java.endorsed.dirs=C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\endorsed, sun.cpu.isalist=, sun.jnu.encoding=Cp1252, file.encoding.pkg=sun.io, file.separator=\, java.specification.name=Java Platform API Specification, hibernate.format_sql=false, java.class.version=50.0, user.country=DE, connection.url=jdbc:mysql://localhost/crm, java.home=C:\Program Files (x86)\Java\jdk1.6.0_04\jre, java.vm.info=mixed mode, sharing, os.version=6.0, path.separator=;, connection.password=uniadmin, java.vm.version=10.0-b19, hibernate.connection.password=uniadmin, user.variant=, hibernate.jdbc.batch_size=10, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, hibernate.connection.username=root, hibernate.validator.autoregister_listeners=false, user.home=E:\Matthias Dateien, java.specification.vendor=Sun Microsystems Inc., hibernate.hbm2ddl.auto=update, java.library.path=C:\Program Files (x86)\Java\jdk1.6.0_04\bin;.;C:\Windows\Sun\Java\bin;C:\Windows\system32;C:\Windows;C:\Program Files (x86)\CodeGear\RAD Studio\5.0\bin;C:\Users\Public\Documents\RAD Studio\5.0\Bpl;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Program Files (x86)\Bitvise Tunnelier;C:\Program Files (x86)\MySQL\MySQL Server 5.0\bin;C:\Program Files (x86)\Smart Projects\IsoBuster, java.vendor.url=http://java.sun.com/, hibernate.connection.driver_class=com.mysql.jdbc.Driver, connection.username=root, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=org.hibernate.dialect.MySQL5InnoDBDialect, java.runtime.name=Java(TM) SE Runtime Environment, java.class.path=C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\charsets.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\deploy.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\javaws.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\jce.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\jsse.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\management-agent.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\plugin.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\resources.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\rt.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\ext\dnsns.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\ext\localedata.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\ext\sunjce_provider.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\ext\sunmscapi.jar;C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\ext\sunpkcs11.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\out\production\crm_database;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\hibernate3.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\dom4j.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\cglib.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\servlet-2_5-api.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\commons-lang-2.3.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\commons-collections.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\asm.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\log4j-1.2.11.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\commons-logging.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\antlr.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database\lib\jta.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_test\lib\mysql-connector-java-5.0.7-bin.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_test\lib\hibernate-annotations.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_test\lib\ejb3-persistence.jar;E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_test\lib\hibernate-commons-annotations.jar;E:\Matthias Dateien\Desktop\Java Bibliotheken\JDom\jdom-1.1\jdom-1.1\build\jdom.jar;C:\Program Files (x86)\JetBrains\IntelliJ IDEA 7.0.2\lib\idea_rt.jar, hibernate.bytecode.use_reflection_optimizer=false, idea.launcher.port=7537, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, sun.cpu.endian=little, sun.os.patch.level=Service Pack 1, connection.autocommit=true, connection.pool_size=1, java.io.tmpdir=C:\Users\Matthias\AppData\Local\Temp\, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=C:\Program Files (x86)\Java\jdk1.6.0_04\jre\lib\ext;C:\Windows\Sun\Java\lib\ext, hibernate.use_sql_comments=false, user.dir=E:\Matthias Dateien\Desktop\IDEA Projekte\SIGMA\crm_database, line.separator=
, java.vm.name=Java HotSpot(TM) Client VM, cache.provider_class=org.hibernate.cache.NoCacheProvider, file.encoding=windows-1252, format_sql=false, java.specification.version=1.6, hibernate.show_sql=true, hibernate.connection.pool_size=1}
19:34:08,158 DEBUG [AnnotationConfiguration] Validator not present in classpath, ignoring event listener registration
19:34:08,158 DEBUG [AnnotationConfiguration] Search not present in classpath, ignoring event listener registration
19:34:08,159 DEBUG [Configuration] Preparing to build session factory with filters : {}
19:34:08,159 DEBUG [AnnotationConfiguration] Execute first pass mapping processing
19:34:08,349 DEBUG [AnnotationConfiguration] Process hbm files
19:34:08,350 DEBUG [AnnotationConfiguration] Process annotated classes
19:34:08,359 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.Address
19:34:08,378 DEBUG [Ejb3Column] Binding column DTYPE unique false
19:34:08,399 DEBUG [EntityBinder] Import with entity name=Address
19:34:08,406 INFO [EntityBinder] Bind entity tuc_d_k.crm.database.entities.Address on table addresses
19:34:08,418 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.Address property annotation
19:34:08,765 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.id_address
19:34:08,769 DEBUG [Ejb3Column] Binding column id_address unique false
19:34:08,769 DEBUG [AnnotationBinder] id_address is an id
19:34:08,772 DEBUG [SimpleValueBinder] building SimpleValue for id_address
19:34:08,813 DEBUG [PropertyBinder] Building property id_address
19:34:08,817 DEBUG [PropertyBinder] Cascading id_address with null
19:34:08,817 DEBUG [AnnotationBinder] Bind @Id on id_address
19:34:08,818 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.belongsTo
19:34:08,822 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,822 DEBUG [Ejb3Column] Binding column belongsTo unique false
19:34:08,828 DEBUG [PropertyBinder] Building property belongsTo
19:34:08,828 DEBUG [PropertyBinder] Cascading belongsTo with none
19:34:08,828 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.country
19:34:08,828 DEBUG [Ejb3Column] Binding column country unique false
19:34:08,829 DEBUG [PropertyBinder] binding property country with lazy=false
19:34:08,832 DEBUG [SimpleValueBinder] building SimpleValue for country
19:34:08,833 DEBUG [PropertyBinder] Building property country
19:34:08,833 DEBUG [PropertyBinder] Cascading country with null
19:34:08,833 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.district
19:34:08,833 DEBUG [Ejb3Column] Binding column district unique false
19:34:08,833 DEBUG [PropertyBinder] binding property district with lazy=false
19:34:08,833 DEBUG [SimpleValueBinder] building SimpleValue for district
19:34:08,834 DEBUG [PropertyBinder] Building property district
19:34:08,834 DEBUG [PropertyBinder] Cascading district with null
19:34:08,834 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.number
19:34:08,834 DEBUG [Ejb3Column] Binding column number unique false
19:34:08,834 DEBUG [PropertyBinder] binding property number with lazy=false
19:34:08,834 DEBUG [SimpleValueBinder] building SimpleValue for number
19:34:08,834 DEBUG [PropertyBinder] Building property number
19:34:08,836 DEBUG [PropertyBinder] Cascading number with null
19:34:08,836 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.poBox
19:34:08,836 DEBUG [Ejb3Column] Binding column poBox unique false
19:34:08,836 DEBUG [PropertyBinder] binding property poBox with lazy=false
19:34:08,836 DEBUG [SimpleValueBinder] building SimpleValue for poBox
19:34:08,836 DEBUG [PropertyBinder] Building property poBox
19:34:08,836 DEBUG [PropertyBinder] Cascading poBox with null
19:34:08,837 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.recordManager
19:34:08,838 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,838 DEBUG [Ejb3Column] Binding column recordManager unique false
19:34:08,838 DEBUG [PropertyBinder] Building property recordManager
19:34:08,838 DEBUG [PropertyBinder] Cascading recordManager with none
19:34:08,838 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.state
19:34:08,838 DEBUG [Ejb3Column] Binding column state unique false
19:34:08,839 DEBUG [PropertyBinder] binding property state with lazy=false
19:34:08,840 DEBUG [SimpleValueBinder] building SimpleValue for state
19:34:08,840 DEBUG [PropertyBinder] Building property state
19:34:08,840 DEBUG [PropertyBinder] Cascading state with null
19:34:08,840 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.street
19:34:08,840 DEBUG [Ejb3Column] Binding column street unique false
19:34:08,840 DEBUG [PropertyBinder] binding property street with lazy=false
19:34:08,841 DEBUG [SimpleValueBinder] building SimpleValue for street
19:34:08,842 DEBUG [PropertyBinder] Building property street
19:34:08,842 DEBUG [PropertyBinder] Cascading street with null
19:34:08,842 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.town
19:34:08,842 DEBUG [Ejb3Column] Binding column town unique false
19:34:08,842 DEBUG [PropertyBinder] binding property town with lazy=false
19:34:08,842 DEBUG [SimpleValueBinder] building SimpleValue for town
19:34:08,842 DEBUG [PropertyBinder] Building property town
19:34:08,842 DEBUG [PropertyBinder] Cascading town with null
19:34:08,844 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.type
19:34:08,844 DEBUG [Ejb3Column] Binding column type unique false
19:34:08,844 DEBUG [PropertyBinder] binding property type with lazy=false
19:34:08,844 DEBUG [SimpleValueBinder] building SimpleValue for type
19:34:08,844 DEBUG [PropertyBinder] Building property type
19:34:08,844 DEBUG [PropertyBinder] Cascading type with null
19:34:08,844 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Address.zipCode
19:34:08,846 DEBUG [Ejb3Column] Binding column zipCode unique false
19:34:08,846 DEBUG [PropertyBinder] binding property zipCode with lazy=false
19:34:08,846 DEBUG [SimpleValueBinder] building SimpleValue for zipCode
19:34:08,846 DEBUG [PropertyBinder] Building property zipCode
19:34:08,846 DEBUG [PropertyBinder] Cascading zipCode with null
19:34:08,848 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.Attribute
19:34:08,849 DEBUG [Ejb3Column] Binding column DTYPE unique false
19:34:08,849 DEBUG [EntityBinder] Import with entity name=Attribute
19:34:08,849 INFO [EntityBinder] Bind entity tuc_d_k.crm.database.entities.Attribute on table attributes
19:34:08,849 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.Attribute property annotation
19:34:08,875 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.id_attribute
19:34:08,875 DEBUG [Ejb3Column] Binding column id_attribute unique false
19:34:08,875 DEBUG [AnnotationBinder] id_attribute is an id
19:34:08,875 DEBUG [SimpleValueBinder] building SimpleValue for id_attribute
19:34:08,875 DEBUG [PropertyBinder] Building property id_attribute
19:34:08,875 DEBUG [PropertyBinder] Cascading id_attribute with null
19:34:08,875 DEBUG [AnnotationBinder] Bind @Id on id_attribute
19:34:08,876 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.CTime
19:34:08,876 DEBUG [Ejb3Column] Binding column ctime unique false
19:34:08,876 DEBUG [PropertyBinder] binding property CTime with lazy=false
19:34:08,876 DEBUG [SimpleValueBinder] building SimpleValue for CTime
19:34:08,876 DEBUG [PropertyBinder] Building property CTime
19:34:08,876 DEBUG [PropertyBinder] Cascading CTime with null
19:34:08,876 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.creator
19:34:08,878 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,878 DEBUG [Ejb3Column] Binding column creator unique false
19:34:08,878 DEBUG [PropertyBinder] Building property creator
19:34:08,878 DEBUG [PropertyBinder] Cascading creator with none
19:34:08,878 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.description
19:34:08,878 DEBUG [Ejb3Column] Binding column description unique false
19:34:08,878 DEBUG [PropertyBinder] binding property description with lazy=false
19:34:08,881 DEBUG [SimpleValueBinder] building SimpleValue for description
19:34:08,881 DEBUG [PropertyBinder] Building property description
19:34:08,881 DEBUG [PropertyBinder] Cascading description with null
19:34:08,881 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.locked
19:34:08,881 DEBUG [Ejb3Column] Binding column locked unique false
19:34:08,881 DEBUG [PropertyBinder] binding property locked with lazy=false
19:34:08,881 DEBUG [SimpleValueBinder] building SimpleValue for locked
19:34:08,882 DEBUG [PropertyBinder] Building property locked
19:34:08,882 DEBUG [PropertyBinder] Cascading locked with null
19:34:08,882 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.objectID
19:34:08,882 DEBUG [Ejb3Column] Binding column objID unique false
19:34:08,882 DEBUG [PropertyBinder] binding property objectID with lazy=false
19:34:08,882 DEBUG [SimpleValueBinder] building SimpleValue for objectID
19:34:08,882 DEBUG [PropertyBinder] Building property objectID
19:34:08,884 DEBUG [PropertyBinder] Cascading objectID with null
19:34:08,884 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.objectType
19:34:08,885 DEBUG [Ejb3Column] Binding column objType unique false
19:34:08,885 DEBUG [PropertyBinder] binding property objectType with lazy=false
19:34:08,885 DEBUG [SimpleValueBinder] building SimpleValue for objectType
19:34:08,885 DEBUG [PropertyBinder] Building property objectType
19:34:08,885 DEBUG [PropertyBinder] Cascading objectType with null
19:34:08,886 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.published
19:34:08,886 DEBUG [Ejb3Column] Binding column published unique false
19:34:08,887 DEBUG [PropertyBinder] binding property published with lazy=false
19:34:08,887 DEBUG [SimpleValueBinder] building SimpleValue for published
19:34:08,887 DEBUG [PropertyBinder] Building property published
19:34:08,887 DEBUG [PropertyBinder] Cascading published with null
19:34:08,887 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Attribute.removed
19:34:08,888 DEBUG [Ejb3Column] Binding column removed unique false
19:34:08,888 DEBUG [PropertyBinder] binding property removed with lazy=false
19:34:08,888 DEBUG [SimpleValueBinder] building SimpleValue for removed
19:34:08,888 DEBUG [PropertyBinder] Building property removed
19:34:08,888 DEBUG [PropertyBinder] Cascading removed with null
19:34:08,888 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.Person
19:34:08,888 DEBUG [Ejb3Column] Binding column personType unique false
19:34:08,890 DEBUG [EntityBinder] Import with entity name=Person
19:34:08,890 INFO [EntityBinder] Bind entity tuc_d_k.crm.database.entities.Person on table persons
19:34:08,890 DEBUG [AnnotationBinder] Setting discriminator for entity tuc_d_k.crm.database.entities.Person
19:34:08,890 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.Person property annotation
19:34:08,908 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.id_person
19:34:08,909 DEBUG [Ejb3Column] Binding column id_person unique false
19:34:08,909 DEBUG [AnnotationBinder] id_person is an id
19:34:08,909 DEBUG [SimpleValueBinder] building SimpleValue for id_person
19:34:08,909 DEBUG [PropertyBinder] Building property id_person
19:34:08,909 DEBUG [PropertyBinder] Cascading id_person with null
19:34:08,909 DEBUG [AnnotationBinder] Bind @Id on id_person
19:34:08,909 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.cellPhoneNumber
19:34:08,911 DEBUG [Ejb3Column] Binding column cellPhoneNumber unique false
19:34:08,911 DEBUG [PropertyBinder] binding property cellPhoneNumber with lazy=false
19:34:08,911 DEBUG [SimpleValueBinder] building SimpleValue for cellPhoneNumber
19:34:08,911 DEBUG [PropertyBinder] Building property cellPhoneNumber
19:34:08,911 DEBUG [PropertyBinder] Cascading cellPhoneNumber with null
19:34:08,911 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.dateOfBirth
19:34:08,912 DEBUG [Ejb3Column] Binding column dateOfBirth unique false
19:34:08,913 DEBUG [PropertyBinder] binding property dateOfBirth with lazy=false
19:34:08,913 DEBUG [SimpleValueBinder] building SimpleValue for dateOfBirth
19:34:08,913 DEBUG [PropertyBinder] Building property dateOfBirth
19:34:08,913 DEBUG [PropertyBinder] Cascading dateOfBirth with null
19:34:08,913 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.dateOfEstimation
19:34:08,913 DEBUG [Ejb3Column] Binding column dateOfEstimation unique false
19:34:08,913 DEBUG [PropertyBinder] binding property dateOfEstimation with lazy=false
19:34:08,915 DEBUG [SimpleValueBinder] building SimpleValue for dateOfEstimation
19:34:08,915 DEBUG [PropertyBinder] Building property dateOfEstimation
19:34:08,915 DEBUG [PropertyBinder] Cascading dateOfEstimation with null
19:34:08,915 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.defaultAddress
19:34:08,915 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,915 DEBUG [Ejb3Column] Binding column defaultAddress unique false
19:34:08,915 DEBUG [PropertyBinder] Building property defaultAddress
19:34:08,917 DEBUG [PropertyBinder] Cascading defaultAddress with none
19:34:08,917 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.emailAddress
19:34:08,917 DEBUG [Ejb3Column] Binding column emailAddress unique false
19:34:08,917 DEBUG [PropertyBinder] binding property emailAddress with lazy=false
19:34:08,917 DEBUG [SimpleValueBinder] building SimpleValue for emailAddress
19:34:08,917 DEBUG [PropertyBinder] Building property emailAddress
19:34:08,917 DEBUG [PropertyBinder] Cascading emailAddress with null
19:34:08,919 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.faxNumber
19:34:08,919 DEBUG [Ejb3Column] Binding column faxNumber unique false
19:34:08,919 DEBUG [PropertyBinder] binding property faxNumber with lazy=false
19:34:08,919 DEBUG [SimpleValueBinder] building SimpleValue for faxNumber
19:34:08,920 DEBUG [PropertyBinder] Building property faxNumber
19:34:08,920 DEBUG [PropertyBinder] Cascading faxNumber with null
19:34:08,920 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.lastResults
19:34:08,921 DEBUG [Ejb3Column] Binding column lastResult unique false
19:34:08,922 DEBUG [PropertyBinder] binding property lastResults with lazy=false
19:34:08,922 DEBUG [SimpleValueBinder] building SimpleValue for lastResults
19:34:08,922 DEBUG [PropertyBinder] Building property lastResults
19:34:08,922 DEBUG [PropertyBinder] Cascading lastResults with null
19:34:08,922 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.leadStatus
19:34:08,922 DEBUG [Ejb3Column] Binding column leadStatus unique false
19:34:08,923 DEBUG [PropertyBinder] binding property leadStatus with lazy=false
19:34:08,923 DEBUG [SimpleValueBinder] building SimpleValue for leadStatus
19:34:08,923 DEBUG [PropertyBinder] Building property leadStatus
19:34:08,923 DEBUG [PropertyBinder] Cascading leadStatus with null
19:34:08,923 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.mailTitle
19:34:08,923 DEBUG [Ejb3Column] Binding column mailTitle unique false
19:34:08,923 DEBUG [PropertyBinder] binding property mailTitle with lazy=false
19:34:08,925 DEBUG [SimpleValueBinder] building SimpleValue for mailTitle
19:34:08,925 DEBUG [PropertyBinder] Building property mailTitle
19:34:08,925 DEBUG [PropertyBinder] Cascading mailTitle with null
19:34:08,925 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.memberOf
19:34:08,925 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,925 DEBUG [Ejb3Column] Binding column memberOf unique false
19:34:08,926 DEBUG [PropertyBinder] Building property memberOf
19:34:08,927 DEBUG [PropertyBinder] Cascading memberOf with none
19:34:08,927 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.members
19:34:08,927 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,927 DEBUG [Ejb3Column] Binding column members unique false
19:34:08,929 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,948 DEBUG [Ejb3Column] Binding column element unique false
19:34:08,949 DEBUG [Ejb3Column] Binding column mapkey unique false
19:34:08,950 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,950 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,950 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,952 DEBUG [CollectionBinder] Collection role: tuc_d_k.crm.database.entities.Person.members
19:34:08,955 DEBUG [PropertyBinder] Building property members
19:34:08,955 DEBUG [PropertyBinder] Cascading members with none
19:34:08,955 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.phoneNumber
19:34:08,955 DEBUG [Ejb3Column] Binding column phoneNumber unique false
19:34:08,955 DEBUG [PropertyBinder] binding property phoneNumber with lazy=false
19:34:08,955 DEBUG [SimpleValueBinder] building SimpleValue for phoneNumber
19:34:08,955 DEBUG [PropertyBinder] Building property phoneNumber
19:34:08,956 DEBUG [PropertyBinder] Cascading phoneNumber with null
19:34:08,957 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.recordManager
19:34:08,957 DEBUG [Ejb3Column] Binding column null unique false
19:34:08,957 DEBUG [Ejb3Column] Binding column recordManager unique false
19:34:08,957 DEBUG [PropertyBinder] Building property recordManager
19:34:08,957 DEBUG [PropertyBinder] Cascading recordManager with none
19:34:08,957 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.sortName
19:34:08,958 DEBUG [Ejb3Column] Binding column sortName unique false
19:34:08,958 DEBUG [PropertyBinder] binding property sortName with lazy=false
19:34:08,958 DEBUG [SimpleValueBinder] building SimpleValue for sortName
19:34:08,958 DEBUG [PropertyBinder] Building property sortName
19:34:08,958 DEBUG [PropertyBinder] Cascading sortName with null
19:34:08,958 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.surName
19:34:08,958 DEBUG [Ejb3Column] Binding column surName unique false
19:34:08,960 DEBUG [PropertyBinder] binding property surName with lazy=false
19:34:08,960 DEBUG [SimpleValueBinder] building SimpleValue for surName
19:34:08,960 DEBUG [PropertyBinder] Building property surName
19:34:08,960 DEBUG [PropertyBinder] Cascading surName with null
19:34:08,960 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Person.type
19:34:08,960 DEBUG [Ejb3Column] Binding column personType unique false
19:34:08,960 DEBUG [PropertyBinder] binding property type with lazy=false
19:34:08,965 DEBUG [SimpleValueBinder] building SimpleValue for type
19:34:08,965 DEBUG [PropertyBinder] Building property type
19:34:08,965 DEBUG [PropertyBinder] Cascading type with null
19:34:08,966 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.LegalPerson
19:34:08,967 DEBUG [EntityBinder] Import with entity name=LegalPerson
19:34:08,982 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.LegalPerson property annotation
19:34:08,990 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.abcPotential
19:34:08,990 DEBUG [Ejb3Column] Binding column abcPotential unique false
19:34:08,990 DEBUG [PropertyBinder] binding property abcPotential with lazy=false
19:34:08,990 DEBUG [SimpleValueBinder] building SimpleValue for abcPotential
19:34:08,990 DEBUG [PropertyBinder] Building property abcPotential
19:34:08,990 DEBUG [PropertyBinder] Cascading abcPotential with null
19:34:08,990 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.accumulatedCapital
19:34:08,991 DEBUG [Ejb3Column] Binding column accumulatedCapital unique false
19:34:08,991 DEBUG [PropertyBinder] binding property accumulatedCapital with lazy=false
19:34:08,991 DEBUG [SimpleValueBinder] building SimpleValue for accumulatedCapital
19:34:08,991 DEBUG [PropertyBinder] Building property accumulatedCapital
19:34:08,991 DEBUG [PropertyBinder] Cascading accumulatedCapital with null
19:34:08,991 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.annualRevenue
19:34:08,993 DEBUG [Ejb3Column] Binding column annualRevenue unique false
19:34:08,993 DEBUG [PropertyBinder] binding property annualRevenue with lazy=false
19:34:08,993 DEBUG [SimpleValueBinder] building SimpleValue for annualRevenue
19:34:08,993 DEBUG [PropertyBinder] Building property annualRevenue
19:34:08,993 DEBUG [PropertyBinder] Cascading annualRevenue with null
19:34:08,993 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.annualTurnover
19:34:08,993 DEBUG [Ejb3Column] Binding column annualTurnover unique false
19:34:08,995 DEBUG [PropertyBinder] binding property annualTurnover with lazy=false
19:34:08,995 DEBUG [SimpleValueBinder] building SimpleValue for annualTurnover
19:34:08,995 DEBUG [PropertyBinder] Building property annualTurnover
19:34:08,995 DEBUG [PropertyBinder] Cascading annualTurnover with null
19:34:08,995 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.businessFields
19:34:08,995 DEBUG [Ejb3Column] Binding column businessFields unique false
19:34:08,996 DEBUG [PropertyBinder] binding property businessFields with lazy=false
19:34:08,997 DEBUG [SimpleValueBinder] building SimpleValue for businessFields
19:34:08,997 DEBUG [PropertyBinder] Building property businessFields
19:34:08,997 DEBUG [PropertyBinder] Cascading businessFields with null
19:34:08,997 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.countryOfHQ
19:34:08,997 DEBUG [Ejb3Column] Binding column countryOfHQ unique false
19:34:08,997 DEBUG [PropertyBinder] binding property countryOfHQ with lazy=false
19:34:08,997 DEBUG [SimpleValueBinder] building SimpleValue for countryOfHQ
19:34:08,999 DEBUG [PropertyBinder] Building property countryOfHQ
19:34:08,999 DEBUG [PropertyBinder] Cascading countryOfHQ with null
19:34:08,999 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.dateOf1stBusiness
19:34:08,999 DEBUG [Ejb3Column] Binding column dateOf1stBusiness unique false
19:34:08,999 DEBUG [PropertyBinder] binding property dateOf1stBusiness with lazy=false
19:34:08,999 DEBUG [SimpleValueBinder] building SimpleValue for dateOf1stBusiness
19:34:08,999 DEBUG [PropertyBinder] Building property dateOf1stBusiness
19:34:09,001 DEBUG [PropertyBinder] Cascading dateOf1stBusiness with null
19:34:09,001 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.economicSectors
19:34:09,001 DEBUG [Ejb3Column] Binding column economicSectors unique false
19:34:09,001 DEBUG [PropertyBinder] binding property economicSectors with lazy=false
19:34:09,001 DEBUG [SimpleValueBinder] building SimpleValue for economicSectors
19:34:09,001 DEBUG [PropertyBinder] Building property economicSectors
19:34:09,003 DEBUG [PropertyBinder] Cascading economicSectors with null
19:34:09,003 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.newsletter
19:34:09,003 DEBUG [Ejb3Column] Binding column newsletter unique false
19:34:09,003 DEBUG [PropertyBinder] binding property newsletter with lazy=false
19:34:09,003 DEBUG [SimpleValueBinder] building SimpleValue for newsletter
19:34:09,003 DEBUG [PropertyBinder] Building property newsletter
19:34:09,003 DEBUG [PropertyBinder] Cascading newsletter with null
19:34:09,005 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.ourTerms
19:34:09,005 DEBUG [Ejb3Column] Binding column ourTerms unique false
19:34:09,005 DEBUG [PropertyBinder] binding property ourTerms with lazy=false
19:34:09,005 DEBUG [SimpleValueBinder] building SimpleValue for ourTerms
19:34:09,005 DEBUG [PropertyBinder] Building property ourTerms
19:34:09,005 DEBUG [PropertyBinder] Cascading ourTerms with null
19:34:09,005 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.sumOfBalances
19:34:09,007 DEBUG [Ejb3Column] Binding column sumOfBalances unique false
19:34:09,007 DEBUG [PropertyBinder] binding property sumOfBalances with lazy=false
19:34:09,007 DEBUG [SimpleValueBinder] building SimpleValue for sumOfBalances
19:34:09,007 DEBUG [PropertyBinder] Building property sumOfBalances
19:34:09,007 DEBUG [PropertyBinder] Cascading sumOfBalances with null
19:34:09,007 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.thereTerms
19:34:09,007 DEBUG [Ejb3Column] Binding column thereTerms unique false
19:34:09,009 DEBUG [PropertyBinder] binding property thereTerms with lazy=false
19:34:09,009 DEBUG [SimpleValueBinder] building SimpleValue for thereTerms
19:34:09,009 DEBUG [PropertyBinder] Building property thereTerms
19:34:09,009 DEBUG [PropertyBinder] Cascading thereTerms with null
19:34:09,009 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.LegalPerson.websiteURL
19:34:09,009 DEBUG [Ejb3Column] Binding column websiteURL unique false
19:34:09,009 DEBUG [PropertyBinder] binding property websiteURL with lazy=false
19:34:09,011 DEBUG [SimpleValueBinder] building SimpleValue for websiteURL
19:34:09,011 DEBUG [PropertyBinder] Building property websiteURL
19:34:09,012 DEBUG [PropertyBinder] Cascading websiteURL with null
19:34:09,012 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.Company
19:34:09,012 DEBUG [EntityBinder] Import with entity name=Company
19:34:09,012 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.Company property annotation
19:34:09,021 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Company.VATNumber
19:34:09,021 DEBUG [Ejb3Column] Binding column VATNumber unique false
19:34:09,021 DEBUG [PropertyBinder] binding property VATNumber with lazy=false
19:34:09,021 DEBUG [SimpleValueBinder] building SimpleValue for VATNumber
19:34:09,021 DEBUG [PropertyBinder] Building property VATNumber
19:34:09,021 DEBUG [PropertyBinder] Cascading VATNumber with null
19:34:09,021 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Company.businessConditions
19:34:09,023 DEBUG [Ejb3Column] Binding column businessConditions unique false
19:34:09,023 DEBUG [PropertyBinder] binding property businessConditions with lazy=false
19:34:09,023 DEBUG [SimpleValueBinder] building SimpleValue for businessConditions
19:34:09,023 DEBUG [PropertyBinder] Building property businessConditions
19:34:09,023 DEBUG [PropertyBinder] Cascading businessConditions with null
19:34:09,023 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Company.courtOfRegistry
19:34:09,024 DEBUG [Ejb3Column] Binding column courtOfRegistry unique false
19:34:09,024 DEBUG [PropertyBinder] binding property courtOfRegistry with lazy=false
19:34:09,024 DEBUG [SimpleValueBinder] building SimpleValue for courtOfRegistry
19:34:09,024 DEBUG [PropertyBinder] Building property courtOfRegistry
19:34:09,024 DEBUG [PropertyBinder] Cascading courtOfRegistry with null
19:34:09,024 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Company.hoppenstedtID
19:34:09,024 DEBUG [Ejb3Column] Binding column hoppenstedtID unique false
19:34:09,027 DEBUG [PropertyBinder] binding property hoppenstedtID with lazy=false
19:34:09,027 DEBUG [SimpleValueBinder] building SimpleValue for hoppenstedtID
19:34:09,027 DEBUG [PropertyBinder] Building property hoppenstedtID
19:34:09,027 DEBUG [PropertyBinder] Cascading hoppenstedtID with null
19:34:09,027 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Company.numEmployees
19:34:09,027 DEBUG [Ejb3Column] Binding column numEmployees unique false
19:34:09,027 DEBUG [PropertyBinder] binding property numEmployees with lazy=false
19:34:09,028 DEBUG [SimpleValueBinder] building SimpleValue for numEmployees
19:34:09,028 DEBUG [PropertyBinder] Building property numEmployees
19:34:09,028 DEBUG [PropertyBinder] Cascading numEmployees with null
19:34:09,028 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Company.taxNumber
19:34:09,028 DEBUG [Ejb3Column] Binding column taxNumber unique false
19:34:09,028 DEBUG [PropertyBinder] binding property taxNumber with lazy=false
19:34:09,028 DEBUG [SimpleValueBinder] building SimpleValue for taxNumber
19:34:09,030 DEBUG [PropertyBinder] Building property taxNumber
19:34:09,030 DEBUG [PropertyBinder] Cascading taxNumber with null
19:34:09,030 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Company.tradeRegisterID
19:34:09,030 DEBUG [Ejb3Column] Binding column tradeRegisterID unique false
19:34:09,030 DEBUG [PropertyBinder] binding property tradeRegisterID with lazy=false
19:34:09,030 DEBUG [SimpleValueBinder] building SimpleValue for tradeRegisterID
19:34:09,030 DEBUG [PropertyBinder] Building property tradeRegisterID
19:34:09,032 DEBUG [PropertyBinder] Cascading tradeRegisterID with null
19:34:09,032 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.Authority
19:34:09,032 DEBUG [EntityBinder] Import with entity name=Authority
19:34:09,033 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.Authority property annotation
19:34:09,035 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Authority.level
19:34:09,035 DEBUG [Ejb3Column] Binding column level unique false
19:34:09,035 DEBUG [PropertyBinder] binding property level with lazy=false
19:34:09,036 DEBUG [SimpleValueBinder] building SimpleValue for level
19:34:09,036 DEBUG [PropertyBinder] Building property level
19:34:09,036 DEBUG [PropertyBinder] Cascading level with null
19:34:09,036 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.Change
19:34:09,036 DEBUG [Ejb3Column] Binding column DTYPE unique false
19:34:09,036 DEBUG [EntityBinder] Import with entity name=Change
19:34:09,037 INFO [EntityBinder] Bind entity tuc_d_k.crm.database.entities.Change on table changes
19:34:09,038 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.Change property annotation
19:34:09,047 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.id_change
19:34:09,048 DEBUG [Ejb3Column] Binding column id_change unique false
19:34:09,048 DEBUG [AnnotationBinder] id_change is an id
19:34:09,048 DEBUG [SimpleValueBinder] building SimpleValue for id_change
19:34:09,048 DEBUG [PropertyBinder] Building property id_change
19:34:09,048 DEBUG [PropertyBinder] Cascading id_change with null
19:34:09,048 DEBUG [AnnotationBinder] Bind @Id on id_change
19:34:09,048 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.newValue
19:34:09,048 DEBUG [Ejb3Column] Binding column newValue unique false
19:34:09,050 DEBUG [PropertyBinder] binding property newValue with lazy=false
19:34:09,050 DEBUG [SimpleValueBinder] building SimpleValue for newValue
19:34:09,050 DEBUG [PropertyBinder] Building property newValue
19:34:09,050 DEBUG [PropertyBinder] Cascading newValue with null
19:34:09,050 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.objectAttribute
19:34:09,050 DEBUG [Ejb3Column] Binding column objectAttribute unique false
19:34:09,050 DEBUG [PropertyBinder] binding property objectAttribute with lazy=false
19:34:09,052 DEBUG [SimpleValueBinder] building SimpleValue for objectAttribute
19:34:09,052 DEBUG [PropertyBinder] Building property objectAttribute
19:34:09,052 DEBUG [PropertyBinder] Cascading objectAttribute with null
19:34:09,052 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.objectID
19:34:09,052 DEBUG [Ejb3Column] Binding column objectID unique false
19:34:09,052 DEBUG [PropertyBinder] binding property objectID with lazy=false
19:34:09,053 DEBUG [SimpleValueBinder] building SimpleValue for objectID
19:34:09,054 DEBUG [PropertyBinder] Building property objectID
19:34:09,054 DEBUG [PropertyBinder] Cascading objectID with null
19:34:09,054 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.objectType
19:34:09,054 DEBUG [Ejb3Column] Binding column objectType unique false
19:34:09,054 DEBUG [PropertyBinder] binding property objectType with lazy=false
19:34:09,054 DEBUG [SimpleValueBinder] building SimpleValue for objectType
19:34:09,054 DEBUG [PropertyBinder] Building property objectType
19:34:09,056 DEBUG [PropertyBinder] Cascading objectType with null
19:34:09,056 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.oldValue
19:34:09,056 DEBUG [Ejb3Column] Binding column oldValue unique false
19:34:09,056 DEBUG [PropertyBinder] binding property oldValue with lazy=false
19:34:09,056 DEBUG [SimpleValueBinder] building SimpleValue for oldValue
19:34:09,056 DEBUG [PropertyBinder] Building property oldValue
19:34:09,056 DEBUG [PropertyBinder] Cascading oldValue with null
19:34:09,058 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.when
19:34:09,058 DEBUG [Ejb3Column] Binding column wtime unique false
19:34:09,058 DEBUG [PropertyBinder] binding property when with lazy=false
19:34:09,058 DEBUG [SimpleValueBinder] building SimpleValue for when
19:34:09,058 DEBUG [PropertyBinder] Building property when
19:34:09,058 DEBUG [PropertyBinder] Cascading when with null
19:34:09,058 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.Change.who
19:34:09,060 DEBUG [Ejb3Column] Binding column null unique false
19:34:09,060 DEBUG [Ejb3Column] Binding column who unique false
19:34:09,061 DEBUG [PropertyBinder] Building property who
19:34:09,061 DEBUG [PropertyBinder] Cascading who with none
19:34:09,061 INFO [AnnotationBinder] Binding entity from annotated class: tuc_d_k.crm.database.entities.NaturalPerson
19:34:09,061 DEBUG [EntityBinder] Import with entity name=NaturalPerson
19:34:09,061 DEBUG [AnnotationBinder] Processing tuc_d_k.crm.database.entities.NaturalPerson property annotation
19:34:09,064 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.NaturalPerson.academicTitle
19:34:09,064 DEBUG [Ejb3Column] Binding column academicTitle unique false
19:34:09,064 DEBUG [PropertyBinder] binding property academicTitle with lazy=false
19:34:09,064 DEBUG [SimpleValueBinder] building SimpleValue for academicTitle
19:34:09,064 DEBUG [PropertyBinder] Building property academicTitle
19:34:09,064 DEBUG [PropertyBinder] Cascading academicTitle with null
19:34:09,064 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.NaturalPerson.additionalNames
19:34:09,065 DEBUG [Ejb3Column] Binding column additionalNames unique false
19:34:09,065 DEBUG [PropertyBinder] binding property additionalNames with lazy=false
19:34:09,065 DEBUG [SimpleValueBinder] building SimpleValue for additionalNames
19:34:09,065 DEBUG [PropertyBinder] Building property additionalNames
19:34:09,065 DEBUG [PropertyBinder] Cascading additionalNames with null
19:34:09,065 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.NaturalPerson.firstName
19:34:09,065 DEBUG [Ejb3Column] Binding column firstName unique false
19:34:09,067 DEBUG [PropertyBinder] binding property firstName with lazy=false
19:34:09,067 DEBUG [SimpleValueBinder] building SimpleValue for firstName
19:34:09,067 DEBUG [PropertyBinder] Building property firstName
19:34:09,067 DEBUG [PropertyBinder] Cascading firstName with null
19:34:09,067 DEBUG [AnnotationBinder] Processing annotations of tuc_d_k.crm.database.entities.NaturalPerson.gender
19:34:09,067 DEBUG [Ejb3Column] Binding column gender unique false
19:34:09,067 DEBUG [PropertyBinder] binding property gender with lazy=false
19:34:09,079 DEBUG [SimpleValueBinder] building SimpleValue for gender
19:34:09,079 DEBUG [PropertyBinder] Building property gender
19:34:09,080 DEBUG [PropertyBinder] Cascading gender with null
19:34:09,080 INFO [AnnotationBinder] Binding entity from annotated class: tuc_