Sync Engine issue: Decryption fails

Hi there,

and a happy new year!

Running 8.1.3 in a MS only environment am I experiencing the issuewhen simulating a provisioning workflow to AD on objectclass user:

Der Workflow (Provisioning) aus dem Synchronisationsprojekt (Sync: iamdemo.local) konnte nicht fehlerfrei ausgeführt werden.
at VI.Projector.Projection.ProjectorEngine.<ExecuteAsync>d__3.MoveNext()
Der Synchronisationsschritt (user) aus der Synchronisationskonfiguration (Provisioning (Provisioning)) konnte nicht fehlerfrei ausgeführt werden.
at VI.Projector.Projection.ProjectorEngine.<ExecuteAsync>d__3.MoveNext()
Der Synchronisationsschritt (user) konnte nicht fehlerfrei ausgeführt werden!
at VI.Projector.Projection.ProjectorEngine.<ExecuteAsync>d__3.MoveNext()
at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
at VI.Projector.Projection.ProjectionStrategy.<ExecuteStepAsync>d__3.MoveNext()
Fehler beim Neuladen von 1 Systemobjekten.
at System.Threading.Tasks.Task.Execute()
at System.Threading.Tasks.Task`1.InnerInvoke()
at VI.Projector.Projection.Internal.ObjectPartitionReloader._ReloadPartition(ISystemObject[] partition)
at VI.Projector.Connection.SystemConnection.ReloadObject(IEnumerable`1 systemObjects, ReloadObjectOptions option)
Der verschlüsselte Wert kann nicht entschlüsselt werden, es ist keine Verschlüsselung konfiguriert.
at VI.Projector.Connection.SystemConnection.ReloadObject(IEnumerable`1 systemObjects, ReloadObjectOptions option)
at VI.Projector.Journal.JournalConnector.OnReloadObject(ReloadObjectsRequest request)
at VI.Projector.Connection.Connectors.DistributionConnector.ReloadObject(ReloadObjectsRequest request)
at VI.Projector.Connection.SystemConnector.ReloadObject(ReloadObjectsRequest request)
at VI.Projector.Database.DatabaseConnector.OnReloadObject(ReloadObjectsRequest request)
at System.Collections.Generic.List`1.InsertRange(Int32 index, IEnumerable`1 collection)
at VI.Projector.Database.DatabaseSystemObjectData.<FromEntities>d__6.MoveNext()
at VI.Projector.Database.DatabaseSystemObjectData._GetValue(IMetaColumn column, Object value, Boolean throwIfDataDecryptionFails)
at VI.Base.Encryption.NoEncryption.Decrypt(String data)

Crashbericht

2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wikstedt Simon@ADSAccount[] and Wikstedt Simon@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping not applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping not applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Wilcox, Gustavo@ADSAccount[] and Wilcox, Gustavo@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping not applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping not applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 SystemMappingRule Perform mapping between Williams, Danny@ADSAccount[] and Williams, Danny@user[].
2021-01-06 15:55:26 SystemMappingRule Mapping applied.
2021-01-06 15:55:26 GenericPool Getting item...
2021-01-06 15:55:26 GenericPool Got existing item: IAM-OIM-DB\OneIM
2021-01-06 15:55:26 GenericPool Release item: IAM-OIM-DB\OneIM
2021-01-06 15:55:26 SystemScope Invalidating scope of Active Directory user accounts (ADSAccount)...
2021-01-06 15:55:26 SystemScope Invalidating scope of Active Directory user accounts (ADSAccount)...
2021-01-06 15:55:26 StopWatch Committing 119 objects. done in 0ms.
2021-01-06 15:55:26 SystemConnector Result: State (Success) Failures (0)
2021-01-06 15:55:26 SystemConnection ReloadObject-Result: 6 system objects.
2021-01-06 15:55:26 StopWatch Reloading 6 objects. done in 106ms.
2021-01-06 15:55:26 ProjectorEngine Performing hierarchy sort of 1 system objects via CanonicalName@ADSAccount.
2021-01-06 15:55:26 SystemConnection ReloadObject: Reloading 1 objects of type Active Directory user accounts (ADSAccount).
2021-01-06 15:55:26 SystemConnection Options: ExceptionHandling=BreakOnError
Properties: AccountDisabled, AccountExpires, AccountLockedOut, AccountSensitive, AccountTrustedForDelegation, AllowDialIn, AllowDialinByPolicy, AllowLogonTerminalServer, cn, Company, Department, Description, DisplayName, DistinguishedName, DoNotRequireKerberos, EmployeeID, EmployeeNumber, EmployeeType, Fax, GivenName, HomeDirectory, HomeDrive, HomePhone, Info, Initials, ipPhone, Locality, LogonHours, LogonWorkstation, Mail, Mobile, MSDsConsistencyGuid, MSNPCallingStationID, MSRADIUSCallBackNumber, MSRADIUSFramedIPAddress, MSRADIUSFramedRoute, MSRADIUSServiceType, ObjectClass, OtherFax, OtherHomePhone, OtherIPPhone, OtherMailBox, OtherMobile, OtherPager, OtherTelephoneNumber, OtherWWW, Pager, PasswordNeverExpires, PersonalTitle, PhysicalDeliveryOfficeName, PostalCode, PostOfficeBox, ProfilePath, RASAlwaysCallBack, RASCallerSetCallBack, RASNoCallBack, SAMAccountName, ScriptPath, SmartCardRequired, State, StorePWUsingRevEncrypt, StreetAddress, Surname, TelephoneNumber, TerminalServerHomeDir, TerminalServerHomeDirDrive, TerminalServerProfilePath, Title, TSBrokenTimeoutSet, TSDeviceClientDefaultPrinter, TSDeviceClientDrives, TSDeviceClientPrinters, TSInheritInitialProgram, TSInitialProgram, TSReconnectSet, TSRemoteEnable, TSRemoteInteractWithSession, TSRemotePermissionRequired, TSRemoteViewSession, TSTimeoutSetConnections, TSTimeoutSetDisconnections, TSTimeoutSetIdle, TSWorkingDirectory, UID_ADSContainer, UseDES, UserCanNotChangePassword, UserMustChangePassword, UserPrincipalName, UID_ADSDomain, UID_ADSCountryCode, UID_ADSGroupPrimary, UserPassword, WWWHomePage, CanonicalName, UID_ADSAccount, XObjectKey
2021-01-06 15:55:26 GenericPool Getting item...
2021-01-06 15:55:26 GenericPool Got existing item: IAM-OIM-DB\OneIM
2021-01-06 15:55:26 SystemConnector Reloading objects.
2021-01-06 15:55:26 SystemConnector Reloading 1 objects of schema type ADSAccount.
2021-01-06 15:55:26 SystemConnector Reloading 1 objects of table ADSAccount.
2021-01-06 15:55:26 SystemConnector Otto Friedhelm (Loaded): UID_ADSAccount = '2d0903f9-f82f-445b-87d0-b1fffe38f8a2'
2021-01-06 15:55:26 ObjectLog ADSAccount: Getting collection, load type: Bulk
2021-01-06 15:55:26 SqlLog (1 ms) - select AccountDisabled, AccountExpires, AccountLockedOut, AccountSensitive, AccountTrustedForDelegation, AllowDialIn, AllowDialinByPolicy, AllowLogonTerminalServer, cn, Company, Department, Description, DisplayName, DistinguishedName, DoNotRequireKerberos, EmployeeID, EmployeeNumber, EmployeeType, Fax, GivenName, HomeDirectory, HomeDrive, HomePhone, Info, Initials, ipPhone, Locality, LogonHours, LogonWorkstation, Mail, Mobile, MSDsConsistencyGuid, MSNPCallingStationID, MSRADIUSCallBackNumber, MSRADIUSFramedIPAddress, MSRADIUSFramedRoute, MSRADIUSServiceType, ObjectClass, OtherFax, OtherHomePhone, OtherIPPhone, OtherMailBox, OtherMobile, OtherPager, OtherTelephoneNumber, OtherWWW, Pager, PasswordNeverExpires, PersonalTitle, PhysicalDeliveryOfficeName, PostalCode, PostOfficeBox, ProfilePath, RASAlwaysCallBack, RASCallerSetCallBack, RASNoCallBack, SAMAccountName, ScriptPath, SmartCardRequired, State, StorePWUsingRevEncrypt, StreetAddress, Surname, TelephoneNumber, TerminalServerHomeDir, TerminalServerHomeDirDrive, TerminalServerProfilePath, Title, TSBrokenTimeoutSet, TSDeviceClientDefaultPrinter, TSDeviceClientDrives, TSDeviceClientPrinters, TSInheritInitialProgram, TSInitialProgram, TSReconnectSet, TSRemoteEnable, TSRemoteInteractWithSession, TSRemotePermissionRequired, TSRemoteViewSession, TSTimeoutSetConnections, TSTimeoutSetDisconnections, TSTimeoutSetIdle, TSWorkingDirectory, UID_ADSContainer, UseDES, UserCanNotChangePassword, UserMustChangePassword, UserPrincipalName, UID_ADSDomain, UID_ADSCountryCode, UID_ADSGroupPrimary, UserPassword, WWWHomePage, CanonicalName, UID_ADSAccount, XObjectKey, edsvaDeprovisionDeletionDate, edsvaDeprovisionStatus, ExtensionAttribute1, ExtensionAttribute10, ExtensionAttribute11, ExtensionAttribute12, ExtensionAttribute13, ExtensionAttribute14, ExtensionAttribute15, ExtensionAttribute2, ExtensionAttribute3, ExtensionAttribute4, ExtensionAttribute5, ExtensionAttribute6, ExtensionAttribute7, ExtensionAttribute8, ExtensionAttribute9, ExtensionData, HomeDirPath, HomeShare, HomeSize, IdentityType, IsGroupAccount, IsPreferredAccount, IsPrivilegedAccount, LastLogon, MatchPatternForMembership, MaxStorage, ObjectGUID, ObjectKeyManager, ObjectSID, ProfileDirPath, ProfileShare, PSharedAs, PWDLastSet, RiskIndexCalculated, SharedAs, SIDHistory, StructuralObjectClass, TerminalHomeDirPath, TerminalHomeShare, TerminalProfileDirPath, TerminalProfileShare, TerminalServerRemoteHomeDir, TerminalSharedAs, UID_HomeServer, UID_Person, UID_ProfileServer, UID_TerminalHomeServer, UID_TerminalProfileServer, UID_TSBAccountDef, UID_TSBBehavior, XDateInserted, XDateSubItem, XDateUpdated, XMarkedForDeletion, XTouched, XUserInserted, XUserUpdated from ADSAccount where (UID_ADSAccount in ('2d0903f9-f82f-445b-87d0-b1fffe38f8a2')) order by cn
2021-01-06 15:55:26 ObjectLog Collection: Run statement and fetch data done in 1ms.
2021-01-06 15:55:26 ObjectLog Collection.Count: 1
2021-01-06 15:55:26 ObjectLog Getting collection done in 2ms.
2021-01-06 15:55:26 ObjectLog Old state: Loaded, New state: Loaded, PermissionBased
2021-01-06 15:55:26 SystemObjectData Creating SystemObjectData based on entity (Otto Friedhelm) columns (AccountDisabled, AccountExpires, AccountLockedOut, AccountSensitive, AccountTrustedForDelegation, AllowDialIn, AllowDialinByPolicy, AllowLogonTerminalServer, CanonicalName, cn, Company, Department, Description, DisplayName, DistinguishedName, DoNotRequireKerberos, EmployeeID, EmployeeNumber, EmployeeType, Fax, GivenName, HomeDirectory, HomeDrive, HomePhone, Info, Initials, ipPhone, Locality, LogonHours, LogonWorkstation, Mail, Mobile, MSDsConsistencyGuid, MSNPCallingStationID, MSRADIUSCallBackNumber, MSRADIUSFramedIPAddress, MSRADIUSFramedRoute, MSRADIUSServiceType, ObjectClass, OtherFax, OtherHomePhone, OtherIPPhone, OtherMailBox, OtherMobile, OtherPager, OtherTelephoneNumber, OtherWWW, Pager, PasswordNeverExpires, PersonalTitle, PhysicalDeliveryOfficeName, PostalCode, PostOfficeBox, ProfilePath, RASAlwaysCallBack, RASCallerSetCallBack, RASNoCallBack, SAMAccountName, ScriptPath, SmartCardRequired, State, StorePWUsingRevEncrypt, StreetAddress, Surname, TelephoneNumber, TerminalServerHomeDir, TerminalServerHomeDirDrive, TerminalServerProfilePath, Title, TSBrokenTimeoutSet, TSDeviceClientDefaultPrinter, TSDeviceClientDrives, TSDeviceClientPrinters, TSInheritInitialProgram, TSInitialProgram, TSReconnectSet, TSRemoteEnable, TSRemoteInteractWithSession, TSRemotePermissionRequired, TSRemoteViewSession, TSTimeoutSetConnections, TSTimeoutSetDisconnections, TSTimeoutSetIdle, TSWorkingDirectory, UID_ADSAccount, UID_ADSContainer, UID_ADSCountryCode, UID_ADSDomain, UID_ADSGroupPrimary, UseDES, UserCanNotChangePassword, UserMustChangePassword, UserPassword, UserPrincipalName, WWWHomePage, XObjectKey).
2021-01-06 15:55:26 GenericPool Release item: IAM-OIM-DB\OneIM
2021-01-06 15:55:26 StopWatch Reloading 1 objects. done in 5ms.
2021-01-06 15:55:26 SystemConnection ProcessContext has changed from (72db1669-5e54-4516-84dd-ed64b4bf5f41) to (<null>).
2021-01-06 15:55:26 SystemConnection ProcessContext has changed from (72db1669-5e54-4516-84dd-ed64b4bf5f41) to (<null>).
2021-01-06 15:55:26 SystemScope Invalidating scope of Active Directory user accounts (ADSAccount)...
2021-01-06 15:55:26 SystemScope Invalidating scope of Active Directory user accounts (ADSAccount)...
2021-01-06 15:55:26 SystemConnection Leaving update phase.
2021-01-06 15:55:26 SystemConnection Leaving update phase.
2021-01-06 15:55:26 SystemConnector Leaving update phase.
2021-01-06 15:55:26 StopWatch Executing step (user)... done in 17,44s.
2021-01-06 15:55:26 StopWatch Time consumption for (SQL): 63ms (0,36%)
2021-01-06 15:55:26 StopWatch Time consumption for (Cache): 0ms (0,00%)
2021-01-06 15:55:26 StopWatch Time consumption for (Session): 0ms (0,00%)
2021-01-06 15:55:26 StopWatch Time consumption for (Entities): 96ms (0,55%)
2021-01-06 15:55:26 StopWatch Time consumption for (XmlProjectorReader): 0ms (0,00%)
2021-01-06 15:55:26 StopWatch Time consumption for (DatabaseReader): 0ms (0,00%)
2021-01-06 15:55:26 StopWatch Time consumption for (ProjectorEngine): 5ms (0,03%)
2021-01-06 15:55:26 StopWatch Time consumption for (One Identity Manager (IAM-OIM-DB\OneIM)): 555ms (3,18%)
2021-01-06 15:55:26 StopWatch Time consumption for (Active Directory Service (Root-DN dc=iamdemo,dc=local, Server iamdemo-dc.iamdemo.local)): 16,50s (94,61%)
2021-01-06 15:55:26 StopWatch Time consumption for the rest: 221ms (1,27%). (This result might be affected by multithreading!)
2021-01-06 15:55:26 ProjectorEngine Performing finalization tasks.
2021-01-06 15:55:26 SystemConnection Leaving simulation mode.
2021-01-06 15:55:26 ProjectorEngine Unregister journal recorder.
2021-01-06 15:55:26 ProjectorEngine Reset variable set.
2021-01-06 15:55:26 SystemConnection Disconnecting connection One Identity Manager (IAM-OIM-DB\OneIM)...
2021-01-06 15:55:26 SystemScope Invalidating the entire scope (Scope). Force = True
2021-01-06 15:55:26 SystemScope Invalidating the entire scope (Reference Scope). Force = True
2021-01-06 15:55:26 SystemConnector Disconnecting target system.
2021-01-06 15:55:26 ObjectLog Closing session
2021-01-06 15:55:26 SqlLog Closing database session.
2021-01-06 15:55:26 ObjectLog Closing session
2021-01-06 15:55:26 SqlLog Closing database session.
2021-01-06 15:55:26 SystemConnector Disconnecting target system.
2021-01-06 15:55:26 ObjectLog Closing session
2021-01-06 15:55:26 SqlLog Closing database session.
2021-01-06 15:55:26 SystemConnector Disconnecting target system.
2021-01-06 15:55:26 ObjectLog Closing session
2021-01-06 15:55:26 SqlLog Closing database session.
2021-01-06 15:55:26 SystemConnector Disconnecting target system.
2021-01-06 15:55:26 ObjectLog Closing session
2021-01-06 15:55:26 SqlLog Closing database session.
2021-01-06 15:55:26 SqlLog Closing database session.
2021-01-06 15:55:26 SystemConnection Connection disconnected successfully (One Identity Manager (IAM-OIM-DB\OneIM)).
2021-01-06 15:55:26 SystemConnection Leaving simulation mode.
2021-01-06 15:55:26 ProjectorEngine Unregister journal recorder.
2021-01-06 15:55:26 ProjectorEngine Reset variable set.
2021-01-06 15:55:26 SystemConnection Disconnecting connection Active Directory Service (Root-DN dc=iamdemo,dc=local, Server iamdemo-dc.iamdemo.local)...
2021-01-06 15:55:26 SystemConnector Disconnecting target system.
2021-01-06 15:55:26 SystemConnection Connection disconnected successfully (Active Directory Service (Root-DN dc=iamdemo,dc=local, Server iamdemo-dc.iamdemo.local)).
2021-01-06 15:55:26 ProjectorEngine Flushing journal...
2021-01-06 15:55:26 ProjectorEngine Disposing process context.
2021-01-06 15:55:26 ProjectorEngine ProcessContext has changed from (c7813287-0cd2-423a-a311-f3a2a3adf77c) to (<null>).
2021-01-06 15:55:26 SystemConnector Resolving instance of type VI.Projector.Connection.Optimization.ISystemAccessOptimizer.
2021-01-06 15:55:26 SystemConnector Instance <null> resolved.
2021-01-06 15:55:26 SystemConnector Resolving instance of type VI.Projector.Connection.Optimization.ISystemAccessOptimizer.
2021-01-06 15:55:26 SystemConnector Instance Root-DN dc=iamdemo,dc=local, Server iamdemo-dc.iamdemo.local resolved.
2021-01-06 15:55:26 StopWatch Führe Synchronisationskonfiguration (Provisioning) aus.... done in 46,38s.
2021-01-06 15:55:26 StopWatch Time consumption for (SQL): 252ms (0,54%)
2021-01-06 15:55:26 StopWatch Time consumption for (Cache): 1ms (0,00%)
2021-01-06 15:55:26 StopWatch Time consumption for (Session): 27ms (0,06%)
2021-01-06 15:55:26 StopWatch Time consumption for (Entities): 344ms (0,74%)
2021-01-06 15:55:26 StopWatch Time consumption for (XmlProjectorReader): 0ms (0,00%)
2021-01-06 15:55:26 StopWatch Time consumption for (DatabaseReader): 0ms (0,00%)
2021-01-06 15:55:26 StopWatch Time consumption for (ProjectorEngine): 21ms (0,05%)
2021-01-06 15:55:26 StopWatch Time consumption for (One Identity Manager (IAM-OIM-DB\OneIM)): 909ms (1,96%)
2021-01-06 15:55:26 StopWatch Time consumption for (Active Directory Service (Root-DN dc=iamdemo,dc=local, Server iamdemo-dc.iamdemo.local)): 23,45s (50,56%)
2021-01-06 15:55:26 StopWatch Time consumption for the rest: 21,38s (46,09%). (This result might be affected by multithreading!)
2021-01-06 15:55:26 ProjectorEngine Der Synchronisationsschritt (user) aus der Synchronisationskonfiguration (Provisioning (Provisioning)) konnte nicht fehlerfrei ausgeführt werden.
2021-01-06 15:55:26 VI.FormBase.ExceptionMgr One or more errors occurred.

Any hints?

Thanks

Dirk

Parents Reply Children
No Data