﻿[11-18 11:15:24,Telerik.TestStudio.RemoteExecutor.exe(4448:16),Execution] RunningTestsController.StartTest() : Test run requested for Cloud path=C:\Users\PLK056397\Documents\Test Studio Projects\Iteracje
[11-18 11:15:36,ArtOfTest.Runner.exe(5620:3)] First trace message from process 5620: "C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Runner.exe"  /controller /parentprocesshandle=2484
[11-18 11:15:36,ArtOfTest.Runner.exe(5620:3)] First trace message from foreground thread "Remote.ArtOfTest.Runner.Listener" (managed ID = 3, native ID = 2004).
[11-18 11:15:36,ArtOfTest.Runner.exe(5620:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11-18 11:15:38,ArtOfTest.Runner.exe(5620:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function End -------
[11-18 11:15:38,ArtOfTest.Runner.exe(5620:5)] First trace message from pool unnamed thread (managed ID = 5, native ID = 5864).
[11-18 11:15:38,ArtOfTest.Runner.exe(5620:5),Framework] Manager.LaunchNewApplication() : Process launched (ID=2244, Path="C:\Users\PLK056397\Documents\Aplikacja_mock2\WpfApplication2.exe", Arguments="").
[11-18 11:15:38,ArtOfTest.Runner.exe(5620:5),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 6, native ID = 2748).
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] <>c__DisplayClass4c.<WaitForApplicationToConnect>b__46() : WPF HWNDs detected after 35 msec: {262918}.
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] Connector.Start() : Process launched (ID=5144, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 262918").
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] Connector.Start() : Process exited (ID=5144, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 262918").
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] Connector.InjectCode() : ------- Function Start -------
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] Connector.InjectCode() : Connection string: C:\Windows\Microsoft.Net\assembly\GAC_MSIL\Telerik.TestingFramework.WpfExtension\v4.0_2015.3.1314.0__3fd81c5c4516f739\Telerik.TestingFramework.WpfExtension.dll?Telerik.TestingFramework.WpfExtension.WpfCommunicationEntryPoint?5620
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 262918 (lpData = "C:\Windows\Microsoft.Net\assembly\GAC_MSIL\Telerik.TestingFramework.WpfExtension\v4.0_2015.3.1314.0__3fd81c5c4516f739\Telerik.TestingFramework.WpfExtension.dll?Telerik.TestingFramework.WpfExtension.WpfCommunicationEntryPoint?5620")...
[11-18 11:15:39,WpfApplication2.exe(2244:1)] First trace message from process 2244: "C:\Users\PLK056397\Documents\Aplikacja_mock2\WpfApplication2.exe" 
[11-18 11:15:39,WpfApplication2.exe(2244:1)] First trace message from foreground thread "WpfCommunicationEntryPoint entry point thread" (managed ID = 1, native ID = 780).
[11-18 11:15:39,WpfApplication2.exe(2244:1),Recording] WpfCommunicationEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (hwndString="262918:Pipe.ArtOfTest.WebAii.BrowserProvisioner_-2105967504:5620").
[11-18 11:15:39,WpfApplication2.exe(2244:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_f58eb805-75c4-4b7c-8a04-a756b3be518a".
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:7)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 7, native ID = 2012).
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:7),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[11-18 11:15:39,WpfApplication2.exe(2244:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "18e59e96-7d00-4a89-8b5b-d7c4c32816cf.CommandPipe", Async = "18e59e96-7d00-4a89-8b5b-d7c4c32816cf.AsyncPipe"}
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:9)] First trace message from background thread "Remoted async command listener" (managed ID = 9, native ID = 5496).
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:9),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:9),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:9),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:6),Framework] Connector.InjectCode() : ------- Function End -------
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'Mock2', path: 'Budowanie\Mock2.tstest.'
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:5),Execution] ExtensionsManager.LoadExtensions() : ------- Function Start -------
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Got 10 plugin(s) in folder "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins".
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Jira.BugTracking.dll" from plugins folder.
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Load.dll" from plugins folder.
[11-18 11:15:39,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Manual.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.OTA.Interop.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Plugins.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.ProductGuide.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Shared.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.TeamPulse.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Web.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Wpf.dll" from plugins folder.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Execution] ExtensionsManager.LoadExtensions() : ------- Function End -------
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11-18 11:15:40,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Wait for '2000' msec."...
[11-18 11:15:42,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Wait for '2000' msec.".
[11-18 11:15:42,ArtOfTest.Runner.exe(5620:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "LeftClick on OtwórzDrugieTextblock"...
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10)] First trace message from background thread "UAI Dispatcher Thread" (managed ID = 10, native ID = 5344).
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "LeftClick on OtwórzDrugieTextblock".
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 3 "Wait for '2000' msec."...
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Manager._windowMonitor_WindowOpened() : New WPF window detected (HWND=394000, Caption="Okno 2").
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Connector.Start() : Process launched (ID=4376, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 394000").
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Connector.Start() : Process exited (ID=4376, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 394000").
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Connector.InjectCode() : ------- Function Start -------
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Connector.InjectCode() : Connection string: C:\Windows\Microsoft.Net\assembly\GAC_MSIL\Telerik.TestingFramework.WpfExtension\v4.0_2015.3.1314.0__3fd81c5c4516f739\Telerik.TestingFramework.WpfExtension.dll?Telerik.TestingFramework.WpfExtension.WpfCommunicationEntryPoint?5620
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 394000 (lpData = "C:\Windows\Microsoft.Net\assembly\GAC_MSIL\Telerik.TestingFramework.WpfExtension\v4.0_2015.3.1314.0__3fd81c5c4516f739\Telerik.TestingFramework.WpfExtension.dll?Telerik.TestingFramework.WpfExtension.WpfCommunicationEntryPoint?5620")...
[11-18 11:15:44,WpfApplication2.exe(2244:1),Recording] WpfCommunicationEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (hwndString="394000:Pipe.ArtOfTest.WebAii.BrowserProvisioner_-2105967504:5620").
[11-18 11:15:44,WpfApplication2.exe(2244:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_6c51007e-90f9-40f9-b9b9-2ff626c42e37".
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:7),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:15)] First trace message from background thread "Remoted async command listener" (managed ID = 15, native ID = 5776).
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:15),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[11-18 11:15:44,WpfApplication2.exe(2244:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "fcd9e469-5a01-4a26-aa3c-b7e0ca0b1f2e.CommandPipe", Async = "fcd9e469-5a01-4a26-aa3c-b7e0ca0b1f2e.AsyncPipe"}
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:15),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:15),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Connector.InjectCode() : ------- Function End -------
[11-18 11:15:44,ArtOfTest.Runner.exe(5620:10),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[11-18 11:15:46,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 3 "Wait for '2000' msec.".
[11-18 11:15:46,ArtOfTest.Runner.exe(5620:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11-18 11:15:47,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 4 "LeftClick on ZamknijTextblock"...
[11-18 11:15:47,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 4 "LeftClick on ZamknijTextblock".
[11-18 11:15:47,ArtOfTest.Runner.exe(5620:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11-18 11:15:47,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Wait for '2000' msec."...
[11-18 11:15:47,WpfApplication2.exe(2244:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_6c51007e-90f9-40f9-b9b9-2ff626c42e37") to pipe server...
[11-18 11:15:47,ArtOfTest.Runner.exe(5620:15),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A ClientDisconnectRequest(ClientId="Client_6c51007e-90f9-40f9-b9b9-2ff626c42e37") has been received from the pipe client.
[11-18 11:15:49,ArtOfTest.Runner.exe(5620:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Wait for '2000' msec.".
[11-18 11:15:49,ArtOfTest.Runner.exe(5620:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11-18 11:15:49,WpfApplication2.exe(2244:1),Error] BrowserRemoteClient.Disconnect() : Could not join the listener thread even after two 1-second wait attempts and an interrupt.
[11-18 11:15:49,WpfApplication2.exe(2244:1),Framework] BrowserRemoteClient.Disconnect() : Disconnecting command pipe (Handle = 1544).