M-HybridSync master (8fd4444e4) [20:41:21.581] [ 1] [INFO ] machine.config path: C:\Windows\Microsoft.NET\Framework64\v4.0.30319\Config\machine.config. [20:41:21.581] [ 1] [INFO ] Default Proxy [ProxyAddress]: [20:41:21.596] [ 1] [INFO ] Default Proxy [UseSystemDefault]: Unspecified [20:41:21.596] [ 1] [INFO ] Default Proxy [BypassOnLocal]: Unspecified [20:41:21.596] [ 1] [INFO ] Default Proxy [Enabled]: True [20:41:21.596] [ 1] [INFO ] Default Proxy [AutoDetect]: Unspecified [20:41:21.596] [ 1] [INFO ] Default Proxy [UseDefaultCredentials]: False [20:41:21.643] [ 1] [VERB ] Scheduler wizard mutex wait timeout: 00:00:05 [20:41:21.643] [ 1] [INFO ] AADConnect changes ALLOWED: Successfully acquired the configuration change mutex. [20:41:21.721] [ 1] [INFO ] RootPageViewModel.GetInitialPages: Beginning detection for creating initial pages. [20:41:21.752] [ 1] [INFO ] Loading the persisted settings . [20:41:21.784] [ 1] [INFO ] Checking if machine version is 6.1.7601 or higher [20:41:21.846] [ 1] [INFO ] The current operating system version is 6.1.7601, the requirement is 6.1.7601. [20:41:21.846] [ 1] [INFO ] Password Hash Sync supported: 'True' [20:41:21.908] [ 1] [INFO ] DetectInstalledComponents stage: The installed OS SKU is 9 [20:41:21.924] [ 1] [INFO ] DetectInstalledComponents stage: Checking install context. [20:41:21.940] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Microsoft Visual C++ 2013 Redistributable Package [20:41:21.940] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:21.955] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {20400cf0-de7c-327e-9ae4-f0f38d9085f8}: verified product code {a749d8e6-b613-3be3-8f5f-045c84eba29b}. [20:41:21.955] [ 1] [VERB ] Package=Microsoft Visual C++ 2013 x64 Minimum Runtime - 12.0.21005, Version=12.0.21005, ProductCode=a749d8e6-b613-3be3-8f5f-045c84eba29b, UpgradeCode=20400cf0-de7c-327e-9ae4-f0f38d9085f8 [20:41:21.955] [ 1] [INFO ] Determining installation action for Microsoft Visual C++ 2013 Redistributable Package (20400cf0-de7c-327e-9ae4-f0f38d9085f8) [20:41:21.955] [ 1] [INFO ] Product Microsoft Visual C++ 2013 Redistributable Package (version 12.0.21005) is installed. [20:41:21.955] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Microsoft Directory Sync Tool [20:41:21.971] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:21.971] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {bef7e7d9-2ac2-44b9-abfc-3335222b92a7}: no registered products found. [20:41:21.971] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {dc9e604e-37b0-4efc-b429-21721cf49d0d}: no registered products found. [20:41:21.971] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {545334d7-13cd-4bab-8da1-2775fa8cf7c2}: no registered products found. [20:41:21.971] [ 1] [INFO ] Determining installation action for Microsoft Directory Sync Tool UpgradeCodes {bef7e7d9-2ac2-44b9-abfc-3335222b92a7}, {dc9e604e-37b0-4efc-b429-21721cf49d0d} [20:41:21.971] [ 1] [INFO ] DirectorySyncComponent: Product Microsoft Directory Sync Tool is not installed. [20:41:21.971] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Azure AD Sync Engine [20:41:21.971] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:21.971] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {545334d7-13cd-4bab-8da1-2775fa8cf7c2}: no registered products found. [20:41:21.971] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {dc9e604e-37b0-4efc-b429-21721cf49d0d}: no registered products found. [20:41:21.971] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {bef7e7d9-2ac2-44b9-abfc-3335222b92a7}: no registered products found. [20:41:21.986] [ 1] [INFO ] Determining installation action for Azure AD Sync Engine (545334d7-13cd-4bab-8da1-2775fa8cf7c2) [20:41:22.439] [ 1] [INFO ] Product Azure AD Sync Engine is not installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Azure AD Connect Synchronization Agent [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {3cd653e3-5195-4ff2-9d6c-db3dacc82c25}: no registered products found. [20:41:22.439] [ 1] [INFO ] Determining installation action for Azure AD Connect Synchronization Agent (3cd653e3-5195-4ff2-9d6c- db3dacc82c25) [20:41:22.439] [ 1] [INFO ] Product Azure AD Connect Synchronization Agent is not installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Azure AD Connect Health agent for sync [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {114fb294-8aa6-43db-9e5c-4ede5e32886f}: no registered products found. [20:41:22.439] [ 1] [INFO ] Determining installation action for Azure AD Connect Health agent for sync (114fb294-8aa6-43db-9e5c-4ede5e32886f) [20:41:22.439] [ 1] [INFO ] Product Azure AD Connect Health agent for sync is not installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Microsoft Azure AD Connect Authentication Agent [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {0c06f9df-c56b-42c4-a41b-f5f64d01a35c}: no registered products found. [20:41:22.439] [ 1] [INFO ] Determining installation action for Microsoft Azure AD Connect Authentication Agent (0c06f9df-c56b-42c4-a41b-f5f64d01a35c) [20:41:22.439] [ 1] [INFO ] Product Microsoft Azure AD Connect Authentication Agent is not installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Azure AD Connect Administration Agent [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {886051ec-1165-4df8-a492-19d1e0ff57ee}: no registered products found. [20:41:22.439] [ 1] [INFO ] Determining installation action for Azure AD Connect Administration Agent (886051ec-1165-4df8-a492- 19d1e0ff57ee) [20:41:22.439] [ 1] [INFO ] Product Azure AD Connect Administration Agent is not installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Microsoft SQL Server 2012 Command Line Utilities [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {52446750-c08e-49ef-8c2e-1e0662791e7b}: verified product code {89ca7913-f891-4546-8f55-355338677fe6}. [20:41:22.439] [ 1] [VERB ] Package=Microsoft SQL Server 2012 Command Line Utilities , Version=11.4.7001.0, ProductCode=89ca7913-f891-4546-8f55-355338677fe6, UpgradeCode=52446750-c08e-49ef-8c2e-1e0662791e7b [20:41:22.439] [ 1] [INFO ] Determining installation action for Microsoft SQL Server 2012 Command Line Utilities (52446750-c08e-49ef-8c2e-1e0662791e7b) [20:41:22.439] [ 1] [INFO ] Product Microsoft SQL Server 2012 Command Line Utilities (version 11.4.7001.0) is installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Microsoft SQL Server 2012 Express LocalDB [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {c3593f78-0f11-4d8d-8d82-55460308e261}: verified product code {72b030ed-b1e3-45e5-ba33-a1f5625f2b93}. [20:41:22.439] [ 1] [VERB ] Package=Microsoft SQL Server 2012 Express LocalDB , Version=11.4.7469.6, ProductCode=72b030ed-b1e3-45e5-ba33-a1f5625f2b93, UpgradeCode=c3593f78-0f11-4d8d-8d82-55460308e261 [20:41:22.439] [ 1] [INFO ] Determining installation action for Microsoft SQL Server 2012 Express LocalDB (c3593f78-0f11-4d8d-8d82-55460308e261) [20:41:22.439] [ 1] [INFO ] Product Microsoft SQL Server 2012 Express LocalDB (version 11.4.7469.6) is installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Microsoft SQL Server 2012 Native Client [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {1d2d1fa0-e158-4798-98c6-a296f55414f9}: verified product code {b9274744-8bae-4874-8e59-2610919cd419}. [20:41:22.439] [ 1] [VERB ] Package=Microsoft SQL Server 2012 Native Client , Version=11.4.7001.0, ProductCode=b9274744-8bae-4874-8e59-2610919cd419, UpgradeCode=1d2d1fa0-e158-4798-98c6-a296f55414f9 [20:41:22.439] [ 1] [INFO ] Determining installation action for Microsoft SQL Server 2012 Native Client (1d2d1fa0-e158-4798-98c6-a296f55414f9) [20:41:22.439] [ 1] [INFO ] Product Microsoft SQL Server 2012 Native Client (version 11.4.7001.0) is installed. [20:41:22.439] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Microsoft Azure AD Connect Authentication Agent [20:41:22.439] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.439] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {fb3feca7-5190-43e7-8d4b-5eec88ed9455}: no registered products found. [20:41:22.439] [ 1] [INFO ] Determining installation action for Microsoft Azure AD Connect Authentication Agent (fb3feca7-5190-43e7- 8d4b-5eec88ed9455) [20:41:22.439] [ 1] [INFO ] Product Microsoft Azure AD Connect Authentication Agent is not installed. [20:41:22.439] [ 1] [INFO ] Determining installation action for Microsoft Azure AD Connection Tool. [20:41:22.579] [ 1] [WARN ] Failed to read DisplayName registry key: An error occurred while executing the 'Get-ItemProperty' command. Cannot find path 'HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\Windows\CurrentVersion\Uninstall\MicrosoftAzureADConnectionTool' because it does not exist. [20:41:22.579] [ 1] [INFO ] Product Microsoft Azure AD Connection Tool is not installed. [20:41:22.579] [ 1] [INFO ] Performing direct lookup of upgrade codes for: Azure Active Directory Connect [20:41:22.579] [ 1] [VERB ] Getting list of installed packages by upgrade code [20:41:22.579] [ 1] [INFO ] GetInstalledPackagesByUpgradeCode {d61eb959-f2d1-4170-be64-4dc367f451ea}: verified product code {2c4c8839-89ed-40eb-b59a-614824f8d5ac}. [20:41:22.579] [ 1] [VERB ] Package=Microsoft Azure AD Connect, Version=1.4.38.0, ProductCode=2c4c8839-89ed-40eb-b59a-614824f8d5ac, UpgradeCode=d61eb959-f2d1-4170-be64-4dc367f451ea [20:41:22.579] [ 1] [INFO ] Determining installation action for Azure Active Directory Connect (d61eb959-f2d1-4170-be64-4dc367f451ea) [20:41:22.579] [ 1] [INFO ] Product Azure Active Directory Connect (version 1.4.38.0) is installed. [20:41:23.141] [ 1] [INFO ] ServiceControllerProvider: GetServiceStartMode(seclogon) is 'Manual'. [20:41:23.141] [ 1] [INFO ] ServiceControllerProvider: verifying EventLog is in state (Running) [20:41:23.141] [ 1] [INFO ] ServiceControllerProvider: current service status: Running [20:41:23.141] [ 1] [INFO ] Checking for DirSync conditions. [20:41:23.141] [ 1] [INFO ] DirSync not detected. Checking for AADSync/AADConnect upgrade conditions. [20:41:23.141] [ 1] [INFO ] Sync engine is not present. Performing clean install. [20:41:23.359] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Start background task Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.ExpressSettingsPageViewModel.GatherEnvironmentData in Page:"Express Settings" [20:41:23.359] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Started Background Task Id:1 [20:41:23.406] [ 13] [INFO ] Checking if machine version is 6.1.7601 or higher [20:41:23.422] [ 13] [INFO ] The current operating system version is 6.1.7601, the requirement is 6.1.7601. [20:41:23.422] [ 13] [INFO ] Password Hash Sync supported: 'True' [20:41:23.827] [ 1] [INFO ] Express Settings install is supported: domain-joined + OS version allowed. [20:41:32.332] [ 1] [INFO ] Express Settings: Updating page flow for CUSTOM installation. [20:41:32.334] [ 1] [INFO ] Called SetWizardMode(CustomInstall, True) [20:41:32.337] [ 1] [WARN ] MicrosoftOnlinePersistedStateProvider.Save: zero state elements provided, saving an empty persisted state file [20:41:32.338] [ 1] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: False [20:41:32.347] [ 1] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: True [20:41:32.362] [ 1] [INFO ] Page transition from "Express Settings" [ExpressSettingsPageViewModel] to "Required Components" [InstallSyncEnginePageViewModel] [20:41:36.962] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Start background task Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.InstallSyncEnginePageViewModel.StartNewInstallation in Page:"Install required components" [20:41:36.962] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Started Background Task Id:1660 [20:41:37.211] [ 9] [INFO ] SyncEngineSetupViewModel: Validating sync engine settings. [20:41:37.227] [ 9] [INFO ] Enter ValidateSqlVersion. [20:41:37.227] [ 9] [INFO ] Exit ValidateSqlVersion (localdb). [20:41:37.227] [ 9] [INFO ] Enter ValidateSqlAoaAsyncInstance. [20:41:37.227] [ 9] [INFO ] Exit ValidateSqlAoaAsyncInstance (localdb). [20:41:37.243] [ 9] [INFO ] The ADSync database does not exist and will be created. serverAdmin=True. [20:41:37.243] [ 9] [INFO ] Attaching to the ADSync database: SQLServerName= SQLInstanceName= ServiceAccountName=, state=DoesNotExist, Collation=, /UseExistingDatabase=False. [20:41:37.243] [ 9] [INFO ] Starting Sync Engine installation [20:41:37.243] [ 9] [INFO ] Starting Prerequisite installation [20:41:37.243] [ 9] [VERB ] WorkflowEngine created [20:41:37.243] [ 9] [INFO ] Performing direct lookup of upgrade codes for: Microsoft Visual C++ 2013 Redistributable Package [20:41:37.243] [ 9] [VERB ] Getting list of installed packages by upgrade code [20:41:37.243] [ 9] [INFO ] GetInstalledPackagesByUpgradeCode {20400cf0-de7c-327e-9ae4-f0f38d9085f8}: verified product code {a749d8e6-b613-3be3-8f5f-045c84eba29b}. [20:41:37.243] [ 9] [VERB ] Package=Microsoft Visual C++ 2013 x64 Minimum Runtime - 12.0.21005, Version=12.0.21005, ProductCode=a749d8e6-b613-3be3-8f5f-045c84eba29b, UpgradeCode=20400cf0-de7c-327e-9ae4-f0f38d9085f8 [20:41:37.243] [ 9] [INFO ] Determining installation action for Microsoft Visual C++ 2013 Redistributable Package (20400cf0-de7c-327e-9ae4-f0f38d9085f8) [20:41:37.243] [ 9] [INFO ] Product Microsoft Visual C++ 2013 Redistributable Package (version 12.0.21005) is installed. [20:41:37.243] [ 9] [INFO ] Starting Sync Engine installation [20:41:43.904] [ 9] [INFO ] ServiceControllerProvider: InvalidOperationException on serviceController.Status property means the service ADSync was not found [20:41:44.107] [ 9] [INFO ] ServiceControllerProvider:CreateService - serviceName:ADSync, username:ABC\AAD_08472823a2f0, assemblyPath:C:\Program Files\Microsoft Azure Active Directory Connect\ADSyncBootstrap.exe [20:41:48.475] [ 9] [INFO ] ServiceControllerProvider: Processing StartService request for: ADSync [20:41:48.475] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:41:48.475] [ 9] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:42:09.894] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (1). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:42:09.909] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:42:09.909] [ 9] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:43:45.679] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (2). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:43:45.679] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:43:45.679] [ 9] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:45:21.667] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (3). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:45:21.667] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:45:21.667] [ 9] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:45:42.790] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (4). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:45:42.790] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:45:42.790] [ 9] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:46:04.521] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (5). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:46:04.521] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:46:04.521] [ 9] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:47:37.364] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (6). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:47:37.364] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:47:37.364] [ 9] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:47:58.502] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (7). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:47:58.502] [ 9] [ERROR] ServiceControllerProvider: StartService unable to start service (ADSync). The system event log may contain more details for this issue. [20:47:58.533] [ 9] [INFO ] GetEvents: Get-WinEvent -FilterHashTable @{ StartTime='03/06/2020 20:41:47';LogName='System';Data='ADSync';Level='2'; } [20:48:00.124] [ 9] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:48:00.124] [ 9] [INFO ] GetEvents: found 0 total System event log records on attempt 1 [20:48:01.497] [ 9] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:48:01.497] [ 9] [INFO ] GetEvents: found 0 total System event log records on attempt 2 [20:48:02.823] [ 9] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:48:02.823] [ 9] [INFO ] GetEvents: found 0 total System event log records on attempt 3 [20:48:04.180] [ 9] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:48:04.180] [ 9] [INFO ] GetEvents: found 0 total System event log records on attempt 4 [20:48:05.537] [ 9] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:48:05.537] [ 9] [INFO ] GetEvents: found 0 total System event log records on attempt 5 [20:48:05.537] [ 9] [INFO ] ServiceControllerProvider: service ADSync exists [20:48:05.537] [ 9] [INFO ] ServiceControllerProvider: processing StopService request for: ADSync [20:48:05.537] [ 9] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:48:05.537] [ 9] [INFO ] ServiceControllerProvider: StopService status: Stopped [20:48:05.553] [ 9] [INFO ] ServiceControllerProvider:DeleteService - serviceName:ADSync [20:48:15.911] [ 9] [INFO ] ServiceControllerProvider: InvalidOperationException on serviceController.Status property means the service ADSync was not found [20:48:15.911] [ 9] [INFO ] ServiceControllerProvider:DeleteService successful - serviceName:ADSync [20:48:20.591] [ 9] [INFO ] ServiceControllerProvider: processing StopService request for: ADSync [20:48:20.591] [ 9] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (1). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:48:20.591] [ 9] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (2). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:48:20.591] [ 9] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (3). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (4). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (5). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (6). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (7). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:48:20.607] [ 9] [ERROR] ServiceControllerProvider: StopService unable to stop service (ADSync). The system event log may contain more details for this issue. [20:48:20.607] [ 9] [INFO ] ServiceControllerProvider: Processing StartService request for: ADSync [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (1). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (2). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (3). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (4). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (5). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (6). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:48:20.607] [ 9] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (7). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:48:20.607] [ 9] [ERROR] ServiceControllerProvider: StartService unable to start service (ADSync). The system event log may contain more details for this issue. [20:48:20.654] [ 9] [ERROR] InstallSyncEnginePageViewModel: Error occurred while installing sync engine. Exception Data (Raw): System.Exception: Unable to install the Synchronization Service. The ADSync service failed to start with an unexpected error for AutoGeneratedAccount: ABC\AAD_08472823a2f0. Please see the Application and System event logs for additional details. ---> System.InvalidOperationException: The ADSync service failed to start with an unexpected error for AutoGeneratedAccount: ABC\AAD_08472823a2f0. at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SynchronizationServiceSetupTask.StartBootstrapService(SyncServiceAccount syncServiceAccount) at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SynchronizationServiceSetupTask.InstallCore(String logFilePath, String logFileSuffix) at Microsoft.Azure.ActiveDirectory.Synchronization.Framework.ActionExecutor.ExecuteWithSetupResultsStatus(SetupAction action, String description, String logFileName, String logFileSuffix) at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SetupBase.Install() --- End of inner exception stack trace --- at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SetupBase.ThrowSetupTaskFailureException(String exceptionFormatString, String taskName, Exception innerException) at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SetupBase.Install() at Microsoft.Online.Deployment.OneADWizard.Runtime.Stages.InstallSyncEngineStage.ExecuteInstallCore(ISyncEngineInstallContext syncEngineInstallContext, ProgressChangedEventHandler progressChangesEventHandler) at Microsoft.Online.Deployment.OneADWizard.Runtime.Stages.InstallSyncEngineStage.ExecuteInstall(ISyncEngineInstallContext syncEngineInstallContext, ProgressChangedEventHandler progressChangesEventHandler) at Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.InstallSyncEnginePageViewModel.StartNewInstallation(Boolean skipSyncEngineInstall) [20:51:21.709] [ 1] [INFO ] Page transition from "Required Components" [InstallSyncEnginePageViewModel] to "Express Settings" [ExpressSettingsPageViewModel] [20:51:27.834] [ 1] [INFO ] Express Settings: Updating page flow for EXPRESS mode install. [20:51:27.834] [ 1] [INFO ] Called SetWizardMode(ExpressInstall, True) [20:51:27.834] [ 1] [WARN ] MicrosoftOnlinePersistedStateProvider.Save: zero state elements provided, saving an empty persisted state file [20:51:27.834] [ 1] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: False [20:51:27.837] [ 1] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: True [20:51:27.882] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Start background task Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.ExpressSettingsPageViewModel.StartPrerequisiteInstallation in Page:"Express Settings" [20:51:27.883] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Started Background Task Id:3392 [20:51:27.916] [ 11] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Start background task Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.InstallSyncEnginePageViewModel.StartNewInstallation in Page:"Install required components" [20:51:27.917] [ 11] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Started Background Task Id:3405 [20:51:27.917] [ 17] [INFO ] SyncEngineSetupViewModel: Validating sync engine settings. [20:51:27.917] [ 17] [INFO ] Enter ValidateSqlVersion. [20:51:27.917] [ 17] [INFO ] Exit ValidateSqlVersion (localdb). [20:51:27.917] [ 17] [INFO ] Enter ValidateSqlAoaAsyncInstance. [20:51:27.917] [ 17] [INFO ] Exit ValidateSqlAoaAsyncInstance (localdb). [20:51:27.918] [ 17] [INFO ] The ADSync database does not exist and will be created. serverAdmin=True. [20:51:27.918] [ 17] [INFO ] Attaching to the ADSync database: SQLServerName= SQLInstanceName= ServiceAccountName=, state=DoesNotExist, Collation=, /UseExistingDatabase=False. [20:51:27.918] [ 17] [INFO ] Starting Sync Engine installation [20:51:27.918] [ 17] [INFO ] Starting Prerequisite installation [20:51:27.918] [ 17] [VERB ] WorkflowEngine created [20:51:27.919] [ 17] [INFO ] Performing direct lookup of upgrade codes for: Microsoft Visual C++ 2013 Redistributable Package [20:51:27.919] [ 17] [VERB ] Getting list of installed packages by upgrade code [20:51:27.919] [ 17] [INFO ] GetInstalledPackagesByUpgradeCode {20400cf0-de7c-327e-9ae4-f0f38d9085f8}: verified product code {a749d8e6-b613-3be3-8f5f-045c84eba29b}. [20:51:27.919] [ 17] [VERB ] Package=Microsoft Visual C++ 2013 x64 Minimum Runtime - 12.0.21005, Version=12.0.21005, ProductCode=a749d8e6-b613-3be3-8f5f-045c84eba29b, UpgradeCode=20400cf0-de7c-327e-9ae4-f0f38d9085f8 [20:51:27.919] [ 17] [INFO ] Determining installation action for Microsoft Visual C++ 2013 Redistributable Package (20400cf0-de7c-327e-9ae4-f0f38d9085f8) [20:51:27.920] [ 17] [INFO ] Product Microsoft Visual C++ 2013 Redistributable Package (version 12.0.21005) is installed. [20:51:27.922] [ 1] [INFO ] Page transition from "Express Settings" [ExpressSettingsPageViewModel] to "Connect to Azure AD" [AzureTenantPageViewModel] [20:51:27.928] [ 1] [INFO ] Property Username failed validation with error The Microsoft Azure account name cannot be empty. [20:51:33.259] [ 1] [INFO ] Property Username failed validation with error Username must be in the format name@domain.com or name@domain.onmicrosoft.com [20:51:39.503] [ 1] [INFO ] Property Password failed validation with error A valid domain must be selected. [20:51:44.631] [ 1] [INFO ] Property Username failed validation with error Username must be in the format name@domain.com or name@domain.onmicrosoft.com [20:51:51.318] [ 13] [INFO ] AzureTenantPage: Beginning Windows Azure tenant credential validation for user - admin@abc.onmicrosoft.com [20:51:51.349] [ 13] [INFO ] AzureConfigurationFromPrincipalName: Successfully resolved UPN (admin@abc.onmicrosoft.com) to the Worldwide Azure instance. Resolution Method [Registry Configuration]: Worldwide. [20:51:51.380] [ 13] [INFO ] ResolveAzureInstance [Worldwide]: authority=HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM, Resolution Method [Registry Configuration]: Worldwide. [20:51:51.396] [ 13] [INFO ] Authenticate-ADAL [Acquiring token]: STS endpoint (HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM), resource (https://graph.windows.net), userName (admin@abc.onmicrosoft.com). [20:51:51.505] [ 13] [INFO ] ADAL: 2020-03-06T09:51:51.5052584Z: 00000000-0000-0000-0000-000000000000 - AdalLoggerBase.cs: Clearing Cache :- 0 items to be removed [20:51:51.505] [ 13] [INFO ] ADAL: 2020-03-06T09:51:51.5052584Z: 00000000-0000-0000-0000-000000000000 - AdalLoggerBase.cs: Successfully Cleared Cache [20:51:51.536] [ 13] [INFO ] ADAL: 2020-03-06T09:51:51.5364586Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: ADAL PCL.Desktop with assembly version '5.2.2.0', file version '5.2.2.0' and informational version '5.2.2' is running... [20:51:51.536] [ 13] [INFO ] ADAL: 2020-03-06T09:51:51.5364586Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: === Token Acquisition started: CacheType: Microsoft.IdentityModel.Clients.ActiveDirectory.TokenCache (0 items) Authentication Target: User , Authority Host: login.windows.net [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: No matching token was found in the cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: Checking MSAL cache for user token cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: A match was found in the MSAL cache ? False [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: No matching token was found in the cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: Checking MSAL cache for user token cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: A match was found in the MSAL cache ? False [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: No matching token was found in the cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: Checking MSAL cache for user token cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: A match was found in the MSAL cache ? False [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: No matching token was found in the cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: Checking MSAL cache for user token cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: A match was found in the MSAL cache ? False [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: No matching token was found in the cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: Checking MSAL cache for user token cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: A match was found in the MSAL cache ? False [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: No matching token was found in the cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: Checking MSAL cache for user token cache [20:52:03.330] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3301342Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: A match was found in the MSAL cache ? False [20:52:03.345] [ 20] [INFO ] ADAL: 2020-03-06T09:52:03.3457343Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: Sending request to userrealm endpoint. [20:52:04.000] [ 19] [INFO ] ADAL: 2020-03-06T09:52:04.0009385Z: 978e9892-b641-4208-9b7f-156fe4609475 - AdalLoggerBase.cs: === Token Acquisition finished successfully. An access token was returned: Expiration Time: 6/03/2020 10:52:02 AM +00:00 [20:52:04.000] [ 13] [INFO ] Authenticate-ADAL: successfully acquired an access token. TenantId=f1407550-fc7d-422c-aa0d-95db9688158a, ExpiresUTC=6/03/2020 10:52:02 AM +00:00, UserInfo=admin@abc.onmicrosoft.com, IdentityProvider=https://sts.windows.net/f1407550-fc7d-422c-aa0d-95db9688158a/. [20:52:04.078] [ 13] [INFO ] DiscoverServiceEndpoint [AdminWebService]: ServiceEndpoint=https://adminwebservice.microsoftonline.com/provisioningservice.svc, AdalAuthority=HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM, AdalResource=https://graph.windows.net. [20:52:04.078] [ 13] [INFO ] AzureTenantPage: attempting to connect to Azure via AAD PowerShell. [20:52:04.078] [ 13] [INFO ] DiscoverServiceEndpoint [AzurePowerShell]: ServiceEndpoint=https://provisioningapi.microsoftonline.com/provisioningwebservice.svc, AdalAuthority=HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM, AdalResource=https://graph.windows.net. [20:52:04.078] [ 13] [INFO ] AcquireServiceToken [AzurePowerShell]: acquiring service token. [20:52:04.078] [ 13] [INFO ] Authenticate-ADAL [Acquiring token]: STS endpoint (HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM), resource (https://graph.windows.net), userName (admin@ABC.onmicrosoft.com). [20:52:04.078] [ 13] [INFO ] ADAL: 2020-03-06T09:52:04.0789390Z: afc74088-dd9e-4a6e-98b2-3d4f35dcbfc4 - AdalLoggerBase.cs: ADAL PCL.Desktop with assembly version '5.2.2.0', file version '5.2.2.0' and informational version '5.2.2' is running... [20:52:04.078] [ 13] [INFO ] ADAL: 2020-03-06T09:52:04.0789390Z: afc74088-dd9e-4a6e-98b2-3d4f35dcbfc4 - AdalLoggerBase.cs: === Token Acquisition started: CacheType: Microsoft.IdentityModel.Clients.ActiveDirectory.TokenCache (1 items) Authentication Target: User , Authority Host: login.windows.net [20:52:04.078] [ 13] [INFO ] ADAL: 2020-03-06T09:52:04.0789390Z: afc74088-dd9e-4a6e-98b2-3d4f35dcbfc4 - AdalLoggerBase.cs: An item matching the requested resource was found in the cache [20:52:04.078] [ 13] [INFO ] ADAL: 2020-03-06T09:52:04.0789390Z: afc74088-dd9e-4a6e-98b2-3d4f35dcbfc4 - AdalLoggerBase.cs: 59.9809933183333 minutes left until token in cache expires [20:52:04.078] [ 13] [INFO ] ADAL: 2020-03-06T09:52:04.0789390Z: afc74088-dd9e-4a6e-98b2-3d4f35dcbfc4 - AdalLoggerBase.cs: A matching item (access token or refresh token or both) was found in the cache [20:52:04.078] [ 13] [INFO ] ADAL: 2020-03-06T09:52:04.0789390Z: afc74088-dd9e-4a6e-98b2-3d4f35dcbfc4 - AdalLoggerBase.cs: === Token Acquisition finished successfully. An access token was returned: Expiration Time: 6/03/2020 10:52:02 AM +00:00 [20:52:04.078] [ 13] [INFO ] Authenticate-ADAL: successfully acquired an access token. TenantId=f1407550-fc7d-422c-aa0d-95db9688158a, ExpiresUTC=6/03/2020 10:52:02 AM +00:00, UserInfo=admin@ABC.onmicrosoft.com, IdentityProvider=https://sts.windows.net/f1407550-fc7d-422c-aa0d-95db9688158a/. [20:52:04.078] [ 13] [INFO ] PowerShellHelper.ConnectMsolService: Connecting using an AccessToken. AzureEnvironment=0. [20:52:04.921] [ 13] [WARN ] Failed to import module MSOnline for PowerShell Command Connect-MsolService [20:52:06.153] [ 13] [INFO ] AzureTenantPage: successfully connected to Azure via AAD PowerShell. [20:52:07.167] [ 13] [WARN ] Failed to import module MSOnline for PowerShell Command Get-MsolCompanyInformation [20:52:07.729] [ 13] [INFO ] AzureTenantPage: Successfully retrieved company information for tenant f1407550-fc7d-422c-aa0d-95db9688158a. Initial domain (ABC.onmicrosoft.com). [20:52:07.729] [ 13] [INFO ] AzureTenantPage: DirectorySynchronizationEnabled=False [20:52:07.729] [ 13] [INFO ] AzureTenantPage: DirectorySynchronizationStatus=Disabled [20:52:07.729] [ 13] [INFO ] PowershellHelper: lastDirectorySyncTime=null [20:52:08.181] [ 13] [INFO ] AzureTenantPageViewModel.GetSynchronizedUserCount: number of synchronized users (max 500) - 6 [20:52:08.571] [ 13] [INFO ] AzureTenantPageViewModel.GetSynchronizedUserCount: number of synchronized users (max 500) - 6 [20:52:08.587] [ 13] [WARN ] Failed to import module MSOnline for PowerShell Command Get-MsolDomain [20:52:08.992] [ 13] [INFO ] AzureTenantPage: Successfully retrieved 2 domains from the tenant. [20:52:08.992] [ 13] [INFO ] AzureTenantPage: Calling to get the last dir sync time for the current user [20:52:09.398] [ 13] [INFO ] DiscoverServiceEndpoint [AdminWebService]: ServiceEndpoint=https://adminwebservice.microsoftonline.com/provisioningservice.svc, AdalAuthority=HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM, AdalResource=https://graph.windows.net. [20:52:09.398] [ 13] [INFO ] AcquireServiceToken [AdminWebService]: acquiring service token. [20:52:09.398] [ 13] [INFO ] Authenticate-ADAL [Acquiring token]: STS endpoint (HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM), resource (https://graph.windows.net), userName (admin@ABC.onmicrosoft.com). [20:52:09.398] [ 13] [INFO ] ADAL: 2020-03-06T09:52:09.3985731Z: 6fa1e0a9-a172-4369-94a7-1395938c9d59 - AdalLoggerBase.cs: ADAL PCL.Desktop with assembly version '5.2.2.0', file version '5.2.2.0' and informational version '5.2.2' is running... [20:52:09.398] [ 13] [INFO ] ADAL: 2020-03-06T09:52:09.3985731Z: 6fa1e0a9-a172-4369-94a7-1395938c9d59 - AdalLoggerBase.cs: === Token Acquisition started: CacheType: Microsoft.IdentityModel.Clients.ActiveDirectory.TokenCache (1 items) Authentication Target: User , Authority Host: login.windows.net [20:52:09.398] [ 13] [INFO ] ADAL: 2020-03-06T09:52:09.3985731Z: 6fa1e0a9-a172-4369-94a7-1395938c9d59 - AdalLoggerBase.cs: An item matching the requested resource was found in the cache [20:52:09.398] [ 13] [INFO ] ADAL: 2020-03-06T09:52:09.3985731Z: 6fa1e0a9-a172-4369-94a7-1395938c9d59 - AdalLoggerBase.cs: 59.89233275 minutes left until token in cache expires [20:52:09.398] [ 13] [INFO ] ADAL: 2020-03-06T09:52:09.3985731Z: 6fa1e0a9-a172-4369-94a7-1395938c9d59 - AdalLoggerBase.cs: A matching item (access token or refresh token or both) was found in the cache [20:52:09.398] [ 13] [INFO ] ADAL: 2020-03-06T09:52:09.3985731Z: 6fa1e0a9-a172-4369-94a7-1395938c9d59 - AdalLoggerBase.cs: === Token Acquisition finished successfully. An access token was returned: Expiration Time: 6/03/2020 10:52:02 AM +00:00 [20:52:09.398] [ 13] [INFO ] Authenticate-ADAL: successfully acquired an access token. TenantId=f1407550-fc7d-422c-aa0d-95db9688158a, ExpiresUTC=6/03/2020 10:52:02 AM +00:00, UserInfo=admin@ABC.onmicrosoft.com, IdentityProvider=https://sts.windows.net/f1407550-fc7d-422c-aa0d-95db9688158a/. [20:52:10.084] [ 13] [INFO ] GetCompanyConfiguration: tenantId=(f1407550-fc7d-422c-aa0d-95db9688158a), IsDirSyncing=False, IsPasswordSyncing=False, DomainName=, DirSyncFeatures=0, AllowedFeatures=None. [20:52:10.084] [ 13] [INFO ] AzureTenantPage: AdminWebService returned the company information for tenant f1407550-fc7d-422c-aa0d-95db9688158a. [20:52:10.100] [ 13] [INFO ] MicrosoftOnlinePersistedStateProvider.Save: saving the persisted state file [20:52:10.100] [ 13] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: False [20:52:10.100] [ 13] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: True [20:52:10.100] [ 13] [INFO ] AzureTenantPage: Windows Azure tenant credentials validation succeeded. [20:52:10.116] [ 1] [INFO ] Page transition from "Connect to Azure AD" [AzureTenantPageViewModel] to "Connect to AD DS" [ConfigOnPremiseCredentialsPageViewModel] [20:52:10.116] [ 1] [INFO ] Property Username failed validation with error Enterprise Administrator credentials are required [20:52:25.590] [ 1] [INFO ] Property Username failed validation with error The username format is incorrect. Specify the username in the format of DOMAIN\username. [20:52:54.202] [ 7] [INFO ] ConfigOnPremiseCredentialsPage: Validating credentials for user - ABC.LOCAL\administrator [20:52:54.427] [ 7] [INFO ] ConfigOnPremiseCredentialsPage: LogonUser succeeded for user ABC.LOCAL\administrator [20:52:54.433] [ 7] [INFO ] ActiveDirectoryProvider.GetRootDomainName: getting user root domain name [20:52:54.555] [ 7] [INFO ] ActiveDirectoryProvider.GetRootDomainName: user root domain - ABC.local [20:52:54.560] [ 7] [INFO ] ActiveDirectoryProvider.IsUserGroupMember: checking if ABC.LOCAL\administrator has AccountEnterpriseAdminsSid privileges in ABC.local [20:52:54.697] [ 7] [INFO ] ActiveDirectoryProvider.IsUserGroupMember: domain sid - S-1-5-21-3310195197-3775739805-4002099260, group sid - S-1-5-21-3310195197-3775739805-4002099260-519 [20:52:54.837] [ 7] [INFO ] ActiveDirectoryProvider.GetGroupMembershipSidsForUser: retrieving group membership SIDs for user ABC.LOCAL\administrator [20:52:54.867] [ 7] [INFO ] ActiveDirectoryProvider.IsUserGroupMember: found membership - user is a member of the group [20:52:54.928] [ 7] [INFO ] ValidateCredentials UseExpressSettings: The domain name 'ABC.local' was successfully matched. [20:52:54.936] [ 7] [INFO ] ConfigOnPremiseCredentialsPage: Validating forest [20:52:54.948] [ 7] [INFO ] Validating forest with FABCABC.local (:0% complete) [20:52:55.113] [ 7] [INFO ] ValidateForest: using SRV02.ABC.local to validate domain ABC.local [20:52:55.120] [ 7] [INFO ] Successfully examined domain ABC.local GUID:32a3a449-06e3-4264-aece-4e81c0c064b5 DN:DC=ABC,DC=local [20:52:55.196] [ 7] [INFO ] ConfigOnPremiseCredentialsPageViewModel: Credentials will be used to administer the AD MA account (New Install). [20:52:55.328] [ 7] [VERB ] MsolDomainExtensions.ConnectMsolService: Connecting to MSOL service. [20:52:55.329] [ 7] [INFO ] DiscoverServiceEndpoint [AzurePowerShell]: ServiceEndpoint=https://provisioningapi.microsoftonline.com/provisioningwebservice.svc, AdalAuthority=HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM, AdalResource=https://graph.windows.net. [20:52:55.329] [ 7] [INFO ] AcquireServiceToken [AzurePowerShell]: acquiring service token. [20:52:55.329] [ 7] [INFO ] Authenticate-ADAL [Acquiring token]: STS endpoint (HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM), resource (https://graph.windows.net), userName (admin@ABC.onmicrosoft.com). [20:52:55.330] [ 7] [INFO ] ADAL: 2020-03-06T09:52:55.3306549Z: 01333c3e-fc34-42e4-8243-e4747ab90933 - AdalLoggerBase.cs: ADAL PCL.Desktop with assembly version '5.2.2.0', file version '5.2.2.0' and informational version '5.2.2' is running... [20:52:55.330] [ 7] [INFO ] ADAL: 2020-03-06T09:52:55.3306549Z: 01333c3e-fc34-42e4-8243-e4747ab90933 - AdalLoggerBase.cs: === Token Acquisition started: CacheType: Microsoft.IdentityModel.Clients.ActiveDirectory.TokenCache (1 items) Authentication Target: User , Authority Host: login.windows.net [20:52:55.330] [ 7] [INFO ] ADAL: 2020-03-06T09:52:55.3306549Z: 01333c3e-fc34-42e4-8243-e4747ab90933 - AdalLoggerBase.cs: An item matching the requested resource was found in the cache [20:52:55.330] [ 7] [INFO ] ADAL: 2020-03-06T09:52:55.3306549Z: 01333c3e-fc34-42e4-8243-e4747ab90933 - AdalLoggerBase.cs: 59.1267980533333 minutes left until token in cache expires [20:52:55.330] [ 7] [INFO ] ADAL: 2020-03-06T09:52:55.3306549Z: 01333c3e-fc34-42e4-8243-e4747ab90933 - AdalLoggerBase.cs: A matching item (access token or refresh token or both) was found in the cache [20:52:55.330] [ 7] [INFO ] ADAL: 2020-03-06T09:52:55.3306549Z: 01333c3e-fc34-42e4-8243-e4747ab90933 - AdalLoggerBase.cs: === Token Acquisition finished successfully. An access token was returned: Expiration Time: 6/03/2020 10:52:02 AM +00:00 [20:52:55.331] [ 7] [INFO ] Authenticate-ADAL: successfully acquired an access token. TenantId=f1407550-fc7d-422c-aa0d-95db9688158a, ExpiresUTC=6/03/2020 10:52:02 AM +00:00, UserInfo=admin@ABC.onmicrosoft.com, IdentityProvider=https://sts.windows.net/f1407550-fc7d-422c-aa0d-95db9688158a/. [20:52:55.331] [ 7] [INFO ] PowerShellHelper.ConnectMsolService: Connecting using an AccessToken. AzureEnvironment=0. [20:52:55.719] [ 7] [WARN ] Failed to import module MSOnline for PowerShell Command Connect-MsolService [20:52:56.128] [ 7] [WARN ] Failed to import module MSOnline for PowerShell Command Get-MsolDomain [20:52:56.572] [ 7] [INFO ] Page transition from "Connect to AD DS" [ConfigOnPremiseCredentialsPageViewModel] to "Azure AD sign-in" [UserSignInConfigPageViewModel] [20:52:56.577] [ 7] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Start background task Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.UserSignInConfigPageViewModel.ValidateScenario in Page:"Azure AD sign-in configuration" [20:52:56.577] [ 7] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Started Background Task Id:9148 [20:52:56.718] [ 17] [VERB ] MsolDomainExtensions.ConnectMsolService: Connecting to MSOL service. [20:52:56.718] [ 17] [INFO ] DiscoverServiceEndpoint [AzurePowerShell]: ServiceEndpoint=https://provisioningapi.microsoftonline.com/provisioningwebservice.svc, AdalAuthority=HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM, AdalResource=https://graph.windows.net. [20:52:56.718] [ 17] [INFO ] AcquireServiceToken [AzurePowerShell]: acquiring service token. [20:52:56.718] [ 17] [INFO ] Authenticate-ADAL [Acquiring token]: STS endpoint (HTTPS://LOGIN.WINDOWS.NET/ABC.ONMICROSOFT.COM), resource (https://graph.windows.net), userName (admin@ABC.onmicrosoft.com). [20:52:56.718] [ 17] [INFO ] ADAL: 2020-03-06T09:52:56.7187937Z: 8eb213b2-616d-4283-9adb-2f5002b97bcb - AdalLoggerBase.cs: ADAL PCL.Desktop with assembly version '5.2.2.0', file version '5.2.2.0' and informational version '5.2.2' is running... [20:52:56.718] [ 17] [INFO ] ADAL: 2020-03-06T09:52:56.7187937Z: 8eb213b2-616d-4283-9adb-2f5002b97bcb - AdalLoggerBase.cs: === Token Acquisition started: CacheType: Microsoft.IdentityModel.Clients.ActiveDirectory.TokenCache (1 items) Authentication Target: User , Authority Host: login.windows.net [20:52:56.719] [ 17] [INFO ] ADAL: 2020-03-06T09:52:56.7197938Z: 8eb213b2-616d-4283-9adb-2f5002b97bcb - AdalLoggerBase.cs: An item matching the requested resource was found in the cache [20:52:56.719] [ 17] [INFO ] ADAL: 2020-03-06T09:52:56.7197938Z: 8eb213b2-616d-4283-9adb-2f5002b97bcb - AdalLoggerBase.cs: 59.1036457383333 minutes left until token in cache expires [20:52:56.719] [ 17] [INFO ] ADAL: 2020-03-06T09:52:56.7197938Z: 8eb213b2-616d-4283-9adb-2f5002b97bcb - AdalLoggerBase.cs: A matching item (access token or refresh token or both) was found in the cache [20:52:56.719] [ 17] [INFO ] ADAL: 2020-03-06T09:52:56.7197938Z: 8eb213b2-616d-4283-9adb-2f5002b97bcb - AdalLoggerBase.cs: === Token Acquisition finished successfully. An access token was returned: Expiration Time: 6/03/2020 10:52:02 AM +00:00 [20:52:56.719] [ 17] [INFO ] Authenticate-ADAL: successfully acquired an access token. TenantId=f1407550-fc7d-422c-aa0d-95db9688158a, ExpiresUTC=6/03/2020 10:52:02 AM +00:00, UserInfo=admin@ABC.onmicrosoft.com, IdentityProvider=https://sts.windows.net/f1407550-fc7d-422c-aa0d-95db9688158a/. [20:52:56.719] [ 17] [INFO ] PowerShellHelper.ConnectMsolService: Connecting using an AccessToken. AzureEnvironment=0. [20:52:57.038] [ 17] [WARN ] Failed to import module MSOnline for PowerShell Command Connect-MsolService [20:52:57.423] [ 17] [WARN ] Failed to import module MSOnline for PowerShell Command Get-MsolDomain [20:52:57.987] [ 1] [INFO ] UPN Suffix List [20:52:57.987] [ 1] [INFO ] -------------------------------------------------------------------- [20:52:57.987] [ 1] [INFO ] UPN Suffix [Azure Status] [20:52:57.987] [ 1] [INFO ] -------------------------------------------------------------------- [20:52:57.991] [ 1] [INFO ] ABC.local [Not Added] [20:52:57.992] [ 1] [INFO ] ABC.com.au [Verified] [20:52:57.992] [ 1] [INFO ] -------------------------------------------------------------------- [20:52:57.992] [ 17] [INFO ] UserSignInConfigPageViewModel: AD Domains: notAddedDomains 1, notVerifiedDomains 0, verifiedDomains 1 [20:52:57.992] [ 17] [INFO ] UserSignInConfigPageViewModel: Azure Domains: aadUnverifiedDomains 0, aadVerifiedDomains 1 [20:52:57.992] [ 17] [INFO ] UserSignInConfigPageViewModel: The currently selected sign-in method is PasswordHashSync [20:52:57.994] [ 1] [WARN ] UserSignInConfigPageViewModel: Some users will not be able to sign-in to Azure AD with on-premises credentials as their UPN suffixes in AD do not have a corresponding Azure verified domain in tenant (ABC.onmicrosoft.com). [20:53:02.248] [ 1] [INFO ] Page transition from "Azure AD sign-in" [UserSignInConfigPageViewModel] to "Configure" [PerformConfigurationPageViewModel] [20:53:02.254] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Start background task Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.PerformConfigurationPageViewModel.BackgroundInitialize in Page:"Ready to configure" [20:53:02.254] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Started Background Task Id:10054 [20:53:03.270] [ 7] [VERB ] PerformConfigurationPageViewModel:ExecuteAutoUpgradeCheck: context.WizardMode ExpressInstall. [20:53:03.292] [ 7] [WARN ] DetermineAutoUpgradeState: AutoUpgrade entering ENABLED mode for express installation. [20:53:03.292] [ 7] [VERB ] PerformConfigurationPageViewModel:ExecuteAutoUpgradeCheck: autoUpgradeState set to Enabled. [20:53:03.295] [ 7] [INFO ] SetAutoUpgradeViaAdhealthRegistrykey: Updated SOFTWARE\Microsoft\ADHealthAgent\Sync\UpdateCheckEnabled registry value to 1 [20:53:03.298] [ 7] [INFO ] Restarting Monitoring Agent service. [20:53:03.299] [ 7] [INFO ] ServiceControllerProvider: InvalidOperationException on serviceController.Status property means the service AzureADConnectHealthSyncMonitor was not found [20:53:03.299] [ 7] [WARN ] Monitoring Agent service is not installed, so the service cannot be restarted. [20:53:08.637] [ 1] [INFO ] MicrosoftOnlinePersistedStateProvider.Save: saving the persisted state file [20:53:08.638] [ 1] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: False [20:53:08.640] [ 1] [INFO ] MicrosoftOnlinePersistedStateProvider.UpdateFileProtection: updating file protection from the persisted state file: C:\ProgramData\AADConnect\PersistedState.xml, isAddProtection: True [20:53:08.646] [ 1] [INFO ] PersistAzureAffinity: Azure affinity was previously persisted as Worldwide (0). [20:53:08.646] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Start background task Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.PerformConfigurationPageViewModel.ExecuteADSyncConfiguration in Page:"Configuring" [20:53:08.646] [ 1] [INFO ] ProgressWizardPageViewModel:StartProgressOperation Started Background Task Id:11093 [20:53:08.647] [ 23] [INFO ] PerformConfigurationPageViewModel.ExecuteADSyncConfiguration: Preparing to configure sync engine (WizardMode=ExpressInstall). [20:53:08.650] [ 23] [INFO ] PerformConfigurationPageViewModel.ExecuteSyncEngineInstallCore: Preparing to install sync engine (WizardMode=ExpressInstall). [20:53:08.650] [ 23] [INFO ] Starting Sync Engine installation [20:53:13.656] [ 23] [INFO ] ServiceControllerProvider: InvalidOperationException on serviceController.Status property means the service ADSync was not found [20:53:13.657] [ 23] [INFO ] ServiceControllerProvider:CreateService - serviceName:ADSync, username:ABC\AAD_08472823a2f0, assemblyPath:C:\Program Files\Microsoft Azure Active Directory Connect\ADSyncBootstrap.exe [20:53:14.775] [ 23] [INFO ] ServiceControllerProvider: Processing StartService request for: ADSync [20:53:14.775] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:53:14.775] [ 23] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:53:35.216] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (1). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:53:35.217] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:53:35.217] [ 23] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:53:55.665] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (2). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:53:55.666] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:53:55.666] [ 23] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:54:16.017] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (3). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:54:16.019] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:54:16.019] [ 23] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:54:36.475] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (4). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:54:36.476] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:54:36.476] [ 23] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:54:56.824] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (5). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:54:56.825] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:54:56.825] [ 23] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:55:17.264] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (6). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:17.266] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:55:17.266] [ 23] [VERB ] ServiceControllerProvider: Starting service and waiting for completion. [20:55:37.646] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (7). Exception Data (Raw): System.ServiceProcess.TimeoutException: Time out has expired and the operation has not been completed. at System.ServiceProcess.ServiceController.WaitForStatus(ServiceControllerStatus desiredStatus, TimeSpan timeout) at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:37.646] [ 23] [ERROR] ServiceControllerProvider: StartService unable to start service (ADSync). The system event log may contain more details for this issue. [20:55:37.648] [ 23] [INFO ] GetEvents: Get-WinEvent -FilterHashTable @{ StartTime='03/06/2020 20:53:13';LogName='System';Data='ADSync';Level='2'; } [20:55:39.163] [ 23] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:55:39.163] [ 23] [INFO ] GetEvents: found 0 total System event log records on attempt 1 [20:55:40.468] [ 23] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:55:40.468] [ 23] [INFO ] GetEvents: found 0 total System event log records on attempt 2 [20:55:41.793] [ 23] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:55:41.793] [ 23] [INFO ] GetEvents: found 0 total System event log records on attempt 3 [20:55:43.102] [ 23] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:55:43.102] [ 23] [INFO ] GetEvents: found 0 total System event log records on attempt 4 [20:55:44.419] [ 23] [WARN ] GetEvents: An error occurred while executing the 'Get-WinEvent' command. No events were found that match the specified selection criteria. [20:55:44.419] [ 23] [INFO ] GetEvents: found 0 total System event log records on attempt 5 [20:55:44.422] [ 23] [INFO ] ServiceControllerProvider: service ADSync exists [20:55:44.422] [ 23] [INFO ] ServiceControllerProvider: processing StopService request for: ADSync [20:55:44.423] [ 23] [VERB ] ServiceControllerProvider: Initial service status: Stopped [20:55:44.423] [ 23] [INFO ] ServiceControllerProvider: StopService status: Stopped [20:55:44.423] [ 23] [INFO ] ServiceControllerProvider:DeleteService - serviceName:ADSync [20:55:54.501] [ 23] [INFO ] ServiceControllerProvider: InvalidOperationException on serviceController.Status property means the service ADSync was not found [20:55:54.502] [ 23] [INFO ] ServiceControllerProvider:DeleteService successful - serviceName:ADSync [20:55:59.107] [ 23] [INFO ] ServiceControllerProvider: processing StopService request for: ADSync [20:55:59.108] [ 23] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (1). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:55:59.109] [ 23] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (2). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:55:59.110] [ 23] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (3). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:55:59.111] [ 23] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (4). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:55:59.111] [ 23] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (5). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:55:59.112] [ 23] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (6). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:55:59.113] [ 23] [WARN ] ServiceControllerProvider: StopService failed to stop service (ADSync), attempt (7). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StopService(String serviceName, TimeSpan timeout) [20:55:59.113] [ 23] [ERROR] ServiceControllerProvider: StopService unable to stop service (ADSync). The system event log may contain more details for this issue. [20:55:59.113] [ 23] [INFO ] ServiceControllerProvider: Processing StartService request for: ADSync [20:55:59.113] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (1). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:59.114] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (2). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:59.115] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (3). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:59.115] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (4). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:59.116] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (5). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:59.117] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (6). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:59.117] [ 23] [WARN ] ServiceControllerProvider: StartService failed to start service (ADSync), attempt (7). Exception Data (Raw): System.InvalidOperationException: Service ADSync was not found on computer '.'. ---> System.ComponentModel.Win32Exception: The specified service does not exist as an installed service --- End of inner exception stack trace --- at System.ServiceProcess.ServiceController.GenerateNames() at System.ServiceProcess.ServiceController.get_ServiceName() at System.ServiceProcess.ServiceController.GenerateStatus() at System.ServiceProcess.ServiceController.get_Status() at Microsoft.Online.Deployment.Framework.Providers.ServiceControllerProvider.StartService(String serviceName, TimeSpan timeout, Boolean verifyStart, String[] args) [20:55:59.117] [ 23] [ERROR] ServiceControllerProvider: StartService unable to start service (ADSync). The system event log may contain more details for this issue. [20:55:59.119] [ 23] [ERROR] PerformConfigurationPageViewModel: Caught exception while installing synchronization service. Exception Data (Raw): System.Exception: Unable to install the Synchronization Service. The ADSync service failed to start with an unexpected error for AutoGeneratedAccount: ABC\AAD_08472823a2f0. Please see the Application and System event logs for additional details. ---> System.InvalidOperationException: The ADSync service failed to start with an unexpected error for AutoGeneratedAccount: ABC\AAD_08472823a2f0. at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SynchronizationServiceSetupTask.StartBootstrapService(SyncServiceAccount syncServiceAccount) at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SynchronizationServiceSetupTask.InstallCore(String logFilePath, String logFileSuffix) at Microsoft.Azure.ActiveDirectory.Synchronization.Framework.ActionExecutor.ExecuteWithSetupResultsStatus(SetupAction action, String description, String logFileName, String logFileSuffix) at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SetupBase.Install() --- End of inner exception stack trace --- at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SetupBase.ThrowSetupTaskFailureException(String exceptionFormatString, String taskName, Exception innerException) at Microsoft.Azure.ActiveDirectory.Synchronization.Setup.SetupBase.Install() at Microsoft.Online.Deployment.OneADWizard.Runtime.Stages.InstallSyncEngineStage.ExecuteInstallCore(ISyncEngineInstallContext syncEngineInstallContext, ProgressChangedEventHandler progressChangesEventHandler) at Microsoft.Online.Deployment.OneADWizard.Runtime.Stages.InstallSyncEngineStage.ExecuteInstall(ISyncEngineInstallContext syncEngineInstallContext, ProgressChangedEventHandler progressChangesEventHandler) at Microsoft.Online.Deployment.OneADWizard.UI.WizardPages.PerformConfigurationPageViewModel.ExecuteSyncEngineInstallCore(AADConnectResult& result) [20:56:25.985] [ 1] [INFO ] Opened log file at path C:\ProgramData\AADConnect\trace-20200306-204120.log