-->
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.

View unanswered posts | View active topics


Board index » Hibernate & Java Persistence » Hibernate Users

All times are UTC - 5 hours [ DST ]


Forum locked This topic is locked, you cannot edit posts or make further replies.  Page 1 of 1
  [ 1 post ] 
  Previous topic | Next topic 
Author Message
tzman
 Post subject: OneToMany fetch
PostPosted: Thu Dec 11, 2008 5:27 pm 
Beginner
Beginner

Joined: Fri Jan 16, 2004 11:05 am
Posts: 33
Need help with Hibernate? Read this first:
http://www.hibernate.org/ForumMailingli ... AskForHelp

I am having a performance issues with parent-> child lazy initialization and I am sure it is in my mapping. I beleive this should be pretty easy to understand the context. A state has many cities. The state abbreviation is the primary key to the state table. The primary key of the city table is the city name and state abbreviation, which is a foreign key to the state table. This seems like it should be pretty straight forward. When a call is made to state.getCities(), the sql generated is selecting all cities not the cities associated with the state. Anyone have a clue what is causing this? When adding real data this same query take 5+ seconds to execute.

Thanks in advance for the time.


Hibernate version:
3.2.6

Mapping documents:
Code:
@Entity
@Table( name = "COM_ST" )
public class StateEntity extends AbstractConcurrentEntity
{
    private static final long           serialVersionUID = 1L;

    @Id
    @NotNull
    @Length( min = 1, max = 4 )
    @Column( name = "ST_ABRV", nullable = false, length = 4 )
    private String                      abbreviation;

    @Length( max = 100 )
    @Column( name = "ST_NAME", length = 100 )
    private String                      name;

    @NotNull
    @ManyToOne( fetch = FetchType.LAZY )
    @JoinColumn( name = "CTRY_ABRV" )
    private CountryEntity               country;

    @OnDelete( action = OnDeleteAction.CASCADE )
    @Cascade( org.hibernate.annotations.CascadeType.DELETE_ORPHAN )
    @OneToMany( cascade = CascadeType.ALL, fetch = FetchType.LAZY, mappedBy = "pk.state" )
    private Set<CityEntity>             cities = new HashSet<CityEntity>( 0 );

...
}

@Entity
@Table( name = "COM_CITY" )
public class CityEntity extends AbstractConcurrentEntity
{
    private static final long           serialVersionUID = 1L;

    @EmbeddedId
    private CityEntityPk                pk;

    @Length( min = 1, max = 50 )
    @Column( name = "AKA_NAME", length = 50 )
    private String                      akaName;

    @ManyToMany( cascade = CascadeType.ALL, fetch = FetchType.LAZY, mappedBy = "cities" )
    private Set<PostalCodeEntity>       postalCodes = new HashSet<PostalCodeEntity>( 0 );
...
}

@Embeddable
public class CityEntityPk implements Serializable
{
    private static final long           serialVersionUID = 1L;

    @NotNull
    @ManyToOne( fetch = FetchType.EAGER )
    @JoinColumn( name = "ST_ABRV" )
    private StateEntity                 state;

    @NotNull
    @Length( min = 1, max = 50 )
    @Column( name = "CITY_NAME", nullable = false, updatable = false )
    private String                      name;
...
}



Code between sessionFactory.openSession() and session.close():

Code:
        CountryEntity                   country;
        StateEntity                     state       = null;
        Set<StateEntity>                states;
        DateTime                        start;
        DateTime                        end;
        DateTime                        dur;

        try
        {
            country = entityManager.find( CountryEntity.class, "US" );
            start   = DateTimeUtils.getCurrentUtcDateTime();
            states  = country.getStates();
            end     = DateTimeUtils.getCurrentUtcDateTime();
            dur     = end.minus( start.getMillis() );
            logger.info( "States query executed in :" + dur.getMillis() + "ms." );

            assert( country != null ): "Country not foud: US";
            for( StateEntity s : states )
            {
                if( "CA".equals( s.getAbbreviation() ) )
                {
                    state = s;
                    break;
                }
            }
            assert( state != null ): "State not foud: CA";
            state   = entityManager.find( StateEntity.class, "CA" );
            //
            // Everything is fine to this point ... start Hibernate debug logging.
            //
            logger.info( "Loading cities." );
            start   = DateTimeUtils.getCurrentUtcDateTime();
            for( CityEntity city : state.getCities() )
            {
                city.getName();
            }
            end     = DateTimeUtils.getCurrentUtcDateTime();
            dur     = end.minus( start.getMillis() );
            logger.info( "Cities query executed in :" + dur.getMillis() + "ms." );
        }
        catch( Exception e )
        {
            e.printStackTrace();
            logger.error( e.getMessage() );
            assert( false ): e.getMessage();
        }


Full stack trace of any exception that occurs:

Name and version of the database you are using:
Oracle 10

The generated SQL (show_sql=true):
Code:
Hibernate:
    select
        cities0_.ST_ABRV as ST8_1_,
        cities0_.CITY_NAME as CITY1_1_,
        cities0_.CITY_NAME as CITY1_41_0_,
        cities0_.ST_ABRV as ST8_41_0_,
        cities0_.LAST_UPTD_TMST as LAST2_41_0_,
        cities0_.LAST_UPTD_USER_ID as LAST3_41_0_,
        cities0_.AKA_NAME as AKA4_41_0_,
        cities0_.DENS_OR_SPAR_FLAG as DENS5_41_0_,
        cities0_.RAD_MILE as RAD6_41_0_,
        cities0_.VALD_IND as VALD7_41_0_
    from
        COM_CITY cities0_
    where
        cities0_.ST_ABRV in (
            ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?
        )


Debug level Hibernate log excerpt:
31422 INFO [main] dao.TestCountryDao - Loading cities.
31422 DEBUG [main] def.DefaultInitializeCollectionEventListener - initializing collection [common.entity.St
ateEntity.cities#CA]
31422 DEBUG [main] def.DefaultInitializeCollectionEventListener - checking second-level cache
31422 DEBUG [main] def.DefaultInitializeCollectionEventListener - collection not cached
31422 DEBUG [main] loader.Loader - batch loading collection: [common.entity.StateEntity.cities#<CA, RI, MO,
KY, DC, IA, NV, ND, WI, KS, MD, AK, TN, NM, WA, LA, VA, NY, MS, PA, TX, GA, MA, NJ, SD, UT, MI, ME, OH, HI, FL, NH>]
31422 DEBUG [main] jdbc.AbstractBatcher - about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
31422 DEBUG [main] hibernate.SQL -
select
cities0_.ST_ABRV as ST8_1_,
cities0_.CITY_NAME as CITY1_1_,
cities0_.CITY_NAME as CITY1_41_0_,
cities0_.ST_ABRV as ST8_41_0_,
cities0_.LAST_UPTD_TMST as LAST2_41_0_,
cities0_.LAST_UPTD_USER_ID as LAST3_41_0_,
cities0_.AKA_NAME as AKA4_41_0_,
cities0_.DENS_OR_SPAR_FLAG as DENS5_41_0_,
cities0_.RAD_MILE as RAD6_41_0_,
cities0_.VALD_IND as VALD7_41_0_
from
COM_CITY cities0_
where
cities0_.ST_ABRV in (
?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?
)
Hibernate:
select
cities0_.ST_ABRV as ST8_1_,
cities0_.CITY_NAME as CITY1_1_,
cities0_.CITY_NAME as CITY1_41_0_,
cities0_.ST_ABRV as ST8_41_0_,
cities0_.LAST_UPTD_TMST as LAST2_41_0_,
cities0_.LAST_UPTD_USER_ID as LAST3_41_0_,
cities0_.AKA_NAME as AKA4_41_0_,
cities0_.DENS_OR_SPAR_FLAG as DENS5_41_0_,
cities0_.RAD_MILE as RAD6_41_0_,
cities0_.VALD_IND as VALD7_41_0_
from
COM_CITY cities0_
where
cities0_.ST_ABRV in (
?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?
)
31422 DEBUG [main] jdbc.AbstractBatcher - preparing statement
31422 DEBUG [main] type.StringType - binding 'CA' to parameter: 1
31422 DEBUG [main] type.StringType - binding 'RI' to parameter: 2
31422 DEBUG [main] type.StringType - binding 'MO' to parameter: 3
31422 DEBUG [main] type.StringType - binding 'KY' to parameter: 4
31422 DEBUG [main] type.StringType - binding 'DC' to parameter: 5
31422 DEBUG [main] type.StringType - binding 'IA' to parameter: 6
31422 DEBUG [main] type.StringType - binding 'NV' to parameter: 7
31422 DEBUG [main] type.StringType - binding 'ND' to parameter: 8
31422 DEBUG [main] type.StringType - binding 'WI' to parameter: 9
31422 DEBUG [main] type.StringType - binding 'KS' to parameter: 10
31422 DEBUG [main] type.StringType - binding 'MD' to parameter: 11
31422 DEBUG [main] type.StringType - binding 'AK' to parameter: 12
31422 DEBUG [main] type.StringType - binding 'TN' to parameter: 13
31422 DEBUG [main] type.StringType - binding 'NM' to parameter: 14
31422 DEBUG [main] type.StringType - binding 'WA' to parameter: 15
31422 DEBUG [main] type.StringType - binding 'LA' to parameter: 16
31422 DEBUG [main] type.StringType - binding 'VA' to parameter: 17
31422 DEBUG [main] type.StringType - binding 'NY' to parameter: 18
31422 DEBUG [main] type.StringType - binding 'MS' to parameter: 19
31422 DEBUG [main] type.StringType - binding 'PA' to parameter: 20
31422 DEBUG [main] type.StringType - binding 'TX' to parameter: 21
31422 DEBUG [main] type.StringType - binding 'GA' to parameter: 22
31422 DEBUG [main] type.StringType - binding 'MA' to parameter: 23
31422 DEBUG [main] type.StringType - binding 'NJ' to parameter: 24
31422 DEBUG [main] type.StringType - binding 'SD' to parameter: 25
31422 DEBUG [main] type.StringType - binding 'UT' to parameter: 26
31422 DEBUG [main] type.StringType - binding 'MI' to parameter: 27
31422 DEBUG [main] type.StringType - binding 'ME' to parameter: 28
31422 DEBUG [main] type.StringType - binding 'OH' to parameter: 29
31422 DEBUG [main] type.StringType - binding 'HI' to parameter: 30
31422 DEBUG [main] type.StringType - binding 'FL' to parameter: 31
31422 DEBUG [main] type.StringType - binding 'NH' to parameter: 32
31437 DEBUG [main] jdbc.AbstractBatcher - about to open ResultSet (open ResultSets: 0, globally: 0)
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#CA]
31437 DEBUG [main] loading.LoadContexts - constructing collection load context for result set [org.apache.commons.dbcp.Delega
tingResultSet@3f1f39]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#CA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#CA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#CA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#RI]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#RI]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#RI]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#RI]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#MO]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#MO]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#MO]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#MO]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#KY]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#KY]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#KY]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#KY]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#DC]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#DC]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#DC]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#DC]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#IA]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#IA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#IA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#IA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#NV]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#NV]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#NV]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#NV]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#ND]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#ND]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#ND]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#ND]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#WI]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#WI]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#WI]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#WI]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#KS]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#KS]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#KS]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#KS]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#MD]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#MD]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#MD]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#MD]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#AK]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#AK]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#AK]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#AK]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#TN]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#TN]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#TN]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#TN]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#NM]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#NM]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#NM]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#NM]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#WA]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#WA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#WA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#WA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#LA]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#LA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#LA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#LA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#VA]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#VA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#VA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#VA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#NY]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#NY]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#NY]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#NY]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#MS]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#MS]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#MS]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#MS]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#PA]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#PA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#PA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#PA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#TX]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#TX]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#TX]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#TX]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#GA]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#GA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#GA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#GA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#MA]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#MA]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#MA]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#MA]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#NJ]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#NJ]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#NJ]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#NJ]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#SD]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#SD]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#SD]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#SD]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#UT]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#UT]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#UT]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#UT]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#MI]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#MI]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#MI]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#MI]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#ME]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#ME]]
31437 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#ME]] in any result-set context
31437 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#ME]] n
ot located in load context
31437 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31437 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#OH]
31437 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#OH]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#OH]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#OH]] n
ot located in load context
31453 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31453 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#HI]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#HI]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#HI]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#HI]] n
ot located in load context
31453 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31453 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#FL]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#FL]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#FL]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#FL]] n
ot located in load context
31453 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31453 DEBUG [main] loader.Loader - result set contains (possibly empty) collection: [common.entity.StateEnt
ity.cities#NH]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#NH]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#NH]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#NH]] n
ot located in load context
31453 DEBUG [main] loading.CollectionLoadContext - collection not yet initialized; initializing
31453 DEBUG [main] loader.Loader - processing result set
31453 DEBUG [main] loader.Loader - result set row: 0
31453 DEBUG [main] type.StringType - returning 'San Antonio' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#TX]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#TX, name=San Antonio}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#TX, name=San Antonio}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#TX, name=San Antonio}]
31453 DEBUG [main] type.TimestampType - returning '2008-11-25 11:03:24' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'testuser' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'false' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-11-25T17:03:24.482Z
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#TX]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#TX]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#TX]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#TX]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'San Antonio' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#TX, name=San Antonio}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#TX, name=San Antonio}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#TX, name=San Antonio}]
31453 DEBUG [main] loader.Loader - result set row: 1
31453 DEBUG [main] type.StringType - returning 'Danville' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#IA]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#IA, name=Danville}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#IA, name=Danville}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#IA, name=Danville}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#IA]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#IA]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#IA]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#IA]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'Danville' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#IA, name=Danville}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#IA, name=Danville}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#IA, name=Danville}]
31453 DEBUG [main] loader.Loader - result set row: 2
31453 DEBUG [main] type.StringType - returning 'Iowa City' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#IA]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#IA, name=Iowa City}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#IA, name=Iowa City}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#IA, name=Iowa City}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#IA]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#IA]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#IA]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#IA]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'Iowa City' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#IA, name=Iowa City}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#IA, name=Iowa City}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#IA, name=Iowa City}]
31453 DEBUG [main] loader.Loader - result set row: 3
31453 DEBUG [main] type.StringType - returning 'Sioux City' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#IA]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#IA, name=Sioux City}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#IA, name=Sioux City}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#IA, name=Sioux City}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#IA]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#IA]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#IA]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#IA]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'Sioux City' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'IA' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#IA]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#IA, name=Sioux City}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#IA, name=Sioux City}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#IA, name=Sioux City}]
31453 DEBUG [main] loader.Loader - result set row: 4
31453 DEBUG [main] type.StringType - returning 'Sioux City' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'SD' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#SD]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#SD]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#SD]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#SD, name=Sioux City}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#SD, name=Sioux City}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#SD, name=Sioux City}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'SD' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#SD]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#SD]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#SD]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#SD]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'Sioux City' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'SD' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#SD]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#SD]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#SD]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#SD, name=Sioux City}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#SD, name=Sioux City}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#SD, name=Sioux City}]
31453 DEBUG [main] loader.Loader - result set row: 5
31453 DEBUG [main] type.StringType - returning 'St. Louis' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'MO' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#MO]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#MO]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#MO]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#MO, name=St. Louis}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#MO, name=St. Louis}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#MO, name=St. Louis}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'MO' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#MO]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#MO]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#MO]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#MO]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'St. Louis' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'MO' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#MO]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#MO]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#MO]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#MO, name=St. Louis}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#MO, name=St. Louis}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#MO, name=St. Louis}]
31453 DEBUG [main] loader.Loader - result set row: 6
31453 DEBUG [main] type.StringType - returning 'Orlando' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'FL' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#FL]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#FL]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#FL]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#FL, name=Orlando}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#FL, name=Orlando}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#FL, name=Orlando}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'FL' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#FL]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#FL]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#FL]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#FL]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'Orlando' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'FL' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#FL]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#FL]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#FL]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#FL, name=Orlando}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#FL, name=Orlando}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#FL, name=Orlando}]
31453 DEBUG [main] loader.Loader - result set row: 7
31453 DEBUG [main] type.StringType - returning 'Houston' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#TX]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#TX, name=Houston}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#TX, name=Houston}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#TX, name=Houston}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#TX]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#TX]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#TX]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#TX]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'Houston' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#TX, name=Houston}]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#TX, name=Houston}]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#TX, name=Houston}]
31453 DEBUG [main] loader.Loader - result set row: 8
31453 DEBUG [main] type.StringType - returning 'The Woodlands' as column: CITY1_41_0_
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_41_0_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#TX]
31453 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#TX, name=The Woodlands}]
31453 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#TX, name=The Woodlands}]
31453 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#TX, name=The Woodlands}]
31453 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31453 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31453 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31453 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31453 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31453 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31453 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_1_
31453 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#TX]
31453 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#TX]]
31453 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#TX]] in any result-set context
31453 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#TX]] l
ocated in load context
31453 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31453 DEBUG [main] type.StringType - returning 'The Woodlands' as column: CITY1_1_
31453 DEBUG [main] type.StringType - returning 'TX' as column: ST8_1_
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#TX]
31453 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.CityEntity#component[name,
state]{state=common.entity.StateEntity#TX, name=The Woodlands}]
31468 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.CityEntity#componen
t[name,state]{state=common.entity.StateEntity#TX, name=The Woodlands}]
31468 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.CityEnti
ty#component[name,state]{state=common.entity.StateEntity#TX, name=The Woodlands}]
31468 DEBUG [main] loader.Loader - result set row: 9
31468 DEBUG [main] type.StringType - returning 'Clovis' as column: CITY1_41_0_
31468 DEBUG [main] type.StringType - returning 'CA' as column: ST8_41_0_
31468 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#CA]
31468 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#CA]
31468 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entity.StateEnt
ity#CA]
31468 DEBUG [main] loader.Loader - result row: EntityKey[common.entity.CityEntity#component[name,state]{sta
te=common.entity.StateEntity#CA, name=Clovis}]
31468 DEBUG [main] loader.Loader - Initializing object from ResultSet: [common.entity.CityEntity#component[
name,state]{state=common.entity.StateEntity#CA, name=Clovis}]
31468 DEBUG [main] entity.AbstractEntityPersister - Hydrating entity: [common.entity.CityEntity#component[n
ame,state]{state=common.entity.StateEntity#CA, name=Clovis}]
31468 DEBUG [main] type.TimestampType - returning '2008-10-16 14:21:32' as column: LAST2_41_0_
31468 DEBUG [main] type.StringType - returning 'dbload' as column: LAST3_41_0_
31468 DEBUG [main] type.StringType - returning null as column: AKA4_41_0_
31468 DEBUG [main] type.YesNoType - returning null as column: DENS5_41_0_
31468 DEBUG [main] type.IntegerType - returning null as column: RAD6_41_0_
31468 DEBUG [main] type.YesNoType - returning 'true' as column: VALD7_41_0_
31468 DEBUG [main] engine.TwoPhaseLoad - Version: 2008-10-16T19:21:32.000Z
31468 DEBUG [main] type.StringType - returning 'CA' as column: ST8_1_
31468 DEBUG [main] loader.Loader - found row of collection: [common.entity.StateEntity.cities#CA]
31468 DEBUG [main] loading.CollectionLoadContext - starting attempt to find loading collection [[common.ent
ity.StateEntity.cities#CA]]
31468 DEBUG [main] loading.LoadContexts - attempting to locate loading collection entry [CollectionKey[comm
on.entity.StateEntity.cities#CA]] in any result-set context
31468 DEBUG [main] loading.LoadContexts - collection [CollectionKey[common.entity.StateEntity.cities#CA]] l
ocated in load context
31468 DEBUG [main] loading.CollectionLoadContext - found loading collection bound to current result set processing; reading r
ow
31468 DEBUG [main] type.StringType - returning 'Clovis' as column: CITY1_1_
31468 DEBUG [main] type.StringType - returning 'CA' as column: ST8_1_
31468 DEBUG [main] def.DefaultLoadEventListener - loading entity: [common.entity.StateEntity#CA]
31468 DEBUG [main] def.DefaultLoadEventListener - attempting to resolve: [common.entity.StateEntity#CA]
31468 DEBUG [main] def.DefaultLoadEventListener - resolved object in session cache: [common.entit
Top
 Profile  
 
Display posts from previous:  Sort by  
Forum locked This topic is locked, you cannot edit posts or make further replies.  Page 1 of 1
  [ 1 post ] 

Board index » Hibernate & Java Persistence » Hibernate Users

All times are UTC - 5 hours [ DST ]

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

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