-->
These old forums are deprecated now and set to read-only. We are waiting for you on our new forums!
More modern, Discourse-based and with GitHub/Google/Twitter authentication built-in.

All times are UTC - 5 hours [ DST ]



Forum locked This topic is locked, you cannot edit posts or make further replies.  [ 3 posts ] 
Author Message
 Post subject: Detached Object Collection problem
PostPosted: Thu Oct 14, 2004 4:12 pm 
Regular
Regular

Joined: Fri Jul 16, 2004 3:04 pm
Posts: 52
Location: Wiltshire UK
Hi All, in my unit test below something weird is happening. When the test is run it fails at this line
Code:
assertFalse("account4 should not contain elist2",account4.getElists().contains(elist2));

However if I comment out the code marked failure code & run the commented out code marked successful code, the test passes. I don't really understand why it works if I reload my Account Object, but not when I re-attach the detached Account Object. I have been working through Hibernate in Action (which incidentally, Christian & Gavin is Awesome!! Thanks!) & have created this code after getting through Chapters 3 & 4, and I thought it should work. If anyone can please explain to me why it doesn't work I'd be really grateful, as it will really aid my understanding.

Please note that I do have a tearDown() method in my test which cleans up by deleting the Account, so the execution of this tearDown() method will be seen in the logs.

Many, many thanks

Paul :-)

Hibernate version:
2.1.6

Mapping documents:
Code:
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
   "-//Hibernate/Hibernate Mapping DTD 2.0//EN"
   "http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd">

<hibernate-mapping>

    <class name="com.easylists.Account" table="ACCOUNT">

        <id name="hibernateId" type="long" column="HIBERNATE_ID">
            <meta attribute="scope-set">protected</meta>
            <generator class="native"/>
        </id>

        <version name="version" column="VERSION"/>

        <property name="pk" type="long">
            <column name="PK" not-null="true"/>
        </property>

        <property name="active" type="boolean">
            <column name="ACTIVE" not-null="true"/>
        </property>

        <property name="hasBeenActivated" type="boolean">
            <column name="HAS_BEEN_ACTIVATED" not-null="true"/>
        </property>

        <property name="createdDate" type="java.util.Date">
            <column name="CREATED_DATE" not-null="true"/>
        </property>

        <property name="expiryDate" type="java.util.Date">
            <column name="EXPIRY_DATE"/>
        </property>

        <property name="title" type="string">
            <meta attribute="use-in-tostring">true</meta>
            <column name="TITLE" not-null="true"/>
        </property>

        <property name="forename" type="string">
            <meta attribute="use-in-tostring">true</meta>
            <column name="FORENAME" not-null="true"/>
        </property>

        <property name="surname" type="string">
            <column name="SURNAME" not-null="true"/>
        </property>

        <property name="emailAddress" type="string">
            <column name="EMAIL_ADDRESS" not-null="true" unique="true" index="EMAIL_IDX"/>
        </property>

        <property name="password" type="string">
            <column name="PASSWORD" not-null="true"/>
        </property>

        <property name="quota" type="int">
            <column name="QUOTA"/>
        </property>

        <component name="address" class="com.easylists.Address">
            <property name="houseNumber" type="string">
                <column name="HOUSE_NUMBER" not-null="true"/>
            </property>

            <property name="houseName" type="string">
                <column name="HOUSE_NAME" not-null="true"/>
            </property>

            <property name="street" type="string">
                <meta attribute="use-in-toString">true</meta>
                <column name="STREET" not-null="true"/>
            </property>

            <property name="townOrCity" type="string">
                <column name="TOWN_OR_CITY" not-null="true"/>
            </property>

            <property name="countyOrState" type="string">
                <column name="COUNTY_OR_STATE" not-null="true"/>
            </property>

            <property name="postcode" type="string">
                <column name="POSTCODE" not-null="true"/>
            </property>

            <property name="country" type="string">
                <column name="COUNTRY" not-null="true"/>
            </property>
        </component>

        <set name="elists" table="ELIST" cascade="all-delete-orphan" inverse="true" >
            <key column="ACCOUNT_ID"/>
            <one-to-many class="com.easylists.EList"/>
        </set>

        <set name="emailAddressBooks" table="EMAIL_ADDRESS_BOOK" cascade="all-delete-orphan" >
            <key column="ACCOUNT_ID"/>
            <one-to-many class="com.easylists.EmailAddressBook"/>
        </set>

    </class>

</hibernate-mapping>


Code:
<?xml version="1.0"?>
<!DOCTYPE hibernate-mapping PUBLIC
   "-//Hibernate/Hibernate Mapping DTD 2.0//EN"
   "http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd">

<hibernate-mapping>

    <class name="com.easylists.EList" table="ELIST">

        <id name="hibernateId" type="long" column="HIBERNATE_ID">
            <meta attribute="scope-set">protected</meta>
            <generator class="native"/>
        </id>

        <version name="version" column="VERSION"/>

        <property name="pk" type="long">
            <column name="PK" not-null="true"/>
        </property>

        <property name="elistName" type="string">
            <column name="ELIST_NAME" not-null="true"/>
        </property>

        <property name="emailMessage" type="string">
            <column name="EMAIL_MESSAGE"/>
        </property>

        <property name="password" type="string">
            <column name="PASSWORD"/>
        </property>

        <property name="hideWhenPurchased" type="boolean">
            <column name="HIDE_WHEN_PURCHASED" not-null="true"/>
        </property>

        <property name="sendEmailWhenItemPurchased" type="boolean">
            <column name="EMAIL_WHEN_ITEM_PURCHASED" not-null="true"/>
        </property>

        <property name="expiryDate" type="java.util.Date">
            <column name="EXPIRY_DATE"/>
        </property>

        <many-to-one name="account" class="com.easylists.Account" column="ACCOUNT_ID" not-null="true"/>

        <set name="elistItems" table="ELIST_ITEM" cascade="all-delete-orphan">
            <key column="ELIST_ID"/>
            <one-to-many class="com.easylists.EListItem"/>
        </set>

    </class>

</hibernate-mapping>


Code between sessionFactory.openSession() and session.close():
This is the code called from the test for PERSISTENCE_MANAGER.saveObject(Object ob)
Code:
public static void saveObject(Object ob) throws PersistenceException {
        try {
            Session session = null;
            Transaction tx = null;
            try {
                session = HibernateUtil.openSession();
                tx = session.beginTransaction();
                session.saveOrUpdate(ob);
                tx.commit();
            }
            catch (StaleObjectStateException e) {
                if (tx != null) {
                    tx.rollback();
                }
                throw new StalePersistentObjectException(e);
            }
            catch (HibernateException e) {
                if (tx != null) {
                    tx.rollback();
                }
                throw new PersistenceException(e);
            }
            finally {
                closeSession(session);
            }
        }
        catch (HibernateException e) {
            throw new PersistenceException(e);
        }
    }


Full stack trace of any exception that occurs:
N/A

Name and version of the database you are using:
MySQL 4.0

The generated SQL (show_sql=true):
14-10-2004 20:48:43 INFO - Hibernate 2.1.6 (Environment.java:469)
14-10-2004 20:48:43 INFO - loaded properties from resource hibernate.properties: {hibernate.cglib.use_reflection_optimizer=true, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, hibernate.cache.use_query_cache=true, hibernate.max_fetch_depth=1, hibernate.dialect=net.sf.hibernate.dialect.MySQLDialect, hibernate.jdbc.use_streams_for_binary=true, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.jdbc.batch_size=0, hibernate.proxool.pool_alias=pool1, hibernate.cache.region_prefix=hibernate.test, hibernate.connection.datasource=java:comp/env/jdbc/easytwo, hibernate.show_sql=true, hibernate.connection.pool_size=1} (Environment.java:503)
14-10-2004 20:48:43 INFO - using java.io streams to persist binary types (Environment.java:528)
14-10-2004 20:48:43 INFO - using CGLIB reflection optimizer (Environment.java:529)
14-10-2004 20:48:43 INFO - configuring from resource: /hibernate.cfg.xml (Configuration.java:895)
14-10-2004 20:48:43 INFO - Configuration resource: /hibernate.cfg.xml (Configuration.java:867)
14-10-2004 20:48:43 INFO - Mapping resource: com/easylists/Account.hbm.xml (Configuration.java:331)
14-10-2004 20:48:43 INFO - Mapping class: com.easylists.Account -> ACCOUNT (Binder.java:229)
14-10-2004 20:48:44 INFO - Mapping resource: com/easylists/EList.hbm.xml (Configuration.java:331)
14-10-2004 20:48:45 INFO - Mapping class: com.easylists.EList -> ELIST (Binder.java:229)
14-10-2004 20:48:45 INFO - Mapping resource: com/easylists/EListItem.hbm.xml (Configuration.java:331)
14-10-2004 20:48:45 INFO - Mapping class: com.easylists.EListItem -> ELIST_ITEM (Binder.java:229)
14-10-2004 20:48:45 INFO - Mapping resource: com/easylists/EmailAddress.hbm.xml (Configuration.java:331)
14-10-2004 20:48:45 INFO - Mapping class: com.easylists.EmailAddress -> EMAIL_ADDRESS (Binder.java:229)
14-10-2004 20:48:45 INFO - Mapping resource: com/easylists/EmailAddressBook.hbm.xml (Configuration.java:331)
14-10-2004 20:48:45 INFO - Mapping class: com.easylists.EmailAddressBook -> EMAIL_ADDRESS_BOOK (Binder.java:229)
14-10-2004 20:48:45 INFO - Mapping collection: com.easylists.EmailAddressBook.emailAddresses -> EML_ADDR_BKS_EMAIL_ADDRESSES (Binder.java:571)
14-10-2004 20:48:45 INFO - Configured SessionFactory: null (Configuration.java:1053)
14-10-2004 20:48:45 INFO - processing one-to-many association mappings (Configuration.java:627)
14-10-2004 20:48:45 INFO - Mapping collection: com.easylists.Account.elists -> ELIST (Binder.java:1181)
14-10-2004 20:48:45 INFO - Mapping collection: com.easylists.Account.emailAddressBooks -> EMAIL_ADDRESS_BOOK (Binder.java:1181)
14-10-2004 20:48:45 INFO - Mapping collection: com.easylists.EList.elistItems -> ELIST_ITEM (Binder.java:1181)
14-10-2004 20:48:45 INFO - processing one-to-one association property references (Configuration.java:636)
14-10-2004 20:48:45 INFO - processing foreign key constraints (Configuration.java:661)
14-10-2004 20:48:46 INFO - Using dialect: net.sf.hibernate.dialect.MySQLDialect (Dialect.java:82)
14-10-2004 20:48:46 INFO - Maximim outer join fetch depth: 1 (SettingsFactory.java:59)
14-10-2004 20:48:46 INFO - Use outer join fetching: true (SettingsFactory.java:63)
14-10-2004 20:48:46 INFO - JNDI InitialContext properties:{} (NamingHelper.java:26)
14-10-2004 20:48:46 INFO - Using datasource: java:comp/env/jdbc/easytwo (DatasourceConnectionProvider.java:51)
14-10-2004 20:48:46 INFO - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended) (TransactionManagerLookupFactory.java:33)
14-10-2004 20:48:46 INFO - Use scrollable result sets: true (SettingsFactory.java:103)
14-10-2004 20:48:46 INFO - Use JDBC3 getGeneratedKeys(): true (SettingsFactory.java:106)
14-10-2004 20:48:46 INFO - Optimize cache for minimal puts: false (SettingsFactory.java:109)
14-10-2004 20:48:46 INFO - echoing all SQL to stdout (SettingsFactory.java:115)
14-10-2004 20:48:46 INFO - Query language substitutions: {no='N', true=1, yes='Y', false=0} (SettingsFactory.java:118)
14-10-2004 20:48:46 INFO - cache provider: net.sf.ehcache.hibernate.Provider (SettingsFactory.java:129)
14-10-2004 20:48:46 INFO - query cache factory: net.sf.hibernate.cache.StandardQueryCacheFactory (SettingsFactory.java:141)
14-10-2004 20:48:46 INFO - instantiating and configuring caches (Configuration.java:1116)
14-10-2004 20:48:46 INFO - building session factory (SessionFactoryImpl.java:118)
14-10-2004 20:48:47 INFO - reflection optimizer disabled for: com.easylists.EmailAddressBook, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:48:47 INFO - reflection optimizer disabled for: com.easylists.Account, BulkBeanException: Property is private (property setElists) (ReflectHelper.java:186)
14-10-2004 20:48:47 INFO - reflection optimizer disabled for: com.easylists.EList, BulkBeanException: Property is private (property setElistItems) (ReflectHelper.java:186)
14-10-2004 20:48:47 INFO - reflection optimizer disabled for: com.easylists.EListItem, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:48:47 INFO - reflection optimizer disabled for: com.easylists.EmailAddress, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:48:48 INFO - Not binding factory to JNDI, no JNDI name configured (SessionFactoryObjectFactory.java:82)
14-10-2004 20:48:48 INFO - starting update timestamps cache at region: net.sf.hibernate.cache.UpdateTimestampsCache (UpdateTimestampsCache.java:35)
14-10-2004 20:48:48 INFO - starting query cache at region: net.sf.hibernate.cache.StandardQueryCache (StandardQueryCache.java:41)
14-10-2004 20:48:48 DEBUG - insert into ACCOUNT (VERSION, PK, ACTIVE, HAS_BEEN_ACTIVATED, CREATED_DATE, EXPIRY_DATE, TITLE, FORENAME, SURNAME, EMAIL_ADDRESS, PASSWORD, QUOTA, HOUSE_NUMBER, HOUSE_NAME, STREET, TOWN_OR_CITY, COUNTY_OR_STATE, POSTCODE, COUNTRY) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) (BatcherImpl.java:226)
14-10-2004 20:48:48 DEBUG - select this.HIBERNATE_ID as HIBERNAT1_0_, this.VERSION as VERSION0_, this.PK as PK0_, this.ACTIVE as ACTIVE0_, this.HAS_BEEN_ACTIVATED as HAS_BEEN5_0_, this.CREATED_DATE as CREATED_6_0_, this.EXPIRY_DATE as EXPIRY_D7_0_, this.TITLE as TITLE0_, this.FORENAME as FORENAME0_, this.SURNAME as SURNAME0_, this.EMAIL_ADDRESS as EMAIL_A11_0_, this.PASSWORD as PASSWORD0_, this.QUOTA as QUOTA0_, this.HOUSE_NUMBER as HOUSE_N14_0_, this.HOUSE_NAME as HOUSE_NAME0_, this.STREET as STREET0_, this.TOWN_OR_CITY as TOWN_OR17_0_, this.COUNTY_OR_STATE as COUNTY_18_0_, this.POSTCODE as POSTCODE0_, this.COUNTRY as COUNTRY0_ from ACCOUNT this where this.EMAIL_ADDRESS=? (BatcherImpl.java:226)
14-10-2004 20:48:48 DEBUG - select emailaddre0_.ACCOUNT_ID as ACCOUNT_ID__, emailaddre0_.HIBERNATE_ID as HIBERNAT1___, emailaddre0_.HIBERNATE_ID as HIBERNAT1_0_, emailaddre0_.VERSION as VERSION0_, emailaddre0_.PK as PK0_, emailaddre0_.NAME as NAME0_ from EMAIL_ADDRESS_BOOK emailaddre0_ where emailaddre0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select elists0_.ACCOUNT_ID as ACCOUNT_ID__, elists0_.HIBERNATE_ID as HIBERNAT1___, elists0_.HIBERNATE_ID as HIBERNAT1_0_, elists0_.VERSION as VERSION0_, elists0_.PK as PK0_, elists0_.ELIST_NAME as ELIST_NAME0_, elists0_.EMAIL_MESSAGE as EMAIL_ME5_0_, elists0_.PASSWORD as PASSWORD0_, elists0_.HIDE_WHEN_PURCHASED as HIDE_WHE7_0_, elists0_.EMAIL_WHEN_ITEM_PURCHASED as EMAIL_WH8_0_, elists0_.EXPIRY_DATE as EXPIRY_D9_0_, elists0_.ACCOUNT_ID as ACCOUNT_ID0_ from ELIST elists0_ where elists0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - insert into ELIST (VERSION, PK, ELIST_NAME, EMAIL_MESSAGE, PASSWORD, HIDE_WHEN_PURCHASED, EMAIL_WHEN_ITEM_PURCHASED, EXPIRY_DATE, ACCOUNT_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?) (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - update ACCOUNT set VERSION=?, PK=?, ACTIVE=?, HAS_BEEN_ACTIVATED=?, CREATED_DATE=?, EXPIRY_DATE=?, TITLE=?, FORENAME=?, SURNAME=?, EMAIL_ADDRESS=?, PASSWORD=?, QUOTA=?, HOUSE_NUMBER=?, HOUSE_NAME=?, STREET=?, TOWN_OR_CITY=?, COUNTY_OR_STATE=?, POSTCODE=?, COUNTRY=? where HIBERNATE_ID=? and VERSION=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select this.HIBERNATE_ID as HIBERNAT1_0_, this.VERSION as VERSION0_, this.PK as PK0_, this.ACTIVE as ACTIVE0_, this.HAS_BEEN_ACTIVATED as HAS_BEEN5_0_, this.CREATED_DATE as CREATED_6_0_, this.EXPIRY_DATE as EXPIRY_D7_0_, this.TITLE as TITLE0_, this.FORENAME as FORENAME0_, this.SURNAME as SURNAME0_, this.EMAIL_ADDRESS as EMAIL_A11_0_, this.PASSWORD as PASSWORD0_, this.QUOTA as QUOTA0_, this.HOUSE_NUMBER as HOUSE_N14_0_, this.HOUSE_NAME as HOUSE_NAME0_, this.STREET as STREET0_, this.TOWN_OR_CITY as TOWN_OR17_0_, this.COUNTY_OR_STATE as COUNTY_18_0_, this.POSTCODE as POSTCODE0_, this.COUNTRY as COUNTRY0_ from ACCOUNT this where this.PK=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select emailaddre0_.ACCOUNT_ID as ACCOUNT_ID__, emailaddre0_.HIBERNATE_ID as HIBERNAT1___, emailaddre0_.HIBERNATE_ID as HIBERNAT1_0_, emailaddre0_.VERSION as VERSION0_, emailaddre0_.PK as PK0_, emailaddre0_.NAME as NAME0_ from EMAIL_ADDRESS_BOOK emailaddre0_ where emailaddre0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select elists0_.ACCOUNT_ID as ACCOUNT_ID__, elists0_.HIBERNATE_ID as HIBERNAT1___, elists0_.HIBERNATE_ID as HIBERNAT1_0_, elists0_.VERSION as VERSION0_, elists0_.PK as PK0_, elists0_.ELIST_NAME as ELIST_NAME0_, elists0_.EMAIL_MESSAGE as EMAIL_ME5_0_, elists0_.PASSWORD as PASSWORD0_, elists0_.HIDE_WHEN_PURCHASED as HIDE_WHE7_0_, elists0_.EMAIL_WHEN_ITEM_PURCHASED as EMAIL_WH8_0_, elists0_.EXPIRY_DATE as EXPIRY_D9_0_, elists0_.ACCOUNT_ID as ACCOUNT_ID0_ from ELIST elists0_ where elists0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select elistitems0_.ELIST_ID as ELIST_ID__, elistitems0_.HIBERNATE_ID as HIBERNAT1___, elistitems0_.HIBERNATE_ID as HIBERNAT1_0_, elistitems0_.VERSION as VERSION0_, elistitems0_.PK as PK0_, elistitems0_.DESCRIPTION as DESCRIPT4_0_, elistitems0_.WHERE_TO_BUY as WHERE_TO5_0_, elistitems0_.LINK as LINK0_, elistitems0_.PRICE as PRICE0_, elistitems0_.sortOrder as sortOrder0_, elistitems0_.DISPLAY as DISPLAY0_, elistitems0_.PURCHASED as PURCHASED0_ from ELIST_ITEM elistitems0_ where elistitems0_.ELIST_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select this.HIBERNATE_ID as HIBERNAT1_0_, this.VERSION as VERSION0_, this.PK as PK0_, this.ACTIVE as ACTIVE0_, this.HAS_BEEN_ACTIVATED as HAS_BEEN5_0_, this.CREATED_DATE as CREATED_6_0_, this.EXPIRY_DATE as EXPIRY_D7_0_, this.TITLE as TITLE0_, this.FORENAME as FORENAME0_, this.SURNAME as SURNAME0_, this.EMAIL_ADDRESS as EMAIL_A11_0_, this.PASSWORD as PASSWORD0_, this.QUOTA as QUOTA0_, this.HOUSE_NUMBER as HOUSE_N14_0_, this.HOUSE_NAME as HOUSE_NAME0_, this.STREET as STREET0_, this.TOWN_OR_CITY as TOWN_OR17_0_, this.COUNTY_OR_STATE as COUNTY_18_0_, this.POSTCODE as POSTCODE0_, this.COUNTRY as COUNTRY0_ from ACCOUNT this where this.EMAIL_ADDRESS=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select emailaddre0_.ACCOUNT_ID as ACCOUNT_ID__, emailaddre0_.HIBERNATE_ID as HIBERNAT1___, emailaddre0_.HIBERNATE_ID as HIBERNAT1_0_, emailaddre0_.VERSION as VERSION0_, emailaddre0_.PK as PK0_, emailaddre0_.NAME as NAME0_ from EMAIL_ADDRESS_BOOK emailaddre0_ where emailaddre0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select elists0_.ACCOUNT_ID as ACCOUNT_ID__, elists0_.HIBERNATE_ID as HIBERNAT1___, elists0_.HIBERNATE_ID as HIBERNAT1_0_, elists0_.VERSION as VERSION0_, elists0_.PK as PK0_, elists0_.ELIST_NAME as ELIST_NAME0_, elists0_.EMAIL_MESSAGE as EMAIL_ME5_0_, elists0_.PASSWORD as PASSWORD0_, elists0_.HIDE_WHEN_PURCHASED as HIDE_WHE7_0_, elists0_.EMAIL_WHEN_ITEM_PURCHASED as EMAIL_WH8_0_, elists0_.EXPIRY_DATE as EXPIRY_D9_0_, elists0_.ACCOUNT_ID as ACCOUNT_ID0_ from ELIST elists0_ where elists0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - select elistitems0_.ELIST_ID as ELIST_ID__, elistitems0_.HIBERNATE_ID as HIBERNAT1___, elistitems0_.HIBERNATE_ID as HIBERNAT1_0_, elistitems0_.VERSION as VERSION0_, elistitems0_.PK as PK0_, elistitems0_.DESCRIPTION as DESCRIPT4_0_, elistitems0_.WHERE_TO_BUY as WHERE_TO5_0_, elistitems0_.LINK as LINK0_, elistitems0_.PRICE as PRICE0_, elistitems0_.sortOrder as sortOrder0_, elistitems0_.DISPLAY as DISPLAY0_, elistitems0_.PURCHASED as PURCHASED0_ from ELIST_ITEM elistitems0_ where elistitems0_.ELIST_ID=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - delete from ELIST where HIBERNATE_ID=? and VERSION=? (BatcherImpl.java:226)
14-10-2004 20:48:49 DEBUG - delete from ACCOUNT where HIBERNATE_ID=? and VERSION=? (BatcherImpl.java:226)


Debug level Hibernate log excerpt:
14-10-2004 20:52:03 INFO - Hibernate 2.1.6 (Environment.java:469)
14-10-2004 20:52:03 INFO - loaded properties from resource hibernate.properties: {hibernate.cglib.use_reflection_optimizer=true, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, hibernate.cache.use_query_cache=true, hibernate.max_fetch_depth=1, hibernate.dialect=net.sf.hibernate.dialect.MySQLDialect, hibernate.jdbc.use_streams_for_binary=true, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.jdbc.batch_size=0, hibernate.proxool.pool_alias=pool1, hibernate.cache.region_prefix=hibernate.test, hibernate.connection.datasource=java:comp/env/jdbc/easytwo, hibernate.show_sql=true, hibernate.connection.pool_size=1} (Environment.java:503)
14-10-2004 20:52:03 INFO - using java.io streams to persist binary types (Environment.java:528)
14-10-2004 20:52:03 INFO - using CGLIB reflection optimizer (Environment.java:529)
14-10-2004 20:52:03 INFO - configuring from resource: /hibernate.cfg.xml (Configuration.java:895)
14-10-2004 20:52:03 INFO - Configuration resource: /hibernate.cfg.xml (Configuration.java:867)
14-10-2004 20:52:03 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:04 DEBUG - found http://hibernate.sourceforge.net/hibern ... on-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:04 DEBUG - show_sql=true (Configuration.java:853)
14-10-2004 20:52:04 DEBUG - connection.datasource=java:comp/env/jdbc/easytwo (Configuration.java:853)
14-10-2004 20:52:04 DEBUG - dialect=net.sf.hibernate.dialect.MySQLDialect (Configuration.java:853)
14-10-2004 20:52:04 DEBUG - null<-org.dom4j.tree.DefaultAttribute@8acfc3 [Attribute: name resource value "com/easylists/Account.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:04 INFO - Mapping resource: com/easylists/Account.hbm.xml (Configuration.java:331)
14-10-2004 20:52:04 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:04 DEBUG - found http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:04 INFO - Mapping class: com.easylists.Account -> ACCOUNT (Binder.java:229)
14-10-2004 20:52:05 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: active -> ACTIVE, type: boolean (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: hasBeenActivated -> HAS_BEEN_ACTIVATED, type: boolean (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: createdDate -> CREATED_DATE, type: timestamp (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: expiryDate -> EXPIRY_DATE, type: timestamp (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: title -> TITLE, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: forename -> FORENAME, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: surname -> SURNAME, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: emailAddress -> EMAIL_ADDRESS, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: password -> PASSWORD, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: quota -> QUOTA, type: integer (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: houseNumber -> HOUSE_NUMBER, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: houseName -> HOUSE_NAME, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: street -> STREET, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: townOrCity -> TOWN_OR_CITY, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: countyOrState -> COUNTY_OR_STATE, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: postcode -> POSTCODE, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: country -> COUNTRY, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: address -> HOUSE_NUMBER, HOUSE_NAME, STREET, TOWN_OR_CITY, COUNTY_OR_STATE, POSTCODE, COUNTRY, type: com.easylists.Address (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: elists, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: emailAddressBooks, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:07 DEBUG - null<-org.dom4j.tree.DefaultAttribute@1df5f21 [Attribute: name resource value "com/easylists/EList.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:07 INFO - Mapping resource: com/easylists/EList.hbm.xml (Configuration.java:331)
14-10-2004 20:52:07 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:07 DEBUG - found http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:07 INFO - Mapping class: com.easylists.EList -> ELIST (Binder.java:229)
14-10-2004 20:52:07 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: elistName -> ELIST_NAME, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: emailMessage -> EMAIL_MESSAGE, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: password -> PASSWORD, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: hideWhenPurchased -> HIDE_WHEN_PURCHASED, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: sendEmailWhenItemPurchased -> EMAIL_WHEN_ITEM_PURCHASED, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: expiryDate -> EXPIRY_DATE, type: timestamp (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: account -> ACCOUNT_ID, type: com.easylists.Account (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: elistItems, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:07 DEBUG - null<-org.dom4j.tree.DefaultAttribute@87e704 [Attribute: name resource value "com/easylists/EListItem.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:07 INFO - Mapping resource: com/easylists/EListItem.hbm.xml (Configuration.java:331)
14-10-2004 20:52:07 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:07 DEBUG - found http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:07 INFO - Mapping class: com.easylists.EListItem -> ELIST_ITEM (Binder.java:229)
14-10-2004 20:52:07 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: description -> DESCRIPTION, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: whereToBuy -> WHERE_TO_BUY, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: link -> LINK, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: price -> PRICE, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: sortOrder -> sortOrder, type: integer (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: display -> DISPLAY, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: purchased -> PURCHASED, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - null<-org.dom4j.tree.DefaultAttribute@135f44e [Attribute: name resource value "com/easylists/EmailAddress.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:07 INFO - Mapping resource: com/easylists/EmailAddress.hbm.xml (Configuration.java:331)
14-10-2004 20:52:08 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:08 DEBUG - found http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:08 INFO - Mapping class: com.easylists.EmailAddress -> EMAIL_ADDRESS (Binder.java:229)
14-10-2004 20:52:08 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: emailAddress -> EMAIL_ADDRESS, type: string (Binder.java:486)
14-10-2004 20:52:08 DEBUG - null<-org.dom4j.tree.DefaultAttribute@20c906 [Attribute: name resource value "com/easylists/EmailAddressBook.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:08 INFO - Mapping resource: com/easylists/EmailAddressBook.hbm.xml (Configuration.java:331)
14-10-2004 20:52:08 DEBUG - trying to locate http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:08 DEBUG - found http://hibernate.sourceforge.net/hibern ... ng-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:08 INFO - Mapping class: com.easylists.EmailAddressBook -> EMAIL_ADDRESS_BOOK (Binder.java:229)
14-10-2004 20:52:08 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: name -> NAME, type: string (Binder.java:486)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.EmailAddressBook.emailAddresses -> EML_ADDR_BKS_EMAIL_ADDRESSES (Binder.java:571)
14-10-2004 20:52:08 DEBUG - Mapped property: emailAddresses, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:08 INFO - Configured SessionFactory: null (Configuration.java:1053)
14-10-2004 20:52:08 DEBUG - properties: {show_sql=true, java.vendor=Sun Microsystems Inc., catalina.base=D:\Apache Software Foundation\Tomcat 5.0, connection.datasource=java:comp/env/jdbc/easytwo, catalina.useNaming=true, os.name=Windows XP, sun.boot.class.path=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xercesImpl.jar;D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xmlParserAPIs.jar;D:\j2sdk1.4.2_01\jre\lib\rt.jar;D:\j2sdk1.4.2_01\jre\lib\i18n.jar;D:\j2sdk1.4.2_01\jre\lib\sunrsasign.jar;D:\j2sdk1.4.2_01\jre\lib\jsse.jar;D:\j2sdk1.4.2_01\jre\lib\jce.jar;D:\j2sdk1.4.2_01\jre\lib\charsets.jar;D:\j2sdk1.4.2_01\jre\classes, sun.java2d.fontpath=, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.4.2_01-b06, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, user.name=SYSTEM, shared.loader=${catalina.base}/shared/classes,${catalina.base}/shared/lib/*.jar, user.language=en, java.naming.factory.initial=org.apache.naming.java.javaURLContextFactory, cactus.contextURL=http://127.0.0.1:8080/easy-lists, sun.boot.library.path=D:\j2sdk1.4.2_01\jre\bin, dialect=net.sf.hibernate.dialect.MySQLDialect, java.version=1.4.2_01, user.timezone=Europe/London, sun.arch.data.model=32, java.endorsed.dirs=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed, sun.cpu.isalist=pentium i486 i386, file.encoding.pkg=sun.io, package.access=sun.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper.,sun.beans., file.separator=\, java.specification.name=Java Platform API Specification, hibernate.cglib.use_reflection_optimizer=true, java.class.version=48.0, user.country=GB, java.home=D:\j2sdk1.4.2_01\jre, java.vm.info=mixed mode, os.version=5.1, hibernate.connection.datasource=java:comp/env/jdbc/easytwo, path.separator=;, java.vm.version=1.4.2_01-b06, hibernate.max_fetch_depth=1, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, user.variant=, hibernate.jdbc.batch_size=0, cactus.jspRedirectorName=JspRedirector, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, package.definition=sun.,java.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper., hibernate.cache.region_prefix=hibernate.test, java.naming.factory.url.pkgs=org.apache.naming, user.home=C:\WINDOWS\system32\config\systemprofile, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', java.specification.vendor=Sun Microsystems Inc., java.library.path=D:\Apache Software Foundation\Tomcat 5.0\bin;.;C:\WINDOWS\System32;C:\WINDOWS;D:\Perl\bin\;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;D:\apache-ant-1.5.4\bin;D:\j2sdk1.4.2_01\bin;D:\j2sdkee1.3.1\bin;D:\gpg, java.vendor.url=http://java.sun.com/, hibernate.proxool.pool_alias=pool1, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=net.sf.hibernate.dialect.MySQLDialect, common.loader=${catalina.home}/common/classes,${catalina.home}/common/endorsed/*.jar,${catalina.home}/common/lib/*.jar, hibernate.jdbc.use_streams_for_binary=true, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=D:\Apache Software Foundation\Tomcat 5.0\bin\bootstrap.jar, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, catalina.home=D:\Apache Software Foundation\Tomcat 5.0, sun.cpu.endian=little, sun.os.patch.level=Service Pack 1, hibernate.cache.use_query_cache=true, java.io.tmpdir=D:\Apache Software Foundation\Tomcat 5.0, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, server.loader=${catalina.home}/server/classes,${catalina.home}/server/lib/*.jar, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=D:\j2sdk1.4.2_01\jre\lib\ext, cactus.filterRedirectorName=test/filterRedirector.jsp, user.dir=C:\WINDOWS\system32, line.separator=
, java.vm.name=Java HotSpot(TM) Server VM, cactus.servletRedirectorName=ServletRedirector, file.encoding=Cp1252, java.specification.version=1.4, hibernate.connection.pool_size=1, hibernate.show_sql=true} (Configuration.java:1054)
14-10-2004 20:52:08 INFO - processing one-to-many association mappings (Configuration.java:627)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.Account.elists (Binder.java:1353)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.Account.elists -> ELIST (Binder.java:1181)
14-10-2004 20:52:08 DEBUG - Mapped collection key: ACCOUNT_ID, one-to-many: com.easylists.EList (Binder.java:1368)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.Account.emailAddressBooks (Binder.java:1353)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.Account.emailAddressBooks -> EMAIL_ADDRESS_BOOK (Binder.java:1181)
14-10-2004 20:52:08 DEBUG - Mapped collection key: ACCOUNT_ID, one-to-many: com.easylists.EmailAddressBook (Binder.java:1368)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.EList.elistItems (Binder.java:1353)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.EList.elistItems -> ELIST_ITEM (Binder.java:1181)
14-10-2004 20:52:08 DEBUG - Mapped collection key: ELIST_ID, one-to-many: com.easylists.EListItem (Binder.java:1368)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.EmailAddressBook.emailAddresses (Binder.java:1353)
14-10-2004 20:52:08 DEBUG - Mapped collection key: EMAIL_ADDR_BOOK_ID, element: EMAIL_ADDRESS_ID, type: com.easylists.EmailAddress (Binder.java:1368)
14-10-2004 20:52:08 INFO - processing one-to-one association property references (Configuration.java:636)
14-10-2004 20:52:08 INFO - processing foreign key constraints (Configuration.java:661)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.EmailAddress (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.EmailAddressBook (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.Account (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.Account (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.EList (Configuration.java:678)
14-10-2004 20:52:09 INFO - Using dialect: net.sf.hibernate.dialect.MySQLDialect (Dialect.java:82)
14-10-2004 20:52:09 INFO - Maximim outer join fetch depth: 1 (SettingsFactory.java:59)
14-10-2004 20:52:09 INFO - Use outer join fetching: true (SettingsFactory.java:63)
14-10-2004 20:52:09 INFO - JNDI InitialContext properties:{} (NamingHelper.java:26)
14-10-2004 20:52:09 INFO - Using datasource: java:comp/env/jdbc/easytwo (DatasourceConnectionProvider.java:51)
14-10-2004 20:52:09 INFO - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended) (TransactionManagerLookupFactory.java:33)
14-10-2004 20:52:09 INFO - Use scrollable result sets: true (SettingsFactory.java:103)
14-10-2004 20:52:09 INFO - Use JDBC3 getGeneratedKeys(): true (SettingsFactory.java:106)
14-10-2004 20:52:09 INFO - Optimize cache for minimal puts: false (SettingsFactory.java:109)
14-10-2004 20:52:09 INFO - echoing all SQL to stdout (SettingsFactory.java:115)
14-10-2004 20:52:09 INFO - Query language substitutions: {no='N', true=1, yes='Y', false=0} (SettingsFactory.java:118)
14-10-2004 20:52:09 INFO - cache provider: net.sf.ehcache.hibernate.Provider (SettingsFactory.java:129)
14-10-2004 20:52:09 INFO - query cache factory: net.sf.hibernate.cache.StandardQueryCacheFactory (SettingsFactory.java:141)
14-10-2004 20:52:09 INFO - instantiating and configuring caches (Configuration.java:1116)
14-10-2004 20:52:09 INFO - building session factory (SessionFactoryImpl.java:118)
14-10-2004 20:52:09 DEBUG - instantiating session factory with properties: {show_sql=true, java.vendor=Sun Microsystems Inc., catalina.base=D:\Apache Software Foundation\Tomcat 5.0, connection.datasource=java:comp/env/jdbc/easytwo, catalina.useNaming=true, os.name=Windows XP, sun.boot.class.path=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xercesImpl.jar;D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xmlParserAPIs.jar;D:\j2sdk1.4.2_01\jre\lib\rt.jar;D:\j2sdk1.4.2_01\jre\lib\i18n.jar;D:\j2sdk1.4.2_01\jre\lib\sunrsasign.jar;D:\j2sdk1.4.2_01\jre\lib\jsse.jar;D:\j2sdk1.4.2_01\jre\lib\jce.jar;D:\j2sdk1.4.2_01\jre\lib\charsets.jar;D:\j2sdk1.4.2_01\jre\classes, sun.java2d.fontpath=, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.4.2_01-b06, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, user.name=SYSTEM, shared.loader=${catalina.base}/shared/classes,${catalina.base}/shared/lib/*.jar, user.language=en, java.naming.factory.initial=org.apache.naming.java.javaURLContextFactory, cactus.contextURL=http://127.0.0.1:8080/easy-lists, sun.boot.library.path=D:\j2sdk1.4.2_01\jre\bin, dialect=net.sf.hibernate.dialect.MySQLDialect, java.version=1.4.2_01, user.timezone=Europe/London, sun.arch.data.model=32, java.endorsed.dirs=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed, sun.cpu.isalist=pentium i486 i386, file.encoding.pkg=sun.io, package.access=sun.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper.,sun.beans., file.separator=\, java.specification.name=Java Platform API Specification, hibernate.cglib.use_reflection_optimizer=true, java.class.version=48.0, user.country=GB, java.home=D:\j2sdk1.4.2_01\jre, java.vm.info=mixed mode, os.version=5.1, hibernate.connection.datasource=java:comp/env/jdbc/easytwo, path.separator=;, java.vm.version=1.4.2_01-b06, hibernate.max_fetch_depth=1, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, user.variant=, hibernate.jdbc.batch_size=0, cactus.jspRedirectorName=JspRedirector, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, package.definition=sun.,java.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper., hibernate.cache.region_prefix=hibernate.test, java.naming.factory.url.pkgs=org.apache.naming, user.home=C:\WINDOWS\system32\config\systemprofile, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', java.specification.vendor=Sun Microsystems Inc., java.library.path=D:\Apache Software Foundation\Tomcat 5.0\bin;.;C:\WINDOWS\System32;C:\WINDOWS;D:\Perl\bin\;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;D:\apache-ant-1.5.4\bin;D:\j2sdk1.4.2_01\bin;D:\j2sdkee1.3.1\bin;D:\gpg, java.vendor.url=http://java.sun.com/, hibernate.proxool.pool_alias=pool1, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=net.sf.hibernate.dialect.MySQLDialect, common.loader=${catalina.home}/common/classes,${catalina.home}/common/endorsed/*.jar,${catalina.home}/common/lib/*.jar, hibernate.jdbc.use_streams_for_binary=true, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=D:\Apache Software Foundation\Tomcat 5.0\bin\bootstrap.jar, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, catalina.home=D:\Apache Software Foundation\Tomcat 5.0, sun.cpu.endian=little, sun.os.patch.level=Service Pack 1, hibernate.cache.use_query_cache=true, java.io.tmpdir=D:\Apache Software Foundation\Tomcat 5.0, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, server.loader=${catalina.home}/server/classes,${catalina.home}/server/lib/*.jar, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=D:\j2sdk1.4.2_01\jre\lib\ext, cactus.filterRedirectorName=test/filterRedirector.jsp, user.dir=C:\WINDOWS\system32, line.separator=
, java.vm.name=Java HotSpot(TM) Server VM, cactus.servletRedirectorName=ServletRedirector, file.encoding=Cp1252, java.specification.version=1.4, hibernate.connection.pool_size=1, hibernate.show_sql=true} (SessionFactoryImpl.java:124)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EList, BulkBeanException: Property is private (property setElistItems) (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.Account, BulkBeanException: Property is private (property setElists) (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EmailAddress, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EListItem, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EmailAddressBook, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:52:10 DEBUG - initializing class SessionFactoryObjectFactory (SessionFactoryObjectFactory.java:39)
14-10-2004 20:52:10 DEBUG - registered: d2a1cd8bff98ff5000ff98ff553a0000 (unnamed) (SessionFactoryObjectFactory.java:76)
14-10-2004 20:52:10 INFO - Not binding factory to JNDI, no JNDI name configured (SessionFactoryObjectFactory.java:82)
14-10-2004 20:52:10 DEBUG - instantiated session factory (SessionFactoryImpl.java:195)
14-10-2004 20:52:10 INFO - starting update timestamps cache at region: net.sf.hibernate.cache.UpdateTimestampsCache (UpdateTimestampsCache.java:35)
14-10-2004 20:52:10 INFO - starting query cache at region: net.sf.hibernate.cache.StandardQueryCache (StandardQueryCache.java:41)
14-10-2004 20:52:11 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:11 DEBUG - begin (JDBCTransaction.java:37)
14-10-2004 20:52:11 DEBUG - current autocommit status:true (JDBCTransaction.java:41)
14-10-2004 20:52:11 DEBUG - disabling autocommit (JDBCTransaction.java:43)
14-10-2004 20:52:11 DEBUG - saveOrUpdate() unsaved instance (SessionImpl.java:1387)
14-10-2004 20:52:11 DEBUG - saving [com.easylists.Account#<null>] (SessionImpl.java:825)
14-10-2004 20:52:11 DEBUG - executing insertions (SessionImpl.java:2309)
14-10-2004 20:52:11 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:11 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:11 DEBUG - using initial version: 0 (Versioning.java:56)
14-10-2004 20:52:11 DEBUG - Wrapped collection in role: com.easylists.Account.elists (WrapVisitor.java:81)
14-10-2004 20:52:11 DEBUG - Wrapped collection in role: com.easylists.Account.emailAddressBooks (WrapVisitor.java:81)
14-10-2004 20:52:11 DEBUG - Inserting entity: com.easylists.Account (native id) (EntityPersister.java:490)
14-10-2004 20:52:11 DEBUG - Version: 0 (EntityPersister.java:491)
14-10-2004 20:52:11 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:11 DEBUG - insert into ACCOUNT (VERSION, PK, ACTIVE, HAS_BEEN_ACTIVATED, CREATED_DATE, EXPIRY_DATE, TITLE, FORENAME, SURNAME, EMAIL_ADDRESS, PASSWORD, QUOTA, HOUSE_NUMBER, HOUSE_NAME, STREET, TOWN_OR_CITY, COUNTY_OR_STATE, POSTCODE, COUNTRY) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) (BatcherImpl.java:226)
14-10-2004 20:52:11 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:11 DEBUG - Dehydrating entity: [com.easylists.Account#<null>] (EntityPersister.java:388)
14-10-2004 20:52:11 DEBUG - Natively generated identity: 118 (AbstractEntityPersister.java:1236)
14-10-2004 20:52:11 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:11 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:11 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.elists (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.emailAddressBooks (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:11 DEBUG - commit (JDBCTransaction.java:59)
14-10-2004 20:52:11 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:11 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.elists (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.emailAddressBooks (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:11 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:11 DEBUG - Collection found: [com.easylists.Account.elists#118], was: [<unreferenced>] (SessionImpl.java:2884)
14-10-2004 20:52:11 DEBUG - Collection found: [com.easylists.Account.emailAddressBooks#118], was: [<unreferenced>] (SessionImpl.java:2884)
14-10-2004 20:52:11 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:11 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:11 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects (SessionImpl.java:2270)
14-10-2004 20:52:11 DEBUG - Flushed: 2 (re)creations, 0 updates, 0 removals to 2 collections (SessionImpl.java:2275)
14-10-2004 20:52:11 DEBUG - listing entities: (Printer.java:75)
14-10-2004 20:52:11 DEBUG - com.easylists.Account{active=false, createdDate=2004-10-14 20:52:02, forename=Paul, password=ImbFcQhSD+0=, hasBeenActivated=false, title=Mr, address=Address{country=UK, street=Chapel Street, postcode=BA128BZ, houseName=, countyOrState=Wiltshire, townOrCity=Warminster, houseNumber=15}, hibernateId=118, pk=688, version=0, expiryDate=null, surname=Taylor, emailAddressBooks=[], emailAddress=test@javacoda.com, quota=0, elists=[]} (Printer.java:82)
14-10-2004 20:52:11 DEBUG - executing flush (SessionImpl.java:2359)
14-10-2004 20:52:11 DEBUG - Inserting collection: [com.easylists.Account.emailAddressBooks#118] (AbstractCollectionPersister.java:508)
14-10-2004 20:52:11 DEBUG - collection was empty (AbstractCollectionPersister.java:539)
14-10-2004 20:52:11 DEBUG - post flush (SessionImpl.java:2824)
14-10-2004 20:52:11 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:11 DEBUG - Invalidating space [ACCOUNT] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:11 DEBUG - Invalidating space [ELIST] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:11 DEBUG - Invalidating space [EMAIL_ADDRESS_BOOK] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:11 DEBUG - re-enabling autocommit (JDBCTransaction.java:103)
14-10-2004 20:52:11 DEBUG - closing session (SessionImpl.java:573)
14-10-2004 20:52:11 DEBUG - disconnecting session (SessionImpl.java:3336)
14-10-2004 20:52:11 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:11 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:12 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:12 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:12 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:12 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:12 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects (SessionImpl.java:2270)
14-10-2004 20:52:12 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections (SessionImpl.java:2275)
14-10-2004 20:52:12 DEBUG - Dont need to execute flush (SessionImpl.java:1818)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - select this.HIBERNATE_ID as HIBERNAT1_0_, this.VERSION as VERSION0_, this.PK as PK0_, this.ACTIVE as ACTIVE0_, this.HAS_BEEN_ACTIVATED as HAS_BEEN5_0_, this.CREATED_DATE as CREATED_6_0_, this.EXPIRY_DATE as EXPIRY_D7_0_, this.TITLE as TITLE0_, this.FORENAME as FORENAME0_, this.SURNAME as SURNAME0_, this.EMAIL_ADDRESS as EMAIL_A11_0_, this.PASSWORD as PASSWORD0_, this.QUOTA as QUOTA0_, this.HOUSE_NUMBER as HOUSE_N14_0_, this.HOUSE_NAME as HOUSE_NAME0_, this.STREET as STREET0_, this.TOWN_OR_CITY as TOWN_OR17_0_, this.COUNTY_OR_STATE as COUNTY_18_0_, this.POSTCODE as POSTCODE0_, this.COUNTRY as COUNTRY0_ from ACCOUNT this where this.EMAIL_ADDRESS=? (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:12 DEBUG - result row: 118 (Loader.java:480)
14-10-2004 20:52:12 DEBUG - Initializing object from ResultSet: 118 (Loader.java:611)
14-10-2004 20:52:12 DEBUG - Hydrating entity: com.easylists.Account#118 (Loader.java:680)
14-10-2004 20:52:12 DEBUG - Version: 0 (SessionImpl.java:1910)
14-10-2004 20:52:12 DEBUG - done processing result set (1 rows) (Loader.java:294)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - total objects hydrated: 1 (Loader.java:314)
14-10-2004 20:52:12 DEBUG - resolving associations for [com.easylists.Account#118] (SessionImpl.java:2202)
14-10-2004 20:52:12 DEBUG - creating collection wrapper:[com.easylists.Account.elists#118] (SessionImpl.java:3933)
14-10-2004 20:52:12 DEBUG - creating collection wrapper:[com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3933)
14-10-2004 20:52:12 DEBUG - done materializing entity [com.easylists.Account#118] (SessionImpl.java:2226)
14-10-2004 20:52:12 DEBUG - initializing non-lazy collections (SessionImpl.java:3116)
14-10-2004 20:52:12 DEBUG - initializing collection [com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3260)
14-10-2004 20:52:12 DEBUG - checking second-level cache (SessionImpl.java:3261)
14-10-2004 20:52:12 DEBUG - collection not cached (SessionImpl.java:3267)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - select emailaddre0_.ACCOUNT_ID as ACCOUNT_ID__, emailaddre0_.HIBERNATE_ID as HIBERNAT1___, emailaddre0_.HIBERNATE_ID as HIBERNAT1_0_, emailaddre0_.VERSION as VERSION0_, emailaddre0_.PK as PK0_, emailaddre0_.NAME as NAME0_ from EMAIL_ADDRESS_BOOK emailaddre0_ where emailaddre0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - result set contains (possibly empty) collection: [com.easylists.Account.emailAddressBooks#118] (Loader.java:402)
14-10-2004 20:52:12 DEBUG - uninitialized collection: initializing (SessionImpl.java:3018)
14-10-2004 20:52:12 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:12 DEBUG - done processing result set (0 rows) (Loader.java:294)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - total objects hydrated: 0 (Loader.java:314)
14-10-2004 20:52:12 DEBUG - 1 collections were found in result set (SessionImpl.java:3077)
14-10-2004 20:52:12 DEBUG - collection fully initialized: [com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3095)
14-10-2004 20:52:12 DEBUG - 1 collections initialized (SessionImpl.java:3098)
14-10-2004 20:52:12 DEBUG - collection initialized (SessionImpl.java:3269)
14-10-2004 20:52:12 DEBUG - initializing collection [com.easylists.Account.elists#118] (SessionImpl.java:3260)
14-10-2004 20:52:12 DEBUG - checking second-level cache (SessionImpl.java:3261)
14-10-2004 20:52:12 DEBUG - collection not cached (SessionImpl.java:3267)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - select elists0_.ACCOUNT_ID as ACCOUNT_ID__, elists0_.HIBERNATE_ID as HIBERNAT1___, elists0_.HIBERNATE_ID as HIBERNAT1_0_, elists0_.VERSION as VERSION0_, elists0_.PK as PK0_, elists0_.ELIST_NAME as ELIST_NAME0_, elists0_.EMAIL_MESSAGE as EMAIL_ME5_0_, elists0_.PASSWORD as PASSWORD0_, elists0_.HIDE_WHEN_PURCHASED as HIDE_WHE7_0_, elists0_.EMAIL_WHEN_ITEM_PURCHASED as EMAIL_WH8_0_, elists0_.EXPIRY_DATE as EXPIRY_D9_0_, elists0_.ACCOUNT_ID as ACCOUNT_ID0_ from ELIST elists0_ where elists0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - result set contains (possibly empty) collection: [com.easylists.Account.elists#118] (Loader.java:402)
14-10-2004 20:52:12 DEBUG - uninitialized collection: initializing (SessionImpl.java:3018)
14-10-2004 20:52:12 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:12 DEBUG - done processing result set (0 rows) (Loader.java:294)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - total objects hydrated: 0 (Loader.java:314)
14-10-2004 20:52:12 DEBUG - 1 collections were found in result set (SessionImpl.java:3077)
14-10-2004 20:52:12 DEBUG - collection fully initialized: [com.easylists.Account.elists#118] (SessionImpl.java:3095)
14-10-2004 20:52:12 DEBUG - 1 collections initialized (SessionImpl.java:3098)
14-10-2004 20:52:12 DEBUG - collection initialized (SessionImpl.java:3269)
14-10-2004 20:52:12 DEBUG - closing session (SessionImpl.java:573)
14-10-2004 20:52:12 DEBUG - disconnecting session (SessionImpl.java:3336)
14-10-2004 20:52:12 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:12 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:12 DEBUG - begin (JDBCTransaction.java:37)
14-10-2004 20:52:12 DEBUG - current autocommit status:true (JDBCTransaction.java:41)
14-10-2004 20:52:12 DEBUG - disabling autocommit (JDBCTransaction.java:43)
14-10-2004 20:52:12 DEBUG - saveOrUpdate() unsaved instance (SessionImpl.java:1387)
14-10-2004 20:52:12 DEBUG - saving [com.easylists.EList#<null>] (SessionImpl.java:825)
14-10-2004 20:52:12 DEBUG - executing insertions (SessionImpl.java:2309)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.EList (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.EList (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - using initial version: 0 (Versioning.java:56)
14-10-2004 20:52:12 DEBUG - Wrapped collection in role: com.easylists.EList.elistItems (WrapVisitor.java:81)
14-10-2004 20:52:12 DEBUG - version unsaved-value strategy UNDEFINED (Cascades.java:396)
14-10-2004 20:52:12 DEBUG - id unsaved-value strategy NULL (Cascades.java:341)
14-10-2004 20:52:12 DEBUG - Inserting entity: com.easylists.EList (native id) (EntityPersister.java:490)
14-10-2004 20:52:12 DEBUG - Version: 0 (EntityPersister.java:491)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - insert into ELIST (VERSION, PK, ELIST_NAME, EMAIL_MESSAGE, PASSWORD, HIDE_WHEN_PURCHASED, EMAIL_WHEN_ITEM_PURCHASED, EXPIRY_DATE, ACCOUNT_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?) (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - Dehydrating entity: [com.easylists.EList#<null>] (EntityPersister.java:388)
14-10-2004 20:52:12 DEBUG - version unsaved-value strategy UNDEFINED (Cascades.java:396)
14-10-2004 20:52:12 DEBUG - id unsaved-value strategy NULL (Cascades.java:341)
14-10-2004 20:52:12 DEBUG - Natively generated identity: 20 (AbstractEntityPersister.java:1236)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.EList (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.EList.elistItems (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.EList (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - commit (JDBCTransaction.java:59)
14-10-2004 20:52:12 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.EList (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.EList.elistItems (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.EList (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:12 DEBUG - Collection found: [com.easylists.EList.elistItems#20], was: [<unreferenced>] (SessionImpl.java:2884)
14-10-2004 20:52:12 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:12 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:12 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects (SessionImpl.java:2270)
14-10-2004 20:52:12 DEBUG - Flushed: 1 (re)creations, 0 updates, 0 removals to 1 collections (SessionImpl.java:2275)
14-10-2004 20:52:12 DEBUG - listing entities: (Printer.java:75)
14-10-2004 20:52:12 DEBUG - com.easylists.EList{password=null, expiryDate=null, sendEmailWhenItemPurchased=false, elistItems=[], account=Account#118, emailMessage=null, hideWhenPurchased=false, elistName=TEST, hibernateId=20, pk=584, version=0} (Printer.java:82)
14-10-2004 20:52:12 DEBUG - executing flush (SessionImpl.java:2359)
14-10-2004 20:52:12 DEBUG - Inserting collection: [com.easylists.EList.elistItems#20] (AbstractCollectionPersister.java:508)
14-10-2004 20:52:12 DEBUG - collection was empty (AbstractCollectionPersister.java:539)
14-10-2004 20:52:12 DEBUG - post flush (SessionImpl.java:2824)
14-10-2004 20:52:12 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:12 DEBUG - Invalidating space [ELIST] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:12 DEBUG - Invalidating space [ELIST_ITEM] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:12 DEBUG - re-enabling autocommit (JDBCTransaction.java:103)
14-10-2004 20:52:12 DEBUG - closing session (SessionImpl.java:573)
14-10-2004 20:52:12 DEBUG - disconnecting session (SessionImpl.java:3336)
14-10-2004 20:52:12 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:12 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:12 DEBUG - beg


Top
 Profile  
 
 Post subject: Noticed a bit of the debug log was truncated so reposting it
PostPosted: Thu Oct 14, 2004 4:24 pm 
Regular
Regular

Joined: Fri Jul 16, 2004 3:04 pm
Posts: 52
Location: Wiltshire UK
[code]14-10-2004 20:52:03 INFO - Hibernate 2.1.6 (Environment.java:469)
14-10-2004 20:52:03 INFO - loaded properties from resource hibernate.properties: {hibernate.cglib.use_reflection_optimizer=true, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, hibernate.cache.use_query_cache=true, hibernate.max_fetch_depth=1, hibernate.dialect=net.sf.hibernate.dialect.MySQLDialect, hibernate.jdbc.use_streams_for_binary=true, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', hibernate.jdbc.batch_size=0, hibernate.proxool.pool_alias=pool1, hibernate.cache.region_prefix=hibernate.test, hibernate.connection.datasource=java:comp/env/jdbc/easytwo, hibernate.show_sql=true, hibernate.connection.pool_size=1} (Environment.java:503)
14-10-2004 20:52:03 INFO - using java.io streams to persist binary types (Environment.java:528)
14-10-2004 20:52:03 INFO - using CGLIB reflection optimizer (Environment.java:529)
14-10-2004 20:52:03 INFO - configuring from resource: /hibernate.cfg.xml (Configuration.java:895)
14-10-2004 20:52:03 INFO - Configuration resource: /hibernate.cfg.xml (Configuration.java:867)
14-10-2004 20:52:03 DEBUG - trying to locate http://hibernate.sourceforge.net/hibernate-configuration-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:04 DEBUG - found http://hibernate.sourceforge.net/hibernate-configuration-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:04 DEBUG - show_sql=true (Configuration.java:853)
14-10-2004 20:52:04 DEBUG - connection.datasource=java:comp/env/jdbc/easytwo (Configuration.java:853)
14-10-2004 20:52:04 DEBUG - dialect=net.sf.hibernate.dialect.MySQLDialect (Configuration.java:853)
14-10-2004 20:52:04 DEBUG - null<-org.dom4j.tree.DefaultAttribute@8acfc3 [Attribute: name resource value "com/easylists/Account.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:04 INFO - Mapping resource: com/easylists/Account.hbm.xml (Configuration.java:331)
14-10-2004 20:52:04 DEBUG - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:04 DEBUG - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:04 INFO - Mapping class: com.easylists.Account -> ACCOUNT (Binder.java:229)
14-10-2004 20:52:05 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: active -> ACTIVE, type: boolean (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: hasBeenActivated -> HAS_BEEN_ACTIVATED, type: boolean (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: createdDate -> CREATED_DATE, type: timestamp (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: expiryDate -> EXPIRY_DATE, type: timestamp (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: title -> TITLE, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: forename -> FORENAME, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: surname -> SURNAME, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: emailAddress -> EMAIL_ADDRESS, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: password -> PASSWORD, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: quota -> QUOTA, type: integer (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: houseNumber -> HOUSE_NUMBER, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: houseName -> HOUSE_NAME, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: street -> STREET, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: townOrCity -> TOWN_OR_CITY, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: countyOrState -> COUNTY_OR_STATE, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: postcode -> POSTCODE, type: string (Binder.java:486)
14-10-2004 20:52:05 DEBUG - Mapped property: country -> COUNTRY, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: address -> HOUSE_NUMBER, HOUSE_NAME, STREET, TOWN_OR_CITY, COUNTY_OR_STATE, POSTCODE, COUNTRY, type: com.easylists.Address (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: elists, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: emailAddressBooks, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:07 DEBUG - null<-org.dom4j.tree.DefaultAttribute@1df5f21 [Attribute: name resource value "com/easylists/EList.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:07 INFO - Mapping resource: com/easylists/EList.hbm.xml (Configuration.java:331)
14-10-2004 20:52:07 DEBUG - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:07 DEBUG - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:07 INFO - Mapping class: com.easylists.EList -> ELIST (Binder.java:229)
14-10-2004 20:52:07 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: elistName -> ELIST_NAME, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: emailMessage -> EMAIL_MESSAGE, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: password -> PASSWORD, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: hideWhenPurchased -> HIDE_WHEN_PURCHASED, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: sendEmailWhenItemPurchased -> EMAIL_WHEN_ITEM_PURCHASED, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: expiryDate -> EXPIRY_DATE, type: timestamp (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: account -> ACCOUNT_ID, type: com.easylists.Account (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: elistItems, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:07 DEBUG - null<-org.dom4j.tree.DefaultAttribute@87e704 [Attribute: name resource value "com/easylists/EListItem.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:07 INFO - Mapping resource: com/easylists/EListItem.hbm.xml (Configuration.java:331)
14-10-2004 20:52:07 DEBUG - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:07 DEBUG - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:07 INFO - Mapping class: com.easylists.EListItem -> ELIST_ITEM (Binder.java:229)
14-10-2004 20:52:07 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: description -> DESCRIPTION, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: whereToBuy -> WHERE_TO_BUY, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: link -> LINK, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: price -> PRICE, type: string (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: sortOrder -> sortOrder, type: integer (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: display -> DISPLAY, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - Mapped property: purchased -> PURCHASED, type: boolean (Binder.java:486)
14-10-2004 20:52:07 DEBUG - null<-org.dom4j.tree.DefaultAttribute@135f44e [Attribute: name resource value "com/easylists/EmailAddress.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:07 INFO - Mapping resource: com/easylists/EmailAddress.hbm.xml (Configuration.java:331)
14-10-2004 20:52:08 DEBUG - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:08 DEBUG - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:08 INFO - Mapping class: com.easylists.EmailAddress -> EMAIL_ADDRESS (Binder.java:229)
14-10-2004 20:52:08 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: emailAddress -> EMAIL_ADDRESS, type: string (Binder.java:486)
14-10-2004 20:52:08 DEBUG - null<-org.dom4j.tree.DefaultAttribute@20c906 [Attribute: name resource value "com/easylists/EmailAddressBook.hbm.xml"] (Configuration.java:1012)
14-10-2004 20:52:08 INFO - Mapping resource: com/easylists/EmailAddressBook.hbm.xml (Configuration.java:331)
14-10-2004 20:52:08 DEBUG - trying to locate http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath under net/sf/hibernate/ (DTDEntityResolver.java:20)
14-10-2004 20:52:08 DEBUG - found http://hibernate.sourceforge.net/hibernate-mapping-2.0.dtd in classpath (DTDEntityResolver.java:29)
14-10-2004 20:52:08 INFO - Mapping class: com.easylists.EmailAddressBook -> EMAIL_ADDRESS_BOOK (Binder.java:229)
14-10-2004 20:52:08 DEBUG - Mapped property: hibernateId -> HIBERNATE_ID, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: version -> VERSION, type: integer (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: pk -> PK, type: long (Binder.java:486)
14-10-2004 20:52:08 DEBUG - Mapped property: name -> NAME, type: string (Binder.java:486)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.EmailAddressBook.emailAddresses -> EML_ADDR_BKS_EMAIL_ADDRESSES (Binder.java:571)
14-10-2004 20:52:08 DEBUG - Mapped property: emailAddresses, type: java.util.Set (Binder.java:486)
14-10-2004 20:52:08 INFO - Configured SessionFactory: null (Configuration.java:1053)
14-10-2004 20:52:08 DEBUG - properties: {show_sql=true, java.vendor=Sun Microsystems Inc., catalina.base=D:\Apache Software Foundation\Tomcat 5.0, connection.datasource=java:comp/env/jdbc/easytwo, catalina.useNaming=true, os.name=Windows XP, sun.boot.class.path=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xercesImpl.jar;D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xmlParserAPIs.jar;D:\j2sdk1.4.2_01\jre\lib\rt.jar;D:\j2sdk1.4.2_01\jre\lib\i18n.jar;D:\j2sdk1.4.2_01\jre\lib\sunrsasign.jar;D:\j2sdk1.4.2_01\jre\lib\jsse.jar;D:\j2sdk1.4.2_01\jre\lib\jce.jar;D:\j2sdk1.4.2_01\jre\lib\charsets.jar;D:\j2sdk1.4.2_01\jre\classes, sun.java2d.fontpath=, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.4.2_01-b06, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, user.name=SYSTEM, shared.loader=${catalina.base}/shared/classes,${catalina.base}/shared/lib/*.jar, user.language=en, java.naming.factory.initial=org.apache.naming.java.javaURLContextFactory, cactus.contextURL=http://127.0.0.1:8080/easy-lists, sun.boot.library.path=D:\j2sdk1.4.2_01\jre\bin, dialect=net.sf.hibernate.dialect.MySQLDialect, java.version=1.4.2_01, user.timezone=Europe/London, sun.arch.data.model=32, java.endorsed.dirs=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed, sun.cpu.isalist=pentium i486 i386, file.encoding.pkg=sun.io, package.access=sun.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper.,sun.beans., file.separator=\, java.specification.name=Java Platform API Specification, hibernate.cglib.use_reflection_optimizer=true, java.class.version=48.0, user.country=GB, java.home=D:\j2sdk1.4.2_01\jre, java.vm.info=mixed mode, os.version=5.1, hibernate.connection.datasource=java:comp/env/jdbc/easytwo, path.separator=;, java.vm.version=1.4.2_01-b06, hibernate.max_fetch_depth=1, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, user.variant=, hibernate.jdbc.batch_size=0, cactus.jspRedirectorName=JspRedirector, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, package.definition=sun.,java.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper., hibernate.cache.region_prefix=hibernate.test, java.naming.factory.url.pkgs=org.apache.naming, user.home=C:\WINDOWS\system32\config\systemprofile, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', java.specification.vendor=Sun Microsystems Inc., java.library.path=D:\Apache Software Foundation\Tomcat 5.0\bin;.;C:\WINDOWS\System32;C:\WINDOWS;D:\Perl\bin\;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;D:\apache-ant-1.5.4\bin;D:\j2sdk1.4.2_01\bin;D:\j2sdkee1.3.1\bin;D:\gpg, java.vendor.url=http://java.sun.com/, hibernate.proxool.pool_alias=pool1, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=net.sf.hibernate.dialect.MySQLDialect, common.loader=${catalina.home}/common/classes,${catalina.home}/common/endorsed/*.jar,${catalina.home}/common/lib/*.jar, hibernate.jdbc.use_streams_for_binary=true, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=D:\Apache Software Foundation\Tomcat 5.0\bin\bootstrap.jar, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, catalina.home=D:\Apache Software Foundation\Tomcat 5.0, sun.cpu.endian=little, sun.os.patch.level=Service Pack 1, hibernate.cache.use_query_cache=true, java.io.tmpdir=D:\Apache Software Foundation\Tomcat 5.0, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, server.loader=${catalina.home}/server/classes,${catalina.home}/server/lib/*.jar, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=D:\j2sdk1.4.2_01\jre\lib\ext, cactus.filterRedirectorName=test/filterRedirector.jsp, user.dir=C:\WINDOWS\system32, line.separator=
, java.vm.name=Java HotSpot(TM) Server VM, cactus.servletRedirectorName=ServletRedirector, file.encoding=Cp1252, java.specification.version=1.4, hibernate.connection.pool_size=1, hibernate.show_sql=true} (Configuration.java:1054)
14-10-2004 20:52:08 INFO - processing one-to-many association mappings (Configuration.java:627)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.Account.elists (Binder.java:1353)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.Account.elists -> ELIST (Binder.java:1181)
14-10-2004 20:52:08 DEBUG - Mapped collection key: ACCOUNT_ID, one-to-many: com.easylists.EList (Binder.java:1368)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.Account.emailAddressBooks (Binder.java:1353)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.Account.emailAddressBooks -> EMAIL_ADDRESS_BOOK (Binder.java:1181)
14-10-2004 20:52:08 DEBUG - Mapped collection key: ACCOUNT_ID, one-to-many: com.easylists.EmailAddressBook (Binder.java:1368)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.EList.elistItems (Binder.java:1353)
14-10-2004 20:52:08 INFO - Mapping collection: com.easylists.EList.elistItems -> ELIST_ITEM (Binder.java:1181)
14-10-2004 20:52:08 DEBUG - Mapped collection key: ELIST_ID, one-to-many: com.easylists.EListItem (Binder.java:1368)
14-10-2004 20:52:08 DEBUG - Second pass for collection: com.easylists.EmailAddressBook.emailAddresses (Binder.java:1353)
14-10-2004 20:52:08 DEBUG - Mapped collection key: EMAIL_ADDR_BOOK_ID, element: EMAIL_ADDRESS_ID, type: com.easylists.EmailAddress (Binder.java:1368)
14-10-2004 20:52:08 INFO - processing one-to-one association property references (Configuration.java:636)
14-10-2004 20:52:08 INFO - processing foreign key constraints (Configuration.java:661)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.EmailAddress (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.EmailAddressBook (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.Account (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.Account (Configuration.java:678)
14-10-2004 20:52:08 DEBUG - resolving reference to class: com.easylists.EList (Configuration.java:678)
14-10-2004 20:52:09 INFO - Using dialect: net.sf.hibernate.dialect.MySQLDialect (Dialect.java:82)
14-10-2004 20:52:09 INFO - Maximim outer join fetch depth: 1 (SettingsFactory.java:59)
14-10-2004 20:52:09 INFO - Use outer join fetching: true (SettingsFactory.java:63)
14-10-2004 20:52:09 INFO - JNDI InitialContext properties:{} (NamingHelper.java:26)
14-10-2004 20:52:09 INFO - Using datasource: java:comp/env/jdbc/easytwo (DatasourceConnectionProvider.java:51)
14-10-2004 20:52:09 INFO - No TransactionManagerLookup configured (in JTA environment, use of process level read-write cache is not recommended) (TransactionManagerLookupFactory.java:33)
14-10-2004 20:52:09 INFO - Use scrollable result sets: true (SettingsFactory.java:103)
14-10-2004 20:52:09 INFO - Use JDBC3 getGeneratedKeys(): true (SettingsFactory.java:106)
14-10-2004 20:52:09 INFO - Optimize cache for minimal puts: false (SettingsFactory.java:109)
14-10-2004 20:52:09 INFO - echoing all SQL to stdout (SettingsFactory.java:115)
14-10-2004 20:52:09 INFO - Query language substitutions: {no='N', true=1, yes='Y', false=0} (SettingsFactory.java:118)
14-10-2004 20:52:09 INFO - cache provider: net.sf.ehcache.hibernate.Provider (SettingsFactory.java:129)
14-10-2004 20:52:09 INFO - query cache factory: net.sf.hibernate.cache.StandardQueryCacheFactory (SettingsFactory.java:141)
14-10-2004 20:52:09 INFO - instantiating and configuring caches (Configuration.java:1116)
14-10-2004 20:52:09 INFO - building session factory (SessionFactoryImpl.java:118)
14-10-2004 20:52:09 DEBUG - instantiating session factory with properties: {show_sql=true, java.vendor=Sun Microsystems Inc., catalina.base=D:\Apache Software Foundation\Tomcat 5.0, connection.datasource=java:comp/env/jdbc/easytwo, catalina.useNaming=true, os.name=Windows XP, sun.boot.class.path=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xercesImpl.jar;D:\Apache Software Foundation\Tomcat 5.0\common\endorsed\xmlParserAPIs.jar;D:\j2sdk1.4.2_01\jre\lib\rt.jar;D:\j2sdk1.4.2_01\jre\lib\i18n.jar;D:\j2sdk1.4.2_01\jre\lib\sunrsasign.jar;D:\j2sdk1.4.2_01\jre\lib\jsse.jar;D:\j2sdk1.4.2_01\jre\lib\jce.jar;D:\j2sdk1.4.2_01\jre\lib\charsets.jar;D:\j2sdk1.4.2_01\jre\classes, sun.java2d.fontpath=, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.4.2_01-b06, hibernate.cache.provider_class=net.sf.ehcache.hibernate.Provider, user.name=SYSTEM, shared.loader=${catalina.base}/shared/classes,${catalina.base}/shared/lib/*.jar, user.language=en, java.naming.factory.initial=org.apache.naming.java.javaURLContextFactory, cactus.contextURL=http://127.0.0.1:8080/easy-lists, sun.boot.library.path=D:\j2sdk1.4.2_01\jre\bin, dialect=net.sf.hibernate.dialect.MySQLDialect, java.version=1.4.2_01, user.timezone=Europe/London, sun.arch.data.model=32, java.endorsed.dirs=D:\Apache Software Foundation\Tomcat 5.0\common\endorsed, sun.cpu.isalist=pentium i486 i386, file.encoding.pkg=sun.io, package.access=sun.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper.,sun.beans., file.separator=\, java.specification.name=Java Platform API Specification, hibernate.cglib.use_reflection_optimizer=true, java.class.version=48.0, user.country=GB, java.home=D:\j2sdk1.4.2_01\jre, java.vm.info=mixed mode, os.version=5.1, hibernate.connection.datasource=java:comp/env/jdbc/easytwo, path.separator=;, java.vm.version=1.4.2_01-b06, hibernate.max_fetch_depth=1, java.util.prefs.PreferencesFactory=java.util.prefs.WindowsPreferencesFactory, user.variant=, hibernate.jdbc.batch_size=0, cactus.jspRedirectorName=JspRedirector, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, package.definition=sun.,java.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper., hibernate.cache.region_prefix=hibernate.test, java.naming.factory.url.pkgs=org.apache.naming, user.home=C:\WINDOWS\system32\config\systemprofile, hibernate.query.substitutions=true 1, false 0, yes 'Y', no 'N', java.specification.vendor=Sun Microsystems Inc., java.library.path=D:\Apache Software Foundation\Tomcat 5.0\bin;.;C:\WINDOWS\System32;C:\WINDOWS;D:\Perl\bin\;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;D:\apache-ant-1.5.4\bin;D:\j2sdk1.4.2_01\bin;D:\j2sdkee1.3.1\bin;D:\gpg, java.vendor.url=http://java.sun.com/, hibernate.proxool.pool_alias=pool1, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=net.sf.hibernate.dialect.MySQLDialect, common.loader=${catalina.home}/common/classes,${catalina.home}/common/endorsed/*.jar,${catalina.home}/common/lib/*.jar, hibernate.jdbc.use_streams_for_binary=true, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=D:\Apache Software Foundation\Tomcat 5.0\bin\bootstrap.jar, java.vm.specification.name=Java Virtual Machine Specification, java.vm.specification.version=1.0, catalina.home=D:\Apache Software Foundation\Tomcat 5.0, sun.cpu.endian=little, sun.os.patch.level=Service Pack 1, hibernate.cache.use_query_cache=true, java.io.tmpdir=D:\Apache Software Foundation\Tomcat 5.0, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, server.loader=${catalina.home}/server/classes,${catalina.home}/server/lib/*.jar, os.arch=x86, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, java.ext.dirs=D:\j2sdk1.4.2_01\jre\lib\ext, cactus.filterRedirectorName=test/filterRedirector.jsp, user.dir=C:\WINDOWS\system32, line.separator=
, java.vm.name=Java HotSpot(TM) Server VM, cactus.servletRedirectorName=ServletRedirector, file.encoding=Cp1252, java.specification.version=1.4, hibernate.connection.pool_size=1, hibernate.show_sql=true} (SessionFactoryImpl.java:124)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EList, BulkBeanException: Property is private (property setElistItems) (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.Account, BulkBeanException: Property is private (property setElists) (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EmailAddress, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EListItem, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:52:10 INFO - reflection optimizer disabled for: com.easylists.EmailAddressBook, IllegalArgumentException: Cannot find matching method/constructor (ReflectHelper.java:186)
14-10-2004 20:52:10 DEBUG - initializing class SessionFactoryObjectFactory (SessionFactoryObjectFactory.java:39)
14-10-2004 20:52:10 DEBUG - registered: d2a1cd8bff98ff5000ff98ff553a0000 (unnamed) (SessionFactoryObjectFactory.java:76)
14-10-2004 20:52:10 INFO - Not binding factory to JNDI, no JNDI name configured (SessionFactoryObjectFactory.java:82)
14-10-2004 20:52:10 DEBUG - instantiated session factory (SessionFactoryImpl.java:195)
14-10-2004 20:52:10 INFO - starting update timestamps cache at region: net.sf.hibernate.cache.UpdateTimestampsCache (UpdateTimestampsCache.java:35)
14-10-2004 20:52:10 INFO - starting query cache at region: net.sf.hibernate.cache.StandardQueryCache (StandardQueryCache.java:41)
14-10-2004 20:52:11 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:11 DEBUG - begin (JDBCTransaction.java:37)
14-10-2004 20:52:11 DEBUG - current autocommit status:true (JDBCTransaction.java:41)
14-10-2004 20:52:11 DEBUG - disabling autocommit (JDBCTransaction.java:43)
14-10-2004 20:52:11 DEBUG - saveOrUpdate() unsaved instance (SessionImpl.java:1387)
14-10-2004 20:52:11 DEBUG - saving [com.easylists.Account#<null>] (SessionImpl.java:825)
14-10-2004 20:52:11 DEBUG - executing insertions (SessionImpl.java:2309)
14-10-2004 20:52:11 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:11 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:11 DEBUG - using initial version: 0 (Versioning.java:56)
14-10-2004 20:52:11 DEBUG - Wrapped collection in role: com.easylists.Account.elists (WrapVisitor.java:81)
14-10-2004 20:52:11 DEBUG - Wrapped collection in role: com.easylists.Account.emailAddressBooks (WrapVisitor.java:81)
14-10-2004 20:52:11 DEBUG - Inserting entity: com.easylists.Account (native id) (EntityPersister.java:490)
14-10-2004 20:52:11 DEBUG - Version: 0 (EntityPersister.java:491)
14-10-2004 20:52:11 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:11 DEBUG - insert into ACCOUNT (VERSION, PK, ACTIVE, HAS_BEEN_ACTIVATED, CREATED_DATE, EXPIRY_DATE, TITLE, FORENAME, SURNAME, EMAIL_ADDRESS, PASSWORD, QUOTA, HOUSE_NUMBER, HOUSE_NAME, STREET, TOWN_OR_CITY, COUNTY_OR_STATE, POSTCODE, COUNTRY) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?) (BatcherImpl.java:226)
14-10-2004 20:52:11 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:11 DEBUG - Dehydrating entity: [com.easylists.Account#<null>] (EntityPersister.java:388)
14-10-2004 20:52:11 DEBUG - Natively generated identity: 118 (AbstractEntityPersister.java:1236)
14-10-2004 20:52:11 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:11 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:11 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.elists (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.emailAddressBooks (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:11 DEBUG - commit (JDBCTransaction.java:59)
14-10-2004 20:52:11 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:11 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.elists (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - cascading to collection: com.easylists.Account.emailAddressBooks (Cascades.java:524)
14-10-2004 20:52:11 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:11 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:11 DEBUG - Collection found: [com.easylists.Account.elists#118], was: [<unreferenced>] (SessionImpl.java:2884)
14-10-2004 20:52:11 DEBUG - Collection found: [com.easylists.Account.emailAddressBooks#118], was: [<unreferenced>] (SessionImpl.java:2884)
14-10-2004 20:52:11 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:11 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:11 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects (SessionImpl.java:2270)
14-10-2004 20:52:11 DEBUG - Flushed: 2 (re)creations, 0 updates, 0 removals to 2 collections (SessionImpl.java:2275)
14-10-2004 20:52:11 DEBUG - listing entities: (Printer.java:75)
14-10-2004 20:52:11 DEBUG - com.easylists.Account{active=false, createdDate=2004-10-14 20:52:02, forename=Paul, password=ImbFcQhSD+0=, hasBeenActivated=false, title=Mr, address=Address{country=UK, street=Chapel Street, postcode=BA128BZ, houseName=, countyOrState=Wiltshire, townOrCity=Warminster, houseNumber=15}, hibernateId=118, pk=688, version=0, expiryDate=null, surname=Taylor, emailAddressBooks=[], emailAddress=test@javacoda.com, quota=0, elists=[]} (Printer.java:82)
14-10-2004 20:52:11 DEBUG - executing flush (SessionImpl.java:2359)
14-10-2004 20:52:11 DEBUG - Inserting collection: [com.easylists.Account.emailAddressBooks#118] (AbstractCollectionPersister.java:508)
14-10-2004 20:52:11 DEBUG - collection was empty (AbstractCollectionPersister.java:539)
14-10-2004 20:52:11 DEBUG - post flush (SessionImpl.java:2824)
14-10-2004 20:52:11 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:11 DEBUG - Invalidating space [ACCOUNT] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:11 DEBUG - Invalidating space [ELIST] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:11 DEBUG - Invalidating space [EMAIL_ADDRESS_BOOK] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:11 DEBUG - re-enabling autocommit (JDBCTransaction.java:103)
14-10-2004 20:52:11 DEBUG - closing session (SessionImpl.java:573)
14-10-2004 20:52:11 DEBUG - disconnecting session (SessionImpl.java:3336)
14-10-2004 20:52:11 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:11 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:12 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:12 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:12 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:12 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:12 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects (SessionImpl.java:2270)
14-10-2004 20:52:12 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections (SessionImpl.java:2275)
14-10-2004 20:52:12 DEBUG - Dont need to execute flush (SessionImpl.java:1818)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - select this.HIBERNATE_ID as HIBERNAT1_0_, this.VERSION as VERSION0_, this.PK as PK0_, this.ACTIVE as ACTIVE0_, this.HAS_BEEN_ACTIVATED as HAS_BEEN5_0_, this.CREATED_DATE as CREATED_6_0_, this.EXPIRY_DATE as EXPIRY_D7_0_, this.TITLE as TITLE0_, this.FORENAME as FORENAME0_, this.SURNAME as SURNAME0_, this.EMAIL_ADDRESS as EMAIL_A11_0_, this.PASSWORD as PASSWORD0_, this.QUOTA as QUOTA0_, this.HOUSE_NUMBER as HOUSE_N14_0_, this.HOUSE_NAME as HOUSE_NAME0_, this.STREET as STREET0_, this.TOWN_OR_CITY as TOWN_OR17_0_, this.COUNTY_OR_STATE as COUNTY_18_0_, this.POSTCODE as POSTCODE0_, this.COUNTRY as COUNTRY0_ from ACCOUNT this where this.EMAIL_ADDRESS=? (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:12 DEBUG - result row: 118 (Loader.java:480)
14-10-2004 20:52:12 DEBUG - Initializing object from ResultSet: 118 (Loader.java:611)
14-10-2004 20:52:12 DEBUG - Hydrating entity: com.easylists.Account#118 (Loader.java:680)
14-10-2004 20:52:12 DEBUG - Version: 0 (SessionImpl.java:1910)
14-10-2004 20:52:12 DEBUG - done processing result set (1 rows) (Loader.java:294)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - total objects hydrated: 1 (Loader.java:314)
14-10-2004 20:52:12 DEBUG - resolving associations for [com.easylists.Account#118] (SessionImpl.java:2202)
14-10-2004 20:52:12 DEBUG - creating collection wrapper:[com.easylists.Account.elists#118] (SessionImpl.java:3933)
14-10-2004 20:52:12 DEBUG - creating collection wrapper:[com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3933)
14-10-2004 20:52:12 DEBUG - done materializing entity [com.easylists.Account#118] (SessionImpl.java:2226)
14-10-2004 20:52:12 DEBUG - initializing non-lazy collections (SessionImpl.java:3116)
14-10-2004 20:52:12 DEBUG - initializing collection [com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3260)
14-10-2004 20:52:12 DEBUG - checking second-level cache (SessionImpl.java:3261)
14-10-2004 20:52:12 DEBUG - collection not cached (SessionImpl.java:3267)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - select emailaddre0_.ACCOUNT_ID as ACCOUNT_ID__, emailaddre0_.HIBERNATE_ID as HIBERNAT1___, emailaddre0_.HIBERNATE_ID as HIBERNAT1_0_, emailaddre0_.VERSION as VERSION0_, emailaddre0_.PK as PK0_, emailaddre0_.NAME as NAME0_ from EMAIL_ADDRESS_BOOK emailaddre0_ where emailaddre0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - result set contains (possibly empty) collection: [com.easylists.Account.emailAddressBooks#118] (Loader.java:402)
14-10-2004 20:52:12 DEBUG - uninitialized collection: initializing (SessionImpl.java:3018)
14-10-2004 20:52:12 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:12 DEBUG - done processing result set (0 rows) (Loader.java:294)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - total objects hydrated: 0 (Loader.java:314)
14-10-2004 20:52:12 DEBUG - 1 collections were found in result set (SessionImpl.java:3077)
14-10-2004 20:52:12 DEBUG - collection fully initialized: [com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3095)
14-10-2004 20:52:12 DEBUG - 1 collections initialized (SessionImpl.java:3098)
14-10-2004 20:52:12 DEBUG - collection initialized (SessionImpl.java:3269)
14-10-2004 20:52:12 DEBUG - initializing collection [com.easylists.Account.elists#118] (SessionImpl.java:3260)
14-10-2004 20:52:12 DEBUG - checking second-level cache (SessionImpl.java:3261)
14-10-2004 20:52:12 DEBUG - collection not cached (SessionImpl.java:3267)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - select elists0_.ACCOUNT_ID as ACCOUNT_ID__, elists0_.HIBERNATE_ID as HIBERNAT1___, elists0_.HIBERNATE_ID as HIBERNAT1_0_, elists0_.VERSION as VERSION0_, elists0_.PK as PK0_, elists0_.ELIST_NAME as ELIST_NAME0_, elists0_.EMAIL_MESSAGE as EMAIL_ME5_0_, elists0_.PASSWORD as PASSWORD0_, elists0_.HIDE_WHEN_PURCHASED as HIDE_WHE7_0_, elists0_.EMAIL_WHEN_ITEM_PURCHASED as EMAIL_WH8_0_, elists0_.EXPIRY_DATE as EXPIRY_D9_0_, elists0_.ACCOUNT_ID as ACCOUNT_ID0_ from ELIST elists0_ where elists0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - result set contains (possibly empty) collection: [com.easylists.Account.elists#118] (Loader.java:402)
14-10-2004 20:52:12 DEBUG - uninitialized collection: initializing (SessionImpl.java:3018)
14-10-2004 20:52:12 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:12 DEBUG - done processing result set (0 rows) (Loader.java:294)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - total objects hydrated: 0 (Loader.java:314)
14-10-2004 20:52:12 DEBUG - 1 collections were found in result set (SessionImpl.java:3077)
14-10-2004 20:52:12 DEBUG - collection fully initialized: [com.easylists.Account.elists#118] (SessionImpl.java:3095)
14-10-2004 20:52:12 DEBUG - 1 collections initialized (SessionImpl.java:3098)
14-10-2004 20:52:12 DEBUG - collection initialized (SessionImpl.java:3269)
14-10-2004 20:52:12 DEBUG - closing session (SessionImpl.java:573)
14-10-2004 20:52:12 DEBUG - disconnecting session (SessionImpl.java:3336)
14-10-2004 20:52:12 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:12 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:12 DEBUG - begin (JDBCTransaction.java:37)
14-10-2004 20:52:12 DEBUG - current autocommit status:true (JDBCTransaction.java:41)
14-10-2004 20:52:12 DEBUG - disabling autocommit (JDBCTransaction.java:43)
14-10-2004 20:52:12 DEBUG - saveOrUpdate() unsaved instance (SessionImpl.java:1387)
14-10-2004 20:52:12 DEBUG - saving [com.easylists.EList#<null>] (SessionImpl.java:825)
14-10-2004 20:52:12 DEBUG - executing insertions (SessionImpl.java:2309)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.EList (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.EList (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - using initial version: 0 (Versioning.java:56)
14-10-2004 20:52:12 DEBUG - Wrapped collection in role: com.easylists.EList.elistItems (WrapVisitor.java:81)
14-10-2004 20:52:12 DEBUG - version unsaved-value strategy UNDEFINED (Cascades.java:396)
14-10-2004 20:52:12 DEBUG - id unsaved-value strategy NULL (Cascades.java:341)
14-10-2004 20:52:12 DEBUG - Inserting entity: com.easylists.EList (native id) (EntityPersister.java:490)
14-10-2004 20:52:12 DEBUG - Version: 0 (EntityPersister.java:491)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - insert into ELIST (VERSION, PK, ELIST_NAME, EMAIL_MESSAGE, PASSWORD, HIDE_WHEN_PURCHASED, EMAIL_WHEN_ITEM_PURCHASED, EXPIRY_DATE, ACCOUNT_ID) values (?, ?, ?, ?, ?, ?, ?, ?, ?) (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - Dehydrating entity: [com.easylists.EList#<null>] (EntityPersister.java:388)
14-10-2004 20:52:12 DEBUG - version unsaved-value strategy UNDEFINED (Cascades.java:396)
14-10-2004 20:52:12 DEBUG - id unsaved-value strategy NULL (Cascades.java:341)
14-10-2004 20:52:12 DEBUG - Natively generated identity: 20 (AbstractEntityPersister.java:1236)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.EList (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.EList.elistItems (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.EList (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - commit (JDBCTransaction.java:59)
14-10-2004 20:52:12 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.EList (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.EList.elistItems (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.EList (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:12 DEBUG - Collection found: [com.easylists.EList.elistItems#20], was: [<unreferenced>] (SessionImpl.java:2884)
14-10-2004 20:52:12 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:12 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:12 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 1 objects (SessionImpl.java:2270)
14-10-2004 20:52:12 DEBUG - Flushed: 1 (re)creations, 0 updates, 0 removals to 1 collections (SessionImpl.java:2275)
14-10-2004 20:52:12 DEBUG - listing entities: (Printer.java:75)
14-10-2004 20:52:12 DEBUG - com.easylists.EList{password=null, expiryDate=null, sendEmailWhenItemPurchased=false, elistItems=[], account=Account#118, emailMessage=null, hideWhenPurchased=false, elistName=TEST, hibernateId=20, pk=584, version=0} (Printer.java:82)
14-10-2004 20:52:12 DEBUG - executing flush (SessionImpl.java:2359)
14-10-2004 20:52:12 DEBUG - Inserting collection: [com.easylists.EList.elistItems#20] (AbstractCollectionPersister.java:508)
14-10-2004 20:52:12 DEBUG - collection was empty (AbstractCollectionPersister.java:539)
14-10-2004 20:52:12 DEBUG - post flush (SessionImpl.java:2824)
14-10-2004 20:52:12 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:12 DEBUG - Invalidating space [ELIST] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:12 DEBUG - Invalidating space [ELIST_ITEM] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:12 DEBUG - re-enabling autocommit (JDBCTransaction.java:103)
14-10-2004 20:52:12 DEBUG - closing session (SessionImpl.java:573)
14-10-2004 20:52:12 DEBUG - disconnecting session (SessionImpl.java:3336)
14-10-2004 20:52:12 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:12 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:12 DEBUG - begin (JDBCTransaction.java:37)
14-10-2004 20:52:12 DEBUG - current autocommit status:true (JDBCTransaction.java:41)
14-10-2004 20:52:12 DEBUG - disabling autocommit (JDBCTransaction.java:43)
14-10-2004 20:52:12 DEBUG - version unsaved-value strategy UNDEFINED (Cascades.java:396)
14-10-2004 20:52:12 DEBUG - id unsaved-value strategy NULL (Cascades.java:341)
14-10-2004 20:52:12 DEBUG - saveOrUpdate() previously saved instance with id: 118 (SessionImpl.java:1392)
14-10-2004 20:52:12 DEBUG - updating [com.easylists.Account#118] (SessionImpl.java:1440)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.Account.elists (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.Account.emailAddressBooks (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - commit (JDBCTransaction.java:59)
14-10-2004 20:52:12 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:12 DEBUG - processing cascades for: com.easylists.Account (Cascades.java:497)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.Account.elists (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - cascading to collection: com.easylists.Account.emailAddressBooks (Cascades.java:524)
14-10-2004 20:52:12 DEBUG - done processing cascades for: com.easylists.Account (Cascades.java:506)
14-10-2004 20:52:12 DEBUG - Collection dirty: [com.easylists.Account.elists#118] (SessionImpl.java:342)
14-10-2004 20:52:12 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:12 DEBUG - Updating entity: [com.easylists.Account#118] (SessionImpl.java:2533)
14-10-2004 20:52:12 DEBUG - Incrementing: 0 to 1 (Versioning.java:26)
14-10-2004 20:52:12 DEBUG - Collection found: [com.easylists.Account.elists#118], was: [com.easylists.Account.elists#118] (SessionImpl.java:2884)
14-10-2004 20:52:12 DEBUG - Collection found: [com.easylists.Account.emailAddressBooks#118], was: [com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:2884)
14-10-2004 20:52:12 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:12 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:12 DEBUG - Flushed: 0 insertions, 1 updates, 0 deletions to 1 objects (SessionImpl.java:2270)
14-10-2004 20:52:12 DEBUG - Flushed: 0 (re)creations, 1 updates, 0 removals to 2 collections (SessionImpl.java:2275)
14-10-2004 20:52:12 DEBUG - listing entities: (Printer.java:75)
14-10-2004 20:52:12 DEBUG - com.easylists.Account{active=false, createdDate=2004-10-14 20:52:02, forename=Paul, password=ImbFcQhSD+0=, hasBeenActivated=false, title=Mr, address=Address{country=UK, street=Chapel Street, postcode=BA128BZ, houseName=, countyOrState=Wiltshire, townOrCity=Warminster, houseNumber=15}, hibernateId=118, pk=688, version=0, expiryDate=null, surname=Taylor, emailAddressBooks=[], emailAddress=test@javacoda.com, quota=0, elists=[]} (Printer.java:82)
14-10-2004 20:52:12 DEBUG - executing flush (SessionImpl.java:2359)
14-10-2004 20:52:12 DEBUG - Updating entity: [com.easylists.Account#118] (EntityPersister.java:648)
14-10-2004 20:52:12 DEBUG - Existing version: 0 -> New version: 1 (EntityPersister.java:649)
14-10-2004 20:52:12 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:12 DEBUG - update ACCOUNT set VERSION=?, PK=?, ACTIVE=?, HAS_BEEN_ACTIVATED=?, CREATED_DATE=?, EXPIRY_DATE=?, TITLE=?, FORENAME=?, SURNAME=?, EMAIL_ADDRESS=?, PASSWORD=?, QUOTA=?, HOUSE_NUMBER=?, HOUSE_NAME=?, STREET=?, TOWN_OR_CITY=?, COUNTY_OR_STATE=?, POSTCODE=?, COUNTRY=? where HIBERNATE_ID=? and VERSION=? (BatcherImpl.java:226)
14-10-2004 20:52:12 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:12 DEBUG - Dehydrating entity: [com.easylists.Account#118] (EntityPersister.java:388)
14-10-2004 20:52:12 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:12 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:12 DEBUG - post flush (SessionImpl.java:2824)
14-10-2004 20:52:12 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:12 DEBUG - Invalidating space [ACCOUNT] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:12 DEBUG - Invalidating space [ELIST] (UpdateTimestampsCache.java:51)
14-10-2004 20:52:12 DEBUG - re-enabling autocommit (JDBCTransaction.java:103)
14-10-2004 20:52:12 DEBUG - closing session (SessionImpl.java:573)
14-10-2004 20:52:12 DEBUG - disconnecting session (SessionImpl.java:3336)
14-10-2004 20:52:13 DEBUG - transaction completion (SessionImpl.java:585)
14-10-2004 20:52:13 DEBUG - opened session (SessionImpl.java:555)
14-10-2004 20:52:13 DEBUG - flushing session (SessionImpl.java:2246)
14-10-2004 20:52:13 DEBUG - Flushing entities and processing referenced collections (SessionImpl.java:2439)
14-10-2004 20:52:13 DEBUG - Processing unreferenced collections (SessionImpl.java:2780)
14-10-2004 20:52:13 DEBUG - Scheduling collection removes/(re)creates/updates (SessionImpl.java:2794)
14-10-2004 20:52:13 DEBUG - Flushed: 0 insertions, 0 updates, 0 deletions to 0 objects (SessionImpl.java:2270)
14-10-2004 20:52:13 DEBUG - Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections (SessionImpl.java:2275)
14-10-2004 20:52:13 DEBUG - Dont need to execute flush (SessionImpl.java:1818)
14-10-2004 20:52:13 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:13 DEBUG - select this.HIBERNATE_ID as HIBERNAT1_0_, this.VERSION as VERSION0_, this.PK as PK0_, this.ACTIVE as ACTIVE0_, this.HAS_BEEN_ACTIVATED as HAS_BEEN5_0_, this.CREATED_DATE as CREATED_6_0_, this.EXPIRY_DATE as EXPIRY_D7_0_, this.TITLE as TITLE0_, this.FORENAME as FORENAME0_, this.SURNAME as SURNAME0_, this.EMAIL_ADDRESS as EMAIL_A11_0_, this.PASSWORD as PASSWORD0_, this.QUOTA as QUOTA0_, this.HOUSE_NUMBER as HOUSE_N14_0_, this.HOUSE_NAME as HOUSE_NAME0_, this.STREET as STREET0_, this.TOWN_OR_CITY as TOWN_OR17_0_, this.COUNTY_OR_STATE as COUNTY_18_0_, this.POSTCODE as POSTCODE0_, this.COUNTRY as COUNTRY0_ from ACCOUNT this where this.PK=? (BatcherImpl.java:226)
14-10-2004 20:52:13 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:13 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:13 DEBUG - result row: 118 (Loader.java:480)
14-10-2004 20:52:13 DEBUG - Initializing object from ResultSet: 118 (Loader.java:611)
14-10-2004 20:52:13 DEBUG - Hydrating entity: com.easylists.Account#118 (Loader.java:680)
14-10-2004 20:52:13 DEBUG - Version: 1 (SessionImpl.java:1910)
14-10-2004 20:52:13 DEBUG - done processing result set (1 rows) (Loader.java:294)
14-10-2004 20:52:13 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:13 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:13 DEBUG - total objects hydrated: 1 (Loader.java:314)
14-10-2004 20:52:13 DEBUG - resolving associations for [com.easylists.Account#118] (SessionImpl.java:2202)
14-10-2004 20:52:13 DEBUG - creating collection wrapper:[com.easylists.Account.elists#118] (SessionImpl.java:3933)
14-10-2004 20:52:13 DEBUG - creating collection wrapper:[com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3933)
14-10-2004 20:52:13 DEBUG - done materializing entity [com.easylists.Account#118] (SessionImpl.java:2226)
14-10-2004 20:52:13 DEBUG - initializing non-lazy collections (SessionImpl.java:3116)
14-10-2004 20:52:13 DEBUG - initializing collection [com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3260)
14-10-2004 20:52:13 DEBUG - checking second-level cache (SessionImpl.java:3261)
14-10-2004 20:52:13 DEBUG - collection not cached (SessionImpl.java:3267)
14-10-2004 20:52:13 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:13 DEBUG - select emailaddre0_.ACCOUNT_ID as ACCOUNT_ID__, emailaddre0_.HIBERNATE_ID as HIBERNAT1___, emailaddre0_.HIBERNATE_ID as HIBERNAT1_0_, emailaddre0_.VERSION as VERSION0_, emailaddre0_.PK as PK0_, emailaddre0_.NAME as NAME0_ from EMAIL_ADDRESS_BOOK emailaddre0_ where emailaddre0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:52:13 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:13 DEBUG - result set contains (possibly empty) collection: [com.easylists.Account.emailAddressBooks#118] (Loader.java:402)
14-10-2004 20:52:13 DEBUG - uninitialized collection: initializing (SessionImpl.java:3018)
14-10-2004 20:52:13 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:13 DEBUG - done processing result set (0 rows) (Loader.java:294)
14-10-2004 20:52:13 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:13 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:13 DEBUG - total objects hydrated: 0 (Loader.java:314)
14-10-2004 20:52:13 DEBUG - 1 collections were found in result set (SessionImpl.java:3077)
14-10-2004 20:52:13 DEBUG - collection fully initialized: [com.easylists.Account.emailAddressBooks#118] (SessionImpl.java:3095)
14-10-2004 20:52:13 DEBUG - 1 collections initialized (SessionImpl.java:3098)
14-10-2004 20:52:13 DEBUG - collection initialized (SessionImpl.java:3269)
14-10-2004 20:52:13 DEBUG - initializing collection [com.easylists.Account.elists#118] (SessionImpl.java:3260)
14-10-2004 20:52:13 DEBUG - checking second-level cache (SessionImpl.java:3261)
14-10-2004 20:52:13 DEBUG - collection not cached (SessionImpl.java:3267)
14-10-2004 20:52:13 DEBUG - about to open: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:200)
14-10-2004 20:52:13 DEBUG - select elists0_.ACCOUNT_ID as ACCOUNT_ID__, elists0_.HIBERNATE_ID as HIBERNAT1___, elists0_.HIBERNATE_ID as HIBERNAT1_0_, elists0_.VERSION as VERSION0_, elists0_.PK as PK0_, elists0_.ELIST_NAME as ELIST_NAME0_, elists0_.EMAIL_MESSAGE as EMAIL_ME5_0_, elists0_.PASSWORD as PASSWORD0_, elists0_.HIDE_WHEN_PURCHASED as HIDE_WHE7_0_, elists0_.EMAIL_WHEN_ITEM_PURCHASED as EMAIL_WH8_0_, elists0_.EXPIRY_DATE as EXPIRY_D9_0_, elists0_.ACCOUNT_ID as ACCOUNT_ID0_ from ELIST elists0_ where elists0_.ACCOUNT_ID=? (BatcherImpl.java:226)
14-10-2004 20:52:13 DEBUG - preparing statement (BatcherImpl.java:249)
14-10-2004 20:52:13 DEBUG - result set contains (possibly empty) collection: [com.easylists.Account.elists#118] (Loader.java:402)
14-10-2004 20:52:13 DEBUG - uninitialized collection: initializing (SessionImpl.java:3018)
14-10-2004 20:52:13 DEBUG - processing result set (Loader.java:277)
14-10-2004 20:52:13 DEBUG - result row: 20 (Loader.java:480)
14-10-2004 20:52:13 DEBUG - Initializing object from ResultSet: 20 (Loader.java:611)
14-10-2004 20:52:13 DEBUG - Hydrating entity: com.easylists.EList#20 (Loader.java:680)
14-10-2004 20:52:13 DEBUG - Version: 0 (SessionImpl.java:1910)
14-10-2004 20:52:13 DEBUG - found row of collection: [com.easylists.Account.elists#118] (Loader.java:367)
14-10-2004 20:52:13 DEBUG - reading row (SessionImpl.java:3041)
14-10-2004 20:52:13 DEBUG - loading [com.easylists.EList#20] (SessionImpl.java:1986)
14-10-2004 20:52:13 DEBUG - attempting to resolve [com.easylists.EList#20] (SessionImpl.java:2083)
14-10-2004 20:52:13 DEBUG - resolved object in session cache [com.easylists.EList#20] (SessionImpl.java:2099)
14-10-2004 20:52:13 DEBUG - done processing result set (1 rows) (Loader.java:294)
14-10-2004 20:52:13 DEBUG - done closing: 0 open PreparedStatements, 0 open ResultSets (BatcherImpl.java:207)
14-10-2004 20:52:13 DEBUG - closing statement (BatcherImpl.java:269)
14-10-2004 20:52:13 DEBUG - total objects hydrated: 1 (Loader.java:314)
14-10-2004 20:52:13 DEBUG - resolving associations for [com.easylists.EList#20] (SessionImpl.java:2202)
14-10-2004 20:52:13 DEBUG - loading [com.easylists.Account#118] (SessionImpl.java:1986)
14-10-2004 20:52:13 DEBUG - attempting to resolve [com.easylists.Account#118] (SessionImpl.java:2083)
14-10-2004 20:52:13 DEBUG - resolved object in session cache [com.easylists.Account#118] (SessionImpl.java:2099)
14-10-2004 20:52:13 DEBUG - creating collection wrapper:[com.easylists.EList.elistItems#20] (SessionImpl.java&


Top
 Profile  
 
 Post subject: Limit on size of these forum posts??
PostPosted: Fri Oct 15, 2004 6:26 am 
Regular
Regular

Joined: Fri Jul 16, 2004 3:04 pm
Posts: 52
Location: Wiltshire UK
Hi, I have just checked in to look at this from work & have realized that my code is not actually there.

It was in the preview. Is there a limit on the size of the messages that can be posted to this forum? I noticed that my log message got truncated. I will try to repost tonight.


Top
 Profile  
 
Display posts from previous:  Sort by  
Forum locked This topic is locked, you cannot edit posts or make further replies.  [ 3 posts ] 

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

Search for:
© Copyright 2014, Red Hat Inc. All rights reserved. JBoss and Hibernate are registered trademarks and servicemarks of Red Hat, Inc.