Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

[Bug]: Timeout when 'Starting remaining machines' #1580

Open
Mr-Kappelmann opened this issue Nov 7, 2023 · 5 comments
Open

[Bug]: Timeout when 'Starting remaining machines' #1580

Mr-Kappelmann opened this issue Nov 7, 2023 · 5 comments

Comments

@Mr-Kappelmann
Copy link
Contributor

Mr-Kappelmann commented Nov 7, 2023 •
edited

Description

I get into Timeout (I think), when InstallLab working:

16:13:13|00:57:47|00:00:00.000| - Starting remaining machines
16:13:13|00:57:47|00:00:00.006| - Waiting for machines to start up....................
16:58:26|01:43:00|00:45:12.664| - Done

I have try to reduce the timeout settings, but nothing helps:
Set-PSFConfig -Module 'AutomatedLab' -Name 'Timeout_ConfigurationManagerInstallation' -Value 30 #Default 60
Set-PSFConfig -Module 'AutomatedLab' -Name 'Timeout_DcPromotionRestartAfterDcpromo' -Value 30 #Default 60
Set-PSFConfig -Module 'AutomatedLab' -Name 'Timeout_InstallLabCAInstallation' -Value 10 #Default 40
Set-PSFConfig -Module 'AutomatedLab' -Name 'Timeout_RestartLabMachine_Shutdown' -Value 5 #Default 60
Set-PSFConfig -Module 'AutomatedLab' -Name 'Timeout_StartLabMachine_Online' -Value 5 #Default 60
Set-PSFConfig -Module 'AutomatedLab' -Name 'Timeout_StopLabMachine_Shutdown' -Value 5 #Default 60
Set-PSFConfig -Module 'AutomatedLab' -Name 'Timeout_WaitLabMachine_Online' -Value 5 #Default 60

Test with this working fast, only seconds.
After few Minutes, after 16:13:13|00:57:47|00:00:00.006| - Waiting for machines to start up
ForEach ( $VM in (Get-LabVM).Name) {
$VM
Enter-LabPSSession -ComputerName $VM
Test-WSMan -ComputerName $VM
ping $VM -n 1
}
Exit

Steps to reproduce the issue

Windows Server 2022

on every try

PowerShell Version

7.3.9

AutomatedLab Version

5.48.0
@Mr-Kappelmann
Copy link
Contributor Author

Mr-Kappelmann commented Nov 8, 2023 •
edited

I lost time with step "Get-LabVM Entering... (IncludeLinux=True)"

18:15:29|00:57:17|00:00:00.004| - Waiting for machines to start up...
VERBOSE: [18:15:29][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
.................
VERBOSE: [19:00:40][Write-LogFunctionEntry] Get-LabVM Entering... (Filter= $_.Roles.Name -notcontains 'RootDc' -and $_.Roles.Name -notcontains 'DC' -and $_.Roles.Name -notcontains 'FirstChildDc' -and -not $_.SkipDeployment )

Here a Verbose Log:

18:15:29|00:57:17|00:00:00.004| - Waiting for machines to start up...VERBOSE: [18:15:29][Write-ScreenInfo] 18:15:29|00:57:17|00:00:00.004| - Waiting for machines to start up...
VERBOSE: [18:15:29][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
.................
VERBOSE: [19:00:40][Write-LogFunctionEntry] Get-LabVM Entering... (Filter= $_.Roles.Name -notcontains 'RootDc' -and $_.Roles.Name -notcontains 'DC' -and $_.Roles.Name -notcontains 'FirstChildDc' -and -not $_.SkipDeployment )
VERBOSE: [19:00:40][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
VERBOSE: [19:00:40][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=System.Object[],IncludeLinux=True)
VERBOSE: [19:00:40][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=System.Object[],IncludeLinux=True)
VERBOSE: [19:00:40][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:051)
VERBOSE: [19:00:40][Invoke-LabCommand] Creating session to computer(s) 'labCA labDFS labSQL labADMF lab-Client-GI 
.
.
.

Here a Debug Log:
I have stripped up the redundnat VERBOSE: - Lines
debug.txt

My first idea, there is a mistake, to take the non-Roles-VMs to get "Online" and set setting on them. That can do in parallel and the script do it sequential...

Start Repair-LWHypervNetworkConfig for ONE VM
[09:51:36][Write-LogFunctionEntry] Repair-LWHypervNetworkConfig Entering...
Waiting of ALL VMs?!?
[09:57:51][Write-LogFunctionExit] Repair-LWHypervNetworkConfig...leaving...(Time elapsed: 00:00:03:568)
Take ~6 Minutes, after that, the next VM is in order for Repair-LWHypervNetworkConfig for ONE VM
and so on and so on....

Is THAT the problem:
Get-LabVM Entering... (All=True,IncludeLinux=True)
.
Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:011)

That there is a System.Object[] returned?

DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF)
DEBUG: [09:51:36][Write-LogFunctionEntry] Wait-LabVM Entering... (ComputerName=labADMF,NoNewLine=True,ProgressIndicator=10)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVM Entering... (All=True,IncludeLinux=True)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:36][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:011)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labDC,IncludeLinux=True)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labDC,ErrorAction=<null>)

09:51:34|00:57:30|00:00:00.000| - Starting remaining machines
DEBUG: [09:51:34][Write-ScreenInfo] Waiting for machines to start up...
09:51:34|00:57:30|00:00:00.004|   - Waiting for machines to start up...
DEBUG: [09:51:34][Write-ScreenInfo] 09:51:34|00:57:30|00:00:00.004|   - Waiting for machines to start up...
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:007)
DEBUG: [09:51:34][Write-LogFunctionEntry] Start-LabVM Entering... (ComputerName=System.Object[],DelayBetweenComputers=<null>,ProgressIndicator=30,TimeoutInMinutes=60,Wait=True)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=System.Object[],AsHashTable=True)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=System.Object[],IncludeLinux=True)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:007)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=System.Object[])
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:51:34][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:074)
DEBUG: [09:51:34][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:078)
DEBUG: Machine 'labDC' is already running, removing it from the list of machines to start
DEBUG: Machine 'labSQL' is already running, removing it from the list of machines to start
DEBUG: Machine 'labDFS' is already running, removing it from the list of machines to start
DEBUG: Machine 'labCA' is already running, removing it from the list of machines to start
DEBUG: Machine 'labSDC' is already running, removing it from the list of machines to start
DEBUG: [09:51:34][Start-LabVM] Starting VMs 'labADMF, lab-Client-GI, lab-Admin-GI, labBackupSrv, labHorizonSrv'
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=System.Object[],IncludeLinux=True)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:34][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:007)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF)
DEBUG: [09:51:34][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Client-GI,IncludeLinux=True)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=lab-Client-GI)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Admin-GI,IncludeLinux=True)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=lab-Admin-GI)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labBackupSrv,IncludeLinux=True)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:35][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:006)
DEBUG: [09:51:35][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labBackupSrv)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labHorizonSrv,IncludeLinux=True)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labHorizonSrv)
DEBUG: [09:51:36][Write-LogFunctionExit] Start-LWHypervVM...leaving...(Time elapsed: 00:00:00:425)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LWHypervVMDescription Entering... (ComputerName=labADMF)
DEBUG: [09:51:36][Write-LogFunctionExit] Get-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:012)
DEBUG: [09:51:36][Write-LogFunctionEntry] Repair-LWHypervNetworkConfig Entering... (ComputerName=labADMF)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF)
DEBUG: [09:51:36][Write-LogFunctionEntry] Wait-LabVM Entering... (ComputerName=labADMF,NoNewLine=True,ProgressIndicator=10)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVM Entering... (All=True,IncludeLinux=True)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:36][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:36][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:011)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labDC,IncludeLinux=True)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labDC,ErrorAction=<null>)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:37][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:51:37][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:012)
DEBUG: [09:51:37][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:015)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labSDC)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labSDC,IncludeLinux=True)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labSDC)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labSDC,ErrorAction=<null>)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:47][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:47][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:008)
DEBUG: [09:51:47][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:018)
DEBUG: [09:51:47][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:021)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labCA)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labCA,IncludeLinux=True)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labCA)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labCA,ErrorAction=<null>)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:57][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:51:57][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:51:57][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:022)
DEBUG: [09:51:57][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:030)
DEBUG: [09:52:07][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labDFS)
DEBUG: [09:52:07][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labDFS,IncludeLinux=True)
DEBUG: [09:52:07][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labDFS)
DEBUG: [09:52:07][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labDFS,ErrorAction=<null>)
DEBUG: [09:52:08][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:52:08][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:52:08][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:52:08][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:08][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:08][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:011)
DEBUG: [09:52:08][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:029)
DEBUG: [09:52:08][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:032)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labSQL)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labSQL,IncludeLinux=True)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labSQL)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labSQL,ErrorAction=<null>)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:18][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:18][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:009)
DEBUG: [09:52:18][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:028)
DEBUG: [09:52:18][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:031)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labADMF)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labADMF)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF,ErrorAction=<null>)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:28][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:28][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:018)
DEBUG: [09:52:28][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:036)
DEBUG: [09:52:28][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:039)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=lab-Client-GI)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Client-GI,IncludeLinux=True)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=lab-Client-GI)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=lab-Client-GI,ErrorAction=<null>)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:39][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:39][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:006)
DEBUG: [09:52:39][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:027)
DEBUG: [09:52:39][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:030)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=lab-Admin-GI)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Admin-GI,IncludeLinux=True)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=lab-Admin-GI)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=lab-Admin-GI,ErrorAction=<null>)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:49][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:49][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:016)
DEBUG: [09:52:49][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:031)
DEBUG: [09:52:49][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:038)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labBackupSrv)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labBackupSrv,IncludeLinux=True)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:59][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:014)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labBackupSrv)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labBackupSrv,ErrorAction=<null>)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:59][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:52:59][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:007)
DEBUG: [09:52:59][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:026)
DEBUG: [09:52:59][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:029)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labHorizonSrv)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labHorizonSrv,IncludeLinux=True)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labHorizonSrv)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labHorizonSrv,ErrorAction=<null>)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:10][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:10][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:53:10][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:018)
DEBUG: [09:53:10][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:023)
DEBUG: [09:53:20][Write-LogFunctionEntry] Remove-LabPSSession Entering... (ComputerName=labADMF)
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:53:20][Remove-LabPSSession] Removed 0 PSSessions...
DEBUG: [09:53:20][Write-LogFunctionExit] Remove-LabPSSession...leaving...(Time elapsed: 00:00:00:016)
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LWHypervVMDescription Entering... (ComputerName=labADMF)
DEBUG: [09:53:20][Write-LogFunctionExit] Get-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:007)
DEBUG: [09:53:20][Write-LogFunctionEntry] Wait-LabVM Entering... (ComputerName=labADMF,TimeoutInMinutes=5,PostDelaySeconds=<null>,ProgressIndicator=10,DoNotUseCredSsp=True,NoNewLine=True)
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LabVM Entering... (All=True,IncludeLinux=True)
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:20][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:20][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:009)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labDC,IncludeLinux=True)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labDC,ErrorAction=<null>)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:21][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:21][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:007)
DEBUG: [09:53:21][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:022)
DEBUG: [09:53:21][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:029)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labSDC)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labSDC,IncludeLinux=True)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labSDC)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labSDC,ErrorAction=<null>)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:31][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:31][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:015)
DEBUG: [09:53:31][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:027)
DEBUG: [09:53:31][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:031)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labCA)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labCA,IncludeLinux=True)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labCA)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labCA,ErrorAction=<null>)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:41][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:41][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:030)
DEBUG: [09:53:42][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:062)
DEBUG: [09:53:42][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:067)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labDFS)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labDFS,IncludeLinux=True)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labDFS)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labDFS,ErrorAction=<null>)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:52][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:53:52][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:010)
DEBUG: [09:53:52][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:025)
DEBUG: [09:53:52][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:028)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labSQL)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labSQL,IncludeLinux=True)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labSQL)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labSQL,ErrorAction=<null>)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:54:02][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:54:02][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:54:02][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:025)
DEBUG: [09:54:02][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:027)
DEBUG: [09:54:12][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labADMF)
DEBUG: [09:54:12][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:54:12][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labADMF)
DEBUG: [09:54:12][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF,ErrorAction=<null>)
DEBUG: [09:54:13][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:54:13][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:54:13][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:54:13][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:54:13][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:54:13][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:009)
DEBUG: [09:54:13][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:030)
DEBUG: [09:54:13][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:041)
DEBUG: [09:54:23][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=lab-Client-GI)
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Client-GI,IncludeLinux=True)
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=lab-Client-GI)
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=lab-Client-GI,ErrorAction=<null>)
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:55:58][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:55:58][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:010)
DEBUG: [09:55:58][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:026)
DEBUG: [09:55:58][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:028)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=lab-Admin-GI)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Admin-GI,IncludeLinux=True)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=lab-Admin-GI)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=lab-Admin-GI,ErrorAction=<null>)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:56:08][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:56:08][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:006)
DEBUG: [09:56:08][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:016)
DEBUG: [09:56:08][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:019)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labBackupSrv)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labBackupSrv,IncludeLinux=True)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:56:19][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:008)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labBackupSrv)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labBackupSrv,ErrorAction=<null>)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:56:19][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:56:19][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:006)
DEBUG: [09:56:19][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:016)
DEBUG: [09:56:19][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:018)
DEBUG: [09:56:29][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labHorizonSrv)
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labHorizonSrv,IncludeLinux=True)
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labHorizonSrv)
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labHorizonSrv,ErrorAction=<null>)
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:15][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:15][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:57:15][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:020)
DEBUG: [09:57:15][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:022)
DEBUG: [09:57:25][Write-LogFunctionEntry] Remove-LabPSSession Entering... (ComputerName=labADMF)
DEBUG: [09:57:25][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:25][Remove-LabPSSession] Removed 0 PSSessions...
DEBUG: [09:57:25][Write-LogFunctionExit] Remove-LabPSSession...leaving...(Time elapsed: 00:00:00:017)
DEBUG: [09:57:25][Write-LogFunctionEntry] Get-LWHypervVMDescription Entering... (ComputerName=labADMF)
DEBUG: [09:57:25][Write-LogFunctionExit] Get-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:007)
DEBUG: [09:57:25][Write-LogFunctionEntry] New-LabPSSession Entering... (ComputerName=labADMF,UseLocalCredential=True,Retries=1,DoNotUseCredSsp=True,ErrorAction=<null>)
DEBUG: [09:57:25][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:25][New-LabPSSession] Connecting to machine 'labADMF' using the IP address '172.21.69.16'
DEBUG: [09:57:25][New-LabPSSession] Creating a new PSSession to machine '172.21.69.16:5985' (UserName='labADMF\tier0_AutoLab', Password='Password', DoNotUseCredSsp='True')
DEBUG: [09:57:25][New-LabPSSession] Testing port 5985 on computer '172.21.69.16'
DEBUG: [09:57:26][New-LabPSSession] Port was open, trying to create the session
DEBUG: [09:57:30][New-LabPSSession] Session to computer '172.21.69.16' created
DEBUG: [09:57:30][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:57:30][Write-LogFunctionExit] New-LabPSSession...leaving - return value is 'Session IDs: 39'...(Time elapsed: 00:00:00:013)
DEBUG: [09:57:30][Wait-LabVM] Computer 'labADMF' was reachable
DEBUG: [09:57:31][Wait-LabVM] Waiting for 1 machines to respond in timeout (5 minute(s))
DEBUG: [09:57:31][Write-LogFunctionEntry] Wait-LWLabJob Entering... (Job=System.Management.Automation.Job[](1),ProgressIndicator=10,NoNewLine=True,NoDisplay=True,Timeout=5)
DEBUG: [09:57:31][Write-ScreenInfo] .
DEBUG: [09:57:32][Write-LogFunctionExit] Wait-LWLabJob...leaving...(Time elapsed: 00:00:01:016)
DEBUG: [09:57:32][Wait-LabVM] The following machines are ready: labADMF
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LWHypervVMDescription Entering... (ComputerName=labADMF)
DEBUG: [09:57:32][Write-LogFunctionExit] Get-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:014)
DEBUG: [09:57:32][Write-LogFunctionEntry] Set-LWHypervVMDescription Entering... (Hashtable=System.Collections.Hashtable,ComputerName=labADMF)
DEBUG: [09:57:32][Write-LogFunctionExit] Set-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:007)
DEBUG: [09:57:32][Enable-LabAutoLogon] Enabling autologon on 1 machines
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoAdminLogon -Value 1 -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoLogonCount -Value 9999 -Type DWORD -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultDomainName -Value $parameters.DomainName -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultPassword -Value $parameters.Password -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultUserName -Value $parameters.UserName -Type String -Force
        ,Variable=System.Management.Automation.PSVariable[](1),DoNotUseCredSsp=True,NoDisplay=True)
DEBUG: [09:57:32][Write-LogFunctionEntry] Invoke-LabCommand Entering... (ActivityName=Enabling AutoLogon on labADMF,ComputerName=labADMF,ScriptBlock=
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoAdminLogon -Value 1 -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoLogonCount -Value 9999 -Type DWORD -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultDomainName -Value $parameters.DomainName -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultPassword -Value $parameters.Password -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultUserName -Value $parameters.UserName -Type String -Force
        ,Variable=System.Management.Automation.PSVariable[](1),DoNotUseCredSsp=True,NoDisplay=True)
DEBUG: [09:57:32][Invoke-LabCommand] Executing lab command activity 'Enabling AutoLogon on labADMF' on machines 'labADMF'
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:32][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labADMF,AsHashTable=True)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labADMF)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF,ErrorAction=<null>)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:32][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:008)
DEBUG: [09:57:32][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:018)
DEBUG: [09:57:32][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:020)
DEBUG: [09:57:32][Invoke-LabCommand] Creating session to computer(s) 'labADMF'
DEBUG: [09:57:32][Write-LogFunctionEntry] New-LabPSSession Entering... (ComputerName=labADMF,DoNotUseCredSsp=True,UseLocalCredential=<null>,Credential=<null>,IgnoreAzureLabSources=<null>)
DEBUG: [09:57:32][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:32][New-LabPSSession] Connecting to machine 'labADMF' using the IP address '172.21.69.16'
DEBUG: [09:57:32][New-LabPSSession] Creating a new PSSession to machine '172.21.69.16:5985' (UserName='Domain.de\tier0_AutoLab', Password='Password', DoNotUseCredSsp='True')
DEBUG: [09:57:32][New-LabPSSession] Testing port 5985 on computer '172.21.69.16'
DEBUG: [09:57:32][New-LabPSSession] Port was open, trying to create the session
DEBUG: [09:57:35][New-LabPSSession] Session to computer '172.21.69.16' created
DEBUG: [09:57:35][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:57:35][Write-LogFunctionExit] New-LabPSSession...leaving - return value is 'Session IDs: 40'...(Time elapsed: 00:00:00:007)
DEBUG: [09:57:35][Invoke-LabCommand] Adding variables 'System.Management.Automation.LocalVariable' to session
DEBUG: [Add-VariableToPSSession] Entering function
DEBUG: [Add-VariableToPSSession] Exiting function
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoAdminLogon -Value 1 -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoLogonCount -Value 9999 -Type DWORD -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultDomainName -Value $parameters.DomainName -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultPassword -Value $parameters.Password -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultUserName -Value $parameters.UserName -Type String -Force
        )
DEBUG: [09:57:36][Write-LogFunctionEntry] Invoke-LWCommand Entering... (RetryIntervalInSeconds=10,Verbose=True,ActivityName=Enabling AutoLogon on labADMF,PassThru=<null>,AsJob=<null>,Session=System.Management.Automation.Runspaces.PSSession[](1),Retries=3,ComputerName=labADMF,ScriptBlock=
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoAdminLogon -Value 1 -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name AutoLogonCount -Value 9999 -Type DWORD -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultDomainName -Value $parameters.DomainName -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultPassword -Value $parameters.Password -Type String -Force
            Set-ItemProperty -Path "HKLM:\SOFTWARE\Microsoft\Windows NT\CurrentVersion\Winlogon" -Name DefaultUserName -Value $parameters.UserName -Type String -Force
        )
DEBUG: [09:57:36][Invoke-LWCommand] Starting Activity 'Enabling AutoLogon on labADMF'
DEBUG: Adding LABHOSTNAME to scriptblock
DEBUG: [09:57:37][Invoke-LWCommand] The Output of the task on machine 'labADMF' will be available in the variable 'AL_f7b3b9d7-50ea-44c4-a690-f1b3ffc919f9'
DEBUG: [09:57:37][Invoke-LWCommand] Finished Installation Activity 'Enabling AutoLogon on labADMF'
DEBUG: [09:57:37][Write-LogFunctionExit] Invoke-LWCommand...leaving - return value is 'System.Management.Automation.PSVariable'...(Time elapsed: 00:00:00:258)
DEBUG: [09:57:37][Write-LogFunctionExit] Invoke-LabCommand...leaving...(Time elapsed: 00:00:00:261)

                        if ($PSVersionTable.PSVersion.Major -eq 2)
                        {
                            $d = "{0:HH:mm}" -f (Get-Date).AddMinutes(1)
                            $jobName = "AL_EnableCredSsp"
                            $Path = 'PowerShell'
                            $CommandLine = '-Command Enable-WSManCredSSP -Role Server -Force
DEBUG: [09:57:37][Write-LogFunctionEntry] Invoke-LabCommand Entering... (ComputerName=labADMF,ScriptBlock=

                        if ($PSVersionTable.PSVersion.Major -eq 2)
                        {
                            $d = "{0:HH:mm}" -f (Get-Date).AddMinutes(1)
                            $jobName = "AL_EnableCredSsp"
                            $Path = 'PowerShell'
                            $CommandLine = '-Command Enable-WSManCredSSP -Role Server -Force
DEBUG: [09:57:37][Invoke-LabCommand] Executing lab command activity '<unnamed>' on machines 'labADMF'
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:37][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labADMF,AsHashTable=True)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labADMF)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF,ErrorAction=<null>)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:37][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:011)
DEBUG: [09:57:37][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:013)
DEBUG: [09:57:37][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:015)
DEBUG: [09:57:37][Invoke-LabCommand] Creating session to computer(s) 'labADMF'
DEBUG: [09:57:37][Write-LogFunctionEntry] New-LabPSSession Entering... (ComputerName=labADMF,DoNotUseCredSsp=True,UseLocalCredential=<null>,Credential=<null>,IgnoreAzureLabSources=<null>)
DEBUG: [09:57:37][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:37][New-LabPSSession] Connecting to machine 'labADMF' using the IP address '172.21.69.16'
DEBUG: [09:57:37][New-LabPSSession] Creating a new PSSession to machine '172.21.69.16:5985' (UserName='Domain.de\tier0_AutoLab', Password='Password', DoNotUseCredSsp='True')
DEBUG: [09:57:37][New-LabPSSession] Session labADMF_ae3a0870-d3f3-454a-bddc-533f9b83948a is available and will be reused
DEBUG: [09:57:37][Write-LogFunctionExit] New-LabPSSession...leaving - return value is 'Session IDs: 40'...(Time elapsed: 00:00:00:012)

                        if ($PSVersionTable.PSVersion.Major -eq 2)
                        {
                            $d = "{0:HH:mm}" -f (Get-Date).AddMinutes(1)
                            $jobName = "AL_EnableCredSsp"
                            $Path = 'PowerShell'
                            $CommandLine = '-Command Enable-WSManCredSSP -Role Server -Force
DEBUG: [09:57:37][Write-LogFunctionEntry] Invoke-LWCommand Entering... (RetryIntervalInSeconds=10,Verbose=True,ActivityName=<unnamed>,PassThru=True,AsJob=<null>,Session=System.Management.Automation.Runspaces.PSSession[](1),Retries=3,ComputerName=labADMF,ScriptBlock=

                        if ($PSVersionTable.PSVersion.Major -eq 2)
                        {
                            $d = "{0:HH:mm}" -f (Get-Date).AddMinutes(1)
                            $jobName = "AL_EnableCredSsp"
                            $Path = 'PowerShell'
                            $CommandLine = '-Command Enable-WSManCredSSP -Role Server -Force
DEBUG: [09:57:37][Invoke-LWCommand] Starting Activity '<unnamed>'
DEBUG: Adding LABHOSTNAME to scriptblock
DEBUG: [09:57:38][Invoke-LWCommand] Finished Installation Activity '<unnamed>'
DEBUG: [09:57:38][Write-LogFunctionExit] Invoke-LWCommand...leaving...(Time elapsed: 00:00:00:674)
DEBUG: [09:57:38][Write-LogFunctionExit] Invoke-LabCommand...leaving...(Time elapsed: 00:00:00:684)
DEBUG: [09:57:38][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:57:38][Write-LogFunctionEntry] Set-LWHypervVMDescription Entering... (Hashtable=System.Collections.Hashtable,ComputerName=labADMF)
DEBUG: [09:57:38][Write-LogFunctionExit] Set-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:008)
DEBUG: [09:57:38][Write-LogFunctionExit] Wait-LabVM...leaving...(Time elapsed: 00:00:00:010)
DEBUG: [09:57:38][Write-LogFunctionEntry] New-LabPSSession Entering... (ComputerName=labADMF,UseLocalCredential=True,Retries=1,DoNotUseCredSsp=<null>,ErrorAction=<null>)
DEBUG: [09:57:38][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:38][New-LabPSSession] Connecting to machine 'labADMF' using the IP address '172.21.69.16'
DEBUG: [09:57:38][New-LabPSSession] Creating a new PSSession to machine '172.21.69.16:5985' (UserName='labADMF\tier0_AutoLab', Password='Password', DoNotUseCredSsp='False')
DEBUG: [09:57:38][New-LabPSSession] Testing port 5985 on computer '172.21.69.16'
DEBUG: [09:57:38][New-LabPSSession] Port was open, trying to create the session
DEBUG: [09:57:41][New-LabPSSession] Session to computer '172.21.69.16' created
DEBUG: [09:57:41][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:57:41][Write-LogFunctionExit] New-LabPSSession...leaving - return value is 'Session IDs: 41'...(Time elapsed: 00:00:00:020)
DEBUG: [09:57:41][Wait-LabVM] Computer 'labADMF' was reachable
DEBUG: [09:57:41][Wait-LabVM] Waiting for 1 machines to respond in timeout (5 minute(s))
DEBUG: [09:57:41][Write-LogFunctionEntry] Wait-LWLabJob Entering... (Job=System.Management.Automation.Job[](1),ProgressIndicator=10,NoNewLine=True,NoDisplay=True,Timeout=5)
DEBUG: [09:57:41][Write-ScreenInfo] .
DEBUG: [09:57:42][Write-LogFunctionExit] Wait-LWLabJob...leaving...(Time elapsed: 00:00:01:004)
DEBUG: [09:57:42][Wait-LabVM] The following machines are ready: labADMF
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LWHypervVMDescription Entering... (ComputerName=labADMF)
DEBUG: [09:57:42][Write-LogFunctionExit] Get-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:013)
DEBUG: [09:57:42][Write-LogFunctionExit] Wait-LabVM...leaving...(Time elapsed: 00:00:00:016)
        Write-Verbose "Renaming network adapters"
        #rename the adapters as defined in the lab
        $machineAdapter = [System.Management.Automation.PSSerializer]::Deserialize($machineAdapterStream)
        $newNames = @()
        foreach ($adapterInfo in $machineAdapter)
        {
            $newName = if ($adapterInfo.InterfaceName)
            {
                $adapterInfo.InterfaceName
            }
            else
            {
                $tempName = Add-StringIncrement -String $adapterInfo.VirtualSwitch.ResourceName
                while ($tempName -in $newNames)
                {
                    $tempName = Add-StringIncrement -String $tempName
                }
                $tempName
            }
            $newNames += $newName

            if (-not [string]::IsNullOrEmpty($adapterInfo.VirtualSwitch.FriendlyName))
            {
                $adapterInfo.VirtualSwitch.FriendlyName = $newName
            }
            else
            {
                $adapterInfo.VirtualSwitch.Name = $newName
            }

            $machineOs = [Environment]::OSVersion
            if ($machineOs.Version.Major -lt 6 -and $machineOs.Version.Minor -lt 2)
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join ':'
                $filter = 'MACAddress = "{0}"' -f $mac
                Write-Verbose "Looking for network adapter with using filter '$filter'"
                $adapter = Get-CimInstance -Class Win32_NetworkAdapter -Filter $filter

                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                $adapter.NetConnectionID = $newName
                $adapter.Put()
            }
            else
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join '-'
                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                Get-NetAdapter | Where-Object MacAddress -eq $mac | Rename-NetAdapter -NewName $newName
            }
        }

        #There is no need to change the network binding order in Windows 10 or 2016
        #Adjusting the Network Protocol Bindings in Windows 10 https://blogs.technet.microsoft.com/networking/2015/08/14/adjusting-the-network-protocol-bindings-in-windows-10/
        if ([System.Environment]::OSVersion.Version.Major -lt 10)
        {
            $retries = $machineAdapter.Count * $machineAdapter.Count * 2
            $i = 0

            $sortedAdapters = New-Object System.Collections.ArrayList
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -ne 'Internal' }))
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -eq 'Internal' }))

            Write-Verbose "Setting the network order"
            [array]::Reverse($machineAdapter)
            foreach ($adapterInfo in $sortedAdapters)
            {
                Write-Verbose "Setting the order for adapter '$($adapterInfo.VirtualSwitch.ResourceName)'"
                do {
                    nvspbind.exe /+ $adapterInfo.VirtualSwitch.ResourceName ms_tcpip | Out-File -FilePath c:\nvspbind.log -Append
                    $i++

                    if ($i -gt $retries) { return }
                }  until ($LASTEXITCODE -eq 14)
            }
        }

    ,Function=System.Management.Automation.FunctionInfo[](2),Variable=System.Management.Automation.PSVariable[](1),NoDisplay=True)
DEBUG: [09:57:42][Write-LogFunctionEntry] Invoke-LabCommand Entering... (ComputerName=labADMF,ActivityName=Network config on 'labADMF' (renaming and ordering),ScriptBlock=
        Write-Verbose "Renaming network adapters"
        #rename the adapters as defined in the lab
        $machineAdapter = [System.Management.Automation.PSSerializer]::Deserialize($machineAdapterStream)
        $newNames = @()
        foreach ($adapterInfo in $machineAdapter)
        {
            $newName = if ($adapterInfo.InterfaceName)
            {
                $adapterInfo.InterfaceName
            }
            else
            {
                $tempName = Add-StringIncrement -String $adapterInfo.VirtualSwitch.ResourceName
                while ($tempName -in $newNames)
                {
                    $tempName = Add-StringIncrement -String $tempName
                }
                $tempName
            }
            $newNames += $newName

            if (-not [string]::IsNullOrEmpty($adapterInfo.VirtualSwitch.FriendlyName))
            {
                $adapterInfo.VirtualSwitch.FriendlyName = $newName
            }
            else
            {
                $adapterInfo.VirtualSwitch.Name = $newName
            }

            $machineOs = [Environment]::OSVersion
            if ($machineOs.Version.Major -lt 6 -and $machineOs.Version.Minor -lt 2)
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join ':'
                $filter = 'MACAddress = "{0}"' -f $mac
                Write-Verbose "Looking for network adapter with using filter '$filter'"
                $adapter = Get-CimInstance -Class Win32_NetworkAdapter -Filter $filter

                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                $adapter.NetConnectionID = $newName
                $adapter.Put()
            }
            else
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join '-'
                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                Get-NetAdapter | Where-Object MacAddress -eq $mac | Rename-NetAdapter -NewName $newName
            }
        }

        #There is no need to change the network binding order in Windows 10 or 2016
        #Adjusting the Network Protocol Bindings in Windows 10 https://blogs.technet.microsoft.com/networking/2015/08/14/adjusting-the-network-protocol-bindings-in-windows-10/
        if ([System.Environment]::OSVersion.Version.Major -lt 10)
        {
            $retries = $machineAdapter.Count * $machineAdapter.Count * 2
            $i = 0

            $sortedAdapters = New-Object System.Collections.ArrayList
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -ne 'Internal' }))
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -eq 'Internal' }))

            Write-Verbose "Setting the network order"
            [array]::Reverse($machineAdapter)
            foreach ($adapterInfo in $sortedAdapters)
            {
                Write-Verbose "Setting the order for adapter '$($adapterInfo.VirtualSwitch.ResourceName)'"
                do {
                    nvspbind.exe /+ $adapterInfo.VirtualSwitch.ResourceName ms_tcpip | Out-File -FilePath c:\nvspbind.log -Append
                    $i++

                    if ($i -gt $retries) { return }
                }  until ($LASTEXITCODE -eq 14)
            }
        }

    ,Function=System.Management.Automation.FunctionInfo[](2),Variable=System.Management.Automation.PSVariable[](1),NoDisplay=True)
DEBUG: [09:57:42][Invoke-LabCommand] Executing lab command activity 'Network config on 'labADMF' (renaming and ordering)' on machines 'labADMF'
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:42][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labADMF,AsHashTable=True)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labADMF)
DEBUG: [09:57:42][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labADMF,ErrorAction=<null>)
DEBUG: [09:57:43][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:43][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:43][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:43][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:43][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:43][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:57:43][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:015)
DEBUG: [09:57:43][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:019)
DEBUG: [09:57:43][Invoke-LabCommand] Creating session to computer(s) 'labADMF'
DEBUG: [09:57:43][Write-LogFunctionEntry] New-LabPSSession Entering... (ComputerName=labADMF,DoNotUseCredSsp=<null>,UseLocalCredential=<null>,Credential=<null>,IgnoreAzureLabSources=<null>)
DEBUG: [09:57:43][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF,IncludeLinux=True)
DEBUG: [09:57:43][New-LabPSSession] Connecting to machine 'labADMF' using the IP address '172.21.69.16'
DEBUG: [09:57:43][New-LabPSSession] Creating a new PSSession to machine '172.21.69.16:5985' (UserName='Domain.de\tier0_AutoLab', Password='Password', DoNotUseCredSsp='False')
DEBUG: [09:57:43][New-LabPSSession] Testing port 5985 on computer '172.21.69.16'
DEBUG: [09:57:43][New-LabPSSession] Port was open, trying to create the session
DEBUG: [09:57:46][New-LabPSSession] Session to computer '172.21.69.16' created
DEBUG: [09:57:46][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labADMF)
DEBUG: [09:57:46][Write-LogFunctionExit] New-LabPSSession...leaving - return value is 'Session IDs: 42'...(Time elapsed: 00:00:00:006)
DEBUG: [09:57:46][Invoke-LabCommand] Adding functions 'Get-StringSection,Add-StringIncrement' to session
DEBUG: [Add-FunctionToPSSession] Entering function
DEBUG: [Add-FunctionToPSSession] Exiting function
DEBUG: [09:57:47][Invoke-LabCommand] Adding variables 'System.Management.Automation.LocalVariable' to session
DEBUG: [Add-VariableToPSSession] Entering function
DEBUG: [Add-VariableToPSSession] Exiting function
        Write-Verbose "Renaming network adapters"
        #rename the adapters as defined in the lab
        $machineAdapter = [System.Management.Automation.PSSerializer]::Deserialize($machineAdapterStream)
        $newNames = @()
        foreach ($adapterInfo in $machineAdapter)
        {
            $newName = if ($adapterInfo.InterfaceName)
            {
                $adapterInfo.InterfaceName
            }
            else
            {
                $tempName = Add-StringIncrement -String $adapterInfo.VirtualSwitch.ResourceName
                while ($tempName -in $newNames)
                {
                    $tempName = Add-StringIncrement -String $tempName
                }
                $tempName
            }
            $newNames += $newName

            if (-not [string]::IsNullOrEmpty($adapterInfo.VirtualSwitch.FriendlyName))
            {
                $adapterInfo.VirtualSwitch.FriendlyName = $newName
            }
            else
            {
                $adapterInfo.VirtualSwitch.Name = $newName
            }

            $machineOs = [Environment]::OSVersion
            if ($machineOs.Version.Major -lt 6 -and $machineOs.Version.Minor -lt 2)
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join ':'
                $filter = 'MACAddress = "{0}"' -f $mac
                Write-Verbose "Looking for network adapter with using filter '$filter'"
                $adapter = Get-CimInstance -Class Win32_NetworkAdapter -Filter $filter

                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                $adapter.NetConnectionID = $newName
                $adapter.Put()
            }
            else
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join '-'
                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                Get-NetAdapter | Where-Object MacAddress -eq $mac | Rename-NetAdapter -NewName $newName
            }
        }

        #There is no need to change the network binding order in Windows 10 or 2016
        #Adjusting the Network Protocol Bindings in Windows 10 https://blogs.technet.microsoft.com/networking/2015/08/14/adjusting-the-network-protocol-bindings-in-windows-10/
        if ([System.Environment]::OSVersion.Version.Major -lt 10)
        {
            $retries = $machineAdapter.Count * $machineAdapter.Count * 2
            $i = 0

            $sortedAdapters = New-Object System.Collections.ArrayList
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -ne 'Internal' }))
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -eq 'Internal' }))

            Write-Verbose "Setting the network order"
            [array]::Reverse($machineAdapter)
            foreach ($adapterInfo in $sortedAdapters)
            {
                Write-Verbose "Setting the order for adapter '$($adapterInfo.VirtualSwitch.ResourceName)'"
                do {
                    nvspbind.exe /+ $adapterInfo.VirtualSwitch.ResourceName ms_tcpip | Out-File -FilePath c:\nvspbind.log -Append
                    $i++

                    if ($i -gt $retries) { return }
                }  until ($LASTEXITCODE -eq 14)
            }
        }

    )
DEBUG: [09:57:47][Write-LogFunctionEntry] Invoke-LWCommand Entering... (RetryIntervalInSeconds=10,Verbose=True,ActivityName=Network config on 'labADMF' (renaming and ordering),PassThru=<null>,AsJob=<null>,Session=System.Management.Automation.Runspaces.PSSession[](1),Retries=3,ComputerName=labADMF,ScriptBlock=
        Write-Verbose "Renaming network adapters"
        #rename the adapters as defined in the lab
        $machineAdapter = [System.Management.Automation.PSSerializer]::Deserialize($machineAdapterStream)
        $newNames = @()
        foreach ($adapterInfo in $machineAdapter)
        {
            $newName = if ($adapterInfo.InterfaceName)
            {
                $adapterInfo.InterfaceName
            }
            else
            {
                $tempName = Add-StringIncrement -String $adapterInfo.VirtualSwitch.ResourceName
                while ($tempName -in $newNames)
                {
                    $tempName = Add-StringIncrement -String $tempName
                }
                $tempName
            }
            $newNames += $newName

            if (-not [string]::IsNullOrEmpty($adapterInfo.VirtualSwitch.FriendlyName))
            {
                $adapterInfo.VirtualSwitch.FriendlyName = $newName
            }
            else
            {
                $adapterInfo.VirtualSwitch.Name = $newName
            }

            $machineOs = [Environment]::OSVersion
            if ($machineOs.Version.Major -lt 6 -and $machineOs.Version.Minor -lt 2)
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join ':'
                $filter = 'MACAddress = "{0}"' -f $mac
                Write-Verbose "Looking for network adapter with using filter '$filter'"
                $adapter = Get-CimInstance -Class Win32_NetworkAdapter -Filter $filter

                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                $adapter.NetConnectionID = $newName
                $adapter.Put()
            }
            else
            {
                $mac = (Get-StringSection -String $adapterInfo.MacAddress -SectionSize 2) -join '-'
                Write-Verbose "Renaming adapter '$($adapter.NetConnectionID)' -> '$newName'"
                Get-NetAdapter | Where-Object MacAddress -eq $mac | Rename-NetAdapter -NewName $newName
            }
        }

        #There is no need to change the network binding order in Windows 10 or 2016
        #Adjusting the Network Protocol Bindings in Windows 10 https://blogs.technet.microsoft.com/networking/2015/08/14/adjusting-the-network-protocol-bindings-in-windows-10/
        if ([System.Environment]::OSVersion.Version.Major -lt 10)
        {
            $retries = $machineAdapter.Count * $machineAdapter.Count * 2
            $i = 0

            $sortedAdapters = New-Object System.Collections.ArrayList
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -ne 'Internal' }))
            $sortedAdapters.AddRange(@($machineAdapter | Where-Object { $_.VirtualSwitch.SwitchType.Value -eq 'Internal' }))

            Write-Verbose "Setting the network order"
            [array]::Reverse($machineAdapter)
            foreach ($adapterInfo in $sortedAdapters)
            {
                Write-Verbose "Setting the order for adapter '$($adapterInfo.VirtualSwitch.ResourceName)'"
                do {
                    nvspbind.exe /+ $adapterInfo.VirtualSwitch.ResourceName ms_tcpip | Out-File -FilePath c:\nvspbind.log -Append
                    $i++

                    if ($i -gt $retries) { return }
                }  until ($LASTEXITCODE -eq 14)
            }
        }

    )
DEBUG: [09:57:47][Invoke-LWCommand] Starting Activity 'Network config on 'labADMF' (renaming and ordering)'
DEBUG: Adding LABHOSTNAME to scriptblock
DEBUG: [09:57:51][Invoke-LWCommand] The Output of the task on machine 'labADMF' will be available in the variable 'AL_58b69edf-5f0b-4c2a-9694-d23ab065876f'
DEBUG: [09:57:51][Invoke-LWCommand] Finished Installation Activity 'Network config on 'labADMF' (renaming and ordering)'
DEBUG: [09:57:51][Write-LogFunctionExit] Invoke-LWCommand...leaving - return value is 'System.Management.Automation.PSVariable'...(Time elapsed: 00:00:03:553)
DEBUG: [09:57:51][Write-LogFunctionExit] Invoke-LabCommand...leaving...(Time elapsed: 00:00:03:565)
DEBUG: [09:57:51][Write-LogFunctionExit] Repair-LWHypervNetworkConfig...leaving...(Time elapsed: 00:00:03:568)
DEBUG: [09:57:51][Write-LogFunctionEntry] Set-LWHypervVMDescription Entering... (Hashtable=System.Collections.Hashtable,ComputerName=labADMF)
DEBUG: [09:57:51][Write-LogFunctionExit] Set-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:008)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LWHypervVMDescription Entering... (ComputerName=lab-Client-GI)
DEBUG: [09:57:51][Write-LogFunctionExit] Get-LWHypervVMDescription...leaving...(Time elapsed: 00:00:00:006)
DEBUG: [09:57:51][Write-LogFunctionEntry] Repair-LWHypervNetworkConfig Entering... (ComputerName=lab-Client-GI)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Client-GI)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=lab-Client-GI)
DEBUG: [09:57:51][Write-LogFunctionEntry] Wait-LabVM Entering... (ComputerName=lab-Client-GI,NoNewLine=True,ProgressIndicator=10)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=lab-Client-GI,IncludeLinux=True)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVM Entering... (All=True,IncludeLinux=True)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:51][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labDC,IncludeLinux=True)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labDC)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labDC,ErrorAction=<null>)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:51][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:57:51][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:57:51][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:015)
DEBUG: [09:57:51][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:017)
DEBUG: [09:58:01][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labSDC)
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labSDC,IncludeLinux=True)
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labSDC)
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labSDC,ErrorAction=<null>)
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:22][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:22][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:006)
DEBUG: [09:59:22][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:022)
DEBUG: [09:59:22][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:024)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labCA)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labCA,IncludeLinux=True)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labCA)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labCA,ErrorAction=<null>)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:32][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:32][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:59:32][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:016)
DEBUG: [09:59:32][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:018)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labDFS)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labDFS,IncludeLinux=True)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labDFS)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labDFS,ErrorAction=<null>)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:43][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:43][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:007)
DEBUG: [09:59:43][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:017)
DEBUG: [09:59:43][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:019)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LabVMStatus Entering... (ComputerName=labSQL)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LabVM Entering... (ComputerName=labSQL,IncludeLinux=True)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LWHypervVMStatus Entering... (ComputerName=labSQL)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LWHypervVM Entering... (Name=labSQL,ErrorAction=<null>)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LabVM Entering... (IncludeLinux=True)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LabVHDX Entering... (Name=System.Object[],ErrorAction=<null>)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... (ErrorAction=<null>)
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:53][Write-LogFunctionEntry] Get-LabMachineDefinition Entering... )
DEBUG: [09:59:53][Write-LogFunctionExit] Get-LabVHDX...leaving - return value is 'System.Object[]'...(Time elapsed: 00:00:00:005)
DEBUG: [09:59:53][Write-LogFunctionExit] Get-LWHypervVMStatus...leaving...(Time elapsed: 00:00:00:014)
DEBUG: [09:59:53][Write-LogFunctionExit] Get-LabVMStatus...leaving...(Time elapsed: 00:00:00:019)
[debug.txt](https://github.com/AutomatedLab/AutomatedLab/files/13295074/debug.txt)

@Mr-Kappelmann
Copy link
Contributor Author

Mr-Kappelmann commented Nov 8, 2023 •
edited

There is a Bug in SourceCode:
AutomatedLabWorkerVirtualMachines.psm1

function Start-LWHypervVM
[int]$DelayBetweenComputers = 0,
[int]$PreDelaySeconds = 0,
[int]$PostDelaySeconds = 0,

if ($PreDelay) {
if ($PostDelay)

$PreDelay & $PostDelay should $PreDelaySeconds & $PostDelaySeconds

I started a PullRequest...
#1582

Sorry, that is my first try in github

@Mr-Kappelmann
Copy link
Contributor Author

Is it possible I have this problem:
PowerShell/Win32-OpenSSH#1864

@Mr-Kappelmann
Copy link
Contributor Author

Mr-Kappelmann commented Nov 8, 2023 •
edited

Make "Start-LabVM -Wait -All -Verbose" 5 times faster for me:

AutomatedLabRemoting.psm1

add -T 1 into ssh-keyscan -T 1 $machine.XY

function Install-LabSshKnownHost
..
Line 1384 $keyScanHosts = ssh-keyscan -T 1 $machine.Name 2>$null | Conv........
..
Line 1404 $keyScanIps = ssh-keyscan -T 1 $machine.IpV4Address 2>$null | Conver.......
..

EDIT:
With these changes, they take 17 Minutes.
Without ssh-keyscan -T 1 it will take ~45 Minutes

Is it possible to reduce the Timeout under 1 seconds?!?

17:45:28|00:54:50|00:00:00.000| Starting remaining machines
VERBOSE: [17:45:28][Write-ScreenInfo] Waiting for machines to start up...
DEBUG: [17:45:28][Write-ScreenInfo] Waiting for machines to start up...
.
.
.
18:02:37|01:11:59|00:17:08.939| - Done

debug_1.txt

@Mr-Kappelmann
Copy link
Contributor Author

Mr-Kappelmann commented Nov 9, 2023 •
edited

Changes okay, not guood, but okay.
I think, it should be much quicker... when all "other NON-Roles" VM get parallel/AsJob Tasks. But my programming to bad for that.

With these changes, they take ~15 Minutes.
Without ssh-keyscan -T 1 it will take ~45 Minutes

12:23:54|00:53:22|00:00:00.000| Starting remaining machines
12:23:54|00:53:22|00:00:00.006| - Waiting for machines to start up................................
12:39:22|01:08:51|00:15:28.204| - Done

@Mr-Kappelmann Mr-Kappelmann mentioned this issue Nov 9, 2023
Merged
raandree pushed a commit that referenced this issue Nov 10, 2023
@Mr-Kappelmann
Update Install-LabSshKnownHost.ps1 (#1583)
6bc7a3c 
* Update Install-LabSshKnownHost.ps1

#1580

Improve speed of Start-LabVM -Wait -All (Wait-LabVM -All)

* Update CHANGELOG.md #1583

#1583

* Update CHANGELOG.md

reorder
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@Mr-Kappelmann