Hello,

we are using nh as OR mapper in a relativly big project, we are hosting our business logic an a windows service. the communication is done over dotnet remoting and webservices.

The service runs without any problems, till we got the following error:

2006.09.05 12:15:39.564 [2908] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:15:43.173 [5304] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:17:45.594 [6004] WARN - System.IndexOutOfRangeException: idEventD1_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
2006.09.05 12:17:45.609 [6004] ERROR - idEventD1_

this error occurs on each request we sent a request to the webservice, after restarting the windows service, problem doesn't occure.

Before the error occured we have done some unittests on the webservice API, I post the full log (the errors before 2006.09.05 12:17:45.594 are consciously produced by our unittests (constraint errors):

What means this both lines:
ERROR - idAgentI1_
WARN - System.IndexOutOfRangeException: idAgentI1_0_

This lines look also worrying:
ERROR - idEventD1_
WARN - System.Data.SqlClient.SqlException: Server failed to resume the transaction, desc: 7a00000013.

Which error/problem has such a big impact on nhiberante?

It is really important that the service runs very stable!


Hibernate version: 1.0.2
Name and version of the database you are using: SQL Server 2005


Debug level Hibernate log excerpt:

After this error I set the log level to debug (without restarting)

2006.09.05 12:06:16.790 [5304] WARN - Narrowing proxy to Upper.S3.DataObjects.WorkflowEngine.Nodes.DoWfResponsibleTaskNode - this operation breaks ==
2006.09.05 12:06:55.430 [5304] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:07:26.289 [5304] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:07:44.429 [5304] WARN - Narrowing proxy to Upper.S3.DataObjects.WorkflowEngine.Nodes.DoWfResponsibleTaskNode - this operation breaks ==
2006.09.05 12:08:05.414 [5304] WARN - System.Data.SqlClient.SqlException: The DELETE statement conflicted with the REFERENCE constraint "FK_UserRole_Role_Role". The conflict occurred in database "S3", table "dbo.UserRole", column 'idRole'.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.InternalExecuteNonQuery(DbAsyncResult result, String methodName, Boolean sendToPipe)
at System.Data.SqlClient.SqlCommand.ExecuteNonQuery()
at NHibernate.Impl.BatcherImpl.ExecuteNonQuery(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
2006.09.05 12:08:05.414 [5304] ERROR - The DELETE statement conflicted with the REFERENCE constraint "FK_UserRole_Role_Role". The conflict occurred in database "S3", table "dbo.UserRole", column 'idRole'.
The statement has been terminated.
2006.09.05 12:08:05.414 [5304] ERROR - could not synchronize database state with session
NHibernate.ADOException: could not delete: [Upper.S3.DataObjects.Core.Security.DoRole#299] ---> System.Data.SqlClient.SqlException: The DELETE statement conflicted with the REFERENCE constraint "FK_UserRole_Role_Role". The conflict occurred in database "S3", table "dbo.UserRole", column 'idRole'.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.InternalExecuteNonQuery(DbAsyncResult result, String methodName, Boolean sendToPipe)
at System.Data.SqlClient.SqlCommand.ExecuteNonQuery()
at NHibernate.Impl.BatcherImpl.ExecuteNonQuery(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
--- End of inner exception stack trace ---
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
at NHibernate.Impl.ScheduledDeletion.Execute()
at NHibernate.Impl.SessionImpl.Execute(IExecutable executable)
at NHibernate.Impl.SessionImpl.ExecuteAll(IList list)
at NHibernate.Impl.SessionImpl.Execute()
2006.09.05 12:08:05.945 [5304] WARN - System.Data.SqlClient.SqlException: The DELETE statement conflicted with the REFERENCE constraint "FK_WfTaskResponsible_User_CreatedBy". The conflict occurred in database "S3", table "dbo.WfTaskResponsible", column 'idCreatedBy'.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.InternalExecuteNonQuery(DbAsyncResult result, String methodName, Boolean sendToPipe)
at System.Data.SqlClient.SqlCommand.ExecuteNonQuery()
at NHibernate.Impl.BatcherImpl.ExecuteNonQuery(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
2006.09.05 12:08:05.945 [5304] ERROR - The DELETE statement conflicted with the REFERENCE constraint "FK_WfTaskResponsible_User_CreatedBy". The conflict occurred in database "S3", table "dbo.WfTaskResponsible", column 'idCreatedBy'.
The statement has been terminated.
2006.09.05 12:08:05.945 [5304] ERROR - could not synchronize database state with session
NHibernate.ADOException: could not delete: [Upper.S3.DataObjects.Core.Security.DoUser#433] ---> System.Data.SqlClient.SqlException: The DELETE statement conflicted with the REFERENCE constraint "FK_WfTaskResponsible_User_CreatedBy". The conflict occurred in database "S3", table "dbo.WfTaskResponsible", column 'idCreatedBy'.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.InternalExecuteNonQuery(DbAsyncResult result, String methodName, Boolean sendToPipe)
at System.Data.SqlClient.SqlCommand.ExecuteNonQuery()
at NHibernate.Impl.BatcherImpl.ExecuteNonQuery(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
--- End of inner exception stack trace ---
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
at NHibernate.Impl.ScheduledDeletion.Execute()
at NHibernate.Impl.SessionImpl.Execute(IExecutable executable)
at NHibernate.Impl.SessionImpl.ExecuteAll(IList list)
at NHibernate.Impl.SessionImpl.Execute()
2006.09.05 12:08:09.179 [5304] WARN - System.Data.SqlClient.SqlException: The DELETE statement conflicted with the SAME TABLE REFERENCE constraint "FK_SecurityContext_SecurityContext_Parent". The conflict occurred in database "S3", table "dbo.SecurityContext", column 'idParent'.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.InternalExecuteNonQuery(DbAsyncResult result, String methodName, Boolean sendToPipe)
at System.Data.SqlClient.SqlCommand.ExecuteNonQuery()
at NHibernate.Impl.BatcherImpl.ExecuteNonQuery(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
2006.09.05 12:08:09.179 [5304] ERROR - The DELETE statement conflicted with the SAME TABLE REFERENCE constraint "FK_SecurityContext_SecurityContext_Parent". The conflict occurred in database "S3", table "dbo.SecurityContext", column 'idParent'.
The statement has been terminated.
2006.09.05 12:08:09.179 [5304] ERROR - could not synchronize database state with session
NHibernate.ADOException: could not delete: [Upper.S3.DataObjects.Core.Security.DoSecurityContext#3633] ---> System.Data.SqlClient.SqlException: The DELETE statement conflicted with the SAME TABLE REFERENCE constraint "FK_SecurityContext_SecurityContext_Parent". The conflict occurred in database "S3", table "dbo.SecurityContext", column 'idParent'.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.InternalExecuteNonQuery(DbAsyncResult result, String methodName, Boolean sendToPipe)
at System.Data.SqlClient.SqlCommand.ExecuteNonQuery()
at NHibernate.Impl.BatcherImpl.ExecuteNonQuery(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
--- End of inner exception stack trace ---
at NHibernate.Persister.EntityPersister.Delete(Object id, Object version, Object obj, ISessionImplementor session)
at NHibernate.Impl.ScheduledDeletion.Execute()
at NHibernate.Impl.SessionImpl.Execute(IExecutable executable)
at NHibernate.Impl.SessionImpl.ExecuteAll(IList list)
at NHibernate.Impl.SessionImpl.Execute()
2006.09.05 12:08:13.007 [5304] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:08:33.554 [2908] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:08:36.804 [2908] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:08:53.444 [2908] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:13:00.847 [5796] WARN - System.Data.SqlClient.SqlException: String or binary data would be truncated.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlDataReader.ConsumeMetaData()
at System.Data.SqlClient.SqlDataReader.get_MetaData()
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method)
at System.Data.SqlClient.SqlCommand.ExecuteReader(CommandBehavior behavior, String method)
at System.Data.SqlClient.SqlCommand.ExecuteDbDataReader(CommandBehavior behavior)
at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader()
at NHibernate.Impl.BatcherImpl.ExecuteReader(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Insert(Object[] fields, Boolean[] notNull, SqlString sql, Object obj, ISessionImplementor session)
2006.09.05 12:13:00.847 [5796] ERROR - String or binary data would be truncated.
The statement has been terminated.
2006.09.05 12:13:00.925 [5796] ERROR - Exception initializing proxy.
NHibernate.ObjectNotFoundException: No row with the given identifier exists: 0, of class: Upper.S3.DataObjects.WorkflowEngine.Nodes.DoWfResponsibleTaskNode
at NHibernate.Impl.SessionImpl.ImmediateLoad(Type clazz, Object id)
at NHibernate.Proxy.LazyInitializer.Initialize()
at NHibernate.Proxy.LazyInitializer.InitializeWrapExceptions()
2006.09.05 12:13:00.925 [5796] ERROR - Exception initializing proxy: [DoWfResponsibleTaskNode#0]
NHibernate.LazyInitializationException: Exception initializing proxy: [DoWfResponsibleTaskNode#0] ---> NHibernate.ObjectNotFoundException: No row with the given identifier exists: 0, of class: Upper.S3.DataObjects.WorkflowEngine.Nodes.DoWfResponsibleTaskNode
at NHibernate.Impl.SessionImpl.ImmediateLoad(Type clazz, Object id)
at NHibernate.Proxy.LazyInitializer.Initialize()
at NHibernate.Proxy.LazyInitializer.InitializeWrapExceptions()
--- End of inner exception stack trace ---
2006.09.05 12:13:01.004 [5796] ERROR - An AssertionFailure occured - this may indicate a bug in NHibernate
NHibernate.AssertionFailure: null id in entry (don't flush the Session after an exception occurs)
2006.09.05 12:14:50.768 [4932] WARN - System.Data.SqlClient.SqlException: String or binary data would be truncated.
The statement has been terminated.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlDataReader.ConsumeMetaData()
at System.Data.SqlClient.SqlDataReader.get_MetaData()
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method)
at System.Data.SqlClient.SqlCommand.ExecuteReader(CommandBehavior behavior, String method)
at System.Data.SqlClient.SqlCommand.ExecuteDbDataReader(CommandBehavior behavior)
at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader()
at NHibernate.Impl.BatcherImpl.ExecuteReader(IDbCommand cmd)
at NHibernate.Persister.EntityPersister.Insert(Object[] fields, Boolean[] notNull, SqlString sql, Object obj, ISessionImplementor session)
2006.09.05 12:14:50.768 [4932] ERROR - String or binary data would be truncated.
The statement has been terminated.
2006.09.05 12:14:50.861 [4932] ERROR - Exception initializing proxy.
NHibernate.ObjectNotFoundException: No row with the given identifier exists: 0, of class: Upper.S3.DataObjects.WorkflowEngine.Nodes.DoWfResponsibleTaskNode
at NHibernate.Impl.SessionImpl.ImmediateLoad(Type clazz, Object id)
at NHibernate.Proxy.LazyInitializer.Initialize()
at NHibernate.Proxy.LazyInitializer.InitializeWrapExceptions()
2006.09.05 12:14:50.861 [4932] ERROR - Exception initializing proxy: [DoWfResponsibleTaskNode#0]
NHibernate.LazyInitializationException: Exception initializing proxy: [DoWfResponsibleTaskNode#0] ---> NHibernate.ObjectNotFoundException: No row with the given identifier exists: 0, of class: Upper.S3.DataObjects.WorkflowEngine.Nodes.DoWfResponsibleTaskNode
at NHibernate.Impl.SessionImpl.ImmediateLoad(Type clazz, Object id)
at NHibernate.Proxy.LazyInitializer.Initialize()
at NHibernate.Proxy.LazyInitializer.InitializeWrapExceptions()
--- End of inner exception stack trace ---
2006.09.05 12:14:50.877 [4932] ERROR - An AssertionFailure occured - this may indicate a bug in NHibernate
NHibernate.AssertionFailure: null id in entry (don't flush the Session after an exception occurs)
2006.09.05 12:15:39.564 [2908] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:15:43.173 [5304] WARN - Narrowing proxy to Upper.S3.DataObjects.Core.DoApplication - this operation breaks ==
2006.09.05 12:17:45.594 [6004] WARN - System.IndexOutOfRangeException: idEventD1_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
2006.09.05 12:17:45.609 [6004] ERROR - idEventD1_
2006.09.05 12:23:09.933 [2908] WARN - System.Data.SqlClient.SqlException: Server failed to resume the transaction, desc: 7a00000013.
at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.SqlInternalConnection.OnError(SqlException exception, Boolean breakConnection)
at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj)
at System.Data.SqlClient.TdsParser.Run(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj)
at System.Data.SqlClient.SqlDataReader.ConsumeMetaData()
at System.Data.SqlClient.SqlDataReader.get_MetaData()
at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString)
at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, DbAsyncResult result)
at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method)
at System.Data.SqlClient.SqlCommand.ExecuteReader(CommandBehavior behavior, String method)
at System.Data.SqlClient.SqlCommand.ExecuteDbDataReader(CommandBehavior behavior)
at System.Data.Common.DbCommand.System.Data.IDbCommand.ExecuteReader()
at NHibernate.Impl.BatcherImpl.ExecuteReader(IDbCommand cmd)
at NHibernate.Loader.Loader.GetResultSet(IDbCommand st, RowSelection selection, ISessionImplementor session)
2006.09.05 12:23:09.933 [2908] ERROR - Server failed to resume the transaction, desc: 7a00000013.
2006.09.05 12:24:12.198 [2908] WARN - System.IndexOutOfRangeException: ChangeDate0_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Type.AbstractType.Hydrate(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.Hydrate(IDataReader rs, Object id, Object obj, ILoadable persister, ISessionImplementor session, String[][] suffixedPropertyColumns)
at NHibernate.Loader.Loader.LoadFromResultSet(IDataReader rs, Int32 i, Object obj, Key key, String suffix, LockMode lockMode, ILoadable rootPersister, ISessionImplementor session)
at NHibernate.Loader.Loader.InstanceNotYetLoaded(IDataReader dr, Int32 i, ILoadable persister, String suffix, Key key, LockMode lockMode, Key optionalObjectKey, Object optionalObject, IList hydratedObjects, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRow(IDataReader rs, ILoadable[] persisters, String[] suffixes, Key[] keys, Object optionalObject, Key optionalObjectKey, LockMode[] lockModes, IList hydratedObjects, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
2006.09.05 12:24:12.198 [2908] ERROR - ChangeDate0_
2006.09.05 12:24:12.198 [2908] WARN - System.IndexOutOfRangeException: ChangeDate0_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Type.AbstractType.Hydrate(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.Hydrate(IDataReader rs, Object id, Object obj, ILoadable persister, ISessionImplementor session, String[][] suffixedPropertyColumns)
at NHibernate.Loader.Loader.LoadFromResultSet(IDataReader rs, Int32 i, Object obj, Key key, String suffix, LockMode lockMode, ILoadable rootPersister, ISessionImplementor session)
at NHibernate.Loader.Loader.InstanceNotYetLoaded(IDataReader dr, Int32 i, ILoadable persister, String suffix, Key key, LockMode lockMode, Key optionalObjectKey, Object optionalObject, IList hydratedObjects, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRow(IDataReader rs, ILoadable[] persisters, String[] suffixes, Key[] keys, Object optionalObject, Key optionalObjectKey, LockMode[] lockModes, IList hydratedObjects, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQueryAndInitializeNonLazyCollections(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.EntityLoader.Load(ISessionImplementor session, Object id, Object optionalObject, Object optionalId)
at NHibernate.Loader.EntityLoader.Load(ISessionImplementor session, Object id, Object optionalObject)
at NHibernate.Loader.BatchingEntityLoader.Load(ISessionImplementor session, Object id, Object optionalObject)
at NHibernate.Persister.EntityPersister.Load(Object id, Object optionalObject, LockMode lockMode, ISessionImplementor session)
2006.09.05 12:24:12.198 [2908] ERROR - ChangeDate0_
2006.09.05 12:24:12.198 [4928] WARN - System.IndexOutOfRangeException: idUser
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
2006.09.05 12:24:12.198 [4928] ERROR - idUser
2006.09.05 12:32:19.379 [2908] DEBUG - opened session
2006.09.05 12:32:19.379 [2908] DEBUG - find: from DoUser u where u.ShortName = :name
2006.09.05 12:32:19.379 [2908] DEBUG - named parameters: {name=system}
2006.09.05 12:32:19.379 [2908] DEBUG - HQL: from Upper.S3.DataObjects.Core.Security.DoUser u where u.ShortName = :name
2006.09.05 12:32:19.379 [2908] DEBUG - SQL: select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_ where (douser0_.ShortName=:p00)
2006.09.05 12:32:19.379 [2908] DEBUG - Opened new IDbCommand, open IDbCommands :1
2006.09.05 12:32:19.379 [2908] DEBUG - Building an IDbCommand object for the SqlString: select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_ where (douser0_.ShortName=:p00)
2006.09.05 12:32:19.379 [2908] INFO - select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_ where (douser0_.ShortName=@p0)
2006.09.05 12:32:19.379 [2908] DEBUG - select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_ where (douser0_.ShortName=@p0)
2006.09.05 12:32:19.379 [2908] DEBUG - @p0 = 'system'
2006.09.05 12:32:19.379 [2908] DEBUG - Obtaining IDbConnection from Driver
2006.09.05 12:32:19.379 [2908] DEBUG - Opened Reader, open Readers :1
2006.09.05 12:32:19.379 [2908] DEBUG - processing result set
2006.09.05 12:32:19.379 [2908] DEBUG - result row: 290
2006.09.05 12:32:19.379 [2908] DEBUG - Initializing object from DataReader: 290
2006.09.05 12:32:19.379 [2908] DEBUG - Hydrating entity: Upper.S3.DataObjects.Core.Security.DoUser#290
2006.09.05 12:32:19.379 [2908] DEBUG - Version: 317
2006.09.05 12:32:19.379 [2908] DEBUG - done processing result set (1 rows)
2006.09.05 12:32:19.379 [2908] DEBUG - running NHybridDataReader.Dispose()
2006.09.05 12:32:19.379 [2908] DEBUG - Closed Reader, open Readers :0
2006.09.05 12:32:19.379 [2908] DEBUG - Closed IDbCommand, open IDbCommands :0
2006.09.05 12:32:19.379 [2908] DEBUG - total objects hydrated: 1
2006.09.05 12:32:19.379 [2908] DEBUG - resolving associations for: [Upper.S3.DataObjects.Core.Security.DoUser#290]
2006.09.05 12:32:19.379 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Policies#290]
2006.09.05 12:32:19.379 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.SubstituteFor#290]
2006.09.05 12:32:19.379 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.SubstituteOf#290]
2006.09.05 12:32:19.379 [2908] DEBUG - loading [DoUserType#2]
2006.09.05 12:32:19.379 [2908] DEBUG - loading [DoUser#1]
2006.09.05 12:32:19.379 [2908] DEBUG - loading [DoUser#1]
2006.09.05 12:32:19.379 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Notifications#290]
2006.09.05 12:32:19.379 [2908] DEBUG - loading [DoApplication#1]
2006.09.05 12:32:19.379 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Accounts#290]
2006.09.05 12:32:19.379 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Roles#290]
2006.09.05 12:32:19.379 [2908] DEBUG - calling OnLoad()
2006.09.05 12:32:19.379 [2908] DEBUG - done materializing entity [Upper.S3.DataObjects.Core.Security.DoUser#290]
2006.09.05 12:32:19.379 [2908] DEBUG - initializing non-lazy collections
2006.09.05 12:32:19.379 [2908] DEBUG - running ISession.Dispose()
2006.09.05 12:32:19.379 [2908] DEBUG - running BatcherImpl.Dispose(true)
2006.09.05 12:32:19.379 [2908] DEBUG - Closing connection
2006.09.05 12:32:19.379 [2908] DEBUG - opened session
2006.09.05 12:32:19.379 [2908] DEBUG - version unsaved-value strategy UNDEFINED
2006.09.05 12:32:19.379 [2908] DEBUG - unsaved-value: 0
2006.09.05 12:32:19.379 [2908] DEBUG - reassociating transient instance: [Upper.S3.DataObjects.Core.Security.DoUser#290]
2006.09.05 12:32:19.395 [2908] DEBUG - find: from DoUser usr where usr.ShortName = :shortName and usr.Application.Key = :key
2006.09.05 12:32:19.395 [2908] DEBUG - named parameters: {key=c08857cd-2ea3-4cba-b018-7867d3052a5a, shortName=admin}
2006.09.05 12:32:19.395 [2908] DEBUG - HQL: from Upper.S3.DataObjects.Core.Security.DoUser usr where usr.ShortName = :shortName and usr.Application.Key = :key
2006.09.05 12:32:19.411 [2908] DEBUG - SQL: select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_, [Application] doapplicat1_ left outer join ObjectType [doapplicat1__1_] on doapplicat1_.idApplication=[doapplicat1__1_].idObjectType where (douser0_.ShortName=:p00)and(doapplicat1_.[Key]=:p10 and douser0_.idApplication=doapplicat1_.idApplication)
2006.09.05 12:32:19.411 [2908] DEBUG - Opened new IDbCommand, open IDbCommands :1
2006.09.05 12:32:19.411 [2908] DEBUG - Building an IDbCommand object for the SqlString: select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_, [Application] doapplicat1_ left outer join ObjectType [doapplicat1__1_] on doapplicat1_.idApplication=[doapplicat1__1_].idObjectType where (douser0_.ShortName=:p00)and(doapplicat1_.[Key]=:p10 and douser0_.idApplication=doapplicat1_.idApplication)
2006.09.05 12:32:19.411 [2908] INFO - select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_, [Application] doapplicat1_ left outer join ObjectType [doapplicat1__1_] on doapplicat1_.idApplication=[doapplicat1__1_].idObjectType where (douser0_.ShortName=@p0)and(doapplicat1_.[Key]=@p1 and douser0_.idApplication=doapplicat1_.idApplication)
2006.09.05 12:32:19.411 [2908] DEBUG - select douser0_.idUser as idUser, douser0_.ChangeDate as ChangeDate, douser0_.Password as Password, douser0_.Sex as Sex, douser0_.LastOnlineDate as LastOnli7_, douser0_.Version as Version, douser0_.Department as Department, douser0_.OState as OState, douser0_.Company as Company, douser0_.idType as idType, douser0_.idChangedBy as idChang22_, douser0_.Title as Title, douser0_.idCreatedBy as idCreat21_, douser0_.ShortName as ShortName, douser0_.Description as Descrip14_, douser0_.FirstName as FirstName, douser0_.CreateDate as CreateDate, douser0_.idApplication as idAppli20_, douser0_.SurName as SurName, douser0_.Email as Email, douser0_.Inactive as Inactive, douser0_.PhoneNumber as PhoneNu13_ from [User] douser0_, [Application] doapplicat1_ left outer join ObjectType [doapplicat1__1_] on doapplicat1_.idApplication=[doapplicat1__1_].idObjectType where (douser0_.ShortName=@p0)and(doapplicat1_.[Key]=@p1 and douser0_.idApplication=doapplicat1_.idApplication)
2006.09.05 12:32:19.411 [2908] DEBUG - @p0 = 'admin'
2006.09.05 12:32:19.411 [2908] DEBUG - @p1 = 'c08857cd-2ea3-4cba-b018-7867d3052a5a'
2006.09.05 12:32:19.411 [2908] DEBUG - Obtaining IDbConnection from Driver
2006.09.05 12:32:19.411 [2908] DEBUG - Opened Reader, open Readers :1
2006.09.05 12:32:19.411 [2908] DEBUG - processing result set
2006.09.05 12:32:19.411 [2908] DEBUG - result row: 1
2006.09.05 12:32:19.411 [2908] DEBUG - Initializing object from DataReader: 1
2006.09.05 12:32:19.411 [2908] DEBUG - Hydrating entity: Upper.S3.DataObjects.Core.Security.DoUser#1
2006.09.05 12:32:19.411 [2908] DEBUG - Version: 5501
2006.09.05 12:32:19.411 [2908] DEBUG - done processing result set (1 rows)
2006.09.05 12:32:19.411 [2908] DEBUG - running NHybridDataReader.Dispose()
2006.09.05 12:32:19.411 [2908] DEBUG - Closed Reader, open Readers :0
2006.09.05 12:32:19.411 [2908] DEBUG - Closed IDbCommand, open IDbCommands :0
2006.09.05 12:32:19.411 [2908] DEBUG - total objects hydrated: 1
2006.09.05 12:32:19.411 [2908] DEBUG - resolving associations for: [Upper.S3.DataObjects.Core.Security.DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Policies#1]
2006.09.05 12:32:19.411 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.SubstituteFor#1]
2006.09.05 12:32:19.411 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.SubstituteOf#1]
2006.09.05 12:32:19.411 [2908] DEBUG - loading [DoUserType#1]
2006.09.05 12:32:19.411 [2908] DEBUG - loading [DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - attempting to resolve [DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - resolved object in session cache [Upper.S3.DataObjects.Core.Security.DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - loading [DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - attempting to resolve [DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - resolved object in session cache [Upper.S3.DataObjects.Core.Security.DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Notifications#1]
2006.09.05 12:32:19.411 [2908] DEBUG - loading [DoApplication#1]
2006.09.05 12:32:19.411 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Accounts#1]
2006.09.05 12:32:19.411 [2908] DEBUG - creating collection wrapper:[Upper.S3.DataObjects.Core.Security.DoUser.Roles#1]
2006.09.05 12:32:19.411 [2908] DEBUG - calling OnLoad()
2006.09.05 12:32:19.411 [2908] DEBUG - done materializing entity [Upper.S3.DataObjects.Core.Security.DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - initializing non-lazy collections
2006.09.05 12:32:19.411 [2908] DEBUG - attempting to resolve [DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - resolved object in session cache [Upper.S3.DataObjects.Core.Security.DoUser#1]
2006.09.05 12:32:19.411 [2908] DEBUG - running ISession.Dispose()
2006.09.05 12:32:19.411 [2908] DEBUG - running BatcherImpl.Dispose(true)
2006.09.05 12:32:19.411 [2908] DEBUG - Closing connection
2006.09.05 12:34:25.268 [5796] WARN - System.IndexOutOfRangeException: idAgentI1_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
2006.09.05 12:34:25.268 [5796] ERROR - idAgentI1_
2006.09.05 12:34:25.284 [5796] WARN - System.IndexOutOfRangeException: idAgentI1_0_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
2006.09.05 12:34:25.284 [5796] ERROR - idAgentI1_0_
2006.09.05 12:34:25.284 [5796] WARN - System.IndexOutOfRangeException: idAgentI1_0_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQueryAndInitializeNonLazyCollections(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.OneToManyLoader.Initialize(Object id, ISessionImplementor session)
at NHibernate.Collection.AbstractCollectionPersister.Initialize(Object key, ISessionImplementor session)
2006.09.05 12:34:25.284 [5796] ERROR - idAgentI1_0_
2006.09.05 12:34:25.284 [5796] ERROR - Failed to lazily initialize a collection
NHibernate.ADOException: could not initialize collection: [Upper.S3.DataObjects.Core.Agents.DoAgentInstance.Settings#1] ---> System.IndexOutOfRangeException: idAgentI1_0_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQueryAndInitializeNonLazyCollections(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.OneToManyLoader.Initialize(Object id, ISessionImplementor session)
at NHibernate.Collection.AbstractCollectionPersister.Initialize(Object key, ISessionImplementor session)
--- End of inner exception stack trace ---
at NHibernate.Collection.AbstractCollectionPersister.Initialize(Object key, ISessionImplementor session)
at NHibernate.Impl.SessionImpl.InitializeCollection(PersistentCollection collection, Boolean writing)
at NHibernate.Collection.PersistentCollection.Initialize(Boolean writing)
2006.09.05 12:34:25.284 [5796] ERROR - Failed to lazily initialize a collection
NHibernate.LazyInitializationException: Failed to lazily initialize a collection ---> NHibernate.ADOException: could not initialize collection: [Upper.S3.DataObjects.Core.Agents.DoAgentInstance.Settings#1] ---> System.IndexOutOfRangeException: idAgentI1_0_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQueryAndInitializeNonLazyCollections(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
at NHibernate.Loader.OneToManyLoader.Initialize(Object id, ISessionImplementor session)
at NHibernate.Collection.AbstractCollectionPersister.Initialize(Object key, ISessionImplementor session)
--- End of inner exception stack trace ---
at NHibernate.Collection.AbstractCollectionPersister.Initialize(Object key, ISessionImplementor session)
at NHibernate.Impl.SessionImpl.InitializeCollection(PersistentCollection collection, Boolean writing)
at NHibernate.Collection.PersistentCollection.Initialize(Boolean writing)
--- End of inner exception stack trace ---
2006.09.05 12:34:55.268 [2324] WARN - System.IndexOutOfRangeException: idAgentI1_
at System.Data.ProviderBase.FieldNameLookup.GetOrdinal(String fieldName)
at System.Data.SqlClient.SqlDataReader.GetOrdinal(String name)
at NHibernate.Driver.NHybridDataReader.GetOrdinal(String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String name)
at NHibernate.Type.NullableType.NullSafeGet(IDataReader rs, String[] names, ISessionImplementor session, Object owner)
at NHibernate.Loader.Loader.GetKeyFromResultSet(Int32 i, ILoadable persister, Object id, IDataReader rs, ISessionImplementor session)
at NHibernate.Loader.Loader.GetRowFromResultSet(IDataReader resultSet, ISessionImplementor session, QueryParameters queryParameters, IList hydratedObjects, Object optionalObject, Object optionalId, Key[] keys, Boolean returnProxies)
at NHibernate.Loader.Loader.DoQuery(ISessionImplementor session, QueryParameters queryParameters, Object optionalObject, Object optionalId, Object[] optionalCollectionKeys, Boolean returnProxies)
2006.09.05 12:34:55.268 [2324] ERROR - idAgentI1_


Thanks,
thomas

how do you manage the hibernate session in the service? after an exception the session should be discarded and another one created.

radu

We create for each request a new session and we don't use a session afer an exception/error.

Do you use any testing tool, profiler or something similar? I'm using nhibernate with remoting too and I would like to simulate 500 people connecting to the server. How do you test your remoting server?

Thank you.