I'm evaluting nHibernate and having a problem using some named queries to populate my entities. The mapping here seems right but when executing my unit test I'm getting zero results on the SomeDeps property of the Coverage class. Inspecting the log reveals that nHibernate
is retrieving the dependents but they're somehow not being populated into the property.
I've looked through the examples in the source and I don't see any holes in what I'm doing here.
Can anyone advise what I may be doing wrong ? Thanks to anyone who can provide assistance.
Below you'll find my mappings and the log.
Hibernate version:1.2
Mapping documents:
Coverage Map:
Code:
<hibernate-mapping xmlns="urn:nhibernate-mapping-2.2" namespace="Trion.Census.Service.WCF.BusinessEntities" assembly="Trion.Census.Service.WCF.BusinessEntities">
<class name="Coverage">
<id name="ID" type="Int32" unsaved-value="null" column="COVERAGE_ID">
<generator class="native"/>
</id>
<property name ="BillingIndicator" column="BILLING_INDICATOR" />
<property name="PFAOverride" column="PFA_OVERRIDE" />
<property name="Code" column="COVERAGE_CODE" />
<property name="MinimumTotalDependents" column="MIN_TOTAL_DEPS" />
<component name="Option" class="BenefitOption">
<property name="ID" type="string" column="PLAN_ID" />
<component name="Benefit" class="Benefit">
<property name="Type" type="string" column="PLAN_TYPE" />
</component>
</component>
<bag name="SomeDeps" lazy="false" inverse="false" cascade="all" access="property">
<key column="DEPENDENT_ID"/>
<one-to-many class="Dependent" />
<loader query-ref="CoveredDependentsQuery"/>
</bag>
<loader query-ref="CoverageSelectQuery"/>
</class>
<sql-query name="CoverageSelectQuery">
<return alias="cov" class="Coverage" />
SELECT EOL_COVERAGE.COVERAGE_ID,
EOL_COVERAGE.PLAN_TYPE as PLAN_TYPE,
EOL_COVERAGE.PLAN_ID as PLAN_ID,
EOL_COVERAGE.EMPLOYEE_ID AS EMPLOYEE_ID,
EOL_PLAN_DEFINITION.COVERAGE_CODE AS COVERAGE_CODE,
EOL_PLAN_DEFINITION.BILLING_INDICATOR AS BILLING_INDICATOR,
EOL_PLAN_DEFINITION.PFA_OVERRIDE AS PFA_OVERRIDE,
FTM_COVERAGE_CODE_STD.MIN_TOTAL_DEPS AS MIN_TOTAL_DEPS
FROM EOL_COVERAGE INNER JOIN
EOL_PLAN_DEFINITION ON EOL_COVERAGE.COMPANY_ID = EOL_PLAN_DEFINITION.COMPANY_ID AND
EOL_COVERAGE.PLAN_TYPE = EOL_PLAN_DEFINITION.PLAN_TYPE
join FTM_COVERAGE_CODE_PPLUS on EOL_COVERAGE.COMPANY_ID = FTM_COVERAGE_CODE_PPLUS.COMPANY_ID
and EOL_COVERAGE.PLAN_YEAR_ID = FTM_COVERAGE_CODE_PPLUS.PLAN_YEAR_ID
and EOL_COVERAGE.COVERAGE_CODE = FTM_COVERAGE_CODE_PPLUS.COVERAGE_CODE
join FTM_COVERAGE_CODE_STD on FTM_COVERAGE_CODE_PPLUS.COVERAGE_CODE_STD_ID = FTM_COVERAGE_CODE_STD.COVERAGE_CODE_STD_ID
WHERE EOL_COVERAGE.COVERAGE_ID = ?
</sql-query>
<sql-query name="CoveredDependentsQuery">
<load-collection alias="EOL_DEPENDENT" role="Coverage.SomeDeps" />
SELECT EOL_DEPENDENT.*
FROM EOL_COVERAGE left join
EOL_DEPENDENT on EOL_COVERAGE.EMPLOYEE_ID = EOL_DEPENDENT.EMPLOYEE_ID
WHERE EOL_COVERAGE.COVERAGE_ID = :id
</sql-query>
</hibernate-mapping>
Dependent Map:
Code:
<hibernate-mapping xmlns="urn:nhibernate-mapping-2.2" namespace="Trion.Census.Service.WCF.BusinessEntities" assembly="Trion.Census.Service.WCF.BusinessEntities">
<class name="Dependent" table="EOL_DEPENDENT">
<id name="ID" column="DEPENDENT_ID" type="Int32" unsaved-value="null">
<generator class="identity"/>
</id>
<property name="LastName" column="LAST_NAME" />
<property name="SocialSecurityNumber" column="DEPENDENT_SSN" />
<property name="FirstName" column="FIRST_NAME" />
<property name="DateofBirth" column="DATE_OF_BIRTH" />
<property name="MiddleInitial" column="MIDDLE_INIT"/>
<property name="EmployeeSocialSecurityNumber" column="EMPLOYEE_SSN"/>
<property name="RelationshipCode" column="RELATIONSHIP_CODE"/>
<component class="AuditInformation" name="AuditInformation">
<property name="UpdatedBy" column="UPDATED_BY"/>
<property name="UserType" column="AUD_USER_TYPE"/>
<property name="UserName" column="AUD_USER_NAME"/>
<property name="TimeStamp" column="AUD_TIME_STAMP"/>
<property name="ModuleName" column="AUD_SCRIPT_NAME"/>
<property name="TransactionID" column="QLE_TRANS_ID"/>
</component>
<many-to-one name="Employee" class="Employee" column="EMPLOYEE_ID"/>
<many-to-one name="Company" class="Company" column="COMPANY_ID"/>
</class>
</hibernate-mapping>
Code between sessionFactory.openSession() and session.close():Code:
using (ISession session = SessionFactory.OpenSession())
{
//ICriteria criteria = session.CreateCriteria(typeof(Coverage));
//criteria.Add(new EqExpression("ID", Fixtures.CoverageID));
var coverage = session.Get<Coverage>(Fixtures.CoverageID);
Console.WriteLine(coverage.SomeDeps.Count().ToString());
Console.WriteLine(coverage.ToString());
}
Name and version of the database you are using:sql svr 2005
Debug level Hibernate log excerpt:
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125324]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 7
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125325' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125325
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125325]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125325
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'PATTON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '242178535' as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'CHRISTOPHER' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '7/11/1960' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'L' as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'H' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning null as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125325' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125325]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125325]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125325]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 8
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125326' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125326
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125326]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125326
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'PATTON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'CHRISTOPHER' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '6/20/1985' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'S' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning null as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125326' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125326]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125326]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125326]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 9
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125327' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125327
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125327]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125327
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'PATTON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'ELIZABETH' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '3/13/1981' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'D' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning null as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125327' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125327]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125327]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125327]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 10
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125328' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125328
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125328]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125328
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'PATTON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '111111111' as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'GENERAL' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '11/25/2007' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'S' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'EOL' as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '6' as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125328' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125328]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125328]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125328]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 11
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125329' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125329
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125329]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125329
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'SIMPSON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '111111111' as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'HOMER' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '1/18/1999' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'H' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'EOL' as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '11' as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125329' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125329]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125329]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125329]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 12
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125330' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125330
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125330]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125330
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'SIMPSON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '111111111' as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'LISA' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '11/30/2007' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'D' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'EOL' as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '14' as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125330' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125330]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125330]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125330]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 13
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125331' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125331
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125331]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125331
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'SIMPSON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '111111111' as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'MAGGIE' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '1/1/1900' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'D' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'EOL' as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '12' as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125331' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125331]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125331]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125331]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 14
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125332' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125332
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125332]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125332
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'PATTON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'SHERRY' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '4/24/1984' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'D' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning null as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125332' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125332]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125332]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125332]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 15
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125333' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125333
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125333]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125333
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'TEST2' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '111111111' as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'TEST2' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '1/1/2007' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'A' as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'D' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'EOL' as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '2' as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125333' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125333]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125333]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125333]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 16
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125334' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125334
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125334]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125334
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'TEST2' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '481245986' as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'TEST2' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '5/6/1965' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'A' as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'H' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'EOL' as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125334' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125334]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125334]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125334]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result set row: 17
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125335' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - result row: 125335
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - Initializing object from DataReader: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125335]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Persister.Entity.AbstractEntityPersister - Hydrating entity: Trion.Census.Service.WCF.BusinessEntities.Dependent#125335
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'PATTON' as column: LAST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: DEPENDENT_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'TRACEY' as column: FIRST_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning '12/26/1982' as column: DATE_OF_BIRTH
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: MIDDLE_INIT
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning '001581250' as column: EMPLOYEE_SSN
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning 'D' as column: RELATIONSHIP_CODE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: UPDATED_BY
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_TYPE
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_USER_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.DateTimeType - returning null as column: AUD_TIME_STAMP
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.StringType - returning null as column: AUD_SCRIPT_NAME
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning null as column: QLE_TRANS_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '1' as column: COMPANY_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '394548' as column: EMPLOYEE_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - found row of collection: [Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - starting attempt to find loading collection [[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#394548]]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - found loading collection bound to current result set processing; reading row
10:48:59 [TestRunnerThread] DEBUG NHibernate.Type.Int32Type - returning '125335' as column: DEPENDENT_ID
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125335]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - attempting to resolve: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125335]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - resolved object in session cache: [Trion.Census.Service.WCF.BusinessEntities.Dependent#125335]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - done processing result set (18 rows)
10:48:59 [TestRunnerThread] DEBUG NHibernate.Driver.NHybridDataReader - running NHybridDataReader.Dispose()
10:48:59 [TestRunnerThread] DEBUG NHibernate.AdoNet.BatcherImpl - Closed IDataReader, open IDataReaders :0
10:48:59 [TestRunnerThread] DEBUG NHibernate.AdoNet.BatcherImpl - Closed IDbCommand, open IDbCommands: 0
10:48:59 [TestRunnerThread] DEBUG NHibernate.AdoNet.ConnectionManager - aggressively releasing database connection
10:48:59 [TestRunnerThread] DEBUG NHibernate.Connection.ConnectionProvider - Closing connection
10:48:59 [TestRunnerThread] DEBUG NHibernate.Loader.Loader - total objects hydrated: 18
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125318]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - creating new proxy for entity
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - creating new proxy for entity
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125318]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125319]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125319]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125320]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125320]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125321]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125321]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125322]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125322]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125323]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125323]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125324]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125324]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125325]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125325]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125326]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125326]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125327]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125327]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125328]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125328]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125329]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125329]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125330]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125330]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125331]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125331]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125332]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125332]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125333]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125333]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125334]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125334]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - resolving associations for [Trion.Census.Service.WCF.BusinessEntities.Dependent#125335]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Employee#394548]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - loading entity: [Trion.Census.Service.WCF.BusinessEntities.Company#1]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Event.Default.DefaultLoadEventListener - entity proxy found in session cache
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.TwoPhaseLoad - done materializing entity [Trion.Census.Service.WCF.BusinessEntities.Dependent#125335]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.CollectionKey] in any result-set context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - collection [NHibernate.Engine.CollectionKey] not located in load context
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.CollectionLoadContext - removing collection load entry [NHibernate.Engine.Loading.LoadingCollectionEntry<rs=NHibernate.Driver.NHybridDataReader, coll=[Trion.Census.Service.WCF.BusinessEntities.Coverage.SomeDeps#1304630]>@10b212f]
10:48:59 [TestRunnerThread] DEBUG NHibernate.Engine.Loading.LoadContexts - attempting to locate loading collection entry [NHibernate.Engine.Co