[09/04 10:32:36,Telerik.TestStudio.Desktop.exe(14524:22)] First trace message from pool unnamed thread (managed ID = 22, native ID = 14548).
[09/04 10:32:36,Telerik.TestStudio.Desktop.exe(14524:22),Uncategorized] <>c__DisplayClassd.<Refresh>b__5() : Enumerating test list files in "C:\Users\acouzin\Documents\Test Studio Projects\Swedish\TestLists"...
[09/04 10:32:36,Telerik.TestStudio.Desktop.exe(14524:22),Uncategorized] <>c__DisplayClassd.<Refresh>b__5() : 1 test lists found.
[09/04 10:32:36,Telerik.TestStudio.Desktop.exe(14524:4),Uncategorized] <>c__DisplayClassd.<Refresh>b__9() : All files parsed and 1 viewmodels added.
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\10.0\VSTSCore
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\10.0\VSTDCore
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\10.0\PROCore
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\11.0\ultimate
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\11.0\premium
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\11.0\professional
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\12.0\ultimate
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\12.0\premium
[09/04 10:32:54,Telerik.TestStudio.Desktop.exe(14524:1),Error] RegistryHelper.PerformActionOnCurrentKey() : Cannot locate HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\DevDiv\vs\Servicing\12.0\professional
[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:8)] First trace message from pool unnamed thread (managed ID = 8, native ID = 14828).
[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:8),Execution] RunningTestsController.StartTest() : Test run requested for Local path=C:\Users\acouzin\Documents\Test Studio Projects\Swedish
[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:11)] First trace message from pool unnamed thread (managed ID = 11, native ID = 8728).
[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:11),Uncategorized] BugTrackersLoader.LoadSystems() : ------- Function Start -------
[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:11),Error] <>c__DisplayClass4.<RegisterResolver>b__1() : EXCEPTION! (see below)
     Situation: Exception trying to resolve dependency: Microsoft.TeamFoundation.Client, Version=9.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a
     Outer Exception Type: System.IO.FileNotFoundException
     Message: Could not load file or assembly 'Microsoft.TeamFoundation.Client, Version=12.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a' or one of its dependencies. The system cannot find the file specified.
     HRESULT: 0x80070002 (Official ID (if app.) = 2147942402, Error Bit = FAILED, Facility = FACILITY_WIN32, Code = ERROR_FILE_NOT_FOUND)
     Call Stack:
          at System.Reflection.RuntimeAssembly._nLoad(AssemblyName fileName, String codeBase, Evidence assemblySecurity, RuntimeAssembly locationHint, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.nLoad(AssemblyName fileName, String codeBase, Evidence assemblySecurity, RuntimeAssembly locationHint, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.InternalLoadAssemblyName(AssemblyName assemblyRef, Evidence assemblySecurity, RuntimeAssembly reqAssembly, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.InternalLoad(String assemblyString, Evidence assemblySecurity, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean forIntrospection)
          at System.Reflection.RuntimeAssembly.InternalLoad(String assemblyString, Evidence assemblySecurity, StackCrawlMark& stackMark, Boolean forIntrospection)
          at System.Reflection.Assembly.Load(String assemblyString)
          at ArtOfTest.Common.BaseDependencyLoader.<>c__DisplayClass4.<RegisterResolver>b__1(Object o, ResolveEventArgs e)

[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:11),Error] <>c__DisplayClass4.<RegisterResolver>b__1() : EXCEPTION! (see below)
     Situation: Exception trying to resolve dependency: Microsoft.TeamFoundation.Client, Version=11.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a
     Outer Exception Type: System.IO.FileNotFoundException
     Message: Could not load file or assembly 'Microsoft.TeamFoundation.Client, Version=9.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a' or one of its dependencies. The system cannot find the file specified.
     HRESULT: 0x80070002 (Official ID (if app.) = 2147942402, Error Bit = FAILED, Facility = FACILITY_WIN32, Code = ERROR_FILE_NOT_FOUND)
     Call Stack:
          at System.Reflection.RuntimeAssembly._nLoad(AssemblyName fileName, String codeBase, Evidence assemblySecurity, RuntimeAssembly locationHint, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.nLoad(AssemblyName fileName, String codeBase, Evidence assemblySecurity, RuntimeAssembly locationHint, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.InternalLoadAssemblyName(AssemblyName assemblyRef, Evidence assemblySecurity, RuntimeAssembly reqAssembly, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.InternalLoad(String assemblyString, Evidence assemblySecurity, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean forIntrospection)
          at System.Reflection.RuntimeAssembly.InternalLoad(String assemblyString, Evidence assemblySecurity, StackCrawlMark& stackMark, Boolean forIntrospection)
          at System.Reflection.Assembly.Load(String assemblyString)
          at ArtOfTest.Common.BaseDependencyLoader.<>c__DisplayClass4.<RegisterResolver>b__1(Object o, ResolveEventArgs e)

[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:11),Error] <>c__DisplayClass4.<RegisterResolver>b__1() : EXCEPTION! (see below)
     Situation: Exception trying to resolve dependency: Microsoft.TeamFoundation.Client, Version=10.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a
     Outer Exception Type: System.IO.FileNotFoundException
     Message: Could not load file or assembly 'Microsoft.TeamFoundation.Client, Version=11.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a' or one of its dependencies. The system cannot find the file specified.
     HRESULT: 0x80070002 (Official ID (if app.) = 2147942402, Error Bit = FAILED, Facility = FACILITY_WIN32, Code = ERROR_FILE_NOT_FOUND)
     Call Stack:
          at System.Reflection.RuntimeAssembly._nLoad(AssemblyName fileName, String codeBase, Evidence assemblySecurity, RuntimeAssembly locationHint, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.nLoad(AssemblyName fileName, String codeBase, Evidence assemblySecurity, RuntimeAssembly locationHint, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.InternalLoadAssemblyName(AssemblyName assemblyRef, Evidence assemblySecurity, RuntimeAssembly reqAssembly, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean throwOnFileNotFound, Boolean forIntrospection, Boolean suppressSecurityChecks)
          at System.Reflection.RuntimeAssembly.InternalLoad(String assemblyString, Evidence assemblySecurity, StackCrawlMark& stackMark, IntPtr pPrivHostBinder, Boolean forIntrospection)
          at System.Reflection.RuntimeAssembly.InternalLoad(String assemblyString, Evidence assemblySecurity, StackCrawlMark& stackMark, Boolean forIntrospection)
          at System.Reflection.Assembly.Load(String assemblyString)
          at ArtOfTest.Common.BaseDependencyLoader.<>c__DisplayClass4.<RegisterResolver>b__1(Object o, ResolveEventArgs e)

[09/04 10:32:58,Telerik.TestStudio.RemoteExecutor.exe(15088:11),Error] BugTrackersLoader.LoadSystems() : Telerik.TestStudio.TFSBugTracker.TFSBugTracker could not be instantiated. Exception: Exception has been thrown by the target of an invocation.
[09/04 10:32:59,ArtOfTest.Runner.exe(14132:3)] First trace message from process 14132: "C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Runner.exe"  /controller /parentprocesshandle=1768
[09/04 10:32:59,ArtOfTest.Runner.exe(14132:3)] First trace message from foreground thread "Remote.ArtOfTest.Runner.Listener" (managed ID = 3, native ID = 8620).
[09/04 10:32:59,ArtOfTest.Runner.exe(14132:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function Start -------
[09/04 10:33:00,ArtOfTest.Runner.exe(14132:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function End -------
[09/04 10:33:00,ArtOfTest.Runner.exe(14132:5)] First trace message from pool unnamed thread (managed ID = 5, native ID = 6912).
[09/04 10:33:00,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process launched (ID=5900, Path="C:\Program Files\Internet Explorer\iexplore.exe", Arguments="-nomerge about:blank").
[09/04 10:33:00,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Attempting to attach on IE frame (HWND=1969858)...
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] Connector.Start() : Process launched (ID=14316, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 984820").
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] Connector.Start() : Process exited (ID=14316, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 984820").
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process "Telerik.TestStudio.RemoteExecutor" (ID=15088) is assumed to host the controller.
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : ------- Function Start -------
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : Connection string: C:\windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2015.2.723.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?15088
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 984820 on another thread...
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:6)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 6, native ID = 11648).
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:6),Framework] <>c__DisplayClassf.<WaitForDocument>b__8() : Attempting to get document from window handle
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 984820 (lpData = "C:\windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2015.2.723.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?15088")...
[09/04 10:33:01,IEXPLORE.EXE(9108:1)] First trace message from process 9108: "C:\Program Files (x86)\Internet Explorer\IEXPLORE.EXE" SCODEF:5900 CREDAT:275457 /prefetch:2
[09/04 10:33:01,IEXPLORE.EXE(9108:1)] First trace message from background unnamed thread (managed ID = 1, native ID = 11424).
[09/04 10:33:01,IEXPLORE.EXE(9108:1),Framework] ArtOfTestPluginEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (HWND = 984820, PipeName = "Pipe.ArtOfTest.WebAii.BrowserProvisioner_760541105", PID = 15088).
[09/04 10:33:01,IEXPLORE.EXE(9108:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 984820 on same thread...
[09/04 10:33:01,IEXPLORE.EXE(9108:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[09/04 10:33:01,IEXPLORE.EXE(9108:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_85683386-1a14-43cd-885f-a5b5eeac7a63".
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:7)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 7, native ID = 4644).
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:7),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:13)] First trace message from background thread "Remoted async command listener" (managed ID = 13, native ID = 4204).
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[09/04 10:33:01,IEXPLORE.EXE(9108:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "3e9a38d5-5710-468f-8865-b237cfee532b.CommandPipe", Async = "3e9a38d5-5710-468f-8865-b237cfee532b.AsyncPipe"}
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : ------- Function End -------
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:7),Framework] Manager.AddNewBrowser() : Added client ID "Client_85683386-1a14-43cd-885f-a5b5eeac7a63" (now there is/are 1 total).
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'FAD- Viewing page 1 of', path: 'FAD- Viewing page 1 of.tstest.'
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Execution] ExtensionsManager.LoadExtensions() : ------- Function Start -------
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Got 9 plugin(s) in folder "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins".
[09/04 10:33:01,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Jira.BugTracking.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Load.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Manual.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.OTA.Interop.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Plugins.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Shared.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.TeamPulse.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Web.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Wpf.dll" from plugins folder.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Execution] ExtensionsManager.LoadExtensions() : ------- Function End -------
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Navigate to : 'http://www.swedish.org/'"...
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:9)] First trace message from background thread "UAI Dispatcher Thread" (managed ID = 9, native ID = 6360).
[09/04 10:33:02,ArtOfTest.Runner.exe(14132:9),UIAutomation] AutomationExtensions.AddStructureChangedEventHandler() : Added a structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[09/04 10:33:04,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Navigate to : 'http://www.swedish.org/'".
[09/04 10:33:04,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:04,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "Click 'FindALink'"...
[09/04 10:33:05,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Click 'FindALink'".
[09/04 10:33:05,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:06,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 3 "Enter text 'Cardiac Surgery' in 'Main0Contentpanel2TxtHealthConditionAutoCompleteText'"...
[09/04 10:33:06,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 3 "Enter text 'Cardiac Surgery' in 'Main0Contentpanel2TxtHealthConditionAutoCompleteText'".
[09/04 10:33:06,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:06,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 4 "Click 'Main0Contentpanel2BtnSubmitSubmit'"...
[09/04 10:33:07,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 4 "Click 'Main0Contentpanel2BtnSubmitSubmit'".
[09/04 10:33:07,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:07,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Wait for Exists 'HtmlTag'"...
[09/04 10:33:07,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Wait for Exists 'HtmlTag'".
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_760541105" in order to unblock and eventually terminate it...
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:7),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),Framework] Manager.RemoveBrowser() : Removed client ID "Client_85683386-1a14-43cd-885f-a5b5eeac7a63" (0 remaining).
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:9),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 13).
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:9),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[09/04 10:33:08,IEXPLORE.EXE(9108:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_85683386-1a14-43cd-885f-a5b5eeac7a63") to pipe server...
[09/04 10:33:08,IEXPLORE.EXE(9108:1),Framework] BrowserRemoteClient.Disconnect() : Command pipe is already disconnected.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:13),Warning] PipeCommunication.SyncPipeRead() : Pipe read broken by thread-abort.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:9),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:9),UIAutomation] AutomationExtensions.RemoveStructureChangedEventHandler() : Removed the structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[09/04 10:33:08,ArtOfTest.Runner.exe(14132:5),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[09/04 10:33:08,Telerik.TestStudio.RemoteExecutor.exe(15088:14)] First trace message from background thread "Callback Listener Thread" (managed ID = 14, native ID = 12788).
[09/04 10:33:08,Telerik.TestStudio.RemoteExecutor.exe(15088:14),Execution] TestPlatform.AfterRunFinished() : Finished running test platform- attempting publish
[09/04 10:33:13,Telerik.TestStudio.RemoteExecutor.exe(15088:15)] First trace message from pool unnamed thread (managed ID = 15, native ID = 13196).
[09/04 10:33:13,Telerik.TestStudio.RemoteExecutor.exe(15088:15),Execution] RunningTestsController.StartTest() : Test run requested for Local path=C:\Users\acouzin\Documents\Test Studio Projects\Swedish
[09/04 10:33:13,ArtOfTest.Runner.exe(14132:6)] First trace message from pool unnamed thread (managed ID = 6, native ID = 11648).
[09/04 10:33:13,ArtOfTest.Runner.exe(14132:6),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process launched (ID=11336, Path="C:\Program Files\Internet Explorer\iexplore.exe", Arguments="-nomerge about:blank").
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Attempting to attach on IE frame (HWND=1115502)...
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] Connector.Start() : Process launched (ID=10464, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 2229420").
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] Connector.Start() : Process exited (ID=10464, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 2229420").
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process "Telerik.TestStudio.RemoteExecutor" (ID=15088) is assumed to host the controller.
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] Connector.InjectCode() : ------- Function Start -------
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] Connector.InjectCode() : Connection string: C:\windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2015.2.723.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?15088
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 2229420 on another thread...
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:10)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 10, native ID = 14692).
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:10),Framework] <>c__DisplayClassf.<WaitForDocument>b__8() : Attempting to get document from window handle
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 2229420 (lpData = "C:\windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2015.2.723.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?15088")...
[09/04 10:33:14,IEXPLORE.EXE(1676:1)] First trace message from process 1676: "C:\Program Files (x86)\Internet Explorer\IEXPLORE.EXE" SCODEF:11336 CREDAT:275457 /prefetch:2
[09/04 10:33:14,IEXPLORE.EXE(1676:1)] First trace message from background unnamed thread (managed ID = 1, native ID = 14384).
[09/04 10:33:14,IEXPLORE.EXE(1676:1),Framework] ArtOfTestPluginEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (HWND = 2229420, PipeName = "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-773130813", PID = 15088).
[09/04 10:33:14,IEXPLORE.EXE(1676:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 2229420 on same thread...
[09/04 10:33:14,IEXPLORE.EXE(1676:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[09/04 10:33:14,IEXPLORE.EXE(1676:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_afe55ca9-1875-48f5-8e39-a63a3230a605".
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:19)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 19, native ID = 12356).
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:19),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:20)] First trace message from background thread "Remoted async command listener" (managed ID = 20, native ID = 15000).
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:20),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[09/04 10:33:14,IEXPLORE.EXE(1676:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "771d2023-ac1b-4bb0-9119-93edba5c6f0f.CommandPipe", Async = "771d2023-ac1b-4bb0-9119-93edba5c6f0f.AsyncPipe"}
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:20),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:20),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:19),Framework] Manager.AddNewBrowser() : Added client ID "Client_afe55ca9-1875-48f5-8e39-a63a3230a605" (now there is/are 1 total).
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Framework] Connector.InjectCode() : ------- Function End -------
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'Schedule Appt - Exisitng Patients', path: 'Schedule Appt - Exisitng Patients.tstest.'
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:14,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Navigate to : 'http://www.swedish.org/'"...
[09/04 10:33:15,ArtOfTest.Runner.exe(14132:21)] First trace message from background thread "UAI Dispatcher Thread" (managed ID = 21, native ID = 15012).
[09/04 10:33:15,ArtOfTest.Runner.exe(14132:21),UIAutomation] AutomationExtensions.AddStructureChangedEventHandler() : Added a structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[09/04 10:33:16,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Navigate to : 'http://www.swedish.org/'".
[09/04 10:33:16,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:16,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "Click 'FindALink'"...
[09/04 10:33:17,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Click 'FindALink'".
[09/04 10:33:17,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:17,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 3 "Enter text 'Meena Mital' in 'Main0Contentpanel2TxtNameAutoCompleteText'"...
[09/04 10:33:17,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 3 "Enter text 'Meena Mital' in 'Main0Contentpanel2TxtNameAutoCompleteText'".
[09/04 10:33:17,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:17,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 4 "Click 'Main0Contentpanel2BtnNameSubmitSubmit'"...
[09/04 10:33:19,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 4 "Click 'Main0Contentpanel2BtnNameSubmitSubmit'".
[09/04 10:33:19,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:19,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Click 'Main0Contentpanel2LvSearchResultsHlMoreLink0Link'"...
[09/04 10:33:20,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Click 'Main0Contentpanel2LvSearchResultsHlMoreLink0Link'".
[09/04 10:33:20,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:20,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 6 "Click 'ScheduleDiv'"...
[09/04 10:33:21,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 6 "Click 'ScheduleDiv'".
[09/04 10:33:21,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:21,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 7 "Click 'YesDiv'"...
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 7 "Click 'YesDiv'".
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 8 "Verify element 'ScheduleH3Tag' 'is' visible."...
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 8 "Verify element 'ScheduleH3Tag' 'is' visible.".
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-773130813" in order to unblock and eventually terminate it...
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:19),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Framework] Manager.RemoveBrowser() : Removed client ID "Client_afe55ca9-1875-48f5-8e39-a63a3230a605" (0 remaining).
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:6),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 20).
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:21),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[09/04 10:33:23,IEXPLORE.EXE(1676:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_afe55ca9-1875-48f5-8e39-a63a3230a605") to pipe server...
[09/04 10:33:23,IEXPLORE.EXE(1676:1),Framework] BrowserRemoteClient.Disconnect() : Command pipe is already disconnected.
[09/04 10:33:23,ArtOfTest.Runner.exe(14132:20),Warning] PipeCommunication.SyncPipeRead() : Pipe read broken by thread-abort.
[09/04 10:33:24,ArtOfTest.Runner.exe(14132:21),Framework] Manager.get_ActiveBrowser() : The current ActiveBrowser is either invisible or disconnected.
[09/04 10:33:24,ArtOfTest.Runner.exe(14132:6),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[09/04 10:33:24,ArtOfTest.Runner.exe(14132:6),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[09/04 10:33:24,ArtOfTest.Runner.exe(14132:21),UIAutomation] AutomationExtensions.RemoveStructureChangedEventHandler() : Removed the structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[09/04 10:33:24,Telerik.TestStudio.RemoteExecutor.exe(15088:14),Execution] TestPlatform.AfterRunFinished() : Finished running test platform- attempting publish
[09/04 10:33:28,Telerik.TestStudio.RemoteExecutor.exe(15088:8),Execution] RunningTestsController.StartTest() : Test run requested for Local path=C:\Users\acouzin\Documents\Test Studio Projects\Swedish
[09/04 10:33:28,ArtOfTest.Runner.exe(14132:5)] First trace message from pool unnamed thread (managed ID = 5, native ID = 6912).
[09/04 10:33:28,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process launched (ID=12852, Path="C:\Program Files\Internet Explorer\iexplore.exe", Arguments="-nomerge about:blank").
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Attempting to attach on IE frame (HWND=11142526)...
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] Connector.Start() : Process launched (ID=13080, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 1966926").
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] Connector.Start() : Process exited (ID=13080, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments=""C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Connector.dll",AttachToWindowEntryPoint 1966926").
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process "Telerik.TestStudio.RemoteExecutor" (ID=15088) is assumed to host the controller.
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : ------- Function Start -------
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : Connection string: C:\windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2015.2.723.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?15088
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 1966926 on another thread...
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:10)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 10, native ID = 14692).
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:10),Framework] <>c__DisplayClassf.<WaitForDocument>b__8() : Attempting to get document from window handle
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 1966926 (lpData = "C:\windows\Microsoft.Net\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\v4.0_2015.2.723.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?15088")...
[09/04 10:33:29,IEXPLORE.EXE(11696:1)] First trace message from process 11696: "C:\Program Files (x86)\Internet Explorer\IEXPLORE.EXE" SCODEF:12852 CREDAT:275457 /prefetch:2
[09/04 10:33:29,IEXPLORE.EXE(11696:1)] First trace message from background unnamed thread (managed ID = 1, native ID = 12996).
[09/04 10:33:29,IEXPLORE.EXE(11696:1),Framework] ArtOfTestPluginEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (HWND = 1966926, PipeName = "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-524813846", PID = 15088).
[09/04 10:33:29,IEXPLORE.EXE(11696:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 1966926 on same thread...
[09/04 10:33:29,IEXPLORE.EXE(11696:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[09/04 10:33:29,IEXPLORE.EXE(11696:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_8ef6139b-6580-4678-975c-6fb7ebec63f8".
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:22)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 22, native ID = 12072).
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:22),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:18)] First trace message from background thread "Remoted async command listener" (managed ID = 18, native ID = 15352).
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:18),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[09/04 10:33:29,IEXPLORE.EXE(11696:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "41d75060-067e-4417-ba59-8a6a9f897da7.CommandPipe", Async = "41d75060-067e-4417-ba59-8a6a9f897da7.AsyncPipe"}
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:18),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:18),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:22),Framework] Manager.AddNewBrowser() : Added client ID "Client_8ef6139b-6580-4678-975c-6fb7ebec63f8" (now there is/are 1 total).
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Framework] Connector.InjectCode() : ------- Function End -------
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'Schedule Appt - New Patients', path: 'Schedule Appt - New Patients.tstest.'
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:29,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Navigate to : 'http://www.swedish.org/'"...
[09/04 10:33:30,ArtOfTest.Runner.exe(14132:13)] First trace message from background thread "Remoted async command listener" (managed ID = 13, native ID = 11944).
[09/04 10:33:30,ArtOfTest.Runner.exe(14132:13),UIAutomation] AutomationExtensions.AddStructureChangedEventHandler() : Added a structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[09/04 10:33:31,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Navigate to : 'http://www.swedish.org/'".
[09/04 10:33:31,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:31,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 2 "Click 'FindALink'"...
[09/04 10:33:32,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 2 "Click 'FindALink'".
[09/04 10:33:32,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:32,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 3 "Enter text 'Meena Mital' in 'Main0Contentpanel2TxtNameAutoCompleteText'"...
[09/04 10:33:32,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 3 "Enter text 'Meena Mital' in 'Main0Contentpanel2TxtNameAutoCompleteText'".
[09/04 10:33:32,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:32,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 4 "Click 'Main0Contentpanel2BtnNameSubmitSubmit'"...
[09/04 10:33:34,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 4 "Click 'Main0Contentpanel2BtnNameSubmitSubmit'".
[09/04 10:33:34,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:34,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Click 'Main0Contentpanel2LvSearchResultsHlMoreLink0Link'"...
[09/04 10:33:35,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Click 'Main0Contentpanel2LvSearchResultsHlMoreLink0Link'".
[09/04 10:33:35,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:35,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 6 "Click 'ScheduleDiv'"...
[09/04 10:33:37,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 6 "Click 'ScheduleDiv'".
[09/04 10:33:37,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:37,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 7 "Click 'NoDiv'"...
[09/04 10:33:38,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 7 "Click 'NoDiv'".
[09/04 10:33:38,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 8 "Verify element 'ScheduleH3Tag' 'is' visible."...
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 8 "Verify element 'ScheduleH3Tag' 'is' visible.".
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-524813846" in order to unblock and eventually terminate it...
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:22),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Framework] Manager.RemoveBrowser() : Removed client ID "Client_8ef6139b-6580-4678-975c-6fb7ebec63f8" (0 remaining).
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 18).
[09/04 10:33:39,IEXPLORE.EXE(11696:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_8ef6139b-6580-4678-975c-6fb7ebec63f8") to pipe server...
[09/04 10:33:39,IEXPLORE.EXE(11696:1),Framework] BrowserRemoteClient.Disconnect() : Command pipe is already disconnected.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:18),Warning] PipeCommunication.SyncPipeRead() : Pipe read broken by thread-abort.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:13),UIAutomation] AutomationExtensions.RemoveStructureChangedEventHandler() : Removed the structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[09/04 10:33:39,ArtOfTest.Runner.exe(14132:5),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[09/04 10:33:40,Telerik.TestStudio.RemoteExecutor.exe(15088:14),Execution] TestPlatform.AfterRunFinished() : Finished running test platform- attempting publish
