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

MSFT_xWindowsProcess.Integration.Tests.ps1: Integration Tests Broken #458

Closed
mhendric opened this issue Nov 8, 2018 · 3 comments
Closed

MSFT_xWindowsProcess.Integration.Tests.ps1: Integration Tests Broken #458

mhendric opened this issue Nov 8, 2018 · 3 comments
Labels
stale The issue or pull request was marked as stale because there hasn't been activity from the community.

Comments

@mhendric
Copy link
Contributor

mhendric commented Nov 8, 2018

Details of the scenario you tried and the problem that is occurring

This appears to be similar to #457. This test broken sometime between PR #445 and #447, although no relevant code has changed in that time. The errors are also inconsistent, and sometimes do not occur at all. To me this suggests some sort of Performance problem which causes the tests to behave differently, but that's just a guess.

Here's the last known build that tests worked on (from #445):
https://ci.appveyor.com/project/PowerShell/xpsdesiredstateconfiguration/build/6.0.1165.0

Here's the first build where these failures started (from #447):
https://ci.appveyor.com/project/PowerShell/xpsdesiredstateconfiguration/builds/19890728

Failed Test Output (from #447):

[00:25:26] Executing script C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1
[00:25:26] There is no operation running currently. Stop will return without any action.
[00:25:26] 
[00:25:26]   Describing xWindowsProcess Integration Tests without Credential
[00:25:26] 
[00:25:26]     Context Should stop any current instances of the testProcess running
[00:25:27] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:25:27]       [+] Should compile without throwing 1.24s
[00:25:29]       [+] Should be able to call Get-DscConfiguration without throwing 2.09s
[00:25:29]       [+] Should return the correct configuration 133ms
[00:25:29]       [+] Should not create a logfile 45ms
[00:25:29] 
[00:25:29]     Context Should start a new testProcess instance as running
[00:25:29]       [+] Should not have a logfile already present 104ms
[00:25:29] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:25:30] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:25:30] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0000 seconds.
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Start-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' started.
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 584.
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 584,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:30] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 0.1410 seconds.
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:25:30] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.2040 seconds.
[00:25:30] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:25:30] VERBOSE: Time taken for configuration job to complete is 0.212 seconds
[00:25:30]       [+] Should compile without throwing 565ms
[00:25:32]       [+] Should be able to call Get-DscConfiguration without throwing 2.15s
[00:25:32]       [+] Should return the correct configuration 175ms
[00:25:32]       [+] Should create a logfile 49ms
[00:25:32] 
[00:25:32]     Context Should not start a second new testProcess instance when one is already running
[00:25:32]       [+] Should have a logfile already present 112ms
[00:25:32]       [+] Should not throw when removing the log file 52ms
[00:25:33] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:25:33] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:25:33] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:25:33] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:33] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 584.
[00:25:33] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 584,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:33] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:33] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0310 seconds.
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ Skip   Set      ]  [[xWindowsProcess]Process1]
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:25:33] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.0780 seconds.
[00:25:33] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:25:33] VERBOSE: Time taken for configuration job to complete is 0.108 seconds
[00:25:33]       [+] Should compile without throwing 470ms
[00:25:35]       [+] Should be able to call Get-DscConfiguration without throwing 2.12s
[00:25:35]       [+] Should return the correct configuration 190ms
[00:25:35]       [+] Should not create a logfile 45ms
[00:25:35] 
[00:25:35]     Context Should stop the testProcess instance from running
[00:25:35]       [+] Should not have a logfile already present 108ms
[00:25:35] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:25:36] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:25:36] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 584.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 584,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0320 seconds.
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 584.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 584,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Stop-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' with IDs '(584)' stopped.
[00:25:36] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 0.0930 seconds.
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:25:36] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.2450 seconds.
[00:25:36] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:25:36] VERBOSE: Time taken for configuration job to complete is 0.255 seconds
[00:25:36]       [+] Should compile without throwing 619ms
[00:25:38]       [+] Should be able to call Get-DscConfiguration without throwing 2.12s
[00:25:38]       [+] Should return the correct configuration 132ms
[00:25:38]       [+] Should not create a logfile 49ms
[00:25:38] 
[00:25:38]     Context Should return correct amount of processes running when more than 1 are running
[00:25:38]       [+] Should not have a logfile already present 112ms
[00:25:38] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:25:39] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:25:39] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0000 seconds.
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Start-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' started.
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 1592.
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 1592,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:39] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 0.0310 seconds.
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:25:39] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.0780 seconds.
[00:25:39] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:25:39] VERBOSE: Time taken for configuration job to complete is 0.109 seconds
[00:25:39]       [+] Should compile without throwing 478ms
[00:25:41]       [+] Should start another process running 2.05s
[00:25:41]       [+] Should be able to call Get-DscConfiguration without throwing 175ms
[00:25:41]       [+] Should return the correct configuration 197ms
[00:25:41]       [+] Should create a logfile 48ms
[00:25:41] 
[00:25:41]     Context Should stop all of the testProcess instances from running
[00:25:42]       [+] Should have a logfile already present 115ms
[00:25:42]       [+] Should not throw when removing the log file 48ms
[00:25:42] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:25:42] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:25:42] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:25:42] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:25:42] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:25:42] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 1592.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 1592,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2092.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2092,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:42] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0620 seconds.
[00:25:42] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 1592.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 1592,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2092.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2092,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Stop-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:25:42] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' with IDs '(1592,2092)' stopped.
[00:25:43] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:25:43] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 1.4070 seconds.
[00:25:43] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:25:43] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:25:43] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  1.5320 seconds.
[00:25:43] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:25:43] VERBOSE: Time taken for configuration job to complete is 1.567 seconds
[00:25:43]       [+] Should compile without throwing 1.92s
[00:25:46]       [+] Should be able to call Get-DscConfiguration without throwing 2.1s
[00:25:46]       [+] Should return the correct configuration 143ms
[00:25:46]       [-] Should not create a logfile 71ms
[00:25:46]         Expected $false, but got $true.
[00:25:46]         290:                 $pathResult | Should Be $false
[00:25:46]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:25:46]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 290

Failed Test Output (from #448):

[00:31:44] Executing script C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1
[00:31:44] There is no operation running currently. Stop will return without any action.
[00:31:44] 
[00:31:44]   Describing xWindowsProcess Integration Tests without Credential
[00:31:44] 
[00:31:44]     Context Should stop any current instances of the testProcess running
[00:31:44] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:31:46]       [+] Should compile without throwing 2.07s
[00:31:48]       [+] Should be able to call Get-DscConfiguration without throwing 2.1s
[00:31:48]       [+] Should return the correct configuration 130ms
[00:31:48]       [+] Should not create a logfile 47ms
[00:31:48] 
[00:31:48]     Context Should start a new testProcess instance as running
[00:31:48]       [+] Should not have a logfile already present 111ms
[00:31:48] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:31:48] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:31:48] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:31:48] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:31:49] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:31:49] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:31:49] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:31:49] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:31:49] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0000 seconds.
[00:31:49] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:31:49] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:31:49] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Start-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:31:50] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' started.
[00:31:50] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2680.
[00:31:50] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2680,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:31:51] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:31:51] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:31:51] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 2.3180 seconds.
[00:31:51] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:31:51] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:31:51] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  2.3950 seconds.
[00:31:51] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:31:51] VERBOSE: Time taken for configuration job to complete is 2.4 seconds
[00:31:51]       [+] Should compile without throwing 2.76s
[00:31:53]       [+] Should be able to call Get-DscConfiguration without throwing 2.15s
[00:31:54]       [-] Should return the correct configuration 787ms
[00:31:54]         CimException: Cannot invoke the Get-DscConfiguration cmdlet. The Consistency Check or Pull cmdlet is in progress and must return before Get-DscConfiguration can be invoked. Use -Force option if that is available to cancel the current operation.
[00:31:54]       [-] Should create a logfile 94ms
[00:31:54]         Expected $true, but got $false.
[00:31:54]         112:                 $pathResult | Should Be $true
[00:31:54]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:31:54]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 112
[00:31:54] 
[00:31:54]     Context Should not start a second new testProcess instance when one is already running
[00:31:54]       [-] Should have a logfile already present 133ms
[00:31:54]         Expected $true, but got $false.
[00:31:54]         122:                 $pathResult | Should Be $true
[00:31:54]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:31:54]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 122
[00:31:54]       [-] Should not throw when removing the log file 97ms
[00:31:54]         Expected no exception to be thrown, but an exception "Cannot find path 'C:\projects\xpsdesiredstateconfiguration\Tests\processTestLog.txt' because it does not exist." was thrown from C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1:126 char:19
[00:31:54]             +                 { Remove-Item -Path $logFilePath } | Should not Throw
[00:31:54]             +                   ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~.
[00:31:54]         126:                 { Remove-Item -Path $logFilePath } | Should not Throw
[00:31:54]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:31:54]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 126
[00:31:54] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:31:55] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:31:55] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:31:55] VERBOSE: The -Force option was specified with the Stop operation. The current configuration has been successfully cancelled.
[00:31:56] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:31:56] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:31:56] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2680.
[00:31:56] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2680,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:31:56] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:31:56] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0140 seconds.
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ Skip   Set      ]  [[xWindowsProcess]Process1]
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:31:56] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.0790 seconds.
[00:31:56] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:31:56] VERBOSE: Time taken for configuration job to complete is 1.816 seconds
[00:31:56]       [+] Should compile without throwing 2.25s
[00:31:59]       [+] Should be able to call Get-DscConfiguration without throwing 2.16s
[00:31:59]       [+] Should return the correct configuration 180ms
[00:31:59]       [-] Should not create a logfile 95ms
[00:31:59]         Expected $false, but got $true.
[00:31:59]         158:                 $pathResult | Should Be $false
[00:31:59]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:31:59]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 158
[00:31:59] 
[00:31:59]     Context Should stop the testProcess instance from running
[00:31:59]       [-] Should not have a logfile already present 280ms
[00:31:59]         Expected $false, but got $true.
[00:31:59]         168:                 $pathResult | Should Be $false
[00:31:59]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:31:59]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 168
[00:31:59] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:31:59] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:31:59] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:31:59] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2680.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2680,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0630 seconds.
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2680.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2680,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Stop-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' with IDs '(2680)' stopped.
[00:32:00] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 0.1750 seconds.
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:32:00] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.2690 seconds.
[00:32:00] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:32:00] VERBOSE: Time taken for configuration job to complete is 0.296 seconds
[00:32:00]       [+] Should compile without throwing 681ms
[00:32:02]       [+] Should be able to call Get-DscConfiguration without throwing 2.11s
[00:32:02]       [+] Should return the correct configuration 121ms
[00:32:02]       [-] Should not create a logfile 53ms
[00:32:02]         Expected $false, but got $true.
[00:32:02]         199:                 $pathResult | Should Be $false
[00:32:02]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:32:02]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 199
[00:32:02] 
[00:32:02]     Context Should return correct amount of processes running when more than 1 are running
[00:32:02]       [-] Should not have a logfile already present 121ms
[00:32:02]         Expected $false, but got $true.
[00:32:02]         209:                 $pathResult | Should Be $false
[00:32:02]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:32:02]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 209

Failed Test Output (from #456):

[00:19:17] Executing script C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1
[00:19:18] There is no operation running currently. Stop will return without any action.
[00:19:18] 
[00:19:18]   Describing xWindowsProcess Integration Tests without Credential
[00:19:18] 
[00:19:18]     Context Should stop any current instances of the testProcess running
[00:19:18] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:19:18]       [+] Should compile without throwing 1.34s
[00:19:21]       [+] Should be able to call Get-DscConfiguration without throwing 2.08s
[00:19:21]       [+] Should return the correct configuration 125ms
[00:19:21]       [+] Should not create a logfile 39ms
[00:19:21] 
[00:19:21]     Context Should start a new testProcess instance as running
[00:19:21]       [+] Should not have a logfile already present 91ms
[00:19:21] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:19:21] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:19:21] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:19:21] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:19:21] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:19:21] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:19:21] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:21] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:21] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0000 seconds.
[00:19:21] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:19:21] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:21] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Start-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:19:22] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' started.
[00:19:22] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2492.
[00:19:22] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2492,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:19:22] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:19:22] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:22] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 1.3110 seconds.
[00:19:22] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:19:22] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:19:22] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  1.3730 seconds.
[00:19:22] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:19:22] VERBOSE: Time taken for configuration job to complete is 1.385 seconds
[00:19:22]       [+] Should compile without throwing 1.7s
[00:19:25]       [+] Should be able to call Get-DscConfiguration without throwing 2.12s
[00:19:25]       [+] Should return the correct configuration 165ms
[00:19:25]       [-] Should create a logfile 61ms
[00:19:25]         Expected $true, but got $false.
[00:19:25]         112:                 $pathResult | Should Be $true
[00:19:25]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:19:25]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 112
[00:19:25] 
[00:19:25]     Context Should not start a second new testProcess instance when one is already running
[00:19:25]       [-] Should have a logfile already present 134ms
[00:19:25]         Expected $true, but got $false.
[00:19:25]         122:                 $pathResult | Should Be $true
[00:19:25]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:19:25]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 122
[00:19:25]       [-] Should not throw when removing the log file 70ms
[00:19:25]         Expected no exception to be thrown, but an exception "Cannot find path 'C:\projects\xpsdesiredstateconfiguration\Tests\processTestLog.txt' because it does not exist." was thrown from C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1:126 char:19
[00:19:25]             +                 { Remove-Item -Path $logFilePath } | Should not Throw
[00:19:25]             +                   ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~.
[00:19:25]         126:                 { Remove-Item -Path $logFilePath } | Should not Throw
[00:19:25]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:19:25]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 126
[00:19:25] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:19:25] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:19:25] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:19:25] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:25] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2492.
[00:19:25] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2492,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:19:25] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:19:25] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0150 seconds.
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ Skip   Set      ]  [[xWindowsProcess]Process1]
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:19:25] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.0620 seconds.
[00:19:25] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:19:25] VERBOSE: Time taken for configuration job to complete is 0.077 seconds
[00:19:25]       [+] Should compile without throwing 439ms
[00:19:28]       [+] Should be able to call Get-DscConfiguration without throwing 2.12s
[00:19:28]       [+] Should return the correct configuration 169ms
[00:19:28]       [-] Should not create a logfile 87ms
[00:19:28]         Expected $false, but got $true.
[00:19:28]         158:                 $pathResult | Should Be $false
[00:19:28]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:19:28]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 158
[00:19:28] 
[00:19:28]     Context Should stop the testProcess instance from running
[00:19:28]       [-] Should not have a logfile already present 240ms
[00:19:28]         Expected $false, but got $true.
[00:19:28]         168:                 $pathResult | Should Be $false
[00:19:28]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:19:28]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 168
[00:19:28] The 'Microsoft.PowerShell.Management' module was not imported because the 'Microsoft.PowerShell.Management' snap-in was already imported.
[00:19:28] VERBOSE: Perform operation 'Invoke CimMethod' with following parameters, ''methodName' = SendConfigurationApply,'className' = MSFT_DSCLocalConfigurationManager,'namespaceName' = root/Microsoft/Windows/DesiredStateConfiguration'.
[00:19:28] VERBOSE: An LCM method call arrived from computer APPVYR-WIN with user sid S-1-5-21-2195900957-2730782454-3917332813-1001.
[00:19:28] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]
[00:19:28] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Resource ]  [[xWindowsProcess]Process1]
[00:19:28] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Test     ]  [[xWindowsProcess]Process1]
[00:19:28] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:28] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2492.
[00:19:28] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2492,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:19:28] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Test functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:29] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Test     ]  [[xWindowsProcess]Process1]  in 0.0320 seconds.
[00:19:29] VERBOSE: [APPVYR-WIN]: LCM:  [ Start  Set      ]  [[xWindowsProcess]Process1]
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Begin executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] In process handle 2492.
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Perform operation 'Query CimInstances' with following parameters, ''queryExpression' = SELECT * FROM Win32_Process WHERE ProcessId = 2492,'queryDialect' = WQL,'namespaceName' = root\cimv2'.
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Operation 'Query CimInstances' complete.
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Performing the operation "Stop-Process." on target "C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe".
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] Processes matching path 'C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe' with IDs '(2492)' stopped.
[00:19:29] VERBOSE: [APPVYR-WIN]:                            [[xWindowsProcess]Process1] End executing Set functionality for the process C:\projects\xpsdesiredstateconfiguration\Tests\WindowsProcessTestProcess.exe.
[00:19:29] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]  [[xWindowsProcess]Process1]  in 0.0460 seconds.
[00:19:29] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Resource ]  [[xWindowsProcess]Process1]
[00:19:29] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]
[00:19:29] VERBOSE: [APPVYR-WIN]: LCM:  [ End    Set      ]    in  0.1090 seconds.
[00:19:29] VERBOSE: Operation 'Invoke CimMethod' complete.
[00:19:29] VERBOSE: Time taken for configuration job to complete is 0.125 seconds
[00:19:29]       [+] Should compile without throwing 482ms
[00:19:31]       [+] Should be able to call Get-DscConfiguration without throwing 2.1s
[00:19:31]       [+] Should return the correct configuration 119ms
[00:19:31]       [-] Should not create a logfile 55ms
[00:19:31]         Expected $false, but got $true.
[00:19:31]         199:                 $pathResult | Should Be $false
[00:19:31]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:19:31]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 199
[00:19:31] 
[00:19:31]     Context Should return correct amount of processes running when more than 1 are running
[00:19:31]       [-] Should not have a logfile already present 119ms
[00:19:31]         Expected $false, but got $true.
[00:19:31]         209:                 $pathResult | Should Be $false
[00:19:31]         at Invoke-LegacyAssertion, C:\Program Files\WindowsPowerShell\Modules\Pester\4.4.2\Functions\Assertions\Should.ps1: line 188
[00:19:31]         at <ScriptBlock>, C:\projects\xpsdesiredstateconfiguration\Tests\Integration\MSFT_xWindowsProcess.Integration.Tests.ps1: line 209

Version of the DSC module that was used ('dev' if using current dev branch)

dev
@mhendric
Copy link
Contributor Author

mhendric commented Nov 9, 2018

Reaching out to the community to get opinions on how to proceed with this issue while its being troubleshooted, as it's currently blocking a number of Pull Requests from getting merged, even though it's unrelated to those PR's. Should we continue to block all PR's until this is resolved? Should we ignore these and merge the PR's anyways? Should we disable the corresponding tests until we have a fix for them (that would be my vote)? Any other suggestions?

@mhendric mhendric mentioned this issue Nov 9, 2018
Closed
9 tasks
@stale
Copy link

stale bot commented Dec 9, 2018

This issue has been automatically marked as stale because it has not had activity from the community in the last 30 days. It will be closed if no further activity occurs within 10 days. If the issue is labelled with any of the work labels (e.g bug, enhancement, documentation, or tests) then the issue will not auto-close.

@stale stale bot added the stale The issue or pull request was marked as stale because there hasn't been activity from the community. label Dec 9, 2018
@mhendric mhendric mentioned this issue Jan 11, 2019
Closed
@PlagueHO PlagueHO mentioned this issue Jan 12, 2019
Merged
9 tasks
@stale
Copy link

stale bot commented Jan 19, 2019

This issue has been automatically closed because it is has not had activity from the community in the last 40 days.

@stale stale bot closed this as completed Jan 19, 2019
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
stale The issue or pull request was marked as stale because there hasn't been activity from the community.
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@mhendric