[11.16 15:11:01,Telerik.TestStudio.exe(5936:1)] First trace message from process 5936: "C:\Program Files (x86)\Telerik\Test Studio\Bin\Telerik.TestStudio.exe" 
[11.16 15:11:01,Telerik.TestStudio.exe(5936:1)] First trace message from foreground thread "Application start thread" (managed ID = 1, native ID = 2484).
[11.16 15:11:01,Telerik.TestStudio.exe(5936:1),Uncategorized] App.OnStartup() : 
     Using: ArtOfTest.WebAii, Version=2012.2.920.0, Culture=neutral, PublicKeyToken=4fd5f65be123776c
     OS: Microsoft Windows 7 Enterprise 64-Bit 6.1.7601 Service Pack 1
     .NET version: 4.0.30319.296
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\JiraPlugin.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Newtonsoft.Json.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Load.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Manual.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.OTA.Interop.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Plugins.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Web.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Wpf.dll" to find ITestStudioPkg implementers...
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Finished loading ITestStudioPkg plugins.
[11.16 15:11:02,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Extensibility.ITestStudioPkg"...
[11.16 15:11:03,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Found "Telerik.TestStudio.Load.LoadPkg" in "Telerik.TestStudio.Load, Version=2012.2.920.0, Culture=neutral, PublicKeyToken=85d0e578a53d02ec".
[11.16 15:11:03,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Found "Telerik.TestStudio.Manual.ManualPkg" in "Telerik.TestStudio.Manual, Version=2012.2.920.0, Culture=neutral, PublicKeyToken=06f62486e897f63c".
[11.16 15:11:03,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Found "Telerik.TestStudio.Web.WebPkg" in "Telerik.TestStudio.Web, Version=2012.2.920.0, Culture=neutral, PublicKeyToken=a481bc80aec6669c".
[11.16 15:11:03,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Found "Telerik.TestStudio.Wpf.WpfPkg" in "Telerik.TestStudio.Wpf, Version=2012.2.920.0, Culture=neutral, PublicKeyToken=91731613e21d2b88".
[11.16 15:11:03,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:04,Telerik.TestStudio.exe(5936:1),Uncategorized] Orchestrator.LoadPackages() : Telerik.TestStudio.Load.LoadPkg implements ITestStudioPkg and was added as a package.
[11.16 15:11:04,Telerik.TestStudio.exe(5936:1),Uncategorized] Orchestrator.LoadPackages() : Telerik.TestStudio.Manual.ManualPkg implements ITestStudioPkg and was added as a package.
[11.16 15:11:04,Telerik.TestStudio.exe(5936:1),Uncategorized] Orchestrator.LoadPackages() : Telerik.TestStudio.Web.WebPkg implements ITestStudioPkg and was added as a package.
[11.16 15:11:04,Telerik.TestStudio.exe(5936:1),Uncategorized] Orchestrator.LoadPackages() : Telerik.TestStudio.Wpf.WpfPkg implements ITestStudioPkg and was added as a package.
[11.16 15:11:04,Telerik.TestStudio.exe(5936:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11.16 15:11:04,Telerik.TestStudio.exe(5936:1),Uncategorized] Loader.LoadTranslatorGroups() : Translators Directory is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Translators
[11.16 15:11:05,Telerik.TestStudio.exe(5936:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function End -------
[11.16 15:11:05,Telerik.TestStudio.exe(5936:1),Recording] RecorderHostService constructor : Host endpoint: net.pipe://localhost/Instance/52423/DesignCanvas/5936
[11.16 15:11:07,Telerik.TestStudio.exe(5936:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11.16 15:11:07,Telerik.TestStudio.exe(5936:1),Uncategorized] Loader.LoadTranslatorGroups() : Translators Directory is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Translators
[11.16 15:11:07,Telerik.TestStudio.exe(5936:1),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function End -------
[11.16 15:11:10,Telerik.TestStudio.exe(5936:1),TestStudio] MainWindow.MainWindow_Loaded() : Test Studio (version:2012.2.920.0) started.
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] ActivityLog.WriteErrorLine() : EQAT: Not Connected!
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] ActivityLog.WriteErrorLine() : EQAT: Feature track failed!
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\JiraPlugin.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Newtonsoft.Json.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Load.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Manual.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.OTA.Interop.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Plugins.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Web.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Loading "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Wpf.dll" to find ILoadPlugin_UI implementers...
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),TestStudio] Utils.EnumPluginTypes() : Finished loading ILoadPlugin_UI plugins.
[11.16 15:11:11,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "Telerik.TestStudio.Interfaces.Load.ILoadPlugin_UI"...
[11.16 15:11:15,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Found "Telerik.TestStudio.Load.Common.CommonLoadPlugin_UI" in "Telerik.TestStudio.Load.Common, Version=2012.2.920.0, Culture=neutral, PublicKeyToken=387659ced85663de".
[11.16 15:11:16,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Found "Telerik.TestStudio.Load.Http.HttpLoadPlugin_UI" in "Telerik.TestStudio.Load.Common, Version=2012.2.920.0, Culture=neutral, PublicKeyToken=387659ced85663de".
[11.16 15:11:16,Telerik.TestStudio.exe(5936:1),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:17,Telerik.TestStudio.exe(5936:1),Performance] PerformanceProfileViewModel.get_ViewingTimeRange() : Viewing time range is null, will be defaulted: 16.11.2012 13:11:17 to 16.11.2012 14:11:17.
[11.16 15:11:17,Telerik.TestStudio.exe(5936:1),Performance] PerformanceProfileViewModel.set_ViewingTimeRange() : Viewing time range overwritten: 16.11.2012 13:11:17 to 16.11.2012 14:11:17.
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : ------- Function Start -------
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Bug Trackers folder path is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\JiraPlugin.dll"...
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Jira Plugin implements IBugTracker and was loaded in the system.
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Newtonsoft.Json.dll"...
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Load.dll"...
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Manual.dll"...
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.OTA.Interop.dll"...
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Plugins.dll"...
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : TeamPulse Server implements IBugTracker and was loaded in the system.
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Team Foundation Server implements IBugTracker and was loaded in the system.
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Web.dll"...
[11.16 15:11:20,Telerik.TestStudio.exe(5936:1),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Wpf.dll"...
[11.16 15:11:21,Telerik.TestStudio.exe(5936:1),Uncategorized] Orchestrator.set_SelectedProject() : Active Project is : 'SilverlightBrowserTest'
[11.16 15:11:21,Telerik.TestStudio.exe(5936:1),Uncategorized] Orchestrator._iUIProject_ProjectOpened() : Project 'SilverlightBrowserTest' Ready.
[11.16 15:11:23,Telerik.TestStudio.exe(5936:1),Uncategorized] Orchestrator._iUIProject_TestSelected() : Test 'TestSimpleSilverlight' selected.
[11.16 15:11:23,Telerik.TestStudio.exe(5936:1),Error] PerformanceMainViewModel.EnumProfiles() : Folder "" doesn't exist.
[11.16 15:11:23,Telerik.TestStudio.exe(5936:1),Performance] PerformanceMainViewModel.set_ActiveProfile() : Overwriting ActiveProfile viewmodel...
[11.16 15:11:23,Telerik.TestStudio.exe(5936:1),Performance] PerformanceProfileViewModel.get_ViewingTimeRange() : Viewing time range is null, will be defaulted: 16.11.2012 13:11:23 to 16.11.2012 14:11:23.
[11.16 15:11:23,Telerik.TestStudio.exe(5936:1),Performance] PerformanceProfileViewModel.set_ViewingTimeRange() : Viewing time range overwritten: 16.11.2012 13:11:23 to 16.11.2012 14:11:17.
[11.16 15:11:23,Telerik.TestStudio.exe(5936:1),Performance] PerformanceMainViewModel.set_ActiveProfile() : ActiveProfile viewmodel replaced.
[11.16 15:11:24,Telerik.TestStudio.exe(5936:1),TestStudio] Test.LoadProfilerConfiguration() : Loading profiler configuration from "C:\Users\aco\Documents\Test Studio Projects\SilverlightBrowserTest\Profiler Configurations\{42bc4a5c-219d-40d9-81e4-a738b14e6bdb}.tsprofconfig"...
[11.16 15:11:29,ArtOfTest.Runner.exe(4636:4)] First trace message from process 4636: "C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Runner.exe" /controller /parentprocesshandle=2896
[11.16 15:11:29,ArtOfTest.Runner.exe(4636:4)] First trace message from foreground thread "Remote.ArtOfTest.Runner.Listener" (managed ID = 4, native ID = 6204).
[11.16 15:11:29,ArtOfTest.Runner.exe(4636:4),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11.16 15:11:29,ArtOfTest.Runner.exe(4636:4),Uncategorized] Loader.LoadTranslatorGroups() : Translators Directory is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Translators
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:4),Uncategorized] Loader.LoadTranslatorGroups() : ------- Function End -------
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6)] First trace message from pool unnamed thread (managed ID = 6, native ID = 1592).
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : ------- Function Start -------
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Bug Trackers folder path is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\JiraPlugin.dll"...
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : JiraPlugin.JiraSettingsControl could not be instantiate. Exception: Exception has been thrown by the target of an invocation.
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Newtonsoft.Json.dll"...
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Load.dll"...
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Manual.dll"...
[11.16 15:11:30,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.OTA.Interop.dll"...
[11.16 15:11:31,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Plugins.dll"...
[11.16 15:11:31,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : TeamPulse Server implements IBugTracker and was loaded in the system.
[11.16 15:11:31,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Team Foundation Server implements IBugTracker and was loaded in the system.
[11.16 15:11:31,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Web.dll"...
[11.16 15:11:31,ArtOfTest.Runner.exe(4636:6),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\Telerik.TestStudio.Wpf.dll"...
[11.16 15:11:31,ArtOfTest.Runner.exe(4636:6),Framework] FireFoxInstallation.EnumFireFoxInstallations() : Valid Firefox 16.0.0.2 installation found at "C:\Program Files (x86)\Mozilla Firefox\firefox.exe".
[11.16 15:11:32,ArtOfTest.Runner.exe(4636:9)] First trace message from pool unnamed thread (managed ID = 9, native ID = 1680).
[11.16 15:11:32,ArtOfTest.Runner.exe(4636:9),Framework] BrowserHttpHost.HandleRequest() : Creating command queue for browser fc55fe8b-02b3-41aa-8c48-9fb873f14be6
[11.16 15:11:32,ArtOfTest.Runner.exe(4636:9),Framework] Manager.AddNewBrowser() : Added client ID "fc55fe8b-02b3-41aa-8c48-9fb873f14be6" (now there is/are 1 total).
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Execution] ExtensionsManager.LoadExtensions() : ------- Function Start -------
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Got 8 plugin(s) in folder "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins".
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "JiraPlugin.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Newtonsoft.Json.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Load.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Manual.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.OTA.Interop.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Plugins.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Web.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Wpf.dll" from plugins folder.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Execution] ExtensionsManager.LoadExtensions() : ------- Function End -------
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:6),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 1 "Navigate to : 'http://bubblemark.com/sl3/TestPage.html'"...
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:17)] First trace message from foreground unnamed thread (managed ID = 17, native ID = 7684).
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:17),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[11.16 15:11:33,ArtOfTest.Runner.exe(4636:17),UIAutomation] AutomationExtensions.AddAutomationPropertyChangedEventHandler() : Added property change handler on element System.Windows.Automation.AutomationElement scope Subtree with enlarged property set {ValuePatternIdentifiers.ValueProperty} now including {ValuePatternIdentifiers.ValueProperty}.
[11.16 15:11:35,ArtOfTest.Runner.exe(4636:6),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 1 "Navigate to : 'http://bubblemark.com/sl3/TestPage.html'".
[11.16 15:11:35,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[11.16 15:11:35,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[11.16 15:11:35,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11.16 15:11:35,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[11.16 15:11:35,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[11.16 15:11:35,ArtOfTest.Runner.exe(4636:17),UIAutomation] AutomationExtensions.AddStructureChangedEventHandler() : Added a structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[11.16 15:11:37,ArtOfTest.Runner.exe(4636:17),DialogPlayback] DialogMonitor.AutomationEvent_OnStructureChanged() : ChildAdded event sent by named element "Done".
[11.16 15:11:37,ArtOfTest.Runner.exe(4636:17),DialogPlayback] DialogMonitor.AutomationEvent_OnStructureChanged() : ChildAdded event sent by named element "Silverlight Control".
[11.16 15:11:37,ArtOfTest.Runner.exe(4636:17),DialogPlayback] DialogMonitor.AutomationEvent_OnStructureChanged() : ChildAdded event sent by named element "Neu laden".
[11.16 15:11:58,ArtOfTest.Runner.exe(4636:6),Error] ExecutionEngine.ExecuteStep() : EXCEPTION! (see below)
     Outer Exception Type: System.TimeoutException
     Message: Timeout trying to connect to Silverlight App.
     HRESULT: 0x80131505 (Official ID (if app.) = COR_E_TIMEOUT, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5381)
     Call Stack:
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.WaitUntilExtensionCreated(String extensionCall)
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.Connect(Int32 timeout)
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.GetApp(HtmlControl host, Int32 timeout, Boolean catchedOnly)
          at ArtOfTest.WebAii.Design.Execution.ExecutionUtils.GetHost(IAutomationHost topBrowser, ElementDescriptor element, Int32 hostFindTimeout, Int32 appConnectTimeout, Boolean cachedSLAppOnly, String& error)
          at ArtOfTest.WebAii.Design.Execution.ExecutionUtils.GetHostEE(IAutomationHost topBrowser, ElementDescriptor element, String& error)
          at ArtOfTest.WebAii.Design.Execution.ExecutionUtils.WaitForAllElements(IAutomationHost host, AutomationDescriptor descriptor, Int32 timeout, Boolean& byBackupSearch)
          at ArtOfTest.WebAii.Design.Execution.ExecutionEngine.ExecuteStep(Int32 order)

[11.16 15:11:58,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[11.16 15:11:58,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::BreakOnFail
[11.16 15:11:58,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[11.16 15:11:58,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[11.16 15:11:58,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[11.16 15:11:58,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[11.16 15:12:21,ArtOfTest.Runner.exe(4636:6),Error] ExecutionEngine.ExecuteStep() : EXCEPTION! (see below)
     Outer Exception Type: System.TimeoutException
     Message: Timeout trying to connect to Silverlight App.
     HRESULT: 0x80131505 (Official ID (if app.) = COR_E_TIMEOUT, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5381)
     Call Stack:
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.WaitUntilExtensionCreated(String extensionCall)
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.Connect(Int32 timeout)
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.GetApp(HtmlControl host, Int32 timeout, Boolean catchedOnly)
          at ArtOfTest.WebAii.Design.Execution.ExecutionUtils.GetHost(IAutomationHost topBrowser, ElementDescriptor element, Int32 hostFindTimeout, Int32 appConnectTimeout, Boolean cachedSLAppOnly, String& error)
          at ArtOfTest.WebAii.Design.Execution.ExecutionUtils.GetHostEE(IAutomationHost topBrowser, ElementDescriptor element, String& error)
          at ArtOfTest.WebAii.Design.Execution.ExecutionUtils.WaitForAllElements(IAutomationHost host, AutomationDescriptor descriptor, Int32 timeout, Boolean& byBackupSearch)
          at ArtOfTest.WebAii.Design.Execution.ExecutionEngine.ExecuteStep(Int32 order)

[11.16 15:12:21,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[11.16 15:12:21,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::BreakOnFail
[11.16 15:12:21,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::ShutDown::Start
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::Start
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::End
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DispatcherBeginInvokeShutdown::Start
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::Close::Start
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_-1042385453" in order to unblock and eventually terminate it...
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:7)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 7, native ID = 7804).
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:7),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Framework] Manager.RemoveBrowser() : Removed client ID "fc55fe8b-02b3-41aa-8c48-9fb873f14be6" (0 remaining).
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:6),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[11.16 15:12:22,ArtOfTest.Runner.exe(4636:17),UIAutomation] AutomationExtensions.RemoveAutomationPropertyChangedEventHandler() : Removed the property change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[11.16 15:12:23,ArtOfTest.Runner.exe(4636:6),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[11.16 15:12:24,ArtOfTest.Runner.exe(4636:17),UIAutomation] AutomationExtensions.RemoveStructureChangedEventHandler() : Removed the structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[11.16 15:12:24,Telerik.TestStudio.exe(5936:18)] First trace message from background thread "Callback Listener Thread" (managed ID = 18, native ID = 6360).
[11.16 15:12:24,Telerik.TestStudio.exe(5936:18),Warning] PipeCommunication.AsyncPipeRead() : Pipe was already disposed at the moment of the wait attempt.
