Something in this doesn't seem right. I started getting a null pointer exception in some of my UI code after upgrading to RC1. I traced my result set up into the bowels and I'm not sure if what I'm seeing is valid.

For a particular query I'm getting back 4 null values, and then an actual row. That gets passed through the DistinctRootTransformer and gets 'compressed' to a single null value and the actual row.

My question is, should I ever get NULL values back in my result set?

I'm going to dig into a bit more but some insight would be appreciated. For now, to get around this, I created my own custom distinct root transformer and everything is back to normal for the time being.

Here's a snippet of the log from where it starts....it looks like it hydrates one entity but has 6 rows in the result set....am I missing something?

2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG loading entity: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG attempting to resolve: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG object not resolved in any cache: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.persister.entity.BasicEntityPersister DEBUG Materializing entity: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG loading entity: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to open PreparedStatement (open PreparedStatements: 1, globally: 1)
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.SQL DEBUG select evcostcent0_.CC_NUM as CC1_0_, evcostcent0_.CC_TYPE_CODE as CC2_84_0_, evcostcent0_.CC_NAME as CC3_84_0_, evcostcent0_.ACTIVE_DATE as ACTIVE4_84_0_, evcostcent0_.WELL_STAT_CODE as WELL5_84_0_, evcostcent0_.PRIMARY_PROD_CODE as PRIMARY6_84_0_, evcostcent0_.TERM_DATE as TERM7_84_0_ from EV_COST_CENTRES evcostcent0_ where evcostcent0_.CC_NUM=?
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG preparing statement
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG binding '1002051' to parameter: 1
2005-03-03 15:44:27,297 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to open ResultSet (open ResultSets: 1, globally: 1)
2005-03-03 15:44:27,297 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG processing result set
2005-03-03 15:44:27,297 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 0
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: EntityKey[com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG Initializing object from ResultSet: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.persister.entity.BasicEntityPersister DEBUG Hydrating entity: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning 'DWL' as column: CC2_84_0_
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning '200B068C093P1000 BRASSEY' as column: CC3_84_0_
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG returning '2004-03-29 00:00:00' as column: ACTIVE4_84_0_
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning null as column: WELL5_84_0_
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning null as column: PRIMARY6_84_0_
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG returning null as column: TERM7_84_0_
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG done processing result set (1 rows)
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to close ResultSet (open ResultSets: 2, globally: 2)
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to close PreparedStatement (open PreparedStatements: 2, globally: 2)
2005-03-03 15:44:27,313 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG closing statement
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG total objects hydrated: 1
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.engine.TwoPhaseLoad DEBUG resolving associations for [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.engine.CollectionLoadContext DEBUG creating collection wrapper:[com.entero.enterovision.hibernate.EvCostCentre.ownershipAgreementLinksCcNumCode#1002051]
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.engine.TwoPhaseLoad DEBUG done materializing entity [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG done entity load
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG loading entity: [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG attempting to resolve: [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG object not resolved in any cache: [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.persister.entity.BasicEntityPersister DEBUG Materializing entity: [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,329 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG loading entity: [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,344 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to open PreparedStatement (open PreparedStatements: 1, globally: 1)
2005-03-03 15:44:27,344 [AWT-EventQueue-1] org.hibernate.SQL DEBUG select evdoideck0_.ID as ID0_, evdoideck0_.TERM_DATE as TERM2_169_0_ from EV_DOI_DECKS evdoideck0_ where evdoideck0_.ID=?
2005-03-03 15:44:27,344 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG preparing statement
2005-03-03 15:44:27,344 [AWT-EventQueue-1] org.hibernate.type.LongType DEBUG binding '88823' to parameter: 1
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to open ResultSet (open ResultSets: 1, globally: 1)
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG processing result set
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 0
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: EntityKey[com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG Initializing object from ResultSet: [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.persister.entity.BasicEntityPersister DEBUG Hydrating entity: [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG returning null as column: TERM2_169_0_
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG done processing result set (1 rows)
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to close ResultSet (open ResultSets: 2, globally: 2)
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to close PreparedStatement (open PreparedStatements: 2, globally: 2)
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG closing statement
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG total objects hydrated: 1
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.engine.TwoPhaseLoad DEBUG resolving associations for [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.engine.CollectionLoadContext DEBUG creating collection wrapper:[com.entero.enterovision.hibernate.EvDoiDeck.doiDeckPartnersById#88823]
2005-03-03 15:44:27,391 [AWT-EventQueue-1] org.hibernate.engine.CollectionLoadContext DEBUG creating collection wrapper:[com.entero.enterovision.hibernate.EvDoiDeck.ownershipAgreementLinksById#88823]
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.engine.TwoPhaseLoad DEBUG done materializing entity [com.entero.enterovision.hibernate.EvDoiDeck#88823]
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG done entity load
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: EntityKey[com.entero.enterovision.hibernate.EvOwnershipAgreementLink#component[costCentre,evDoiDeck,productionRevenueCode]{evDoiDeck=com.entero.enterovision.hibernate.EvDoiDeck#88823, productionRevenueCode=REV, costCentre=com.entero.enterovision.hibernate.EvCostCentre#1002051}]
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG Initializing object from ResultSet: [com.entero.enterovision.hibernate.EvOwnershipAgreementLink#component[costCentre,evDoiDeck,productionRevenueCode]{evDoiDeck=com.entero.enterovision.hibernate.EvDoiDeck#88823, productionRevenueCode=REV, costCentre=com.entero.enterovision.hibernate.EvCostCentre#1002051}]
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.persister.entity.BasicEntityPersister DEBUG Hydrating entity: [com.entero.enterovision.hibernate.EvOwnershipAgreementLink#component[costCentre,evDoiDeck,productionRevenueCode]{evDoiDeck=com.entero.enterovision.hibernate.EvDoiDeck#88823, productionRevenueCode=REV, costCentre=com.entero.enterovision.hibernate.EvCostCentre#1002051}]
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG returning '2004-11-01 00:00:00' as column: EFFECTIVE4_66_0_
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG returning null as column: EXPIRY5_66_0_
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG returning null as column: TERM6_66_0_
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG done processing result set (6 rows)
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to close ResultSet (open ResultSets: 1, globally: 1)
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to close PreparedStatement (open PreparedStatements: 1, globally: 1)
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG closing statement
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG total objects hydrated: 1
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.engine.TwoPhaseLoad DEBUG resolving associations for [com.entero.enterovision.hibernate.EvOwnershipAgreementLink#component[costCentre,evDoiDeck,productionRevenueCode]{evDoiDeck=com.entero.enterovision.hibernate.EvDoiDeck#88823, productionRevenueCode=REV, costCentre=com.entero.enterovision.hibernate.EvCostCentre#1002051}]
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.engine.TwoPhaseLoad DEBUG done materializing entity [com.entero.enterovision.hibernate.EvOwnershipAgreementLink#component[costCentre,evDoiDeck,productionRevenueCode]{evDoiDeck=com.entero.enterovision.hibernate.EvDoiDeck#88823, productionRevenueCode=REV, costCentre=com.entero.enterovision.hibernate.EvCostCentre#1002051}]
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.engine.PersistenceContext DEBUG initializing non-lazy collections
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.transform.DistinctRootEntityResultTransformer DEBUG transformed: 6 rows to: 2 distinct results
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.impl.SessionImpl DEBUG closing session
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.impl.SessionImpl DEBUG closing session
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG closing JDBC connection (open PreparedStatements: 0, globally: 0) (open ResultSets: 0, globally: 0)
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.connection.DriverManagerConnectionProvider DEBUG returning connection to pool, pool size: 1
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.jdbc.JDBCContext DEBUG after transaction completion
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.impl.SessionImpl DEBUG after transaction completion
2005-03-03 15:44:27,407 [AWT-EventQueue-1] org.hibernate.impl.SessionImpl DEBUG after transaction completion
2005-03-03 15:44:27,922 [Finalizer] org.hibernate.jdbc.JDBCContext DEBUG running Session.finalize()
2005-03-03 15:44:27,922 [Finalizer] org.hibernate.jdbc.JDBCContext DEBUG running Session.finalize()

Well, it looks like the sys admin took down the db servers tonight for maintenance so I'm pretty much dead in the water until tomorrow.

I had wanted to roll back to RC4 and test it out to see if I was getting the same results but it doesn't look like I'm going to get to it tonight which is unfortunate.

Logged a bug in JIRA.

http://opensource.atlassian.com/project ... se/HHH-177

This JIRA issue is utterly useless. I'll have to reject it unless you can provide code to reproduce the problem.

Can you at least tell me if NULLs should ever come back in a Result Set?

I'll try to get a reproducable test case to you but I'm not quite sure what is going on either. All I know is that it went away when I rolled back to Beta 4.

I have absolutely no idea, since you didnt display your query.

Well, at least that makes 2 of us. You're right I trimmed off too much off of the log,.

I'll be honest, I have clue what (if anything) is different or how to reproduce this for you to run in your environment. I've got a few things to clean up for my day job but as soon as I'm done that I'll throw some time at trying to rig something up.

In this log (which would have been most useful in the first place) it looks like if the PRODUCTION3_0_ isn't set then the result row comes back as NULL. Further info would be that the CC_NUM, AGREEMENT_ID and PRODUCTION_REVENUE_CODE are actually a comp pk defined in the Hibernate mappings.

The PRODUCTION_REVENUE_CODE is really and truly NULL from the data side (it's a bit quirky - it's actually a view to a read only table). I'm leaning towards if one of the values of the PK is NULL then the row gets tossed somehow or perhaps it's even an order thing. Meaning, that the last value in the PK happened to be NULL so it nulled out the row.

2005-03-03 15:44:26,376 [AWT-EventQueue-1] org.hibernate.SQL DEBUG select this_.CC_NUM as CC1_0_, this_.AGREEMENT_ID as AGREEMENT2_0_, this_.PRODUCTION_REVENUE_CODE as PRODUCTION3_0_, this_.EFFECTIVE_DATE as EFFECTIVE4_66_0_, this_.EXPIRY_DATE as EXPIRY5_66_0_, this_.TERM_DATE as TERM6_66_0_ from EV_OWNERSHIP_AGREEMENT_LINKS this_ where this_.CC_NUM=? and this_.EFFECTIVE_DATE<=? and (this_.EXPIRY_DATE>? or this_.EXPIRY_DATE is null) and this_.TERM_DATE is null
2005-03-03 15:44:26,376 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG preparing statement
2005-03-03 15:44:26,376 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG binding '1002051' to parameter: 1
2005-03-03 15:44:26,376 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG binding '2005-03-01 00:00:00' to parameter: 2
2005-03-03 15:44:26,376 [AWT-EventQueue-1] org.hibernate.type.TimestampType DEBUG binding '3000-01-01 00:00:00' to parameter: 3
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to open ResultSet (open ResultSets: 0, globally: 0)
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG processing result set
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 0
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning '1002051' as column: CC1_0_
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.type.LongType DEBUG returning '86551' as column: AGREEMENT2_0_
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning null as column: PRODUCTION3_0_
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: null
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 1
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning '1002051' as column: CC1_0_
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.type.LongType DEBUG returning '86551' as column: AGREEMENT2_0_
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning null as column: PRODUCTION3_0_
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: null
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 2
2005-03-03 15:44:27,079 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning '1002051' as column: CC1_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.LongType DEBUG returning '86551' as column: AGREEMENT2_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning null as column: PRODUCTION3_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: null
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 3
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning '1002051' as column: CC1_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.LongType DEBUG returning '86551' as column: AGREEMENT2_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning null as column: PRODUCTION3_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: null
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 4
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning '1002051' as column: CC1_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.LongType DEBUG returning '86551' as column: AGREEMENT2_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning null as column: PRODUCTION3_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result row: null
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG result set row: 5
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning '1002051' as column: CC1_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.LongType DEBUG returning '88823' as column: AGREEMENT2_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.type.StringType DEBUG returning 'REV' as column: PRODUCTION3_0_
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG loading entity: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG attempting to resolve: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.event.def.DefaultLoadEventListener DEBUG object not resolved in any cache: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.persister.entity.BasicEntityPersister DEBUG Materializing entity: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.loader.Loader DEBUG loading entity: [com.entero.enterovision.hibernate.EvCostCentre#1002051]
2005-03-03 15:44:27,094 [AWT-EventQueue-1] org.hibernate.jdbc.AbstractBatcher DEBUG about to open PreparedStatement (open PreparedStatements: 1, globally: 1)