Hibernate Community • View topic - Referential integrity problem if no flush in between: why?

View unanswered posts | View active topics

Board index » Hibernate & Java Persistence » Hibernate Users

All times are UTC - 5 hours [ DST ]

Referential integrity problem if no flush in between: why?

Page 1 of 1

[ 5 posts ]

Previous topic | Next topic

Author

Message

immanuel

Post subject: Referential integrity problem if no flush in between: why?

Posted: Fri May 07, 2004 9:38 am

Regular

Joined: Tue Jan 13, 2004 4:57 am
Posts: 83

I have a problem which I don't exactly understand. Brief: I have a "relationship" component (managing a m-t-m relationship with attributes) from A to B that gets removed from a set (property of A), and the attached entity (B) is deleted after that.

Shortly after, I add another relationship with a new entity attached (C). If I don't put a sesson.flush between the two operations, I get an integrity error as if the first relationship were not actually deleted (although looking at the log seems to indicate it is). If I put a session.flush in between, everything works. Is this reasonable? Am I forgetting something obvious?

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

More details follow:

1) code is the following (DataAccessUtils is simply a collection of static wrappers over Session methods which factor out the session finding via Spring's threadlocal and the catch/rethrow of HibernateExceptions).

Code:

    
    public void updateCustomer( Customer customer, Map relatives ) {
        // load the customer, and delete its relatives
        List foundRelatives = getPersonRelatives( customer.getPartyId() );
        DataAccessUtils.lock( customer, sessionFactory );
        for ( int i = 0 ; i < foundRelatives.size() ; i++ ) {
            Person relative = ( Person )foundRelatives.get( i );
            unrelate( customer.getPartyId(), relative.getPartyId() );
            DataAccessUtils.delete( relative, sessionFactory );
        }
        DataAccessUtils.flush( sessionFactory ); // absolutely not sure why, but without this it doesn't work
        PartyUtils.setPersonRelatives( customer, relatives );
        saveRelatives( relatives );
    }

    private boolean unrelate( Integer partyIdRelatedFrom, Integer partyIdRelatedTo ) {
        Session session = SessionFactoryUtils.getSession( sessionFactory, false );
        try {
            Party partyRelatedFrom = ( Party )session.load( Party.class, partyIdRelatedFrom );
            Set relatedPartiesFrom = partyRelatedFrom.getRelatedPartiesFrom();
            for ( Iterator iterator = relatedPartiesFrom.iterator() ; iterator.hasNext() ; ) {
                PartyRelationship partyRelationship = ( PartyRelationship )iterator.next();
                Party relatedParty = partyRelationship.getRelatedParty();
                if ( relatedParty != null && relatedParty.getPartyId().equals( partyIdRelatedTo ) ) {
                    iterator.remove();
                    return true;
                }
            }
            return false;
        }
        catch ( HibernateException e ) {
            throw SessionFactoryUtils.convertHibernateAccessException( e );
        }
    }

    public List getPersonRelatives( Integer partyId ) {
        List personRelatives = getPersonRelationshipsByType( partyId, RelativeType.class.getName() );
        return personRelatives;
    }

    public List getPersonRelationshipsByType( Integer partyId, String className ) {
        List personRelatives = DataAccessUtils.find( "select relationship.relatedParty from Person p " +
                                                     "join p.relatedPartiesFrom relationship " +
                                                     "where p.id=? " +
                                                     "and relationship.relationshipType.class=" +
                                                     className,
                                                     partyId, Hibernate.INTEGER, sessionFactory );
        return personRelatives;
    }

2) Mappings for party and partyrelationships are:

Code:

<hibernate-mapping>
    <class name="it.esselunga.ecommerce.data.model.Party" table="PARTY" lazy="true" >
        <id name="partyId" type="int" column="PARTY_ID">
            <generator class="sequence">
                <param name="sequence">PARTY_SEQ</param>
            </generator>
        </id>

        <!-- bi-directional many-to-many association to Party through composite element containing attributes-->
        <set name="relatedPartiesFrom" lazy="true" table="PARTY_RELATIONSHIP">
            <key column="PARTY_ID_TO"/>
            <composite-element class="it.esselunga.ecommerce.data.model.PartyRelationship">
                <property name="fromDate" column="FROM_DATE" type="java.sql.Timestamp" />
                <property name="throughDate" column="THRU_DATE" type="java.sql.Timestamp" />
                <property name="description" column="DESCRIPTION" type="java.lang.String" length="100" />
                <many-to-one name="relationshipType" class="it.esselunga.ecommerce.data.model.PartyRelationshipType">
                    <column name="RELATIONSHIP_TYPE_ID"/>
                </many-to-one>
                <many-to-one name="relatedParty" class="it.esselunga.ecommerce.data.model.Party" column="PARTY_ID_FROM"/>
            </composite-element>
        </set>

        <!-- bi-directional many-to-many association to Party -->
        <set name="relatedPartiesTo" lazy="true" inverse="true" table="PARTY_RELATIONSHIP">
            <key column="PARTY_ID_FROM"/>
            <composite-element class="it.esselunga.ecommerce.data.model.PartyRelationship">
                <property name="fromDate" column="FROM_DATE" type="java.sql.Timestamp" />
                <property name="throughDate" column="THRU_DATE" type="java.sql.Timestamp" />
                <property name="description" column="DESCRIPTION" type="java.lang.String" length="100" />
                <many-to-one name="relationshipType" class="it.esselunga.ecommerce.data.model.PartyRelationshipType">
                    <column name="RELATIONSHIP_TYPE_ID"/>
                </many-to-one>
                <many-to-one name="relatedParty" class="it.esselunga.ecommerce.data.model.Party" column="PARTY_ID_TO"/>
            </composite-element>
        </set>

        <!-- Person is a Party subclass -->
        <joined-subclass name="it.esselunga.ecommerce.data.model.Person" table="PERSON" lazy="true">
           etc...
        </joined-subclass>
    </class>
</hibernate-mapping>

3) Detailed log WITHOUT session.flush

[code]15:28:34,990 DEBUG [TransactionInterceptor] Getting transaction for method 'updateCustomer' in class [it.esselunga.ecommerce.services.party.PartyService]
15:28:34,990 DEBUG [HibernateTransactionManager] Using transaction object [org.springframework.orm.hibernate.HibernateTransactionObject@1ceebfa]
15:28:34,990 DEBUG [HibernateTransactionManager] Creating new transaction
15:28:34,990 DEBUG [SessionFactoryUtils] Opening Hibernate session
15:28:34,990 DEBUG [SessionImpl] opened session
15:28:34,990 DEBUG [HibernateTransactionManager] Opened new session [net.sf.hibernate.impl.SessionImpl@1e6743e] for Hibernate transaction
15:28:34,990 DEBUG [HibernateTransactionManager] Beginning Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1e6743e]
15:28:34,990 DEBUG [JDBCTransaction] begin
15:28:35,010 DEBUG [JDBCTransaction] current autocommit status:true
15:28:35,010 DEBUG [JDBCTransaction] disabling autocommit
15:28:35,020 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] to thread [main]

15:28:35,020 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.jdbc.datasource.ConnectionHolder@1da366c] for key [org.apache.commons.dbcp.BasicDataSource@1a01f91] to thread [main]
15:28:35,020 DEBUG [TransactionSynchronizationManager] Initializing transaction synchronization
15:28:35,020 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:28:35,020 DEBUG [HibernateInterceptor] Found thread-bound session for Hibernate interceptor
15:28:35,050 INFO [SpringHibernatePartyService] updating customer it.esselunga.ecommerce.data.model.Customer@260d8d[partyId=58175] with relatives map {it.esselunga.ecommerce.data.model.Person@7b4ed7[partyId=<null>]=2201}
15:28:35,050 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:28:35,050 DEBUG [SessionImpl] find: select relationship.relatedParty from Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:28:35,050 DEBUG [QueryParameters] parameters: [58175]
15:28:35,050 DEBUG [QueryTranslator] compiling query
15:28:35,060 DEBUG [SessionImpl] flushing session

15:28:35,060 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:28:35,060 DEBUG [SessionImpl] Processing unreferenced collections
15:28:35,060 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:28:35,060 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
15:28:35,060 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
15:28:35,070 DEBUG [SessionImpl] Dont need to execute flush
15:28:35,070 DEBUG [QueryTranslator] HQL: select relationship.relatedParty from it.esselunga.ecommerce.data.model.Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:28:35,070 DEBUG [QueryTranslator] SQL: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:28:35,070 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,080 DEBUG [SQL] select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
Hibernate: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:28:35,090 DEBUG [BatcherImpl] preparing statement
15:28:35,090 DEBUG [IntegerType] binding '58175' to parameter: 1
15:28:35,120 DEBUG [Loader] processing result set

15:28:35,120 DEBUG [Loader] done processing result set (0 rows)
15:28:35,120 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,120 DEBUG [BatcherImpl] closing statement
15:28:35,130 DEBUG [Loader] total objects hydrated: 0
15:28:35,130 DEBUG [SessionImpl] initializing non-lazy collections
15:28:35,130 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:28:35,130 DEBUG [Cascades] id unsaved-value strategy NULL
15:28:35,130 DEBUG [SessionImpl] reassociating transient instance: [it.esselunga.ecommerce.data.model.Customer#58175]
15:28:35,130 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:28:35,130 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:28:35,130 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:28:35,130 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:28:35,130 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:28:35,130 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:28:35,141 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175]
15:28:35,141 DEBUG [SessionImpl] checking second-level cache
15:28:35,141 DEBUG [SessionImpl] collection not cached
15:28:35,141 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,141 DEBUG [SQL] select relatedpar0_.FROM_DATE as FROM_DATE__, relatedpar0_.THRU_DATE as THRU_DATE__, relatedpar0_.DESCRIPTION as DESCRIPT4___, relatedpar0_.RELATIONSHIP_TYPE_ID as RELATION5___, relatedpar0_.PARTY_ID_FROM as PARTY_ID6___, relatedpar0_.PARTY_ID_TO as PARTY_ID1___, partyrelat1_.ENUM_ID as ENUM_ID0_, partyrelat1_.ENUM_TYPE as ENUM_TYPE0_, partyrelat1_.ENUM_CODE as ENUM_CODE0_, partyrelat1_.SEQUENCE as SEQUENCE0_, partyrelat1_.DESCRIPTION as DESCRIPT5_0_ from PARTY_RELATIONSHIP relatedpar0_, ENUMERATION partyrelat1_ where relatedpar0_.PARTY_ID_TO=? and relatedpar0_.RELATIONSHIP_TYPE_ID=partyrelat1_.ENUM_ID(+)
Hibernate: select relatedpar0_.FROM_DATE as FROM_DATE__, relatedpar0_.THRU_DATE as THRU_DATE__, relatedpar0_.DESCRIPTION as DESCRIPT4___, relatedpar0_.RELATIONSHIP_TYPE_ID as RELATION5___, relatedpar0_.PARTY_ID_FROM as PARTY_ID6___, relatedpar0_.PARTY_ID_TO as PARTY_ID1___, partyrelat1_.ENUM_ID as ENUM_ID0_, partyrelat1_.ENUM_TYPE as ENUM_TYPE0_, partyrelat1_.ENUM_CODE as ENUM_CODE0_, partyrelat1_.SEQUENCE as SEQUENCE0_, partyrelat1_.DESCRIPTION as DESCRIPT5_0_ from PARTY_RELATIONSHIP relatedpar0_, ENUMERATION partyrelat1_ where relatedpar0_.PARTY_ID_TO=? and relatedpar0_.RELATIONSHIP_TYPE_ID=partyrelat1_.ENUM_ID(+)
15:28:35,151 DEBUG [BatcherImpl] preparing statement
15:28:35,151 DEBUG [IntegerType] binding '58175' to parameter: 1
15:28:35,151 DEBUG [IntegerType] binding '58175' to parameter: 1
15:28:35,171 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175]
15:28:35,181 DEBUG [SessionImpl] uninitialized collection: initializing
15:28:35,181 DEBUG [Loader] processing result set

15:28:35,181 DEBUG [Loader] done processing result set (0 rows)
15:28:35,181 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,181 DEBUG [BatcherImpl] closing statement
15:28:35,191 DEBUG [Loader] total objects hydrated: 0
15:28:35,191 DEBUG [SessionImpl] 1 collections were found in result set
15:28:35,191 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175]
15:28:35,191 DEBUG [SessionImpl] 1 collections initialized
15:28:35,191 DEBUG [SessionImpl] initializing non-lazy collections
15:28:35,191 DEBUG [SessionImpl] collection initialized
15:28:35,191 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:28:35,191 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,191 DEBUG [SQL] select PARTY_SEQ.nextval from dual
Hibernate: select PARTY_SEQ.nextval from dual
15:28:35,191 DEBUG [BatcherImpl] preparing statement
15:28:35,231 DEBUG [SequenceGenerator] Sequence identifier generated: 58177
15:28:35,231 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,231 DEBUG [BatcherImpl] closing statement
15:28:35,231 DEBUG [SessionImpl] generated identifier: 58177
15:28:35,231 DEBUG [SessionImpl] saving [it.esselunga.ecommerce.data.model.Person#58177]
15:28:35,231 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,381 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,381 DEBUG [Cascades] id unsaved-value strategy NULL
15:28:35,381 DEBUG [Cascades] id unsaved-value strategy NULL
15:28:35,381 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,381 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:28:35,381 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:28:35,381 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:28:35,381 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,381 DEBUG [HibernateInterceptor] Not closing pre-bound Hibernate session after interceptor

15:28:35,381 DEBUG [TransactionInterceptor] Invoking commit for transaction on method 'updateCustomer' in class [it.esselunga.ecommerce.services.party.PartyService]
15:28:35,381 DEBUG [HibernateTransactionManager] Triggering beforeCommit synchronization
15:28:35,381 DEBUG [HibernateTransactionManager] Triggering beforeCompletion synchronization
15:28:35,381 INFO [HibernateTransactionManager] Initiating transaction commit
15:28:35,381 DEBUG [HibernateTransactionManager] Committing Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1e6743e]
15:28:35,381 DEBUG [JDBCTransaction] commit
15:28:35,381 DEBUG [SessionImpl] flushing session

15:28:35,381 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:28:35,381 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:28:35,381 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:28:35,381 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:28:35,391 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:28:35,391 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:28:35,391 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,391 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:28:35,391 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:28:35,391 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:28:35,391 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,391 DEBUG [SessionImpl] Collection dirty: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175]
15:28:35,391 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:28:35,391 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58175], was: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58175]
15:28:35,391 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58175], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58175]
15:28:35,391 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58175], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58175]
15:28:35,391 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58175], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58175]
15:28:35,391 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58175], was: [it.esselunga.ecommerce.data.model.Person.addresses#58175]
15:28:35,391 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175]
15:28:35,391 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58175], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58175]
15:28:35,391 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.userLogins
15:28:35,391 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.trolleys
15:28:35,391 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:28:35,391 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.addresses
15:28:35,391 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom
15:28:35,391 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesTo
15:28:35,401 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58177], was: [<unreferenced>]
15:28:35,401 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58177], was: [<unreferenced>]
15:28:35,401 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58177], was: [<unreferenced>]
15:28:35,401 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58177], was: [<unreferenced>]
15:28:35,401 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58177], was: [<unreferenced>]
15:28:35,401 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58177], was: [<unreferenced>]
15:28:35,401 DEBUG [SessionImpl] Processing unreferenced collections
15:28:35,401 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:28:35,401 DEBUG [SessionImpl] Flushed: 1 insertions, 0 updates, 0 deletions to 2 objects
15:28:35,401 DEBUG [SessionImpl] Flushed: 6 (re)creations, 1 updates, 0 removals to 13 collections
15:28:35,401 DEBUG [Printer] listing entities:
15:28:35,401 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=[], partyId=58177, forename=cognome1, title=Mr., educationLevel=EducationLevel#2203, profession=Profession#2202, shoppingLists=[], creationDate=07 maggio 2004 15:28:27, homeTel=02-57402284, relatedPartiesTo=[PartyRelationship{relationshipType=RelativeType#2201, throughDate=null, relatedParty=Customer#58175, description=null, fromDate=null}], sex=M, surname=parente1, dateOfBirth=11 novembre 1976 15:28:27, detailsPrivate=true, partyType=2, userLogins=[], email=email-parente1@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=[], trolleys=[], mobileTel=347-0077078}
15:28:35,401 DEBUG [Printer] it.esselunga.ecommerce.data.model.Customer{partyId=58175, addresses=uninitialized, title=Mr., homeTel=02-57402284, sendInfo=true, relatedPartiesTo=uninitialized, sex=M, fidelityCardNumber=601724305345034, partyType=2, relatedPartiesFrom=[PartyRelationship{relationshipType=RelativeType#2201, throughDate=null, relatedParty=Person#58177, description=null, fromDate=null}], forename=pluto, deliveryAddresses=uninitialized, howManyRelatives=2, fidelityCardType=GOLD , educationLevel=EducationLevel#2203, creationDate=07 maggio 2004 15:28:12, shoppingLists=uninitialized, profession=Profession#2202, newCardNumber=true, surname=pippo, dateOfBirth=13 febbraio 1973 15:28:12, detailsPrivate=true, userLogins=uninitialized, workTel=347-0077078, email=pippo@pluto.com, trolleys=uninitialized, mobileTel=347-0077078}
15:28:35,411 DEBUG [SessionImpl] executing flush
15:28:35,411 DEBUG [NormalizedEntityPersister] Inserting entity: [it.esselunga.ecommerce.data.model.Person#58177]
15:28:35,411 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,411 DEBUG [SQL] insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
Hibernate: insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
15:28:35,411 DEBUG [BatcherImpl] preparing statement
15:28:35,441 DEBUG [BatcherImpl] about to open: 1 open PreparedStatements, 0 open ResultSets
15:28:35,441 DEBUG [SQL] insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
Hibernate: insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
15:28:35,441 DEBUG [BatcherImpl] preparing statement
15:28:35,441 DEBUG [NormalizedEntityPersister] Dehydrating entity: [it.esselunga.ecommerce.data.model.Person#58177]
15:28:35,441 DEBUG [PersistentEnumType] binding '2' to parameter: 1
15:28:35,441 DEBUG [IntegerType] binding '58177' to parameter: 2
15:28:35,441 DEBUG [StringType] binding 'Mr.' to parameter: 1
15:28:35,441 DEBUG [StringType] binding 'parente1' to parameter: 2
15:28:35,441 DEBUG [StringType] binding 'cognome1' to parameter: 3
15:28:35,441 DEBUG [StringType] binding 'email-parente1@updatecustomer.it' to parameter: 4
15:28:35,441 DEBUG [StringType] binding '02-57402284' to parameter: 5
15:28:35,441 DEBUG [StringType] binding '347-0077078' to parameter: 6
15:28:35,441 DEBUG [StringType] binding '347-0077078' to parameter: 7
15:28:35,441 DEBUG [TimestampType] binding '11 novembre 1976 15:28:27' to parameter: 8
15:28:35,451 DEBUG [StringType] binding 'M' to parameter: 9
15:28:35,451 DEBUG [BooleanType] binding 'true' to parameter: 10
15:28:35,451 DEBUG [TimestampType] binding '07 maggio 2004 15:28:27' to parameter: 11
15:28:35,451 DEBUG [Cascades] id unsaved-value strategy NULL
15:28:35,451 DEBUG [IntegerType] binding '2202' to parameter: 12
15:28:35,451 DEBUG [Cascades] id unsaved-value strategy NULL
15:28:35,451 DEBUG [IntegerType] binding '2203' to parameter: 13
15:28:35,451 DEBUG [IntegerType] binding '58177' to parameter: 14
15:28:35,481 DEBUG [BatcherImpl] done closing: 1 open PreparedStatements, 0 open ResultSets
15:28:35,481 DEBUG [BatcherImpl] closing statement
15:28:35,481 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,481 DEBUG [BatcherImpl] closing statement
15:28:35,491 DEBUG [BasicCollectionPersister] Deleting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175]
15:28:35,491 DEBUG [BasicCollectionPersister] no rows to delete
15:28:35,491 DEBUG [BasicCollectionPersister] Updating rows of collection: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175
15:28:35,491 DEBUG [BasicCollectionPersister] done updating rows: 0 updated
15:28:35,491 DEBUG [BasicCollectionPersister] Inserting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58175]
15:28:35,491 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,491 DEBUG [SQL] insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
Hibernate: insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
15:28:35,491 DEBUG [BatcherImpl] preparing statement
15:28:35,491 DEBUG [IntegerType] binding '58175' to parameter: 1
15:28:35,501 DEBUG [TimestampType] binding null to parameter: 2
15:28:35,501 DEBUG [TimestampType] binding null to parameter: 3
15:28:35,501 DEBUG [StringType] binding null to parameter: 4
15:28:35,501 DEBUG [Cascades] id unsaved-value strategy NULL
15:28:35,501 DEBUG [SessionImpl] running Session.finalize()
15:28:35,501 DEBUG [IntegerType] binding '2201' to parameter: 5
15:28:35,501 DEBUG [IntegerType] binding '58177' to parameter: 6
15:28:35,501 DEBUG [BatcherImpl] Adding to batch
15:28:35,501 DEBUG [BasicCollectionPersister] done inserting rows: 1 inserted
15:28:35,501 DEBUG [BatcherImpl] Executing batch size: 1
15:28:35,511 DEBUG [BatcherImpl] success of batch update unknown: 0
15:28:35,511 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,511 DEBUG [BatcherImpl] closing statement
15:28:35,521 DEBUG [BasicCollectionPersister] Inserting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58177]
15:28:35,521 DEBUG [BasicCollectionPersister] collection was empty
15:28:35,521 DEBUG [SessionImpl] post flush
15:28:35,531 DEBUG [SessionImpl] transaction completion
15:28:35,531 DEBUG [JDBCTransaction] re-enabling autocommit
15:28:35,541 DEBUG [HibernateTransactionManager] Triggering afterCompletion synchronization
15:28:35,541 DEBUG [TransactionSynchronizationManager] Clearing transaction synchronization
15:28:35,541 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.jdbc.datasource.ConnectionHolder@1da366c] for key [org.apache.commons.dbcp.BasicDataSource@1a01f91] from thread [main]
15:28:35,541 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] from thread [main]
15:28:35,541 DEBUG [HibernateTransactionManager] Closing Hibernate session [net.sf.hibernate.impl.SessionImpl@1e6743e] after transaction
15:28:35,541 DEBUG [SessionFactoryUtils] Closing Hibernate session
15:28:35,541 DEBUG [SessionImpl] closing session
15:28:35,541 DEBUG [SessionImpl] disconnecting session
15:28:35,541 DEBUG [SessionImpl] transaction completion
15:28:35,541 DEBUG [TransactionInterceptor] Getting transaction for method 'getPersonRelatives' in class [it.esselunga.ecommerce.services.party.PartyService]
15:28:35,541 DEBUG [HibernateTransactionManager] Using transaction object [org.springframework.orm.hibernate.HibernateTransactionObject@187e184]
15:28:35,541 DEBUG [HibernateTransactionManager] Creating new transaction
15:28:35,541 DEBUG [SessionFactoryUtils] Opening Hibernate session
15:28:35,541 DEBUG [SessionImpl] opened session
15:28:35,551 DEBUG [HibernateTransactionManager] Opened new session [net.sf.hibernate.impl.SessionImpl@1e6cf07] for Hibernate transaction
15:28:35,551 DEBUG [HibernateTransactionManager] Beginning Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1e6cf07]
15:28:35,551 DEBUG [JDBCTransaction] begin
15:28:35,561 DEBUG [JDBCTransaction] current autocommit status:true
15:28:35,561 DEBUG [JDBCTransaction] disabling autocommit
15:28:35,571 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.orm.hibernate.SessionHolder@b53b32] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] to thread [main]
15:28:35,571 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.jdbc.datasource.ConnectionHolder@41647f] for key [org.apache.commons.dbcp.BasicDataSource@1a01f91] to thread [main]
15:28:35,571 DEBUG [TransactionSynchronizationManager] Initializing transaction synchronization
15:28:35,571 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@b53b32] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:28:35,571 DEBUG [HibernateInterceptor] Found thread-bound session for Hibernate interceptor
15:28:35,571 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@b53b32] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:28:35,571 DEBUG [SessionImpl] find: select relationship.relatedParty from Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:28:35,571 DEBUG [QueryParameters] parameters: [58175]
15:28:35,601 DEBUG [QueryTranslator] compiling query
15:28:35,601 DEBUG [SessionImpl] flushing session

15:28:35,601 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:28:35,611 DEBUG [SessionImpl] Processing unreferenced collections
15:28:35,611 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:28:35,611 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
15:28:35,611 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
15:28:35,611 DEBUG [SessionImpl] Dont need to execute flush
15:28:35,611 DEBUG [QueryTranslator] HQL: select relationship.relatedParty from it.esselunga.ecommerce.data.model.Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:28:35,611 DEBUG [QueryTranslator] SQL: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:28:35,621 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,621 DEBUG [SQL] select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
Hibernate: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:28:35,621 DEBUG [BatcherImpl] preparing statement
15:28:35,631 DEBUG [IntegerType] binding '58175' to parameter: 1
15:28:35,701 DEBUG [Loader] processing result set

15:28:35,701 DEBUG [IntegerType] returning '58177' as column: PARTY_ID
15:28:35,701 DEBUG [Loader] result row: 58177
15:28:35,701 DEBUG [IntegerType] returning '2' as column: clazz_
15:28:35,701 DEBUG [Loader] Initializing object from ResultSet: 58177
15:28:35,701 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Person#58177
15:28:35,701 DEBUG [StringType] returning 'Mr.' as column: TITLE10_
15:28:35,701 DEBUG [StringType] returning 'parente1' as column: SURNAME10_
15:28:35,711 DEBUG [StringType] returning 'cognome1' as column: FORENAME10_
15:28:35,711 DEBUG [StringType] returning 'email-parente1@updatecustomer.it' as column: EMAIL10_
15:28:35,711 DEBUG [StringType] returning '02-57402284' as column: HOME_TEL10_
15:28:35,711 DEBUG [StringType] returning '347-0077078' as column: WORK_TEL10_
15:28:35,711 DEBUG [StringType] returning '347-0077078' as column: MOBILE_TEL10_
15:28:35,711 DEBUG [TimestampType] returning '11 novembre 1976 15:28:27' as column: DATE_OF_9_10_
15:28:35,711 DEBUG [StringType] returning 'M' as column: SEX10_
15:28:35,711 DEBUG [BooleanType] returning 'true' as column: DETAILS11_10_
15:28:35,711 DEBUG [TimestampType] returning '07 maggio 2004 15:28:27' as column: CREATIO12_10_
15:28:35,711 DEBUG [IntegerType] returning '2202' as column: PROFESS13_10_
15:28:35,711 DEBUG [IntegerType] returning '2203' as column: EDUCATI14_10_
15:28:35,711 DEBUG [PersistentEnumType] returning '2' as column: PARTY_TYPE8_
15:28:35,721 DEBUG [Loader] done processing result set (1 rows)
15:28:35,721 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,721 DEBUG [BatcherImpl] closing statement
15:28:35,721 DEBUG [Loader] total objects hydrated: 1
15:28:35,721 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Person#58177]
15:28:35,721 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.userLogins#58177]
15:28:35,721 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.trolleys#58177]
15:28:35,721 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.shoppingLists#58177]
15:28:35,721 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.addresses#58177]
15:28:35,721 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.Profession#2202]
15:28:35,721 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.Profession#2202]
15:28:35,731 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.Profession#2202]
15:28:35,731 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.Profession#2202]
15:28:35,731 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,731 DEBUG [SQL] select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
Hibernate: select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
15:28:35,731 DEBUG [BatcherImpl] preparing statement
15:28:35,731 DEBUG [IntegerType] binding '2202' to parameter: 1
15:28:35,761 DEBUG [Loader] processing result set

15:28:35,761 DEBUG [Loader] result row: 2202
15:28:35,761 DEBUG [Loader] Initializing object from ResultSet: 2202
15:28:35,761 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Profession#2202
15:28:35,831 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:28:35,831 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:28:35,831 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:28:35,831 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:28:35,831 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:28:35,831 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:28:35,831 DEBUG [Loader] done processing result set (1 rows)
15:28:35,831 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,831 DEBUG [BatcherImpl] closing statement
15:28:35,842 DEBUG [Loader] total objects hydrated: 1
15:28:35,842 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Profession#2202]
15:28:35,842 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Profession#2202]
15:28:35,842 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.EducationLevel#2203]
15:28:35,842 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.EducationLevel#2203]
15:28:35,842 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.EducationLevel#2203]
15:28:35,842 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.EducationLevel#2203]
15:28:35,842 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:28:35,842 DEBUG [SQL] select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
Hibernate: select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
15:28:35,842 DEBUG [BatcherImpl] preparing statement
15:28:35,842 DEBUG [IntegerType] binding '2203' to parameter: 1
15:28:35,862 DEBUG [Loader] processing result set

15:28:35,862 DEBUG [Loader] result row: 2203
15:28:35,862 DEBUG [Loader] Initializing object from ResultSet: 2203
15:28:35,862 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.EducationLevel#2203

15:28:35,862 DEBUG [StringType] returning 'laurea' as column: ENUM_CODE0_
15:28:35,872 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:28:35,872 DEBUG [StringType] returning 'il livello di educazione della laurea' as column: DESCRIPT5_0_
15:28:35,872 DEBUG [Loader] done processing result set (1 rows)
15:28:35,872 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:28:35,882 DEBUG [BatcherImpl] closing statement
15:28:35,882 DEBUG [Loader] total objects hydrated: 1
15:28:35,882 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.EducationLevel#2203]
15:28:35,882 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.EducationLevel#2203]
15:28:35,882 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58177]
15:28:35,882 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58177]
15:28:35,882 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Person#58177]
15:28:35,882 DEBUG [SessionImpl] initializing non-lazy collections
15:28:35,882 DEBUG [HibernateInterceptor] Not closing pre-bound Hibernate session after interceptor

15:28:35,882 DEBUG [TransactionInterceptor] Invoking commit for transaction on method 'getPersonRelatives' in class [it.esselunga.ecommerce.services.party.PartyService]
15:28:35,882 DEBUG [HibernateTransactionManager] Triggering beforeCommit synchronization
15:28:35,882 DEBUG [HibernateTransactionManager] Triggering beforeCompletion synchronization
15:28:35,882 INFO [HibernateTransactionManager] Initiating transaction commit
15:28:35,882 DEBUG [HibernateTransactionManager] Committing Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1e6cf07]
15:28:35,882 DEBUG [JDBCTransaction] commit
15:28:35,882 DEBUG [SessionImpl] flushing session

15:28:35,882 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,892 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:28:35,892 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:28:35,892 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:28:35,892 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:28:35,892 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:28:35,892 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58177], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58177]
15:28:35,892 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58177], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58177]
15:28:35,892 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58177], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58177]
15:28:35,892 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58177], was: [it.esselunga.ecommerce.data.model.Person.addresses#58177]
15:28:35,892 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58177], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58177]
15:28:35,892 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58177], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58177]
15:28:35,892 DEBUG [SessionImpl] Processing unreferenced collections
15:28:35,892 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:28:35,892 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 3 objects
15:28:35,892 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 6 collections
15:28:35,892 DEBUG [Printer] listing entities:
15:28:35,892 DEBUG [Printer] it.esselunga.ecommerce.data.model.Profession{enumId=2202, description=il mestiere piu antico del mondo, enumCode=ingegnere, sequence=1}
15:28:35,892 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=uninitialized, partyId=58177, forename=cognome1, title=Mr., educationLevel=EducationLevel#2203, profession=Profession#2202, shoppingLists=uninitialized, creationDate=07 maggio 2004 15:28:27, homeTel=02-57402284, relatedPartiesTo=uninitialized, sex=M, surname=parente1, dateOfBirth=11 novembre 1976 15:28:27, detailsPrivate=true, partyType=2, userLogins=uninitialized, email=email-parente1@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=uninitialized, trolleys=uninitialized, mobileTel=347-0077078}
15:28:35,932 DEBUG [Printer] it.esselunga.ecommerce.data.model.EducationLevel{enumId=2203, description=il livello di educazione della laurea, enumCode=laurea, sequence=1}
15:28:35,932 DEBUG [SessionImpl] executing flush
15:28:35,932 DEBUG [SessionImpl] post flush
15:28:35,932 DEBUG [SessionImpl] transaction completion
15:28:35,932 DEBUG [JDBCTransaction] re-enabling autocommit
15:28:35,942 DEBUG [HibernateTransactionManager] Triggering afterCompletion synchronization
15:28:35,942 DEBUG [TransactionSynchronizationManager] Clearing transaction synchronization
15:28:35,942 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.jdbc.datasource.ConnectionHolder@41647f] for key [org.apache.commons.dbcp.BasicDataSource@1a01f91] from thread [main]
15:28:35,942 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.orm.hibernate.SessionHolder@b53b32] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] from thread [main]
15:28:35,942 DEBUG [HibernateTransactionManager] Closing Hibernate session [net.sf.hibernate.impl.SessionImpl@1e6cf07] after transaction
15:28:35,962 DEBUG [SessionFactoryUtils] Closing Hibernate session
15:28:35,962 DEBUG [SessionImpl] closing session
15:28:35,962 DEBUG [SessionImpl] disconnecting session
15:28:35,972 DEBUG [SessionImpl] transaction completion
15:28:35,972 DEBUG [TransactionInterceptor] Getting transaction for method 'updateCustomer' in class [it.esselunga.ecommerce.services.party.PartyService]
15:28:35,972 DEBUG [HibernateTransactionManager] Using transaction object [org.springframework.orm.hibernate.HibernateTransactionObject@bc36ff]
15:28:35,972 DEBUG [HibernateTransactionManager] Creating new transaction
15:28:35,972 DEBUG [SessionFactoryUtils] Opening Hibernate session
15:28:35,972 DEBUG [SessionImpl] opened session
15:28:35,972 DEBUG [HibernateTransactionManager] Opened new session [net.sf.hibernate.impl.SessionImpl@bed1fd] for Hibernate transaction
15:28:35,972 DEBUG [HibernateTransactionManager] Beginning Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@bed1fd]
15:28:35,972 DEBUG [JDBCTransaction] begin
15:28:35,992 DEBUG [JDBCTransaction] current autocommit status:true
15:28:35,992 DEBUG [JDBCTransaction] disabling autocommit
15:28:35,992 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.orm.hibernate.SessionHolder@161c9d1] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] to thread [main]

15:28:35,992 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.jdbc.datasource.ConnectionHolder@108ea49] for key [org.apache.commons.dbcp.BasicDataSource@1a01f91] to thread [main]
15:28:35,992 DEBUG [TransactionSynchronizationManager] Initializing transaction synchronization
15:28:35,992 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@161c9d1] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:28:35,992 DEBUG [HibernateInterceptor] Found thread-bound session for Hibernate interceptor
15:28:35,992 INFO [Sprin

Top

immanuel

Post subject: Retry: working log

Posted: Fri May 07, 2004 9:42 am

Regular

Joined: Tue Jan 13, 2004 4:57 am
Posts: 83

15:40:24,250 INFO [SpringHibernatePartyService] updating customer it.esselunga.ecommerce.data.model.Customer@260d8d[partyId=58185] with relatives map {it.esselunga.ecommerce.data.model.Person@7b4ed7[partyId=<null>]=2207}
15:40:24,250 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:40:24,250 DEBUG [SessionImpl] find: select relationship.relatedParty from Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:40:24,250 DEBUG [QueryParameters] parameters: [58185]
15:40:24,250 DEBUG [QueryTranslator] compiling query
15:40:24,270 DEBUG [SessionImpl] flushing session

15:40:24,270 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:40:24,270 DEBUG [SessionImpl] Processing unreferenced collections
15:40:24,270 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:40:24,270 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
15:40:24,270 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
15:40:24,270 DEBUG [SessionImpl] Dont need to execute flush
15:40:24,270 DEBUG [QueryTranslator] HQL: select relationship.relatedParty from it.esselunga.ecommerce.data.model.Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:40:24,270 DEBUG [QueryTranslator] SQL: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:40:24,280 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:24,280 DEBUG [SQL] select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
Hibernate: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:40:24,290 DEBUG [BatcherImpl] preparing statement
15:40:24,290 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,290 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,330 DEBUG [Loader] processing result set

15:40:24,340 DEBUG [Loader] done processing result set (0 rows)
15:40:24,340 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:24,340 DEBUG [BatcherImpl] closing statement
15:40:24,340 DEBUG [Loader] total objects hydrated: 0
15:40:24,340 DEBUG [SessionImpl] initializing non-lazy collections
15:40:24,340 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:40:24,340 DEBUG [Cascades] id unsaved-value strategy NULL
15:40:24,340 DEBUG [SessionImpl] reassociating transient instance: [it.esselunga.ecommerce.data.model.Customer#58185]
15:40:24,350 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:40:24,350 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:40:24,350 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:40:24,350 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:40:24,350 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:40:24,350 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:40:24,350 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:40:24,350 DEBUG [SessionImpl] flushing session

15:40:24,350 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:40:24,350 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:40:24,360 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:40:24,360 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:40:24,360 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:40:24,360 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:40:24,360 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:40:24,360 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58185], was: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58185]
15:40:24,360 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58185], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58185]
15:40:24,360 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58185], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58185]
15:40:24,360 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58185], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58185]
15:40:24,360 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58185], was: [it.esselunga.ecommerce.data.model.Person.addresses#58185]
15:40:24,360 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,360 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58185], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58185]
15:40:24,360 DEBUG [SessionImpl] Processing unreferenced collections
15:40:24,360 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:40:24,360 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects
15:40:24,360 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 7 collections
15:40:24,360 DEBUG [Printer] listing entities:
15:40:24,370 DEBUG [Printer] it.esselunga.ecommerce.data.model.Customer{partyId=58185, addresses=uninitialized, title=Mr., homeTel=02-57402284, sendInfo=true, relatedPartiesTo=uninitialized, sex=M, fidelityCardNumber=601724305345034, partyType=2, relatedPartiesFrom=uninitialized, forename=pluto, deliveryAddresses=uninitialized, howManyRelatives=2, fidelityCardType=GOLD , educationLevel=EducationLevel#2209, creationDate=07 maggio 2004 15:39:48, shoppingLists=uninitialized, profession=Profession#2208, newCardNumber=true, surname=pippo, dateOfBirth=13 febbraio 1973 15:39:48, detailsPrivate=true, userLogins=uninitialized, workTel=347-0077078, email=pippo@pluto.com, trolleys=uninitialized, mobileTel=347-0077078}
15:40:24,370 DEBUG [SessionImpl] executing flush
15:40:24,370 DEBUG [SessionImpl] post flush
15:40:24,370 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,370 DEBUG [SessionImpl] checking second-level cache
15:40:24,370 DEBUG [SessionImpl] collection not cached
15:40:24,370 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:24,370 DEBUG [SQL] select relatedpar0_.FROM_DATE as FROM_DATE__, relatedpar0_.THRU_DATE as THRU_DATE__, relatedpar0_.DESCRIPTION as DESCRIPT4___, relatedpar0_.RELATIONSHIP_TYPE_ID as RELATION5___, relatedpar0_.PARTY_ID_FROM as PARTY_ID6___, relatedpar0_.PARTY_ID_TO as PARTY_ID1___, partyrelat1_.ENUM_ID as ENUM_ID0_, partyrelat1_.ENUM_TYPE as ENUM_TYPE0_, partyrelat1_.ENUM_CODE as ENUM_CODE0_, partyrelat1_.SEQUENCE as SEQUENCE0_, partyrelat1_.DESCRIPTION as DESCRIPT5_0_ from PARTY_RELATIONSHIP relatedpar0_, ENUMERATION partyrelat1_ where relatedpar0_.PARTY_ID_TO=? and relatedpar0_.RELATIONSHIP_TYPE_ID=partyrelat1_.ENUM_ID(+)
Hibernate: select relatedpar0_.FROM_DATE as FROM_DATE__, relatedpar0_.THRU_DATE as THRU_DATE__, relatedpar0_.DESCRIPTION as DESCRIPT4___, relatedpar0_.RELATIONSHIP_TYPE_ID as RELATION5___, relatedpar0_.PARTY_ID_FROM as PARTY_ID6___, relatedpar0_.PARTY_ID_TO as PARTY_ID1___, partyrelat1_.ENUM_ID as ENUM_ID0_, partyrelat1_.ENUM_TYPE as ENUM_TYPE0_, partyrelat1_.ENUM_CODE as ENUM_CODE0_, partyrelat1_.SEQUENCE as SEQUENCE0_, partyrelat1_.DESCRIPTION as DESCRIPT5_0_ from PARTY_RELATIONSHIP relatedpar0_, ENUMERATION partyrelat1_ where relatedpar0_.PARTY_ID_TO=? and relatedpar0_.RELATIONSHIP_TYPE_ID=partyrelat1_.ENUM_ID(+)
15:40:24,380 DEBUG [BatcherImpl] preparing statement
15:40:24,380 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,380 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,410 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,410 DEBUG [SessionImpl] uninitialized collection: initializing
15:40:24,410 DEBUG [Loader] processing result set

15:40:24,420 DEBUG [Loader] done processing result set (0 rows)
15:40:24,420 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:24,420 DEBUG [BatcherImpl] closing statement
15:40:24,420 DEBUG [Loader] total objects hydrated: 0
15:40:24,420 DEBUG [SessionImpl] 1 collections were found in result set
15:40:24,420 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,420 DEBUG [SessionImpl] 1 collections initialized
15:40:24,420 DEBUG [SessionImpl] initializing non-lazy collections
15:40:24,420 DEBUG [SessionImpl] collection initialized
15:40:24,420 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:40:24,420 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:24,420 DEBUG [SQL] select PARTY_SEQ.nextval from dual
Hibernate: select PARTY_SEQ.nextval from dual
15:40:24,430 DEBUG [BatcherImpl] preparing statement
15:40:24,460 DEBUG [SequenceGenerator] Sequence identifier generated: 58187
15:40:24,460 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:24,460 DEBUG [BatcherImpl] closing statement
15:40:24,460 DEBUG [SessionImpl] generated identifier: 58187
15:40:24,470 DEBUG [SessionImpl] saving [it.esselunga.ecommerce.data.model.Person#58187]
15:40:24,470 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:24,470 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:24,470 DEBUG [Cascades] id unsaved-value strategy NULL
15:40:24,470 DEBUG [Cascades] id unsaved-value strategy NULL
15:40:24,470 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:40:24,470 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:24,470 DEBUG [HibernateInterceptor] Not closing pre-bound Hibernate session after interceptor

15:40:24,470 DEBUG [TransactionInterceptor] Invoking commit for transaction on method 'updateCustomer' in class [it.esselunga.ecommerce.services.party.PartyService]
15:40:24,470 DEBUG [HibernateTransactionManager] Triggering beforeCommit synchronization
15:40:24,470 DEBUG [HibernateTransactionManager] Triggering beforeCompletion synchronization
15:40:24,470 INFO [HibernateTransactionManager] Initiating transaction commit
15:40:24,470 DEBUG [HibernateTransactionManager] Committing Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1e6743e]
15:40:24,470 DEBUG [JDBCTransaction] commit
15:40:24,470 DEBUG [SessionImpl] flushing session

15:40:24,470 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:40:24,470 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:40:24,470 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:24,470 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:40:24,480 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:40:24,480 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:40:24,480 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:24,541 DEBUG [SessionImpl] Collection dirty: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,541 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58185], was: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58185]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58185], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58185]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58185], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58185]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58185], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58185]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58185], was: [it.esselunga.ecommerce.data.model.Person.addresses#58185]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58185], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58185]
15:40:24,541 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.userLogins
15:40:24,541 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.trolleys
15:40:24,541 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:40:24,541 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.addresses
15:40:24,541 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom
15:40:24,541 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesTo
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58187], was: [<unreferenced>]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58187], was: [<unreferenced>]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58187], was: [<unreferenced>]
15:40:24,541 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58187], was: [<unreferenced>]
15:40:24,551 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58187], was: [<unreferenced>]
15:40:24,551 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58187], was: [<unreferenced>]
15:40:24,551 DEBUG [SessionImpl] Processing unreferenced collections
15:40:24,551 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:40:24,551 DEBUG [SessionImpl] Flushed: 1 insertions, 0 updates, 0 deletions to 2 objects
15:40:24,551 DEBUG [SessionImpl] Flushed: 6 (re)creations, 1 updates, 0 removals to 13 collections
15:40:24,551 DEBUG [Printer] listing entities:
15:40:24,551 DEBUG [Printer] it.esselunga.ecommerce.data.model.Customer{partyId=58185, addresses=uninitialized, title=Mr., homeTel=02-57402284, sendInfo=true, relatedPartiesTo=uninitialized, sex=M, fidelityCardNumber=601724305345034, partyType=2, relatedPartiesFrom=[PartyRelationship{relationshipType=RelativeType#2207, throughDate=null, relatedParty=Person#58187, description=null, fromDate=null}], forename=pluto, deliveryAddresses=uninitialized, howManyRelatives=2, fidelityCardType=GOLD , educationLevel=EducationLevel#2209, creationDate=07 maggio 2004 15:39:48, shoppingLists=uninitialized, profession=Profession#2208, newCardNumber=true, surname=pippo, dateOfBirth=13 febbraio 1973 15:39:48, detailsPrivate=true, userLogins=uninitialized, workTel=347-0077078, email=pippo@pluto.com, trolleys=uninitialized, mobileTel=347-0077078}
15:40:24,551 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=[], partyId=58187, forename=cognome1, title=Mr., educationLevel=EducationLevel#2209, profession=Profession#2208, shoppingLists=[], creationDate=07 maggio 2004 15:40:05, homeTel=02-57402284, relatedPartiesTo=[PartyRelationship{relationshipType=RelativeType#2207, throughDate=null, relatedParty=Customer#58185, description=null, fromDate=null}], sex=M, surname=parente1, dateOfBirth=11 novembre 1976 15:40:05, detailsPrivate=true, partyType=2, userLogins=[], email=email-parente1@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=[], trolleys=[], mobileTel=347-0077078}
15:40:24,561 DEBUG [SessionImpl] executing flush
15:40:24,561 DEBUG [NormalizedEntityPersister] Inserting entity: [it.esselunga.ecommerce.data.model.Person#58187]
15:40:24,561 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:24,561 DEBUG [SQL] insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
Hibernate: insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
15:40:24,561 DEBUG [BatcherImpl] preparing statement
15:40:24,681 DEBUG [BatcherImpl] about to open: 1 open PreparedStatements, 0 open ResultSets
15:40:24,681 DEBUG [SQL] insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
Hibernate: insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
15:40:24,681 DEBUG [BatcherImpl] preparing statement
15:40:24,681 DEBUG [NormalizedEntityPersister] Dehydrating entity: [it.esselunga.ecommerce.data.model.Person#58187]
15:40:24,681 DEBUG [PersistentEnumType] binding '2' to parameter: 1
15:40:24,681 DEBUG [PersistentEnumType] binding '2' to parameter: 1
15:40:24,681 DEBUG [IntegerType] binding '58187' to parameter: 2
15:40:24,681 DEBUG [IntegerType] binding '58187' to parameter: 2
15:40:24,681 DEBUG [StringType] binding 'Mr.' to parameter: 1
15:40:24,681 DEBUG [StringType] binding 'Mr.' to parameter: 1
15:40:24,681 DEBUG [StringType] binding 'parente1' to parameter: 2
15:40:24,681 DEBUG [StringType] binding 'parente1' to parameter: 2
15:40:24,681 DEBUG [StringType] binding 'cognome1' to parameter: 3
15:40:24,681 DEBUG [StringType] binding 'cognome1' to parameter: 3
15:40:24,681 DEBUG [StringType] binding 'email-parente1@updatecustomer.it' to parameter: 4
15:40:24,681 DEBUG [StringType] binding 'email-parente1@updatecustomer.it' to parameter: 4
15:40:24,681 DEBUG [StringType] binding '02-57402284' to parameter: 5
15:40:24,681 DEBUG [StringType] binding '02-57402284' to parameter: 5
15:40:24,681 DEBUG [StringType] binding '347-0077078' to parameter: 6
15:40:24,681 DEBUG [StringType] binding '347-0077078' to parameter: 6
15:40:24,711 DEBUG [StringType] binding '347-0077078' to parameter: 7
15:40:24,711 DEBUG [StringType] binding '347-0077078' to parameter: 7
15:40:24,711 DEBUG [TimestampType] binding '11 novembre 1976 15:40:05' to parameter: 8
15:40:24,711 DEBUG [TimestampType] binding '11 novembre 1976 15:40:05' to parameter: 8
15:40:24,711 DEBUG [StringType] binding 'M' to parameter: 9
15:40:24,711 DEBUG [StringType] binding 'M' to parameter: 9
15:40:24,711 DEBUG [BooleanType] binding 'true' to parameter: 10
15:40:24,711 DEBUG [BooleanType] binding 'true' to parameter: 10
15:40:24,711 DEBUG [TimestampType] binding '07 maggio 2004 15:40:05' to parameter: 11
15:40:24,711 DEBUG [TimestampType] binding '07 maggio 2004 15:40:05' to parameter: 11
15:40:24,711 DEBUG [Cascades] id unsaved-value strategy NULL
15:40:24,711 DEBUG [IntegerType] binding '2208' to parameter: 12
15:40:24,711 DEBUG [IntegerType] binding '2208' to parameter: 12
15:40:24,711 DEBUG [Cascades] id unsaved-value strategy NULL
15:40:24,711 DEBUG [IntegerType] binding '2209' to parameter: 13
15:40:24,711 DEBUG [IntegerType] binding '2209' to parameter: 13
15:40:24,711 DEBUG [IntegerType] binding '58187' to parameter: 14
15:40:24,711 DEBUG [IntegerType] binding '58187' to parameter: 14
15:40:24,731 DEBUG [BatcherImpl] done closing: 1 open PreparedStatements, 0 open ResultSets
15:40:24,731 DEBUG [BatcherImpl] closing statement
15:40:24,741 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:24,741 DEBUG [BatcherImpl] closing statement
15:40:24,741 DEBUG [BasicCollectionPersister] Deleting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,741 DEBUG [BasicCollectionPersister] no rows to delete
15:40:24,741 DEBUG [BasicCollectionPersister] Updating rows of collection: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185
15:40:24,751 DEBUG [BasicCollectionPersister] done updating rows: 0 updated
15:40:24,751 DEBUG [BasicCollectionPersister] Inserting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58185]
15:40:24,751 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:24,751 DEBUG [SQL] insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
Hibernate: insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
15:40:24,751 DEBUG [BatcherImpl] preparing statement
15:40:24,751 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,751 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,751 DEBUG [TimestampType] binding null to parameter: 2
15:40:24,751 DEBUG [TimestampType] binding null to parameter: 2
15:40:24,751 DEBUG [TimestampType] binding null to parameter: 3
15:40:24,751 DEBUG [TimestampType] binding null to parameter: 3
15:40:24,751 DEBUG [StringType] binding null to parameter: 4
15:40:24,751 DEBUG [StringType] binding null to parameter: 4
15:40:24,751 DEBUG [Cascades] id unsaved-value strategy NULL
15:40:24,751 DEBUG [IntegerType] binding '2207' to parameter: 5
15:40:24,751 DEBUG [IntegerType] binding '2207' to parameter: 5
15:40:24,751 DEBUG [IntegerType] binding '58187' to parameter: 6
15:40:24,751 DEBUG [IntegerType] binding '58187' to parameter: 6
15:40:24,751 DEBUG [BatcherImpl] Adding to batch
15:40:24,751 DEBUG [BasicCollectionPersister] done inserting rows: 1 inserted
15:40:24,751 DEBUG [BatcherImpl] Executing batch size: 1
15:40:24,761 DEBUG [BatcherImpl] success of batch update unknown: 0
15:40:24,761 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:24,761 DEBUG [BatcherImpl] closing statement
15:40:24,771 DEBUG [BasicCollectionPersister] Inserting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58187]
15:40:24,771 DEBUG [BasicCollectionPersister] collection was empty
15:40:24,771 DEBUG [SessionImpl] post flush
15:40:24,791 DEBUG [SessionImpl] transaction completion
15:40:24,791 DEBUG [JDBCTransaction] re-enabling autocommit
15:40:24,791 DEBUG [HibernateTransactionManager] Triggering afterCompletion synchronization
15:40:24,791 DEBUG [TransactionSynchronizationManager] Clearing transaction synchronization
15:40:24,791 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.jdbc.datasource.ConnectionHolder@1da366c] for key [org.apache.commons.dbcp.BasicDataSource@1786b79] from thread [main]
15:40:24,801 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.orm.hibernate.SessionHolder@19f9c7a] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] from thread [main]
15:40:24,801 DEBUG [HibernateTransactionManager] Closing Hibernate session [net.sf.hibernate.impl.SessionImpl@1e6743e] after transaction
15:40:24,801 DEBUG [SessionFactoryUtils] Closing Hibernate session
15:40:24,801 DEBUG [SessionImpl] closing session
15:40:24,801 DEBUG [SessionImpl] disconnecting session
15:40:24,801 DEBUG [SessionImpl] transaction completion
15:40:24,801 DEBUG [TransactionInterceptor] Getting transaction for method 'getPersonRelatives' in class [it.esselunga.ecommerce.services.party.PartyService]
15:40:24,801 DEBUG [HibernateTransactionManager] Using transaction object [org.springframework.orm.hibernate.HibernateTransactionObject@14a616]
15:40:24,801 DEBUG [HibernateTransactionManager] Creating new transaction
15:40:24,801 DEBUG [SessionFactoryUtils] Opening Hibernate session
15:40:24,811 DEBUG [SessionImpl] opened session
15:40:24,811 DEBUG [HibernateTransactionManager] Opened new session [net.sf.hibernate.impl.SessionImpl@1a3f178] for Hibernate transaction
15:40:24,811 DEBUG [HibernateTransactionManager] Beginning Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1a3f178]
15:40:24,811 DEBUG [JDBCTransaction] begin
15:40:24,841 DEBUG [JDBCTransaction] current autocommit status:true
15:40:24,841 DEBUG [JDBCTransaction] disabling autocommit
15:40:24,861 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.orm.hibernate.SessionHolder@169c6f2] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] to thread [main]

15:40:24,861 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.jdbc.datasource.ConnectionHolder@1843ca4] for key [org.apache.commons.dbcp.BasicDataSource@1786b79] to thread [main]
15:40:24,861 DEBUG [TransactionSynchronizationManager] Initializing transaction synchronization
15:40:24,861 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@169c6f2] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:40:24,861 DEBUG [HibernateInterceptor] Found thread-bound session for Hibernate interceptor
15:40:24,861 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@169c6f2] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:40:24,861 DEBUG [SessionImpl] find: select relationship.relatedParty from Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:40:24,861 DEBUG [QueryParameters] parameters: [58185]
15:40:24,861 DEBUG [QueryTranslator] compiling query
15:40:24,871 DEBUG [SessionImpl] flushing session

15:40:24,871 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:40:24,871 DEBUG [SessionImpl] Processing unreferenced collections
15:40:24,871 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:40:24,871 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
15:40:24,871 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
15:40:24,871 DEBUG [SessionImpl] Dont need to execute flush
15:40:24,871 DEBUG [QueryTranslator] HQL: select relationship.relatedParty from it.esselunga.ecommerce.data.model.Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:40:24,871 DEBUG [QueryTranslator] SQL: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:40:24,881 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:24,881 DEBUG [SQL] select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
Hibernate: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:40:24,911 DEBUG [BatcherImpl] preparing statement
15:40:24,911 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,911 DEBUG [IntegerType] binding '58185' to parameter: 1
15:40:24,941 DEBUG [Loader] processing result set

15:40:24,941 DEBUG [IntegerType] returning '58187' as column: PARTY_ID
15:40:24,941 DEBUG [IntegerType] returning '58187' as column: PARTY_ID
15:40:24,941 DEBUG [Loader] result row: 58187
15:40:24,941 DEBUG [IntegerType] returning '2' as column: clazz_
15:40:24,941 DEBUG [IntegerType] returning '2' as column: clazz_
15:40:24,941 DEBUG [Loader] Initializing object from ResultSet: 58187
15:40:24,941 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Person#58187
15:40:24,941 DEBUG [StringType] returning 'Mr.' as column: TITLE10_
15:40:24,941 DEBUG [StringType] returning 'Mr.' as column: TITLE10_
15:40:24,941 DEBUG [StringType] returning 'parente1' as column: SURNAME10_
15:40:24,941 DEBUG [StringType] returning 'parente1' as column: SURNAME10_
15:40:24,941 DEBUG [StringType] returning 'cognome1' as column: FORENAME10_
15:40:24,941 DEBUG [StringType] returning 'cognome1' as column: FORENAME10_
15:40:24,941 DEBUG [StringType] returning 'email-parente1@updatecustomer.it' as column: EMAIL10_
15:40:24,941 DEBUG [StringType] returning 'email-parente1@updatecustomer.it' as column: EMAIL10_
15:40:24,941 DEBUG [StringType] returning '02-57402284' as column: HOME_TEL10_
15:40:24,941 DEBUG [StringType] returning '02-57402284' as column: HOME_TEL10_
15:40:24,941 DEBUG [StringType] returning '347-0077078' as column: WORK_TEL10_
15:40:24,941 DEBUG [StringType] returning '347-0077078' as column: WORK_TEL10_
15:40:24,941 DEBUG [StringType] returning '347-0077078' as column: MOBILE_TEL10_
15:40:24,941 DEBUG [StringType] returning '347-0077078' as column: MOBILE_TEL10_
15:40:24,941 DEBUG [TimestampType] returning '11 novembre 1976 15:40:05' as column: DATE_OF_9_10_
15:40:24,941 DEBUG [TimestampType] returning '11 novembre 1976 15:40:05' as column: DATE_OF_9_10_
15:40:24,951 DEBUG [StringType] returning 'M' as column: SEX10_
15:40:24,951 DEBUG [StringType] returning 'M' as column: SEX10_
15:40:24,951 DEBUG [BooleanType] returning 'true' as column: DETAILS11_10_
15:40:24,951 DEBUG [BooleanType] returning 'true' as column: DETAILS11_10_
15:40:24,951 DEBUG [TimestampType] returning '07 maggio 2004 15:40:05' as column: CREATIO12_10_
15:40:24,951 DEBUG [TimestampType] returning '07 maggio 2004 15:40:05' as column: CREATIO12_10_
15:40:24,951 DEBUG [IntegerType] returning '2208' as column: PROFESS13_10_
15:40:24,951 DEBUG [IntegerType] returning '2208' as column: PROFESS13_10_
15:40:24,951 DEBUG [IntegerType] returning '2209' as column: EDUCATI14_10_
15:40:24,951 DEBUG [IntegerType] returning '2209' as column: EDUCATI14_10_
15:40:24,951 DEBUG [PersistentEnumType] returning '2' as column: PARTY_TYPE8_
15:40:24,951 DEBUG [PersistentEnumType] returning '2' as column: PARTY_TYPE8_
15:40:24,951 DEBUG [Loader] done processing result set (1 rows)
15:40:24,951 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:24,951 DEBUG [BatcherImpl] closing statement
15:40:24,961 DEBUG [Loader] total objects hydrated: 1
15:40:24,961 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Person#58187]
15:40:24,961 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.userLogins#58187]
15:40:24,961 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.trolleys#58187]
15:40:24,961 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.shoppingLists#58187]
15:40:24,961 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.addresses#58187]
15:40:24,961 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.Profession#2208]
15:40:24,961 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.Profession#2208]
15:40:24,961 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.Profession#2208]
15:40:24,961 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.Profession#2208]
15:40:24,961 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:24,961 DEBUG [SQL] select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
Hibernate: select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
15:40:24,961 DEBUG [BatcherImpl] preparing statement
15:40:24,971 DEBUG [IntegerType] binding '2208' to parameter: 1
15:40:24,971 DEBUG [IntegerType] binding '2208' to parameter: 1
15:40:24,991 DEBUG [Loader] processing result set

15:40:24,991 DEBUG [Loader] result row: 2208
15:40:24,991 DEBUG [Loader] Initializing object from ResultSet: 2208
15:40:24,991 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Profession#2208
15:40:24,991 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:40:24,991 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:40:24,991 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:40:24,991 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:40:24,991 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:40:24,991 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:40:25,001 DEBUG [Loader] done processing result set (1 rows)
15:40:25,001 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:25,001 DEBUG [BatcherImpl] closing statement
15:40:25,001 DEBUG [Loader] total objects hydrated: 1
15:40:25,001 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Profession#2208]
15:40:25,001 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Profession#2208]
15:40:25,001 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.EducationLevel#2209]
15:40:25,001 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.EducationLevel#2209]
15:40:25,001 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.EducationLevel#2209]
15:40:25,001 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.EducationLevel#2209]
15:40:25,001 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:40:25,001 DEBUG [SQL] select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
Hibernate: select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
15:40:25,011 DEBUG [BatcherImpl] preparing statement
15:40:25,011 DEBUG [IntegerType] binding '2209' to parameter: 1
15:40:25,011 DEBUG [IntegerType] binding '2209' to parameter: 1
15:40:25,031 DEBUG [Loader] processing result set

15:40:25,031 DEBUG [Loader] result row: 2209
15:40:25,031 DEBUG [Loader] Initializing object from ResultSet: 2209
15:40:25,031 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.EducationLevel#2209

15:40:25,031 DEBUG [StringType] returning 'laurea' as column: ENUM_CODE0_
15:40:25,031 DEBUG [StringType] returning 'laurea' as column: ENUM_CODE0_
15:40:25,031 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:40:25,031 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:40:25,031 DEBUG [StringType] returning 'il livello di educazione della laurea' as column: DESCRIPT5_0_
15:40:25,031 DEBUG [StringType] returning 'il livello di educazione della laurea' as column: DESCRIPT5_0_
15:40:25,041 DEBUG [Loader] done processing result set (1 rows)
15:40:25,041 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:40:25,041 DEBUG [BatcherImpl] closing statement
15:40:25,041 DEBUG [Loader] total objects hydrated: 1
15:40:25,041 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.EducationLevel#2209]
15:40:25,051 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.EducationLevel#2209]
15:40:25,051 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58187]
15:40:25,051 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58187]
15:40:25,051 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Person#58187]
15:40:25,051 DEBUG [SessionImpl] initializing non-lazy collections
15:40:25,051 DEBUG [HibernateInterceptor] Not closing pre-bound Hibernate session after interceptor

15:40:25,051 DEBUG [TransactionInterceptor] Invoking commit for transaction on method 'getPersonRelatives' in class [it.esselunga.ecommerce.services.party.PartyService]
15:40:25,051 DEBUG [HibernateTransactionManager] Triggering beforeCommit synchronization
15:40:25,051 DEBUG [HibernateTransactionManager] Triggering beforeCompletion synchronization
15:40:25,051 INFO [HibernateTransactionManager] Initiating transaction commit
15:40:25,061 DEBUG [HibernateTransactionManager] Committing Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1a3f178]
15:40:25,061 DEBUG [JDBCTransaction] commit
15:40:25,061 DEBUG [SessionImpl] flushing session

15:40:25,061 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:25,061 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:40:25,061 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:40:25,061 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:40:25,061 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:40:25,061 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:40:25,061 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58187], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58187]
15:40:25,061 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58187], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58187]
15:40:25,061 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58187], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58187]
15:40:25,071 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58187], was: [it.esselunga.ecommerce.data.model.Person.addresses#58187]
15:40:25,071 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58187], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58187]
15:40:25,071 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58187], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58187]
15:40:25,071 DEBUG [SessionImpl] Processing unreferenced collections
15:40:25,071 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:40:25,071 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 3 objects
15:40:25,071 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 6 collections
15:40:25,071 DEBUG [Printer] listing entities:
15:40:25,071 DEBUG [Printer] it.esselunga.ecommerce.data.model.EducationLevel{enumId=2209, description=il livello di educazione della laurea, enumCode=laurea, sequence=1}
15:40:25,071 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=uninitialized, partyId=58187, forename=cognome1, title=Mr., educationLevel=EducationLevel#2209, profession=Profession#2208, shoppingLists=uninitialized, creationDate=07 maggio 2004 15:40:05, homeTel=02-57402284, relatedPartiesTo=uninitialized, sex=M, surname=parente1, dateOfBirth=11 novembre 1976 15:40:05, detailsPrivate=true, partyType=2, userLogins=uninitialized, email=email-parente1@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=uninitialized, trolleys=uninitialized, mobileTel=347-0077078}
15:40:25,071 DEBUG [Printer] it.esselunga.ecommerce.data.model.Profession{enumId=2208, description=il mestiere piu antico del mondo, enumCode=ingegnere, sequence=1}
15:40:25,071 DEBUG [SessionImpl] executing flush
15:40:25,071 DEBUG [SessionImpl] post flush
15:40:25,081 DEBUG [SessionImpl] transaction completion
15:40:25,081 DEBUG [JDBCTransaction] re-enabling autocommit
15:40:25,081 DEBUG [HibernateTransactionManager] Triggering afterCompletion synchronization
15:40:25,081 DEBUG [TransactionSynchronizationManager] Clearing transaction synchronization
15:40:25,081 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.jdbc.datasource.ConnectionHolder@1843ca4] for key [org.apache.commons.dbcp.BasicDataSource@1786b79] from thread [main]
15:40:25,091 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.orm.hibernate.SessionHolder@169c6f2] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] from thread [main]
15:40:25,091 DEBUG [HibernateTransactionManager] Closing Hibernate session [net.sf.hibernate.impl.SessionImpl@1a3f178] after transaction
15:40:25,091 DEBUG [SessionFactoryUtils] Closing Hibernate session
15:40:25,091 DEBUG [SessionImpl] closing session
15:40:25,091 DEBUG [SessionImpl] disconnecting session
15:40:25,091 DEBUG [SessionImpl] transaction completion

Top

immanuel

Post subject: NOT working case

Posted: Fri May 07, 2004 9:44 am

Regular

Joined: Tue Jan 13, 2004 4:57 am
Posts: 83

15:44:09,804 INFO [SpringHibernatePartyService] updating customer it.esselunga.ecommerce.data.model.Customer@260d8d[partyId=58190] with relatives map {it.esselunga.ecommerce.data.model.Person@bed1fd[partyId=<null>]=2210}
15:44:09,804 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@4d8d50] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:44:09,804 DEBUG [SessionImpl] find: select relationship.relatedParty from Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:44:09,804 DEBUG [QueryParameters] parameters: [58190]
15:44:09,804 DEBUG [SessionImpl] flushing session

15:44:09,804 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:44:09,804 DEBUG [SessionImpl] Processing unreferenced collections
15:44:09,804 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:44:09,804 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
15:44:09,804 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
15:44:09,804 DEBUG [SessionImpl] Dont need to execute flush
15:44:09,804 DEBUG [QueryTranslator] HQL: select relationship.relatedParty from it.esselunga.ecommerce.data.model.Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:44:09,804 DEBUG [QueryTranslator] SQL: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:44:09,814 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:09,814 DEBUG [SQL] select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
Hibernate: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:44:09,825 DEBUG [BatcherImpl] preparing statement
15:44:09,825 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:09,825 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:09,855 DEBUG [Loader] processing result set

15:44:09,855 DEBUG [IntegerType] returning '58192' as column: PARTY_ID
15:44:09,855 DEBUG [IntegerType] returning '58192' as column: PARTY_ID
15:44:09,855 DEBUG [Loader] result row: 58192
15:44:09,855 DEBUG [IntegerType] returning '2' as column: clazz_
15:44:09,855 DEBUG [IntegerType] returning '2' as column: clazz_
15:44:09,855 DEBUG [Loader] Initializing object from ResultSet: 58192
15:44:09,855 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Person#58192
15:44:09,855 DEBUG [StringType] returning 'Mr.' as column: TITLE10_
15:44:09,855 DEBUG [StringType] returning 'Mr.' as column: TITLE10_
15:44:09,855 DEBUG [StringType] returning 'parente1' as column: SURNAME10_
15:44:09,855 DEBUG [StringType] returning 'parente1' as column: SURNAME10_
15:44:09,855 DEBUG [StringType] returning 'cognome1' as column: FORENAME10_
15:44:09,855 DEBUG [StringType] returning 'cognome1' as column: FORENAME10_
15:44:09,855 DEBUG [StringType] returning 'email-parente1@updatecustomer.it' as column: EMAIL10_
15:44:09,855 DEBUG [StringType] returning 'email-parente1@updatecustomer.it' as column: EMAIL10_
15:44:09,855 DEBUG [StringType] returning '02-57402284' as column: HOME_TEL10_
15:44:09,855 DEBUG [StringType] returning '02-57402284' as column: HOME_TEL10_
15:44:09,865 DEBUG [StringType] returning '347-0077078' as column: WORK_TEL10_
15:44:09,865 DEBUG [StringType] returning '347-0077078' as column: WORK_TEL10_
15:44:09,865 DEBUG [StringType] returning '347-0077078' as column: MOBILE_TEL10_
15:44:09,865 DEBUG [StringType] returning '347-0077078' as column: MOBILE_TEL10_
15:44:09,865 DEBUG [TimestampType] returning '11 novembre 1976 15:43:38' as column: DATE_OF_9_10_
15:44:09,865 DEBUG [TimestampType] returning '11 novembre 1976 15:43:38' as column: DATE_OF_9_10_
15:44:09,865 DEBUG [StringType] returning 'M' as column: SEX10_
15:44:09,865 DEBUG [StringType] returning 'M' as column: SEX10_
15:44:09,865 DEBUG [BooleanType] returning 'true' as column: DETAILS11_10_
15:44:09,865 DEBUG [BooleanType] returning 'true' as column: DETAILS11_10_
15:44:09,865 DEBUG [TimestampType] returning '07 maggio 2004 15:43:38' as column: CREATIO12_10_
15:44:09,865 DEBUG [TimestampType] returning '07 maggio 2004 15:43:38' as column: CREATIO12_10_
15:44:09,865 DEBUG [IntegerType] returning '2211' as column: PROFESS13_10_
15:44:09,865 DEBUG [IntegerType] returning '2211' as column: PROFESS13_10_
15:44:09,865 DEBUG [IntegerType] returning '2212' as column: EDUCATI14_10_
15:44:09,865 DEBUG [IntegerType] returning '2212' as column: EDUCATI14_10_
15:44:09,865 DEBUG [PersistentEnumType] returning '2' as column: PARTY_TYPE8_
15:44:09,865 DEBUG [PersistentEnumType] returning '2' as column: PARTY_TYPE8_
15:44:09,875 DEBUG [Loader] done processing result set (1 rows)
15:44:09,875 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:09,875 DEBUG [BatcherImpl] closing statement
15:44:09,895 DEBUG [Loader] total objects hydrated: 1
15:44:09,895 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Person#58192]
15:44:09,895 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.userLogins#58192]
15:44:09,895 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.trolleys#58192]
15:44:09,895 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.shoppingLists#58192]
15:44:09,895 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.addresses#58192]
15:44:09,895 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.Profession#2211]
15:44:09,895 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.Profession#2211]
15:44:09,895 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.Profession#2211]
15:44:09,895 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.Profession#2211]
15:44:09,895 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:09,895 DEBUG [SQL] select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
Hibernate: select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
15:44:09,895 DEBUG [BatcherImpl] preparing statement
15:44:09,905 DEBUG [IntegerType] binding '2211' to parameter: 1
15:44:09,905 DEBUG [IntegerType] binding '2211' to parameter: 1
15:44:09,925 DEBUG [Loader] processing result set

15:44:09,925 DEBUG [Loader] result row: 2211
15:44:09,925 DEBUG [Loader] Initializing object from ResultSet: 2211
15:44:09,925 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Profession#2211
15:44:09,925 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:44:09,925 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:44:09,925 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:44:09,925 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:44:09,925 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:44:09,925 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:44:09,935 DEBUG [Loader] done processing result set (1 rows)
15:44:09,935 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:09,935 DEBUG [BatcherImpl] closing statement
15:44:09,935 DEBUG [Loader] total objects hydrated: 1
15:44:09,935 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Profession#2211]
15:44:09,935 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Profession#2211]
15:44:09,935 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.EducationLevel#2212]
15:44:09,935 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.EducationLevel#2212]
15:44:09,935 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.EducationLevel#2212]
15:44:09,935 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.EducationLevel#2212]
15:44:09,935 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:09,935 DEBUG [SQL] select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
Hibernate: select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
15:44:09,945 DEBUG [BatcherImpl] preparing statement
15:44:09,945 DEBUG [IntegerType] binding '2212' to parameter: 1
15:44:09,945 DEBUG [IntegerType] binding '2212' to parameter: 1
15:44:09,955 DEBUG [Loader] processing result set

15:44:09,955 DEBUG [Loader] result row: 2212
15:44:09,955 DEBUG [Loader] Initializing object from ResultSet: 2212
15:44:09,955 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.EducationLevel#2212

15:44:09,955 DEBUG [StringType] returning 'laurea' as column: ENUM_CODE0_
15:44:09,955 DEBUG [StringType] returning 'laurea' as column: ENUM_CODE0_
15:44:09,965 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:44:09,965 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:44:09,965 DEBUG [StringType] returning 'il livello di educazione della laurea' as column: DESCRIPT5_0_
15:44:09,965 DEBUG [StringType] returning 'il livello di educazione della laurea' as column: DESCRIPT5_0_
15:44:09,965 DEBUG [Loader] done processing result set (1 rows)
15:44:09,965 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:09,965 DEBUG [BatcherImpl] closing statement
15:44:09,975 DEBUG [Loader] total objects hydrated: 1
15:44:09,975 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.EducationLevel#2212]
15:44:09,975 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.EducationLevel#2212]
15:44:09,975 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58192]
15:44:09,975 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58192]
15:44:09,975 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Person#58192]
15:44:09,975 DEBUG [SessionImpl] initializing non-lazy collections
15:44:09,975 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@4d8d50] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:44:09,975 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:09,975 DEBUG [SessionImpl] reassociating transient instance: [it.esselunga.ecommerce.data.model.Customer#58190]
15:44:09,975 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:44:09,975 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:44:09,975 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:44:09,975 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:44:09,975 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:44:09,975 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:44:09,975 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@4d8d50] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:44:09,975 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.Party#58190]
15:44:09,975 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.Party#58190]
15:44:09,985 DEBUG [SessionImpl] resolved object in session cache [it.esselunga.ecommerce.data.model.Party#58190]
15:44:09,985 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@4d8d50] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:44:09,985 DEBUG [SessionImpl] deleting a persistent instance
15:44:09,985 DEBUG [SessionImpl] deleting [it.esselunga.ecommerce.data.model.Person#58192]
15:44:09,985 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:09,985 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:44:09,985 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Person.userLogins#58192]
15:44:09,985 DEBUG [SessionImpl] checking second-level cache
15:44:09,985 DEBUG [SessionImpl] collection not cached
15:44:09,985 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:09,985 DEBUG [SQL] select userlogins0_.USER_LOGIN_ID as USER_LOG1___, userlogins0_.PARTY_ID as PARTY_ID__, userlogins0_.USER_LOGIN_ID as USER_LOG1_0_, userlogins0_.USERNAME as USERNAME0_, userlogins0_.PASSWD as PASSWD0_, userlogins0_.DELETED as DELETED0_, userlogins0_.CREATION_DATE as CREATION5_0_, userlogins0_.CHANNEL_ID as CHANNEL_ID0_, userlogins0_.PARTY_ID as PARTY_ID0_ from USER_LOGIN userlogins0_ where userlogins0_.PARTY_ID=?
Hibernate: select userlogins0_.USER_LOGIN_ID as USER_LOG1___, userlogins0_.PARTY_ID as PARTY_ID__, userlogins0_.USER_LOGIN_ID as USER_LOG1_0_, userlogins0_.USERNAME as USERNAME0_, userlogins0_.PASSWD as PASSWD0_, userlogins0_.DELETED as DELETED0_, userlogins0_.CREATION_DATE as CREATION5_0_, userlogins0_.CHANNEL_ID as CHANNEL_ID0_, userlogins0_.PARTY_ID as PARTY_ID0_ from USER_LOGIN userlogins0_ where userlogins0_.PARTY_ID=?
15:44:09,985 DEBUG [BatcherImpl] preparing statement
15:44:09,985 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:09,985 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,015 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Person.userLogins#58192]
15:44:10,015 DEBUG [SessionImpl] uninitialized collection: initializing
15:44:10,015 DEBUG [Loader] processing result set

15:44:10,015 DEBUG [Loader] done processing result set (0 rows)
15:44:10,015 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,015 DEBUG [BatcherImpl] closing statement
15:44:10,025 DEBUG [Loader] total objects hydrated: 0
15:44:10,025 DEBUG [SessionImpl] 1 collections were found in result set
15:44:10,025 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Person.userLogins#58192]
15:44:10,025 DEBUG [SessionImpl] 1 collections initialized
15:44:10,025 DEBUG [SessionImpl] initializing non-lazy collections
15:44:10,025 DEBUG [SessionImpl] collection initialized
15:44:10,025 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:44:10,025 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Person.shoppingLists#58192]
15:44:10,025 DEBUG [SessionImpl] checking second-level cache
15:44:10,025 DEBUG [SessionImpl] collection not cached
15:44:10,025 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,025 DEBUG [SQL] select shoppingli0_.SHOPPING_LIST_ID as SHOPPING1___, shoppingli0_.PARTY_ID as PARTY_ID__, shoppingli0_.SHOPPING_LIST_ID as SHOPPING1_0_, shoppingli0_.LASTUPDATED as LASTUPDA2_0_, shoppingli0_.SHOPPING_LIST_NAME as SHOPPING3_0_, shoppingli0_.PARTY_ID as PARTY_ID0_, shoppingli0_.CHANNEL_ID as CHANNEL_ID0_, shoppingli0_.SHOPPING_LIST_TYPE_ID as SHOPPING6_0_, (select count(*) from SHOPPING_LIST_LINE lines where lines.SHOPPING_LIST_ID = shoppingli0_.SHOPPING_LIST_ID) as f1_0_ from SHOPPING_LIST shoppingli0_ where shoppingli0_.PARTY_ID=?
Hibernate: select shoppingli0_.SHOPPING_LIST_ID as SHOPPING1___, shoppingli0_.PARTY_ID as PARTY_ID__, shoppingli0_.SHOPPING_LIST_ID as SHOPPING1_0_, shoppingli0_.LASTUPDATED as LASTUPDA2_0_, shoppingli0_.SHOPPING_LIST_NAME as SHOPPING3_0_, shoppingli0_.PARTY_ID as PARTY_ID0_, shoppingli0_.CHANNEL_ID as CHANNEL_ID0_, shoppingli0_.SHOPPING_LIST_TYPE_ID as SHOPPING6_0_, (select count(*) from SHOPPING_LIST_LINE lines where lines.SHOPPING_LIST_ID = shoppingli0_.SHOPPING_LIST_ID) as f1_0_ from SHOPPING_LIST shoppingli0_ where shoppingli0_.PARTY_ID=?

15:44:10,025 DEBUG [BatcherImpl] preparing statement
15:44:10,025 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,025 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,055 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58192]
15:44:10,055 DEBUG [SessionImpl] uninitialized collection: initializing
15:44:10,055 DEBUG [Loader] processing result set

15:44:10,055 DEBUG [Loader] done processing result set (0 rows)
15:44:10,055 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,055 DEBUG [BatcherImpl] closing statement
15:44:10,065 DEBUG [Loader] total objects hydrated: 0
15:44:10,065 DEBUG [SessionImpl] 1 collections were found in result set
15:44:10,065 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58192]
15:44:10,065 DEBUG [SessionImpl] 1 collections initialized
15:44:10,065 DEBUG [SessionImpl] initializing non-lazy collections
15:44:10,065 DEBUG [SessionImpl] collection initialized
15:44:10,065 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:44:10,065 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Person.addresses#58192]
15:44:10,065 DEBUG [SessionImpl] checking second-level cache
15:44:10,065 DEBUG [SessionImpl] collection not cached
15:44:10,065 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,065 DEBUG [SQL] select addresses0_.ADDRESS_ID as ADDRESS_ID__, addresses0_.PARTY_ID as PARTY_ID__, addresses0_.ADDRESS_ID as ADDRESS_ID0_, addresses0_.ADDRESS_TYPE as ADDRESS_2_0_, addresses0_.ADDRESSEE as ADDRESSEE0_, addresses0_.COUNTRY as COUNTRY0_, addresses0_.REGION as REGION0_, addresses0_.PROVINCE as PROVINCE0_, addresses0_.COMMUNA as COMMUNA0_, addresses0_.STREET as STREET0_, addresses0_.POSTCODE as POSTCODE0_, addresses0_.HOUSE_NUMBER as HOUSE_N10_0_, addresses0_.PARTY_ID as PARTY_ID0_, addresses0_.TEL as TEL0_, addresses0_.IVA as IVA0_, addresses0_.COMPANY as COMPANY0_ from ADDRESS addresses0_ where addresses0_.PARTY_ID=?
Hibernate: select addresses0_.ADDRESS_ID as ADDRESS_ID__, addresses0_.PARTY_ID as PARTY_ID__, addresses0_.ADDRESS_ID as ADDRESS_ID0_, addresses0_.ADDRESS_TYPE as ADDRESS_2_0_, addresses0_.ADDRESSEE as ADDRESSEE0_, addresses0_.COUNTRY as COUNTRY0_, addresses0_.REGION as REGION0_, addresses0_.PROVINCE as PROVINCE0_, addresses0_.COMMUNA as COMMUNA0_, addresses0_.STREET as STREET0_, addresses0_.POSTCODE as POSTCODE0_, addresses0_.HOUSE_NUMBER as HOUSE_N10_0_, addresses0_.PARTY_ID as PARTY_ID0_, addresses0_.TEL as TEL0_, addresses0_.IVA as IVA0_, addresses0_.COMPANY as COMPANY0_ from ADDRESS addresses0_ where addresses0_.PARTY_ID=?
15:44:10,065 DEBUG [BatcherImpl] preparing statement
15:44:10,065 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,065 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,095 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Person.addresses#58192]
15:44:10,095 DEBUG [SessionImpl] uninitialized collection: initializing
15:44:10,095 DEBUG [Loader] processing result set

15:44:10,095 DEBUG [Loader] done processing result set (0 rows)
15:44:10,095 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,095 DEBUG [BatcherImpl] closing statement
15:44:10,105 DEBUG [Loader] total objects hydrated: 0
15:44:10,105 DEBUG [SessionImpl] 1 collections were found in result set
15:44:10,105 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Person.addresses#58192]
15:44:10,105 DEBUG [SessionImpl] 1 collections initialized
15:44:10,105 DEBUG [SessionImpl] initializing non-lazy collections
15:44:10,105 DEBUG [SessionImpl] collection initialized
15:44:10,105 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,105 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,105 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,105 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@4d8d50] for key [net.sf.hibernate.impl.SessionFactoryImpl@39bf12] bound to thread [main]
15:44:10,105 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,105 DEBUG [SQL] select PARTY_SEQ.nextval from dual
Hibernate: select PARTY_SEQ.nextval from dual
15:44:10,105 DEBUG [BatcherImpl] preparing statement
15:44:10,155 DEBUG [SequenceGenerator] Sequence identifier generated: 58193
15:44:10,155 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,155 DEBUG [BatcherImpl] closing statement
15:44:10,155 DEBUG [SessionImpl] generated identifier: 58193
15:44:10,155 DEBUG [SessionImpl] saving [it.esselunga.ecommerce.data.model.Person#58193]
15:44:10,155 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,155 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,155 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,155 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,155 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,155 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:44:10,155 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:44:10,165 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,165 DEBUG [HibernateInterceptor] Not closing pre-bound Hibernate session after interceptor

15:44:10,165 DEBUG [TransactionInterceptor] Invoking commit for transaction on method 'updateCustomer' in class [it.esselunga.ecommerce.services.party.PartyService]
15:44:10,165 DEBUG [HibernateTransactionManager] Triggering beforeCommit synchronization
15:44:10,165 DEBUG [HibernateTransactionManager] Triggering beforeCompletion synchronization
15:44:10,165 INFO [HibernateTransactionManager] Initiating transaction commit
15:44:10,165 DEBUG [HibernateTransactionManager] Committing Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@161c9d1]
15:44:10,165 DEBUG [JDBCTransaction] commit
15:44:10,165 DEBUG [SessionImpl] flushing session

15:44:10,165 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:44:10,165 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:44:10,165 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:44:10,165 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:44:10,165 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:44:10,165 DEBUG [SessionImpl] Collection dirty: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190]
15:44:10,165 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:44:10,165 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58190], was: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58190]
15:44:10,165 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58190], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58190]
15:44:10,175 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58190], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58190]
15:44:10,175 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58190], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58190]
15:44:10,175 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58190], was: [it.esselunga.ecommerce.data.model.Person.addresses#58190]
15:44:10,175 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190]
15:44:10,175 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58190], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58190]
15:44:10,175 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.userLogins
15:44:10,175 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.trolleys
15:44:10,175 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:44:10,175 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.addresses
15:44:10,185 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom
15:44:10,185 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesTo
15:44:10,185 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58193], was: [<unreferenced>]
15:44:10,185 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58193], was: [<unreferenced>]
15:44:10,205 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58193], was: [<unreferenced>]
15:44:10,205 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58193], was: [<unreferenced>]
15:44:10,205 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58193], was: [<unreferenced>]
15:44:10,205 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58193], was: [<unreferenced>]
15:44:10,205 DEBUG [SessionImpl] Processing unreferenced collections
15:44:10,205 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.userLogins#58192]
15:44:10,205 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.trolleys#58192]
15:44:10,205 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58192]
15:44:10,205 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.addresses#58192]
15:44:10,205 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58192]
15:44:10,205 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58192]
15:44:10,205 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:44:10,205 DEBUG [SessionImpl] Flushed: 1 insertions, 0 updates, 1 deletions to 5 objects
15:44:10,205 DEBUG [SessionImpl] Flushed: 6 (re)creations, 1 updates, 6 removals to 19 collections
15:44:10,205 DEBUG [Printer] listing entities:
15:44:10,205 DEBUG [Printer] it.esselunga.ecommerce.data.model.Profession{enumId=2211, description=il mestiere piu antico del mondo, enumCode=ingegnere, sequence=1}
15:44:10,205 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=[], partyId=58193, forename=cognome2, title=Mr., educationLevel=EducationLevel#2212, profession=Profession#2211, shoppingLists=[], creationDate=07 maggio 2004 15:43:45, homeTel=02-57402284, relatedPartiesTo=[PartyRelationship{relationshipType=RelativeType#2210, throughDate=null, relatedParty=Customer#58190, description=null, fromDate=null}], sex=M, surname=parente2, dateOfBirth=11 novembre 1976 15:43:45, detailsPrivate=true, partyType=2, userLogins=[], email=email-parente2@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=[], trolleys=[], mobileTel=347-0077078}
15:44:10,215 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=[], partyId=58192, forename=cognome1, title=Mr., educationLevel=EducationLevel#2212, profession=Profession#2211, shoppingLists=[], creationDate=07 maggio 2004 15:43:38, homeTel=02-57402284, relatedPartiesTo=uninitialized, sex=M, surname=parente1, dateOfBirth=11 novembre 1976 15:43:38, detailsPrivate=true, partyType=2, userLogins=[], email=email-parente1@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=uninitialized, trolleys=uninitialized, mobileTel=347-0077078}
15:44:10,215 DEBUG [Printer] it.esselunga.ecommerce.data.model.EducationLevel{enumId=2212, description=il livello di educazione della laurea, enumCode=laurea, sequence=1}
15:44:10,215 DEBUG [Printer] it.esselunga.ecommerce.data.model.Customer{partyId=58190, addresses=uninitialized, title=Mr., homeTel=02-57402284, sendInfo=true, relatedPartiesTo=uninitialized, sex=M, fidelityCardNumber=601724305345034, partyType=2, relatedPartiesFrom=[PartyRelationship{relationshipType=RelativeType#2210, throughDate=null, relatedParty=Person#58193, description=null, fromDate=null}], forename=pluto, deliveryAddresses=uninitialized, howManyRelatives=2, fidelityCardType=GOLD , educationLevel=EducationLevel#2212, creationDate=07 maggio 2004 15:43:21, shoppingLists=uninitialized, profession=Profession#2211, newCardNumber=true, surname=pippo, dateOfBirth=13 febbraio 1973 15:43:21, detailsPrivate=true, userLogins=uninitialized, workTel=347-0077078, email=pippo@pluto.com, trolleys=uninitialized, mobileTel=347-0077078}
15:44:10,215 DEBUG [SessionImpl] executing flush
15:44:10,215 DEBUG [NormalizedEntityPersister] Inserting entity: [it.esselunga.ecommerce.data.model.Person#58193]
15:44:10,215 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,215 DEBUG [SQL] insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
Hibernate: insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
15:44:10,215 DEBUG [BatcherImpl] preparing statement
15:44:10,215 DEBUG [BatcherImpl] about to open: 1 open PreparedStatements, 0 open ResultSets
15:44:10,215 DEBUG [SQL] insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
Hibernate: insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
15:44:10,215 DEBUG [BatcherImpl] preparing statement
15:44:10,215 DEBUG [NormalizedEntityPersister] Dehydrating entity: [it.esselunga.ecommerce.data.model.Person#58193]
15:44:10,225 DEBUG [PersistentEnumType] binding '2' to parameter: 1
15:44:10,225 DEBUG [PersistentEnumType] binding '2' to parameter: 1
15:44:10,225 DEBUG [IntegerType] binding '58193' to parameter: 2
15:44:10,225 DEBUG [IntegerType] binding '58193' to parameter: 2
15:44:10,225 DEBUG [StringType] binding 'Mr.' to parameter: 1
15:44:10,225 DEBUG [StringType] binding 'Mr.' to parameter: 1
15:44:10,225 DEBUG [StringType] binding 'parente2' to parameter: 2
15:44:10,225 DEBUG [StringType] binding 'parente2' to parameter: 2
15:44:10,225 DEBUG [StringType] binding 'cognome2' to parameter: 3
15:44:10,225 DEBUG [StringType] binding 'cognome2' to parameter: 3
15:44:10,225 DEBUG [StringType] binding 'email-parente2@updatecustomer.it' to parameter: 4
15:44:10,225 DEBUG [StringType] binding 'email-parente2@updatecustomer.it' to parameter: 4
15:44:10,225 DEBUG [StringType] binding '02-57402284' to parameter: 5
15:44:10,225 DEBUG [StringType] binding '02-57402284' to parameter: 5
15:44:10,225 DEBUG [StringType] binding '347-0077078' to parameter: 6
15:44:10,225 DEBUG [StringType] binding '347-0077078' to parameter: 6
15:44:10,225 DEBUG [StringType] binding '347-0077078' to parameter: 7
15:44:10,225 DEBUG [StringType] binding '347-0077078' to parameter: 7
15:44:10,225 DEBUG [TimestampType] binding '11 novembre 1976 15:43:45' to parameter: 8
15:44:10,225 DEBUG [TimestampType] binding '11 novembre 1976 15:43:45' to parameter: 8
15:44:10,225 DEBUG [StringType] binding 'M' to parameter: 9
15:44:10,225 DEBUG [StringType] binding 'M' to parameter: 9
15:44:10,225 DEBUG [BooleanType] binding 'true' to parameter: 10
15:44:10,225 DEBUG [BooleanType] binding 'true' to parameter: 10
15:44:10,225 DEBUG [TimestampType] binding '07 maggio 2004 15:43:45' to parameter: 11
15:44:10,225 DEBUG [TimestampType] binding '07 maggio 2004 15:43:45' to parameter: 11
15:44:10,225 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,225 DEBUG [IntegerType] binding '2211' to parameter: 12
15:44:10,225 DEBUG [IntegerType] binding '2211' to parameter: 12
15:44:10,225 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,225 DEBUG [IntegerType] binding '2212' to parameter: 13
15:44:10,225 DEBUG [IntegerType] binding '2212' to parameter: 13
15:44:10,225 DEBUG [IntegerType] binding '58193' to parameter: 14
15:44:10,225 DEBUG [IntegerType] binding '58193' to parameter: 14
15:44:10,255 DEBUG [BatcherImpl] done closing: 1 open PreparedStatements, 0 open ResultSets
15:44:10,255 DEBUG [BatcherImpl] closing statement
15:44:10,255 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,255 DEBUG [BatcherImpl] closing statement
15:44:10,265 DEBUG [BasicCollectionPersister] Deleting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58192]
15:44:10,265 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,265 DEBUG [SQL] delete from PARTY_RELATIONSHIP where PARTY_ID_TO=?
Hibernate: delete from PARTY_RELATIONSHIP where PARTY_ID_TO=?
15:44:10,265 DEBUG [BatcherImpl] preparing statement
15:44:10,265 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,265 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,265 DEBUG [BatcherImpl] Adding to batch
15:44:10,265 DEBUG [BasicCollectionPersister] done deleting collection
15:44:10,265 DEBUG [BatcherImpl] Executing batch size: 1
15:44:10,275 DEBUG [BatcherImpl] success of batch update unknown: 0
15:44:10,275 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,275 DEBUG [BatcherImpl] closing statement
15:44:10,275 DEBUG [BasicCollectionPersister] Deleting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190]
15:44:10,275 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,275 DEBUG [SQL] delete from PARTY_RELATIONSHIP where PARTY_ID_TO=? and FROM_DATE=? and THRU_DATE=? and DESCRIPTION=? and RELATIONSHIP_TYPE_ID=? and PARTY_ID_FROM=?
Hibernate: delete from PARTY_RELATIONSHIP where PARTY_ID_TO=? and FROM_DATE=? and THRU_DATE=? and DESCRIPTION=? and RELATIONSHIP_TYPE_ID=? and PARTY_ID_FROM=?
15:44:10,285 DEBUG [BatcherImpl] preparing statement
15:44:10,285 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,285 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,285 DEBUG [StringType] binding null to parameter: 4
15:44:10,285 DEBUG [StringType] binding null to parameter: 4
15:44:10,285 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,285 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,285 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,285 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,285 DEBUG [IntegerType] binding '58192' to parameter: 6
15:44:10,285 DEBUG [IntegerType] binding '58192' to parameter: 6
15:44:10,285 DEBUG [BatcherImpl] Adding to batch
15:44:10,285 DEBUG [BasicCollectionPersister] done deleting collection rows: 1 deleted
15:44:10,285 DEBUG [BasicCollectionPersister] Updating rows of collection: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190
15:44:10,285 DEBUG [BasicCollectionPersister] done updating rows: 0 updated
15:44:10,285 DEBUG [BasicCollectionPersister] Inserting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190]
15:44:10,285 DEBUG [BatcherImpl] Executing batch size: 1
15:44:10,295 DEBUG [BatcherImpl] success of batch update unknown: 0
15:44:10,295 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,295 DEBUG [BatcherImpl] closing statement
15:44:10,305 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,305 DEBUG [SQL] insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
Hibernate: insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
15:44:10,305 DEBUG [BatcherImpl] preparing statement
15:44:10,305 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,305 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,305 DEBUG [StringType] binding null to parameter: 4
15:44:10,305 DEBUG [StringType] binding null to parameter: 4
15:44:10,305 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,305 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,305 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,305 DEBUG [IntegerType] binding '58193' to parameter: 6
15:44:10,305 DEBUG [IntegerType] binding '58193' to parameter: 6
15:44:10,305 DEBUG [BatcherImpl] Adding to batch
15:44:10,305 DEBUG [BasicCollectionPersister] done inserting rows: 1 inserted
15:44:10,305 DEBUG [BatcherImpl] Executing batch size: 1
15:44:10,325 DEBUG [BatcherImpl] success of batch update unknown: 0
15:44:10,325 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,325 DEBUG [BatcherImpl] closing statement
15:44:10,335 DEBUG [BasicCollectionPersister] Inserting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58193]
15:44:10,335 DEBUG [BasicCollectionPersister] collection was empty
15:44:10,335 DEBUG [NormalizedEntityPersister] Deleting entity: [it.esselunga.ecommerce.data.model.Person#58192]
15:44:10,335 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,335 DEBUG [SQL] delete from PARTY where PARTY_ID=?
Hibernate: delete from PARTY where PARTY_ID=?
15:44:10,335 DEBUG [BatcherImpl] preparing statement
15:44:10,335 DEBUG [BatcherImpl] about to open: 1 open PreparedStatements, 0 open ResultSets
15:44:10,335 DEBUG [SQL] delete from PERSON where PARTY_ID=?
Hibernate: delete from PERSON where PARTY_ID=?
15:44:10,335 DEBUG [BatcherImpl] preparing statement
15:44:10,335 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,335 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,345 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,345 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,375 DEBUG [JDBCExceptionReporter] SQL Exception
java.sql.SQLException: ORA-02292: restrizione di integrit

Top

immanuel

Post subject:

Posted: Fri May 07, 2004 9:48 am

Regular

Joined: Tue Jan 13, 2004 4:57 am
Posts: 83

Shit, it seems the logs are too long: I retry attaching the non working case, only the last part, where the relationship deletion is performed and anyway an exception is thrown.

[code]
15:44:10,275 DEBUG [BasicCollectionPersister] Deleting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190]
15:44:10,275 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,275 DEBUG [SQL] delete from PARTY_RELATIONSHIP where PARTY_ID_TO=? and FROM_DATE=? and THRU_DATE=? and DESCRIPTION=? and RELATIONSHIP_TYPE_ID=? and PARTY_ID_FROM=?
Hibernate: delete from PARTY_RELATIONSHIP where PARTY_ID_TO=? and FROM_DATE=? and THRU_DATE=? and DESCRIPTION=? and RELATIONSHIP_TYPE_ID=? and PARTY_ID_FROM=?
15:44:10,285 DEBUG [BatcherImpl] preparing statement
15:44:10,285 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,285 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,285 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,285 DEBUG [StringType] binding null to parameter: 4
15:44:10,285 DEBUG [StringType] binding null to parameter: 4
15:44:10,285 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,285 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,285 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,285 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,285 DEBUG [IntegerType] binding '58192' to parameter: 6
15:44:10,285 DEBUG [IntegerType] binding '58192' to parameter: 6
15:44:10,285 DEBUG [BatcherImpl] Adding to batch
15:44:10,285 DEBUG [BasicCollectionPersister] done deleting collection rows: 1 deleted
15:44:10,285 DEBUG [BasicCollectionPersister] Updating rows of collection: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190
15:44:10,285 DEBUG [BasicCollectionPersister] done updating rows: 0 updated
15:44:10,285 DEBUG [BasicCollectionPersister] Inserting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58190]
15:44:10,285 DEBUG [BatcherImpl] Executing batch size: 1
15:44:10,295 DEBUG [BatcherImpl] success of batch update unknown: 0
15:44:10,295 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,295 DEBUG [BatcherImpl] closing statement
15:44:10,305 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,305 DEBUG [SQL] insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
Hibernate: insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
15:44:10,305 DEBUG [BatcherImpl] preparing statement
15:44:10,305 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,305 DEBUG [IntegerType] binding '58190' to parameter: 1
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 2
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,305 DEBUG [TimestampType] binding null to parameter: 3
15:44:10,305 DEBUG [StringType] binding null to parameter: 4
15:44:10,305 DEBUG [StringType] binding null to parameter: 4
15:44:10,305 DEBUG [Cascades] id unsaved-value strategy NULL
15:44:10,305 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,305 DEBUG [IntegerType] binding '2210' to parameter: 5
15:44:10,305 DEBUG [IntegerType] binding '58193' to parameter: 6
15:44:10,305 DEBUG [IntegerType] binding '58193' to parameter: 6
15:44:10,305 DEBUG [BatcherImpl] Adding to batch
15:44:10,305 DEBUG [BasicCollectionPersister] done inserting rows: 1 inserted
15:44:10,305 DEBUG [BatcherImpl] Executing batch size: 1
15:44:10,325 DEBUG [BatcherImpl] success of batch update unknown: 0
15:44:10,325 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:44:10,325 DEBUG [BatcherImpl] closing statement
15:44:10,335 DEBUG [BasicCollectionPersister] Inserting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58193]
15:44:10,335 DEBUG [BasicCollectionPersister] collection was empty
15:44:10,335 DEBUG [NormalizedEntityPersister] Deleting entity: [it.esselunga.ecommerce.data.model.Person#58192]
15:44:10,335 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:44:10,335 DEBUG [SQL] delete from PARTY where PARTY_ID=?
Hibernate: delete from PARTY where PARTY_ID=?
15:44:10,335 DEBUG [BatcherImpl] preparing statement
15:44:10,335 DEBUG [BatcherImpl] about to open: 1 open PreparedStatements, 0 open ResultSets
15:44:10,335 DEBUG [SQL] delete from PERSON where PARTY_ID=?
Hibernate: delete from PERSON where PARTY_ID=?
15:44:10,335 DEBUG [BatcherImpl] preparing statement
15:44:10,335 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,335 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,345 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,345 DEBUG [IntegerType] binding '58192' to parameter: 1
15:44:10,375 DEBUG [JDBCExceptionReporter] SQL Exception
java.sql.SQLException: ORA-02292: restrizione di integrit

Top

immanuel

Post subject:

Posted: Fri May 07, 2004 9:52 am

Regular

Joined: Tue Jan 13, 2004 4:57 am
Posts: 83

And this is the working case log, for the same situation, with the flush inside and in the more readable form as above:

[code]
15:51:30,478 INFO [SpringHibernatePartyService] updating customer it.esselunga.ecommerce.data.model.Customer@125d568[partyId=58195] with relatives map {it.esselunga.ecommerce.data.model.Person@1cfa965[partyId=<null>]=2213}
15:51:30,478 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@2ee7e5] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:30,478 DEBUG [SessionImpl] find: select relationship.relatedParty from Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:51:30,478 DEBUG [QueryParameters] parameters: [58195]
15:51:30,478 DEBUG [SessionImpl] flushing session

15:51:30,478 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:51:30,478 DEBUG [SessionImpl] Processing unreferenced collections
15:51:30,478 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:51:30,478 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
15:51:30,478 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
15:51:30,478 DEBUG [SessionImpl] Dont need to execute flush
15:51:30,478 DEBUG [QueryTranslator] HQL: select relationship.relatedParty from it.esselunga.ecommerce.data.model.Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:51:30,478 DEBUG [QueryTranslator] SQL: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:51:30,488 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,488 DEBUG [SQL] select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
Hibernate: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID and party3_.PARTY_ID=party3__1_.PARTY_ID(+) and party3_.PARTY_ID=party3__2_.PARTY_ID(+) and party3_.PARTY_ID=party3__3_.PARTY_ID(+) and ((person0_.PARTY_ID=? )and(partyrelat2_.ENUM_TYPE='RelativeType' and relatedpar1_.RELATIONSHIP_TYPE_ID=partyrelat2_.ENUM_ID))
15:51:30,498 DEBUG [BatcherImpl] preparing statement
15:51:30,498 DEBUG [IntegerType] binding '58195' to parameter: 1
15:51:30,498 DEBUG [IntegerType] binding '58195' to parameter: 1
15:51:30,528 DEBUG [Loader] processing result set

15:51:30,528 DEBUG [IntegerType] returning '58197' as column: PARTY_ID
15:51:30,528 DEBUG [IntegerType] returning '58197' as column: PARTY_ID
15:51:30,528 DEBUG [Loader] result row: 58197
15:51:30,528 DEBUG [IntegerType] returning '2' as column: clazz_
15:51:30,528 DEBUG [IntegerType] returning '2' as column: clazz_
15:51:30,528 DEBUG [Loader] Initializing object from ResultSet: 58197
15:51:30,528 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Person#58197
15:51:30,528 DEBUG [StringType] returning 'Mr.' as column: TITLE10_
15:51:30,528 DEBUG [StringType] returning 'Mr.' as column: TITLE10_
15:51:30,528 DEBUG [StringType] returning 'parente1' as column: SURNAME10_
15:51:30,528 DEBUG [StringType] returning 'parente1' as column: SURNAME10_
15:51:30,528 DEBUG [StringType] returning 'cognome1' as column: FORENAME10_
15:51:30,528 DEBUG [StringType] returning 'cognome1' as column: FORENAME10_
15:51:30,528 DEBUG [StringType] returning 'email-parente1@updatecustomer.it' as column: EMAIL10_
15:51:30,528 DEBUG [StringType] returning 'email-parente1@updatecustomer.it' as column: EMAIL10_
15:51:30,538 DEBUG [StringType] returning '02-57402284' as column: HOME_TEL10_
15:51:30,538 DEBUG [StringType] returning '02-57402284' as column: HOME_TEL10_
15:51:30,538 DEBUG [StringType] returning '347-0077078' as column: WORK_TEL10_
15:51:30,538 DEBUG [StringType] returning '347-0077078' as column: WORK_TEL10_
15:51:30,538 DEBUG [StringType] returning '347-0077078' as column: MOBILE_TEL10_
15:51:30,538 DEBUG [StringType] returning '347-0077078' as column: MOBILE_TEL10_
15:51:30,538 DEBUG [TimestampType] returning '11 novembre 1976 15:50:35' as column: DATE_OF_9_10_
15:51:30,538 DEBUG [TimestampType] returning '11 novembre 1976 15:50:35' as column: DATE_OF_9_10_
15:51:30,538 DEBUG [StringType] returning 'M' as column: SEX10_
15:51:30,538 DEBUG [StringType] returning 'M' as column: SEX10_
15:51:30,538 DEBUG [BooleanType] returning 'true' as column: DETAILS11_10_
15:51:30,538 DEBUG [BooleanType] returning 'true' as column: DETAILS11_10_
15:51:30,538 DEBUG [TimestampType] returning '07 maggio 2004 15:50:35' as column: CREATIO12_10_
15:51:30,538 DEBUG [TimestampType] returning '07 maggio 2004 15:50:35' as column: CREATIO12_10_
15:51:30,538 DEBUG [IntegerType] returning '2214' as column: PROFESS13_10_
15:51:30,538 DEBUG [IntegerType] returning '2214' as column: PROFESS13_10_
15:51:30,538 DEBUG [IntegerType] returning '2215' as column: EDUCATI14_10_
15:51:30,538 DEBUG [IntegerType] returning '2215' as column: EDUCATI14_10_
15:51:30,538 DEBUG [PersistentEnumType] returning '2' as column: PARTY_TYPE8_
15:51:30,538 DEBUG [PersistentEnumType] returning '2' as column: PARTY_TYPE8_
15:51:30,548 DEBUG [Loader] done processing result set (1 rows)
15:51:30,548 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,548 DEBUG [BatcherImpl] closing statement
15:51:30,548 DEBUG [Loader] total objects hydrated: 1
15:51:30,548 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Person#58197]
15:51:30,548 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.userLogins#58197]
15:51:30,548 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.trolleys#58197]
15:51:30,548 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.shoppingLists#58197]
15:51:30,558 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Person.addresses#58197]
15:51:30,558 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.Profession#2214]
15:51:30,558 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.Profession#2214]
15:51:30,558 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.Profession#2214]
15:51:30,558 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.Profession#2214]
15:51:30,558 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,558 DEBUG [SQL] select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
Hibernate: select profession0_.ENUM_ID as ENUM_ID0_, profession0_.ENUM_CODE as ENUM_CODE0_, profession0_.SEQUENCE as SEQUENCE0_, profession0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION profession0_ where profession0_.ENUM_ID=?
15:51:30,558 DEBUG [BatcherImpl] preparing statement
15:51:30,558 DEBUG [IntegerType] binding '2214' to parameter: 1
15:51:30,558 DEBUG [IntegerType] binding '2214' to parameter: 1
15:51:30,648 DEBUG [Loader] processing result set

15:51:30,648 DEBUG [Loader] result row: 2214
15:51:30,648 DEBUG [Loader] Initializing object from ResultSet: 2214
15:51:30,648 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.Profession#2214
15:51:30,648 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:51:30,648 DEBUG [StringType] returning 'ingegnere' as column: ENUM_CODE0_
15:51:30,648 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:51:30,648 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:51:30,648 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:51:30,648 DEBUG [StringType] returning 'il mestiere piu antico del mondo' as column: DESCRIPT5_0_
15:51:30,658 DEBUG [Loader] done processing result set (1 rows)
15:51:30,658 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,658 DEBUG [BatcherImpl] closing statement
15:51:30,668 DEBUG [Loader] total objects hydrated: 1
15:51:30,668 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.Profession#2214]
15:51:30,668 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Profession#2214]
15:51:30,668 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.EducationLevel#2215]
15:51:30,668 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.EducationLevel#2215]
15:51:30,668 DEBUG [SessionImpl] object not resolved in any cache [it.esselunga.ecommerce.data.model.EducationLevel#2215]
15:51:30,668 DEBUG [EntityPersister] Materializing entity: [it.esselunga.ecommerce.data.model.EducationLevel#2215]
15:51:30,668 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,668 DEBUG [SQL] select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
Hibernate: select educationl0_.ENUM_ID as ENUM_ID0_, educationl0_.ENUM_CODE as ENUM_CODE0_, educationl0_.SEQUENCE as SEQUENCE0_, educationl0_.DESCRIPTION as DESCRIPT5_0_ from ENUMERATION educationl0_ where educationl0_.ENUM_ID=?
15:51:30,668 DEBUG [BatcherImpl] preparing statement
15:51:30,668 DEBUG [IntegerType] binding '2215' to parameter: 1
15:51:30,668 DEBUG [IntegerType] binding '2215' to parameter: 1
15:51:30,688 DEBUG [Loader] processing result set

15:51:30,688 DEBUG [Loader] result row: 2215
15:51:30,688 DEBUG [Loader] Initializing object from ResultSet: 2215
15:51:30,688 DEBUG [Loader] Hydrating entity: it.esselunga.ecommerce.data.model.EducationLevel#2215

15:51:30,688 DEBUG [StringType] returning 'laurea' as column: ENUM_CODE0_
15:51:30,688 DEBUG [StringType] returning 'laurea' as column: ENUM_CODE0_
15:51:30,698 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:51:30,698 DEBUG [IntegerType] returning '1' as column: SEQUENCE0_
15:51:30,698 DEBUG [StringType] returning 'il livello di educazione della laurea' as column: DESCRIPT5_0_
15:51:30,698 DEBUG [StringType] returning 'il livello di educazione della laurea' as column: DESCRIPT5_0_
15:51:30,698 DEBUG [Loader] done processing result set (1 rows)
15:51:30,698 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,698 DEBUG [BatcherImpl] closing statement
15:51:30,698 DEBUG [Loader] total objects hydrated: 1
15:51:30,698 DEBUG [SessionImpl] resolving associations for [it.esselunga.ecommerce.data.model.EducationLevel#2215]
15:51:30,698 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.EducationLevel#2215]
15:51:30,708 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58197]
15:51:30,708 DEBUG [SessionImpl] creating collection wrapper:[it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58197]
15:51:30,708 DEBUG [SessionImpl] done materializing entity [it.esselunga.ecommerce.data.model.Person#58197]
15:51:30,708 DEBUG [SessionImpl] initializing non-lazy collections
15:51:30,708 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@2ee7e5] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:30,708 DEBUG [Cascades] id unsaved-value strategy NULL
15:51:30,708 DEBUG [SessionImpl] reassociating transient instance: [it.esselunga.ecommerce.data.model.Customer#58195]
15:51:30,708 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:51:30,708 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:51:30,708 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:51:30,708 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:51:30,708 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:51:30,708 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:51:30,708 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@2ee7e5] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:30,708 DEBUG [SessionImpl] loading [it.esselunga.ecommerce.data.model.Party#58195]
15:51:30,708 DEBUG [SessionImpl] attempting to resolve [it.esselunga.ecommerce.data.model.Party#58195]
15:51:30,708 DEBUG [SessionImpl] resolved object in session cache [it.esselunga.ecommerce.data.model.Party#58195]
15:51:30,708 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@2ee7e5] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:30,708 DEBUG [SessionImpl] deleting a persistent instance
15:51:30,708 DEBUG [SessionImpl] deleting [it.esselunga.ecommerce.data.model.Person#58197]
15:51:30,708 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:30,718 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:51:30,718 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Person.userLogins#58197]
15:51:30,718 DEBUG [SessionImpl] checking second-level cache
15:51:30,718 DEBUG [SessionImpl] collection not cached
15:51:30,718 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,718 DEBUG [SQL] select userlogins0_.USER_LOGIN_ID as USER_LOG1___, userlogins0_.PARTY_ID as PARTY_ID__, userlogins0_.USER_LOGIN_ID as USER_LOG1_0_, userlogins0_.USERNAME as USERNAME0_, userlogins0_.PASSWD as PASSWD0_, userlogins0_.DELETED as DELETED0_, userlogins0_.CREATION_DATE as CREATION5_0_, userlogins0_.CHANNEL_ID as CHANNEL_ID0_, userlogins0_.PARTY_ID as PARTY_ID0_ from USER_LOGIN userlogins0_ where userlogins0_.PARTY_ID=?
Hibernate: select userlogins0_.USER_LOGIN_ID as USER_LOG1___, userlogins0_.PARTY_ID as PARTY_ID__, userlogins0_.USER_LOGIN_ID as USER_LOG1_0_, userlogins0_.USERNAME as USERNAME0_, userlogins0_.PASSWD as PASSWD0_, userlogins0_.DELETED as DELETED0_, userlogins0_.CREATION_DATE as CREATION5_0_, userlogins0_.CHANNEL_ID as CHANNEL_ID0_, userlogins0_.PARTY_ID as PARTY_ID0_ from USER_LOGIN userlogins0_ where userlogins0_.PARTY_ID=?
15:51:30,718 DEBUG [BatcherImpl] preparing statement
15:51:30,718 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,718 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,749 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Person.userLogins#58197]
15:51:30,749 DEBUG [SessionImpl] uninitialized collection: initializing
15:51:30,749 DEBUG [Loader] processing result set

15:51:30,749 DEBUG [Loader] done processing result set (0 rows)
15:51:30,749 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,749 DEBUG [BatcherImpl] closing statement
15:51:30,759 DEBUG [Loader] total objects hydrated: 0
15:51:30,759 DEBUG [SessionImpl] 1 collections were found in result set
15:51:30,759 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Person.userLogins#58197]
15:51:30,759 DEBUG [SessionImpl] 1 collections initialized
15:51:30,759 DEBUG [SessionImpl] initializing non-lazy collections
15:51:30,759 DEBUG [SessionImpl] collection initialized
15:51:30,759 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:51:30,759 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Person.shoppingLists#58197]
15:51:30,759 DEBUG [SessionImpl] checking second-level cache
15:51:30,759 DEBUG [SessionImpl] collection not cached
15:51:30,759 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,759 DEBUG [SQL] select shoppingli0_.SHOPPING_LIST_ID as SHOPPING1___, shoppingli0_.PARTY_ID as PARTY_ID__, shoppingli0_.SHOPPING_LIST_ID as SHOPPING1_0_, shoppingli0_.LASTUPDATED as LASTUPDA2_0_, shoppingli0_.SHOPPING_LIST_NAME as SHOPPING3_0_, shoppingli0_.PARTY_ID as PARTY_ID0_, shoppingli0_.CHANNEL_ID as CHANNEL_ID0_, shoppingli0_.SHOPPING_LIST_TYPE_ID as SHOPPING6_0_, (select count(*) from SHOPPING_LIST_LINE lines where lines.SHOPPING_LIST_ID = shoppingli0_.SHOPPING_LIST_ID) as f1_0_ from SHOPPING_LIST shoppingli0_ where shoppingli0_.PARTY_ID=?
Hibernate: select shoppingli0_.SHOPPING_LIST_ID as SHOPPING1___, shoppingli0_.PARTY_ID as PARTY_ID__, shoppingli0_.SHOPPING_LIST_ID as SHOPPING1_0_, shoppingli0_.LASTUPDATED as LASTUPDA2_0_, shoppingli0_.SHOPPING_LIST_NAME as SHOPPING3_0_, shoppingli0_.PARTY_ID as PARTY_ID0_, shoppingli0_.CHANNEL_ID as CHANNEL_ID0_, shoppingli0_.SHOPPING_LIST_TYPE_ID as SHOPPING6_0_, (select count(*) from SHOPPING_LIST_LINE lines where lines.SHOPPING_LIST_ID = shoppingli0_.SHOPPING_LIST_ID) as f1_0_ from SHOPPING_LIST shoppingli0_ where shoppingli0_.PARTY_ID=?

15:51:30,819 DEBUG [BatcherImpl] preparing statement
15:51:30,819 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,819 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,839 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58197]
15:51:30,839 DEBUG [SessionImpl] uninitialized collection: initializing
15:51:30,839 DEBUG [Loader] processing result set

15:51:30,849 DEBUG [Loader] done processing result set (0 rows)
15:51:30,849 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,849 DEBUG [BatcherImpl] closing statement
15:51:30,849 DEBUG [Loader] total objects hydrated: 0
15:51:30,849 DEBUG [SessionImpl] 1 collections were found in result set
15:51:30,849 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58197]
15:51:30,849 DEBUG [SessionImpl] 1 collections initialized
15:51:30,849 DEBUG [SessionImpl] initializing non-lazy collections
15:51:30,849 DEBUG [SessionImpl] collection initialized
15:51:30,849 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:51:30,849 DEBUG [SessionImpl] initializing collection [it.esselunga.ecommerce.data.model.Person.addresses#58197]
15:51:30,849 DEBUG [SessionImpl] checking second-level cache
15:51:30,849 DEBUG [SessionImpl] collection not cached
15:51:30,849 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,849 DEBUG [SQL] select addresses0_.ADDRESS_ID as ADDRESS_ID__, addresses0_.PARTY_ID as PARTY_ID__, addresses0_.ADDRESS_ID as ADDRESS_ID0_, addresses0_.ADDRESS_TYPE as ADDRESS_2_0_, addresses0_.ADDRESSEE as ADDRESSEE0_, addresses0_.COUNTRY as COUNTRY0_, addresses0_.REGION as REGION0_, addresses0_.PROVINCE as PROVINCE0_, addresses0_.COMMUNA as COMMUNA0_, addresses0_.STREET as STREET0_, addresses0_.POSTCODE as POSTCODE0_, addresses0_.HOUSE_NUMBER as HOUSE_N10_0_, addresses0_.PARTY_ID as PARTY_ID0_, addresses0_.TEL as TEL0_, addresses0_.IVA as IVA0_, addresses0_.COMPANY as COMPANY0_ from ADDRESS addresses0_ where addresses0_.PARTY_ID=?
Hibernate: select addresses0_.ADDRESS_ID as ADDRESS_ID__, addresses0_.PARTY_ID as PARTY_ID__, addresses0_.ADDRESS_ID as ADDRESS_ID0_, addresses0_.ADDRESS_TYPE as ADDRESS_2_0_, addresses0_.ADDRESSEE as ADDRESSEE0_, addresses0_.COUNTRY as COUNTRY0_, addresses0_.REGION as REGION0_, addresses0_.PROVINCE as PROVINCE0_, addresses0_.COMMUNA as COMMUNA0_, addresses0_.STREET as STREET0_, addresses0_.POSTCODE as POSTCODE0_, addresses0_.HOUSE_NUMBER as HOUSE_N10_0_, addresses0_.PARTY_ID as PARTY_ID0_, addresses0_.TEL as TEL0_, addresses0_.IVA as IVA0_, addresses0_.COMPANY as COMPANY0_ from ADDRESS addresses0_ where addresses0_.PARTY_ID=?
15:51:30,859 DEBUG [BatcherImpl] preparing statement
15:51:30,859 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,859 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,899 DEBUG [Loader] result set contains (possibly empty) collection: [it.esselunga.ecommerce.data.model.Person.addresses#58197]
15:51:30,899 DEBUG [SessionImpl] uninitialized collection: initializing
15:51:30,899 DEBUG [Loader] processing result set

15:51:30,909 DEBUG [Loader] done processing result set (0 rows)
15:51:30,909 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,909 DEBUG [BatcherImpl] closing statement
15:51:30,909 DEBUG [Loader] total objects hydrated: 0
15:51:30,909 DEBUG [SessionImpl] 1 collections were found in result set
15:51:30,909 DEBUG [SessionImpl] collection fully initialized: [it.esselunga.ecommerce.data.model.Person.addresses#58197]
15:51:30,909 DEBUG [SessionImpl] 1 collections initialized
15:51:30,909 DEBUG [SessionImpl] initializing non-lazy collections
15:51:30,909 DEBUG [SessionImpl] collection initialized
15:51:30,909 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:30,919 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:30,919 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:30,919 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@2ee7e5] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:30,919 DEBUG [SessionImpl] flushing session

15:51:30,919 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:51:30,919 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:51:30,919 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:51:30,919 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:51:30,919 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:51:30,919 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:51:30,919 DEBUG [SessionImpl] Collection dirty: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195]
15:51:30,919 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:51:30,919 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58195], was: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58195]
15:51:30,919 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58195], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58195]
15:51:30,919 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58195], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58195]
15:51:30,929 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58195], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58195]
15:51:30,929 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58195], was: [it.esselunga.ecommerce.data.model.Person.addresses#58195]
15:51:30,929 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195]
15:51:30,929 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58195], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58195]
15:51:30,929 DEBUG [SessionImpl] Processing unreferenced collections
15:51:30,929 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.userLogins#58197]
15:51:30,929 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.trolleys#58197]
15:51:30,929 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58197]
15:51:30,929 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Person.addresses#58197]
15:51:30,929 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58197]
15:51:30,929 DEBUG [SessionImpl] Collection dereferenced: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58197]
15:51:30,929 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:51:30,929 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 1 deletions to 4 objects
15:51:30,929 DEBUG [SessionImpl] Flushed: 0 (re)creations, 1 updates, 6 removals to 13 collections
15:51:30,929 DEBUG [Printer] listing entities:
15:51:30,929 DEBUG [Printer] it.esselunga.ecommerce.data.model.EducationLevel{enumId=2215, description=il livello di educazione della laurea, enumCode=laurea, sequence=1}
15:51:30,929 DEBUG [Printer] it.esselunga.ecommerce.data.model.Customer{partyId=58195, addresses=uninitialized, title=Mr., homeTel=02-57402284, sendInfo=true, relatedPartiesTo=uninitialized, sex=M, fidelityCardNumber=601724305345034, partyType=2, relatedPartiesFrom=[], forename=pluto, deliveryAddresses=uninitialized, howManyRelatives=2, fidelityCardType=GOLD , educationLevel=EducationLevel#2215, creationDate=07 maggio 2004 15:50:11, shoppingLists=uninitialized, profession=Profession#2214, newCardNumber=true, surname=pippo, dateOfBirth=13 febbraio 1973 15:50:11, detailsPrivate=true, userLogins=uninitialized, workTel=347-0077078, email=pippo@pluto.com, trolleys=uninitialized, mobileTel=347-0077078}
15:51:30,939 DEBUG [Printer] it.esselunga.ecommerce.data.model.Profession{enumId=2214, description=il mestiere piu antico del mondo, enumCode=ingegnere, sequence=1}
15:51:30,939 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=[], partyId=58197, forename=cognome1, title=Mr., educationLevel=EducationLevel#2215, profession=Profession#2214, shoppingLists=[], creationDate=07 maggio 2004 15:50:35, homeTel=02-57402284, relatedPartiesTo=uninitialized, sex=M, surname=parente1, dateOfBirth=11 novembre 1976 15:50:35, detailsPrivate=true, partyType=2, userLogins=[], email=email-parente1@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=uninitialized, trolleys=uninitialized, mobileTel=347-0077078}
15:51:30,949 DEBUG [SessionImpl] executing flush
15:51:30,949 DEBUG [BasicCollectionPersister] Deleting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58197]
15:51:30,949 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,949 DEBUG [SQL] delete from PARTY_RELATIONSHIP where PARTY_ID_TO=?
Hibernate: delete from PARTY_RELATIONSHIP where PARTY_ID_TO=?
15:51:30,949 DEBUG [BatcherImpl] preparing statement
15:51:30,949 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,949 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:30,949 DEBUG [BatcherImpl] Adding to batch
15:51:30,949 DEBUG [BasicCollectionPersister] done deleting collection
15:51:30,949 DEBUG [BatcherImpl] Executing batch size: 1
15:51:30,959 DEBUG [BatcherImpl] success of batch update unknown: 0
15:51:30,959 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,959 DEBUG [BatcherImpl] closing statement
15:51:30,989 DEBUG [BasicCollectionPersister] Deleting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195]
15:51:30,989 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,989 DEBUG [SQL] delete from PARTY_RELATIONSHIP where PARTY_ID_TO=?
Hibernate: delete from PARTY_RELATIONSHIP where PARTY_ID_TO=?
15:51:30,989 DEBUG [BatcherImpl] preparing statement
15:51:30,989 DEBUG [IntegerType] binding '58195' to parameter: 1
15:51:30,989 DEBUG [IntegerType] binding '58195' to parameter: 1
15:51:30,989 DEBUG [BatcherImpl] Adding to batch
15:51:30,989 DEBUG [BasicCollectionPersister] done deleting collection
15:51:30,989 DEBUG [BatcherImpl] Executing batch size: 1
15:51:30,999 DEBUG [BatcherImpl] success of batch update unknown: 0
15:51:30,999 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:30,999 DEBUG [BatcherImpl] closing statement
15:51:30,999 DEBUG [NormalizedEntityPersister] Deleting entity: [it.esselunga.ecommerce.data.model.Person#58197]
15:51:30,999 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:30,999 DEBUG [SQL] delete from PARTY where PARTY_ID=?
Hibernate: delete from PARTY where PARTY_ID=?
15:51:30,999 DEBUG [BatcherImpl] preparing statement
15:51:30,999 DEBUG [BatcherImpl] about to open: 1 open PreparedStatements, 0 open ResultSets
15:51:31,009 DEBUG [SQL] delete from PERSON where PARTY_ID=?
Hibernate: delete from PERSON where PARTY_ID=?
15:51:31,009 DEBUG [BatcherImpl] preparing statement
15:51:31,009 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:31,009 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:31,019 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:31,019 DEBUG [IntegerType] binding '58197' to parameter: 1
15:51:31,029 DEBUG [BatcherImpl] done closing: 1 open PreparedStatements, 0 open ResultSets
15:51:31,029 DEBUG [BatcherImpl] closing statement
15:51:31,029 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:31,029 DEBUG [BatcherImpl] closing statement
15:51:31,039 DEBUG [SessionImpl] post flush
15:51:31,039 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@2ee7e5] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:31,039 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:31,039 DEBUG [SQL] select PARTY_SEQ.nextval from dual
Hibernate: select PARTY_SEQ.nextval from dual
15:51:31,039 DEBUG [BatcherImpl] preparing statement
15:51:31,069 DEBUG [SequenceGenerator] Sequence identifier generated: 58198
15:51:31,069 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:31,069 DEBUG [BatcherImpl] closing statement
15:51:31,069 DEBUG [SessionImpl] generated identifier: 58198
15:51:31,069 DEBUG [SessionImpl] saving [it.esselunga.ecommerce.data.model.Person#58198]
15:51:31,069 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:31,079 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:31,079 DEBUG [Cascades] id unsaved-value strategy NULL
15:51:31,079 DEBUG [Cascades] id unsaved-value strategy NULL
15:51:31,079 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:31,079 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:51:31,079 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:51:31,079 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:51:31,079 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:31,079 DEBUG [HibernateInterceptor] Not closing pre-bound Hibernate session after interceptor

15:51:31,079 DEBUG [TransactionInterceptor] Invoking commit for transaction on method 'updateCustomer' in class [it.esselunga.ecommerce.services.party.PartyService]
15:51:31,079 DEBUG [HibernateTransactionManager] Triggering beforeCommit synchronization
15:51:31,079 DEBUG [HibernateTransactionManager] Triggering beforeCompletion synchronization
15:51:31,089 INFO [HibernateTransactionManager] Initiating transaction commit
15:51:31,089 DEBUG [HibernateTransactionManager] Committing Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1e064c]
15:51:31,089 DEBUG [JDBCTransaction] commit
15:51:31,089 DEBUG [SessionImpl] flushing session

15:51:31,089 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:51:31,089 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Customer.deliveryAddresses
15:51:31,099 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:51:31,099 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:51:31,099 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:51:31,099 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Customer
15:51:31,099 DEBUG [Cascades] processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:31,099 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.userLogins
15:51:31,099 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:51:31,099 DEBUG [Cascades] cascading to collection: it.esselunga.ecommerce.data.model.Person.addresses
15:51:31,099 DEBUG [Cascades] done processing cascades for: it.esselunga.ecommerce.data.model.Person
15:51:31,099 DEBUG [SessionImpl] Collection dirty: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195]
15:51:31,099 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:51:31,099 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58195], was: [it.esselunga.ecommerce.data.model.Customer.deliveryAddresses#58195]
15:51:31,109 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58195], was: [it.esselunga.ecommerce.data.model.Person.userLogins#58195]
15:51:31,109 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58195], was: [it.esselunga.ecommerce.data.model.Person.trolleys#58195]
15:51:31,109 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58195], was: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58195]
15:51:31,109 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58195], was: [it.esselunga.ecommerce.data.model.Person.addresses#58195]
15:51:31,109 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195]
15:51:31,109 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58195], was: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58195]
15:51:31,129 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.userLogins
15:51:31,129 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.trolleys
15:51:31,129 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.shoppingLists
15:51:31,129 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Person.addresses
15:51:31,129 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom
15:51:31,129 DEBUG [WrapVisitor] Wrapped collection in role: it.esselunga.ecommerce.data.model.Party.relatedPartiesTo
15:51:31,129 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.userLogins#58198], was: [<unreferenced>]
15:51:31,129 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.trolleys#58198], was: [<unreferenced>]
15:51:31,139 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.shoppingLists#58198], was: [<unreferenced>]
15:51:31,139 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Person.addresses#58198], was: [<unreferenced>]
15:51:31,139 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58198], was: [<unreferenced>]
15:51:31,139 DEBUG [SessionImpl] Collection found: [it.esselunga.ecommerce.data.model.Party.relatedPartiesTo#58198], was: [<unreferenced>]
15:51:31,139 DEBUG [SessionImpl] Processing unreferenced collections
15:51:31,139 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:51:31,139 DEBUG [SessionImpl] Flushed: 1 insertions, 0 updates, 0 deletions to 4 objects
15:51:31,139 DEBUG [SessionImpl] Flushed: 6 (re)creations, 1 updates, 0 removals to 19 collections
15:51:31,139 DEBUG [Printer] listing entities:
15:51:31,139 DEBUG [Printer] it.esselunga.ecommerce.data.model.Person{addresses=[], partyId=58198, forename=cognome2, title=Mr., educationLevel=EducationLevel#2215, profession=Profession#2214, shoppingLists=[], creationDate=07 maggio 2004 15:51:13, homeTel=02-57402284, relatedPartiesTo=[PartyRelationship{relationshipType=RelativeType#2213, throughDate=null, relatedParty=Customer#58195, description=null, fromDate=null}], sex=M, surname=parente2, dateOfBirth=11 novembre 1976 15:51:13, detailsPrivate=true, partyType=2, userLogins=[], email=email-parente2@updatecustomer.it, workTel=347-0077078, relatedPartiesFrom=[], trolleys=[], mobileTel=347-0077078}
15:51:31,139 DEBUG [Printer] it.esselunga.ecommerce.data.model.EducationLevel{enumId=2215, description=il livello di educazione della laurea, enumCode=laurea, sequence=1}
15:51:31,139 DEBUG [Printer] it.esselunga.ecommerce.data.model.Customer{partyId=58195, addresses=uninitialized, title=Mr., homeTel=02-57402284, sendInfo=true, relatedPartiesTo=uninitialized, sex=M, fidelityCardNumber=601724305345034, partyType=2, relatedPartiesFrom=[PartyRelationship{relationshipType=RelativeType#2213, throughDate=null, relatedParty=Person#58198, description=null, fromDate=null}], forename=pluto, deliveryAddresses=uninitialized, howManyRelatives=2, fidelityCardType=GOLD , educationLevel=EducationLevel#2215, creationDate=07 maggio 2004 15:50:11, shoppingLists=uninitialized, profession=Profession#2214, newCardNumber=true, surname=pippo, dateOfBirth=13 febbraio 1973 15:50:11, detailsPrivate=true, userLogins=uninitialized, workTel=347-0077078, email=pippo@pluto.com, trolleys=uninitialized, mobileTel=347-0077078}
15:51:31,149 DEBUG [Printer] it.esselunga.ecommerce.data.model.Profession{enumId=2214, description=il mestiere piu antico del mondo, enumCode=ingegnere, sequence=1}
15:51:31,149 DEBUG [SessionImpl] executing flush
15:51:31,149 DEBUG [NormalizedEntityPersister] Inserting entity: [it.esselunga.ecommerce.data.model.Person#58198]
15:51:31,149 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:31,149 DEBUG [SQL] insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
Hibernate: insert into PARTY (PARTY_TYPE, PARTY_ID) values (?, ?)
15:51:31,149 DEBUG [BatcherImpl] preparing statement
15:51:31,149 DEBUG [BatcherImpl] about to open: 1 open PreparedStatements, 0 open ResultSets
15:51:31,149 DEBUG [SQL] insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
Hibernate: insert into PERSON (TITLE, SURNAME, FORENAME, EMAIL, HOME_TEL, WORK_TEL, MOBILE_TEL, DATE_OF_BIRTH, SEX, DETAILS_PRIVATE, CREATION_DATE, PROFESSION_ID, EDUCATION_LEVEL_ID, PARTY_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
15:51:31,149 DEBUG [BatcherImpl] preparing statement
15:51:31,149 DEBUG [NormalizedEntityPersister] Dehydrating entity: [it.esselunga.ecommerce.data.model.Person#58198]
15:51:31,149 DEBUG [PersistentEnumType] binding '2' to parameter: 1
15:51:31,149 DEBUG [PersistentEnumType] binding '2' to parameter: 1
15:51:31,149 DEBUG [IntegerType] binding '58198' to parameter: 2
15:51:31,149 DEBUG [IntegerType] binding '58198' to parameter: 2
15:51:31,149 DEBUG [StringType] binding 'Mr.' to parameter: 1
15:51:31,149 DEBUG [StringType] binding 'Mr.' to parameter: 1
15:51:31,149 DEBUG [StringType] binding 'parente2' to parameter: 2
15:51:31,149 DEBUG [StringType] binding 'parente2' to parameter: 2
15:51:31,149 DEBUG [StringType] binding 'cognome2' to parameter: 3
15:51:31,149 DEBUG [StringType] binding 'cognome2' to parameter: 3
15:51:31,149 DEBUG [StringType] binding 'email-parente2@updatecustomer.it' to parameter: 4
15:51:31,149 DEBUG [StringType] binding 'email-parente2@updatecustomer.it' to parameter: 4
15:51:31,149 DEBUG [StringType] binding '02-57402284' to parameter: 5
15:51:31,149 DEBUG [StringType] binding '02-57402284' to parameter: 5
15:51:31,159 DEBUG [StringType] binding '347-0077078' to parameter: 6
15:51:31,159 DEBUG [StringType] binding '347-0077078' to parameter: 6
15:51:31,159 DEBUG [StringType] binding '347-0077078' to parameter: 7
15:51:31,159 DEBUG [StringType] binding '347-0077078' to parameter: 7
15:51:31,159 DEBUG [TimestampType] binding '11 novembre 1976 15:51:13' to parameter: 8
15:51:31,159 DEBUG [TimestampType] binding '11 novembre 1976 15:51:13' to parameter: 8
15:51:31,159 DEBUG [StringType] binding 'M' to parameter: 9
15:51:31,159 DEBUG [StringType] binding 'M' to parameter: 9
15:51:31,159 DEBUG [BooleanType] binding 'true' to parameter: 10
15:51:31,159 DEBUG [BooleanType] binding 'true' to parameter: 10
15:51:31,159 DEBUG [TimestampType] binding '07 maggio 2004 15:51:13' to parameter: 11
15:51:31,159 DEBUG [TimestampType] binding '07 maggio 2004 15:51:13' to parameter: 11
15:51:31,159 DEBUG [Cascades] id unsaved-value strategy NULL
15:51:31,159 DEBUG [IntegerType] binding '2214' to parameter: 12
15:51:31,159 DEBUG [IntegerType] binding '2214' to parameter: 12
15:51:31,159 DEBUG [Cascades] id unsaved-value strategy NULL
15:51:31,159 DEBUG [IntegerType] binding '2215' to parameter: 13
15:51:31,159 DEBUG [IntegerType] binding '2215' to parameter: 13
15:51:31,159 DEBUG [IntegerType] binding '58198' to parameter: 14
15:51:31,159 DEBUG [IntegerType] binding '58198' to parameter: 14
15:51:31,189 DEBUG [BatcherImpl] done closing: 1 open PreparedStatements, 0 open ResultSets
15:51:31,189 DEBUG [BatcherImpl] closing statement
15:51:31,189 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:31,189 DEBUG [BatcherImpl] closing statement
15:51:31,199 DEBUG [BasicCollectionPersister] Deleting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195]
15:51:31,199 DEBUG [BasicCollectionPersister] no rows to delete
15:51:31,199 DEBUG [BasicCollectionPersister] Updating rows of collection: it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195
15:51:31,199 DEBUG [BasicCollectionPersister] done updating rows: 0 updated
15:51:31,199 DEBUG [BasicCollectionPersister] Inserting rows of collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58195]
15:51:31,199 DEBUG [BatcherImpl] about to open: 0 open PreparedStatements, 0 open ResultSets
15:51:31,199 DEBUG [SQL] insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
Hibernate: insert into PARTY_RELATIONSHIP (PARTY_ID_TO, FROM_DATE, THRU_DATE, DESCRIPTION, RELATIONSHIP_TYPE_ID, PARTY_ID_FROM) values (?, ?, ?, ?, ?, ?)
15:51:31,199 DEBUG [BatcherImpl] preparing statement
15:51:31,199 DEBUG [IntegerType] binding '58195' to parameter: 1
15:51:31,199 DEBUG [IntegerType] binding '58195' to parameter: 1
15:51:31,199 DEBUG [TimestampType] binding null to parameter: 2
15:51:31,199 DEBUG [TimestampType] binding null to parameter: 2
15:51:31,199 DEBUG [TimestampType] binding null to parameter: 3
15:51:31,199 DEBUG [TimestampType] binding null to parameter: 3
15:51:31,199 DEBUG [StringType] binding null to parameter: 4
15:51:31,199 DEBUG [StringType] binding null to parameter: 4
15:51:31,199 DEBUG [Cascades] id unsaved-value strategy NULL
15:51:31,199 DEBUG [IntegerType] binding '2213' to parameter: 5
15:51:31,199 DEBUG [IntegerType] binding '2213' to parameter: 5
15:51:31,199 DEBUG [IntegerType] binding '58198' to parameter: 6
15:51:31,199 DEBUG [IntegerType] binding '58198' to parameter: 6
15:51:31,199 DEBUG [BatcherImpl] Adding to batch
15:51:31,199 DEBUG [BasicCollectionPersister] done inserting rows: 1 inserted
15:51:31,199 DEBUG [BatcherImpl] Executing batch size: 1
15:51:31,219 DEBUG [BatcherImpl] success of batch update unknown: 0
15:51:31,219 DEBUG [BatcherImpl] done closing: 0 open PreparedStatements, 0 open ResultSets
15:51:31,219 DEBUG [BatcherImpl] closing statement
15:51:31,219 DEBUG [BasicCollectionPersister] Inserting collection: [it.esselunga.ecommerce.data.model.Party.relatedPartiesFrom#58198]
15:51:31,219 DEBUG [BasicCollectionPersister] collection was empty
15:51:31,219 DEBUG [SessionImpl] post flush
15:51:31,249 DEBUG [SessionImpl] transaction completion
15:51:31,249 DEBUG [JDBCTransaction] re-enabling autocommit
15:51:31,249 DEBUG [HibernateTransactionManager] Triggering afterCompletion synchronization
15:51:31,249 DEBUG [TransactionSynchronizationManager] Clearing transaction synchronization
15:51:31,249 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.jdbc.datasource.ConnectionHolder@17aaa0e] for key [org.apache.commons.dbcp.BasicDataSource@d7ffbf] from thread [main]
15:51:31,249 DEBUG [TransactionSynchronizationManager] Removed value [org.springframework.orm.hibernate.SessionHolder@2ee7e5] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] from thread [main]
15:51:31,249 DEBUG [HibernateTransactionManager] Closing Hibernate session [net.sf.hibernate.impl.SessionImpl@1e064c] after transaction
15:51:31,249 DEBUG [SessionFactoryUtils] Closing Hibernate session
15:51:31,249 DEBUG [SessionImpl] closing session
15:51:31,249 DEBUG [SessionImpl] disconnecting session
15:51:31,259 DEBUG [SessionImpl] transaction completion
15:51:31,259 DEBUG [TransactionInterceptor] Getting transaction for method 'getPersonRelatives' in class [it.esselunga.ecommerce.services.party.PartyService]
15:51:31,259 DEBUG [HibernateTransactionManager] Using transaction object [org.springframework.orm.hibernate.HibernateTransactionObject@92eb76]
15:51:31,259 DEBUG [HibernateTransactionManager] Creating new transaction
15:51:31,259 DEBUG [SessionFactoryUtils] Opening Hibernate session
15:51:31,259 DEBUG [SessionImpl] opened session
15:51:31,259 DEBUG [HibernateTransactionManager] Opened new session [net.sf.hibernate.impl.SessionImpl@1a0b94d] for Hibernate transaction
15:51:31,259 DEBUG [HibernateTransactionManager] Beginning Hibernate transaction on session [net.sf.hibernate.impl.SessionImpl@1a0b94d]
15:51:31,259 DEBUG [JDBCTransaction] begin
15:51:31,299 DEBUG [JDBCTransaction] current autocommit status:true
15:51:31,299 DEBUG [JDBCTransaction] disabling autocommit
15:51:31,299 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.orm.hibernate.SessionHolder@f8ae79] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] to thread [main]
15:51:31,299 DEBUG [TransactionSynchronizationManager] Bound value [org.springframework.jdbc.datasource.ConnectionHolder@86b376] for key [org.apache.commons.dbcp.BasicDataSource@d7ffbf] to thread [main]
15:51:31,299 DEBUG [TransactionSynchronizationManager] Initializing transaction synchronization
15:51:31,299 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@f8ae79] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:31,299 DEBUG [HibernateInterceptor] Found thread-bound session for Hibernate interceptor
15:51:31,299 DEBUG [TransactionSynchronizationManager] Retrieved value [org.springframework.orm.hibernate.SessionHolder@f8ae79] for key [net.sf.hibernate.impl.SessionFactoryImpl@69695f] bound to thread [main]
15:51:31,309 DEBUG [SessionImpl] find: select relationship.relatedParty from Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:51:31,309 DEBUG [QueryParameters] parameters: [58195]
15:51:31,309 DEBUG [SessionImpl] flushing session

15:51:31,309 DEBUG [SessionImpl] Flushing entities and processing referenced collections
15:51:31,309 DEBUG [SessionImpl] Processing unreferenced collections
15:51:31,309 DEBUG [SessionImpl] Scheduling collection removes/(re)creates/updates
15:51:31,309 DEBUG [SessionImpl] Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects
15:51:31,309 DEBUG [SessionImpl] Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
15:51:31,309 DEBUG [SessionImpl] Dont need to execute flush
15:51:31,309 DEBUG [QueryTranslator] HQL: select relationship.relatedParty from it.esselunga.ecommerce.data.model.Person p join p.relatedPartiesFrom relationship where p.id=? and relationship.relationshipType.class=it.esselunga.ecommerce.data.model.RelativeType
15:51:31,309 DEBUG [QueryTranslator] SQL: select party3_.PARTY_ID as PARTY_ID, decode (party3_.PARTY_ID, party3__2_.PARTY_ID, 1, party3__1_.PARTY_ID, 2, party3__3_.PARTY_ID, 3,0 ) as clazz_, party3_.PARTY_TYPE as PARTY_TYPE8_, party3__1_.TITLE as TITLE10_, party3__1_.SURNAME as SURNAME10_, party3__1_.FORENAME as FORENAME10_, party3__1_.EMAIL as EMAIL10_, party3__1_.HOME_TEL as HOME_TEL10_, party3__1_.WORK_TEL as WORK_TEL10_, party3__1_.MOBILE_TEL as MOBILE_TEL10_, party3__1_.DATE_OF_BIRTH as DATE_OF_9_10_, party3__1_.SEX as SEX10_, party3__1_.DETAILS_PRIVATE as DETAILS11_10_, party3__1_.CREATION_DATE as CREATIO12_10_, party3__1_.PROFESSION_ID as PROFESS13_10_, party3__1_.EDUCATION_LEVEL_ID as EDUCATI14_10_, party3__2_.FIDELITY_CARD_TYPE as FIDELITY2_11_, party3__2_.FIDELITY_CARD_NUMBER as FIDELITY3_11_, party3__2_.IS_NEW_CARD_NUMBER as IS_NEW_C4_11_, party3__2_.HOW_MANY_RELATIVES as HOW_MANY5_11_, party3__2_.SEND_INFO as SEND_INFO11_, party3__3_.GROUP_NAME as GROUP_NAME12_, party3__3_.DESCRIPTION as DESCRIPT3_12_ from PERSON person0_, PARTY person0__1_, PARTY_RELATIONSHIP relatedpar1_, ENUMERATION partyrelat2_, PARTY party3_, PERSON party3__1_, CUSTOMER party3__2_, PARTY_GROUP party3__3_ where person0_.PARTY_ID=person0__1_.PARTY_ID and person0_.PARTY_ID=relatedpar1_.PARTY_ID_TO and relatedpar1_.PARTY_ID_FROM=party3_.PARTY_ID a

Top

Page 1 of 1

[ 5 posts ]

Board index » Hibernate & Java Persistence » Hibernate Users

All times are UTC - 5 hours [ DST ]

You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum