Hello,
I hope someone can help. I plan to log a ticket tomorrow if I get no response tonight.
I'm unable to create new employees in Manager or Data import process. I get no error and manager or data importer just locks. I can create new business roles, organizations but not employees.
I have some trace logs but i cannot make out what could be wrong.
Has anyone seen this or have some clue as to what could be the issue?
I will put as much as the logs i can in below.
Thank you, Lu
2020-10-28 23:37:07.6689 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:37:07.6689 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:37:07.6689 TRACE (SqlLog Database Session GC) : Available = 1
2020-10-28 23:37:13.2854 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Person: Creating new entity, creation type Interactive
2020-10-28 23:37:13.4416 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicInitialize
2020-10-28 23:37:13.4416 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Person: Initializing Customizer
2020-10-28 23:37:13.4416 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on RiskIndexCalculated CanEdit depends on _IsAdministrativeAccount
2020-10-28 23:37:13.4416 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running CanEdit for RiskIndexCalculated in Person
2020-10-28 23:37:13.4416 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_IsAdministrativeAccount' for entity logic...
2020-10-28 23:37:13.4416 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Expensive function...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: RiskIndexCalculated CanEdit = False
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on DialogUserSalt CanEdit depends on
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running CanEdit for DialogUserSalt in Person
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: DialogUserSalt CanEdit = False
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on DeactivationEnd CanEdit depends on DeactivationStart, IsTemporaryDeactivated
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running CanEdit for DeactivationEnd in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'DeactivationStart' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'IsTemporaryDeactivated' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: DeactivationEnd CanEdit = False
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on UID_RealPerson CanEdit depends on IsDummyPerson
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running CanEdit for UID_RealPerson in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'IsDummyPerson' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: UID_RealPerson CanEdit = False
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on UID_X500Person CanEdit depends on IsX500Dummy
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running CanEdit for UID_X500Person in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'IsX500Dummy' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: UID_X500Person CanEdit = False
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on IsTemporaryDeactivated CanEdit depends on IsInactive
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running CanEdit for IsTemporaryDeactivated in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'IsInactive' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: IsTemporaryDeactivated CanEdit = True
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on UID_PersonHead MinLen depends on IdentityType
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MinLen for UID_PersonHead in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'IdentityType' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: UID_PersonHead MinLen = 0
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on UID_PersonMasterIdentity MinLen depends on IdentityType
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MinLen for UID_PersonMasterIdentity in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'IdentityType' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: UID_PersonMasterIdentity MinLen = 0
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on DateLastWorked MinLen depends on ExitDate
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MinLen for DateLastWorked in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'ExitDate' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: DateLastWorked MinLen = 0
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on CreateAdminUser(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodEnabled depends on _AdminUserExists
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MethodEnabled for CreateAdminUser(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_AdminUserExists' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Expensive function...
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: CreateAdminUser(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodEnabled = False
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on CreateAdminUser(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodVisible depends on _AdminUserExists
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MethodVisible for CreateAdminUser(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) in Person
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_AdminUserExists' for entity logic...
2020-10-28 23:37:13.4572 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Got from cache.
2020-10-28 23:37:13.4572 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: CreateAdminUser(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodVisible = False
2020-10-28 23:37:13.4729 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicInitialize, New state: None
2020-10-28 23:37:13.4729 TRACE (ObjectLog ) : Loading strings from TSB.Customizer, Version=8.1.0.0, Culture=neutral, PublicKeyToken=5d0660cde5b231fd|TSB.Customizer.Properties.Strings.
2020-10-28 23:37:13.4729 TRACE (ObjectLog ) : Loading strings from QER.Customizer, Version=8.1.0.0, Culture=neutral, PublicKeyToken=5d0660cde5b231fd|QER.Customizer.Properties.Strings.
2020-10-28 23:37:13.4729 TRACE (ObjectLog ) : Loading strings from Common.Customizer, Version=8.1.0.0, Culture=neutral, PublicKeyToken=5d0660cde5b231fd|VI.Common.Customizer.Properties.Strings.
2020-10-28 23:37:13.4885 TRACE (ObjectLog ) : Loading strings from CPL.Customizer, Version=8.1.0.0, Culture=neutral, PublicKeyToken=5d0660cde5b231fd|CPL.Customizer.Properties.Strings.
2020-10-28 23:37:13.4729 DEBUG (StopWatch SW) : Getting PolicyColumns/global from cache. done in 0ms.
2020-10-28 23:37:13.4885 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicInitialize
2020-10-28 23:37:13.4885 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Person: Initializing Customizer
2020-10-28 23:37:13.4885 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on ComplianceCheckSimple(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodEnabled depends on [IsLoaded], Config(QER\ComplianceCheck\SimpleMode)
2020-10-28 23:37:13.4885 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MethodEnabled for ComplianceCheckSimple(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) in Person
2020-10-28 23:37:13.4885 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '[IsLoaded]' for entity logic...
2020-10-28 23:37:13.4885 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.4885 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value 'Config(QER\ComplianceCheck\SimpleMode)' for entity logic...
2020-10-28 23:37:13.4885 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Config...
2020-10-28 23:37:13.4885 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: ComplianceCheckSimple(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodEnabled = False
2020-10-28 23:37:13.4885 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicInitialize, New state: None
2020-10-28 23:37:13.5041 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Set default values.
2020-10-28 23:37:13.5041 DEBUG (ObjectLog ) : Loading assembly C:\Users\adminUser\AppData\Local\One Identity\One Identity Manager\AssemblyCache\Tmpl_3aIzoSQxKbNZhI8wGt4AYhYQvI.dll
2020-10-28 23:37:13.5041 DEBUG (ObjectLog ) : ScriptClass: Loading assembly from buffer: Tmpl_3aIzoSQxKbNZhI8wGt4AYhYQvI
2020-10-28 23:37:13.5510 DEBUG (StopWatch SW) : Getting Table/DialogNextID from cache. done in 2ms.
2020-10-28 23:37:13.5510 DEBUG (StopWatch SW) : Getting Schema/DialogNextID from cache. done in 2ms.
2020-10-28 23:37:13.5510 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : DialogNextID: Creating new entity, creation type Interactive
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicInitialize
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : DialogNextID: Initializing Customizer
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on NextNumber CanEdit depends on
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running CanEdit for NextNumber in DialogNextID
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: NextNumber CanEdit = False
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicInitialize, New state: None
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicInitialize
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : DialogNextID: Initializing Customizer
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on SwitchToModuleGuid(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodVisible depends on [IsLoaded], _Enabled, _HasModuleGuid, _ProductionLevel
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MethodVisible for SwitchToModuleGuid(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) in ModuleGuids
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '[IsLoaded]' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_Enabled' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Expensive function...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_HasModuleGuid' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Expensive function...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_ProductionLevel' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Expensive function...
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: SwitchToModuleGuid(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodVisible = False
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Action on SwitchToNormalGuid(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodVisible depends on [IsLoaded], _Enabled, _HasModuleGuid, _NormalGuidsAllowed
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Running MethodVisible for SwitchToNormalGuid(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) in ModuleGuids
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '[IsLoaded]' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Local value...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_Enabled' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Got from cache.
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_HasModuleGuid' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Got from cache.
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value '_NormalGuidsAllowed' for entity logic...
2020-10-28 23:37:13.5666 TRACE (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Getting value from Expensive function...
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Result: SwitchToNormalGuid(VI.DB.Entities.ISession, VI.DB.Entities.IEntity, System.Threading.CancellationToken) MethodVisible = False
2020-10-28 23:37:13.5666 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicInitialize, New state: None
2020-10-28 23:37:13.6135 DEBUG (StopWatch SW) : Getting Notifications/DialogNextID from cache. done in 12ms.
2020-10-28 23:37:13.6291 DEBUG (StopWatch SW) : Getting ColumnDeps/DialogNextID from cache. done in 8ms.
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.7697 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.7854 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Begin transaction in read/write entity
2020-10-28 23:37:13.7854 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Check and execute column format Single Line with 83388cab-2185-4099-8d0a-2b9aa0d4a26d
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : DialogNextID.UID_DialogNextID = 83388cab-2185-4099-8d0a-2b9aa0d4a26d
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Commit transaction in read/write entity
2020-10-28 23:37:13.8010 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Creating new entity done in 248ms.
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Begin transaction in read/write entity
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Check and execute column format Single Line with Person.SecurityIdent
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : DialogNextID.Ident_DialogNextID = Person.SecurityIdent
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: None, New state: LogicSetValues
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Customizer SetValueAsync
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Old state: LogicSetValues, New state: None
2020-10-28 23:37:13.8166 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Commit transaction in read/write entity
2020-10-28 23:37:13.8791 DEBUG (ObjectLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Calling entity method GetNextID
2020-10-28 23:37:13.9104 TRACE (SqlLog ) : -- Connection 1 switched from Available to Working after comparison
2020-10-28 23:37:13.9104 TRACE (SqlLog ) : --> existing connection 1
2020-10-28 23:37:13.9104 DEBUG (SqlLog ffcfb894-bdbb-4c70-b256-f711989125d3) : (< 1 ms) - Pin DbSession to physical connection
2020-10-28 23:37:13.9104 TRACE (SqlLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Incremented pin count to 1
2020-10-28 23:37:13.9104 DEBUG (SqlLog ffcfb894-bdbb-4c70-b256-f711989125d3) : (4 ms) - BEGIN TRANSACTION
2020-10-28 23:37:13.9104 TRACE (SqlLog ffcfb894-bdbb-4c70-b256-f711989125d3) : Increment transaction count to 1
2020-10-28 23:37:13.9260 TRACE (SqlLog ffcfb894-bdbb-4c70-b256-f711989125d3) : ClaimConnectionAsync - read write, _transaction == 7931792
2020-10-28 23:37:13.9260 TRACE (SqlLog ffcfb894-bdbb-4c70-b256-f711989125d3) : ClaimConnectionAsync: Lock aquired on connection 1
2020-10-28 23:37:13.9260 TRACE (SqlLog ffcfb894-bdbb-4c70-b256-f711989125d3) : ClaimConnectionAsync: Use the transaction
2020-10-28 23:37:17.6818 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:37:17.6818 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:37:17.6818 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:37:27.6830 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:37:27.6830 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:37:27.6830 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:37:30.0928 TRACE (SqlLog ) : -- Connection 0 switched from Available to Reusable
2020-10-28 23:37:30.0928 TRACE (SqlLog ) : -- Connection 2 switched from Reusable to Initializing after comparison
2020-10-28 23:37:30.1108 TRACE (SqlLog ) : -- Connection 2 switched from Initializing to Working
2020-10-28 23:37:30.1108 TRACE (SqlLog ) : --> new connection 2
2020-10-28 23:37:30.1108 DEBUG (SqlLog 93a7225c-93bf-4661-a4ec-366a037f1ae2) : (7 ms) - select top 1 IsDBSchedulerDisabled, IsJobServiceDisabled,
case
when exists (select top 1 1
from QBM_VDBQueueContent
where UID_Task = 'QBM-K-COMMONWAITFORCOMPILER'
) then 1
else 0
end as DbQueueWaitForCompiler,
len(dbo.QBM_FGIMaintenanceRunning()) as Maintenance
from DialogDatabase with (nolock)
where IsMainDatabase = 1
2020-10-28 23:37:30.1108 TRACE (SqlLog ) : -- Connection 2 switched from Working to Available
2020-10-28 23:37:37.6891 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:37:37.6891 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:37:37.6891 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:37:37.6891 TRACE (SqlLog Database Session GC) : Available = 1
2020-10-28 23:37:47.6929 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:37:47.6929 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:37:47.6929 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:37:47.6929 TRACE (SqlLog Database Session GC) : Available = 1
2020-10-28 23:37:57.6923 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:37:57.6923 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:37:57.6923 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:37:57.6923 TRACE (SqlLog Database Session GC) : Available = 1
2020-10-28 23:38:00.1092 TRACE (SqlLog ) : -- Connection 2 switched from Available to Working after comparison
2020-10-28 23:38:00.1092 TRACE (SqlLog ) : --> existing connection 2
2020-10-28 23:38:00.1092 DEBUG (SqlLog 93a7225c-93bf-4661-a4ec-366a037f1ae2) : (7 ms) - select top 1 IsDBSchedulerDisabled, IsJobServiceDisabled,
case
when exists (select top 1 1
from QBM_VDBQueueContent
where UID_Task = 'QBM-K-COMMONWAITFORCOMPILER'
) then 1
else 0
end as DbQueueWaitForCompiler,
len(dbo.QBM_FGIMaintenanceRunning()) as Maintenance
from DialogDatabase with (nolock)
where IsMainDatabase = 1
2020-10-28 23:38:00.1092 TRACE (SqlLog ) : -- Connection 2 switched from Working to Available
2020-10-28 23:38:07.7019 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:38:07.7019 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:38:07.7019 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:38:07.7019 TRACE (SqlLog Database Session GC) : Available = 1
2020-10-28 23:38:17.7163 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:38:17.7163 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:38:17.7163 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:38:17.7163 TRACE (SqlLog Database Session GC) : Available = 1
2020-10-28 23:38:27.7197 TRACE (SqlLog Database Session GC) : Cleanup physical connection pool
2020-10-28 23:38:27.7197 TRACE (SqlLog Database Session GC) : 0 connections disposed.
2020-10-28 23:38:27.7197 TRACE (SqlLog Database Session GC) : Working = 1
2020-10-28 23:38:27.7197 TRACE (SqlLog Database Session GC) : Available = 1
2020-10-28 23:38:30.1144 TRACE (SqlLog ) : -- Connection 2 switched from Available to Working after comparison
2020-10-28 23:38:30.1144 TRACE (SqlLog ) : --> existing connection 2
2020-10-28 23:38:30.1144 DEBUG (SqlLog 93a7225c-93bf-4661-a4ec-366a037f1ae2) : (7 ms) - select top 1 IsDBSchedulerDisabled, IsJobServiceDisabled,
case
when exists (select top 1 1
from QBM_VDBQueueContent
where UID_Task = 'QBM-K-COMMONWAITFORCOMPILER'
) then 1
else 0
end as DbQueueWaitForCompiler,
len(dbo.QBM_FGIMaintenanceRunning()) as Maintenance
from DialogDatabase with (nolock)
where IsMainDatabase = 1
