
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5)] First trace message from process 2512: "C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Runner.exe" /controller /parentprocesshandle=2528
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5)] First trace message from pool unnamed thread (managed ID = 5, native ID = 5260).
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Execution] TestAppLoader.LoadRefAssemblies() : External assembly loaded into the AppDomain: C:\Program Files (x86)\Microsoft Visual Studio 10.0\Common7\IDE\PublicAssemblies\Microsoft.VisualStudio.QualityTools.UnitTestFramework.dll.
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Uncategorized] BugTrackersLoader.LoadSystems() : ------- Function Start -------
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Uncategorized] BugTrackersLoader.LoadSystems() : Bug Trackers folder path is : C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\BugTrackers
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\BugTrackers\Telerik.TestStudio.TeamPulseBugTracker.dll"...
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Uncategorized] BugTrackersLoader.LoadSystems() : TeamPulse Server implements IBugTracker and was loaded in the system.
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Uncategorized] BugTrackersLoader.LoadSystems() : Searching for IBugTracker implementers in "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins\BugTrackers\Telerik.TestStudio.TFSBugTracker.dll"...
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Uncategorized] BugTrackersLoader.LoadSystems() : Team Foundation Server implements IBugTracker and was loaded in the system.
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process launched (ID=6736, Path="C:\Program Files (x86)\Internet Explorer\iexplore.exe", Arguments="-nomerge about:blank").
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Attempting to attach on IE frame (HWND=4195922)...
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] Connector.Start() : Process launched (ID=8960, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 1049792").
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] Connector.Start() : Process exited (ID=8960, ExitCode=0, Path="C:\Windows\SysWOW64\rundll32.exe", Arguments="ArtOfTest.Connector.dll,AttachToWindowEntryPoint 1049792").
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] InternetExplorerActions.LaunchNewBrowserInstance() : Process "Telerik.TestStudio" (ID=9040) is assumed to host the controller.
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] Connector.InjectCode() : ------- Function Start -------
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] Connector.InjectCode() : Connection string: C:\Windows\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\2012.1.411.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?9040
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:5),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 1049792 on another thread...
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:7)] First trace message from pool thread "WaitAsync polling wait worker" (managed ID = 7, native ID = 7860).
[06.08 15:40:35,ArtOfTest.Runner.exe(2512:7),Framework] <>c__DisplayClassf.<WaitForDocument>b__8() : Attempting to get document from window handle
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:5),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:5),Framework] Connector.InjectCode() : Sending WM_COPYDATA to HWND 1049792 (lpData = "C:\Windows\assembly\GAC_MSIL\ArtOfTest.InternetExplorer\2012.1.411.0__5339893a7cefe4d6\ArtOfTest.InternetExplorer.dll?ArtOfTest.InternetExplorer.ArtOfTestPluginEntryPoint?9040")...
[06.08 15:40:36,iexplore.exe(3152:1)] First trace message from process 3152: "C:\Program Files (x86)\Internet Explorer\iexplore.exe" SCODEF:6736 CREDAT:145409
[06.08 15:40:36,iexplore.exe(3152:1)] First trace message from background thread "ArtOfTestPluginEntryPoint entry point thread" (managed ID = 1, native ID = 5980).
[06.08 15:40:36,iexplore.exe(3152:1),Framework] ArtOfTestPluginEntryPoint.Connect() : The .NET Framework is now active inside the hooked process (HWND = 1049792, PipeName = "Pipe.ArtOfTest.WebAii.BrowserProvisioner_1412327361", PID = 9040).
[06.08 15:40:36,iexplore.exe(3152:1),Framework] InternetExplorerActions.WaitForDocument() : Attempting to get IHTMLDocument2 from Internet Explorer HWND 1049792 on same thread...
[06.08 15:40:36,iexplore.exe(3152:1),Framework] InternetExplorerActions.WaitForDocument() : IHTMLDocument2 successfully retrieved.
[06.08 15:40:36,iexplore.exe(3152:1),Framework] BrowserRemoteClient constructor : The client ID for this hooked process will be "Client_72095713-fda4-485e-a5e9-fedc2cb20bde".
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:8)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 8, native ID = 6816).
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:8),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe.
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:13)] First trace message from background thread "Remoted async command listener" (managed ID = 13, native ID = 5144).
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Not connected; this will now wait indefinitely for a pipe client connection...
[06.08 15:40:36,iexplore.exe(3152:1),Framework] BrowserRemoteClient.CreateNamedPipes() : Named pipes created for communication with the server: {Command = "6c6e455f-bb99-4f80-b2c9-c3b4a4dadd67.CommandPipe", Async = "6c6e455f-bb99-4f80-b2c9-c3b4a4dadd67.AsyncPipe"}
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : A new client has connected to the pipe.
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:13),Framework] BrowserRemoted.AsyncListenerThreadEntry() : Now waiting indefinitely for a command from the pipe client...
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:8),Framework] Manager.AddNewBrowser() : Added client ID "Client_72095713-fda4-485e-a5e9-fedc2cb20bde" (now there is/are 1 total).
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:5),Framework] Connector.InjectCode() : Returned from sending WM_COPYDATA (LRESULT=0, GetLastError()=ERROR_ALREADY_EXISTS).
[06.08 15:40:36,ArtOfTest.Runner.exe(2512:5),Framework] Connector.InjectCode() : ------- Function End -------
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentResult() : VisualDebugger::SetCurrentResult
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),DialogPlayback] DialogMonitor.Start() : Beginning monitoring for dialogs from the set {}.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Execution] ExtensionsManager.LoadExtensions() : ------- Function Start -------
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Uncategorized] ExtensionsManager.LoadExtensions() : Got 2 plugin(s) in folder "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins".
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:12)] First trace message from foreground unnamed thread (managed ID = 12, native ID = 9024).
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:12),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "ArtOfTest.Common.TFSClient.dll" from plugins folder.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:12),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}.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Uncategorized] Utils.GetInterfaceImplementerTypes() : Scanning assemblies for derivatives of "ArtOfTest.WebAii.Design.Execution.IExecutionExtension"...
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:12),UIAutomation] AutomationExtensions.AddStructureChangedEventHandler() : Added a structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Uncategorized] Utils.GetInterfaceImplementerTypes() : Finished scan.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.QualityCenter.dll" from plugins folder.
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Execution] ExtensionsManager.LoadExtensions() : ------- Function End -------
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:37,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 5 "Navigate to : 'http://dmm-vm-prod/MediaCenterTRANS/'"...
[06.08 15:40:37,iexplore.exe(3152:1),Framework] FilterHelper.FilterFile() : ------- Function Start -------
[06.08 15:40:38,iexplore.exe(3152:1),Framework] FilterHelper.FilterFile() : Filter flag: True
[06.08 15:40:38,iexplore.exe(3152:1),Framework] FilterHelper.FilterFile() : ------- Function End -------
[06.08 15:40:39,ArtOfTest.Runner.exe(2512:12),DialogPlayback] DialogMonitor.AutomationEvent_OnValueChanged() : Named element "Address and search using Bing" changed its value from "" to "http://dmm-vm-prod/MediaCenterTRANS/".
[06.08 15:40:40,ArtOfTest.Runner.exe(2512:12),DialogPlayback] DialogMonitor.AutomationEvent_OnStructureChanged() : ChildAdded event sent by named element "VPMS MediaCenter".
[06.08 15:40:40,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 5 "Navigate to : 'http://dmm-vm-prod/MediaCenterTRANS/'".
[06.08 15:40:40,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:40,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:40,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:40,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:40,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:43,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 6 "LeftClick on Item0Textboxview"...
[06.08 15:40:44,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 6 "LeftClick on Item0Textboxview".
[06.08 15:40:44,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:44,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:44,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:44,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:44,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:44,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 7 "Type 'admin' into LoginUserNameBoxTextbox"...
[06.08 15:40:45,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 7 "Type 'admin' into LoginUserNameBoxTextbox".
[06.08 15:40:45,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:46,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:46,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:46,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:46,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:46,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 8 "LeftClick on Item1Textboxview"...
[06.08 15:40:47,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 8 "LeftClick on Item1Textboxview".
[06.08 15:40:47,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:47,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:47,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:47,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:47,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:48,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 9 "Type 'admin' into LoginPasswordBoxPasswordbox"...
[06.08 15:40:49,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 9 "Type 'admin' into LoginPasswordBoxPasswordbox".
[06.08 15:40:49,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:49,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:49,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:49,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:49,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:49,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 10 "Click LoginButtonButton"...
[06.08 15:40:50,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 10 "Click LoginButtonButton".
[06.08 15:40:50,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:50,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:50,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:50,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:50,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 11 "Click SearchButtonButton"...
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 11 "Click SearchButtonButton".
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:40:55,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 12 "Wait for '5000' msec."...
[06.08 15:41:00,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 12 "Wait for '5000' msec.".
[06.08 15:41:00,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:41:00,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:41:00,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:41:00,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:41:00,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyBeforeStepExecuted() : Executing step 13 "Verify 'NumResultsTextblock' text Contains '4'"...
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),Execution] ExecutionEngine.NotifyAfterStepExecuted() : Finished executing step 13 "Verify 'NumResultsTextblock' text Contains '4'".
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.SetCurrentStep() : VisualDebugger::SetCurrentStep
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),Error] SilverlightApp.Connect() : EXCEPTION! (see below)
     Situation: Error checking HTML access on Silverlight app
     Outer Exception Type: ArtOfTest.WebAii.Exceptions.ExecuteCommandException
     Message: ExecuteCommand failed!
          InError set by the client. Client Error:
          System.InvalidOperationException: Javascript call [document.getElementsByTagName(\'object\')[0].settings.enableHtmlAccess] failed! Please make the function exists and the call is using the correct prototype signature. Javascript error: [object Error]
          at ArtOfTest.InternetExplorer.IECommandProcessor.InvokeFunction(String functionCall, Boolean useEval, Boolean returnJSON)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessActionCommands(BrowserCommand request)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessCommand(WebBrowserClass ieInstance, BrowserCommand request, IHTMLDocument2 document)
          BrowserCommand (Type:'Action',Info:'NotSet',Action:'InvokeJsFunction',Target:'ElementId (tagName: '',occurrenceIndex: '-1')',Data:'document.getElementsByTagName(\'object\')[0].settings.enableHtmlAccess',ClientId:'Client_72095713-fda4-485e-a5e9-fedc2cb20bde',HasFrames:'False',FramesInfo:'',TargetFrameIndex:'-1',InError:'True',Response:'System.InvalidOperationException: Javascript call [document.getElementsByTagName(\'object\')[0].settings.enableHtmlAccess] failed! Please make the function exists and the call is using the correct prototype signature. Javascript error: [object Error]
          at ArtOfTest.InternetExplorer.IECommandProcessor.InvokeFunction(String functionCall, Boolean useEval, Boolean returnJSON)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessActionCommands(BrowserCommand request)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessCommand(WebBrowserClass ieInstance, BrowserCommand request, IHTMLDocument2 document)')
          InnerException: none.
     HRESULT: 0x80131500 (Official ID (if app.) = COR_E_EXCEPTION, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5376)
     Call Stack:
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommandInternal(BrowserCommand request)
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommand(BrowserCommand request, Boolean performDomRefresh, Boolean waitUntilReady)
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommand(BrowserCommand request)
          at ArtOfTest.WebAii.Core.Actions.InvokeScript(String script)
          at ArtOfTest.WebAii.BrowserSpecialized.InternetExplorer.InternetExplorerActions.InvokeScript(String script)
          at ArtOfTest.WebAii.Controls.HtmlControls.HtmlControl.GetValue[T](String propertyName, T defaultValue)
          at ArtOfTest.WebAii.Controls.HtmlControls.HtmlControl.GetValue[T](String propertyName)
          at ArtOfTest.WebAii.Silverlight.SilverlightAppSettings.GetValue[T](String propertyName)
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.Connect(Int32 timeout)

[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),Error] ExecutionEngine.ExecuteStep() : EXCEPTION! (see below)
     Outer Exception Type: ArtOfTest.WebAii.Silverlight.ApplicationNotReadyException
     Message: Error checking HTML access on Silverlight app
     HRESULT: 0x80131500 (Official ID (if app.) = COR_E_EXCEPTION, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5376)
     Call Stack:
          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)

     Inner Exception Type: ArtOfTest.WebAii.Exceptions.ExecuteCommandException
     Message: ExecuteCommand failed!
          InError set by the client. Client Error:
          System.InvalidOperationException: Javascript call [document.getElementsByTagName(\'object\')[0].settings.enableHtmlAccess] failed! Please make the function exists and the call is using the correct prototype signature. Javascript error: [object Error]
          at ArtOfTest.InternetExplorer.IECommandProcessor.InvokeFunction(String functionCall, Boolean useEval, Boolean returnJSON)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessActionCommands(BrowserCommand request)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessCommand(WebBrowserClass ieInstance, BrowserCommand request, IHTMLDocument2 document)
          BrowserCommand (Type:'Action',Info:'NotSet',Action:'InvokeJsFunction',Target:'ElementId (tagName: '',occurrenceIndex: '-1')',Data:'document.getElementsByTagName(\'object\')[0].settings.enableHtmlAccess',ClientId:'Client_72095713-fda4-485e-a5e9-fedc2cb20bde',HasFrames:'False',FramesInfo:'',TargetFrameIndex:'-1',InError:'True',Response:'System.InvalidOperationException: Javascript call [document.getElementsByTagName(\'object\')[0].settings.enableHtmlAccess] failed! Please make the function exists and the call is using the correct prototype signature. Javascript error: [object Error]
          at ArtOfTest.InternetExplorer.IECommandProcessor.InvokeFunction(String functionCall, Boolean useEval, Boolean returnJSON)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessActionCommands(BrowserCommand request)
          at ArtOfTest.InternetExplorer.IECommandProcessor.ProcessCommand(WebBrowserClass ieInstance, BrowserCommand request, IHTMLDocument2 document)')
          InnerException: none.
     HRESULT: 0x80131500 (Official ID (if app.) = COR_E_EXCEPTION, Error Bit = FAILED, Facility = FACILITY_URT, Code = 5376)
     Call Stack:
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommandInternal(BrowserCommand request)
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommand(BrowserCommand request, Boolean performDomRefresh, Boolean waitUntilReady)
          at ArtOfTest.WebAii.Core.Browser.ExecuteCommand(BrowserCommand request)
          at ArtOfTest.WebAii.Core.Actions.InvokeScript(String script)
          at ArtOfTest.WebAii.BrowserSpecialized.InternetExplorer.InternetExplorerActions.InvokeScript(String script)
          at ArtOfTest.WebAii.Controls.HtmlControls.HtmlControl.GetValue[T](String propertyName, T defaultValue)
          at ArtOfTest.WebAii.Controls.HtmlControls.HtmlControl.GetValue[T](String propertyName)
          at ArtOfTest.WebAii.Silverlight.SilverlightAppSettings.GetValue[T](String propertyName)
          at ArtOfTest.WebAii.Silverlight.SilverlightApp.Connect(Int32 timeout)

[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::Start
[06.08 15:41:02,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::BreakOnFail
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.CheckPause() : VisualDebugger::CheckPause::End
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::ShutDown::Start
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::Start
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DetachWrappedWindow::End
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::DispatcherBeginInvokeShutdown::Start
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Uncategorized] AdornerWindow.ShutDown() : AdornerWnd::Close::Start
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_1412327361" in order to unblock and eventually terminate it...
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:8),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Framework] Manager.RemoveBrowser() : Removed client ID "Client_72095713-fda4-485e-a5e9-fedc2cb20bde" (0 remaining).
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:5),Framework] BrowserRemoted.End() : Now aborting the listener thread (TID = 13).
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:12),UIAutomation] AutomationExtensions.RemoveAutomationPropertyChangedEventHandler() : Removed the property change handler on element System.Windows.Automation.AutomationElement scope Subtree.
[06.08 15:41:03,ArtOfTest.Runner.exe(2512:13),Warning] PipeCommunication.AsyncPipeRead() : Pipe read wait broken by thread-abort.
[06.08 15:41:03,iexplore.exe(3152:1),Framework] BrowserRemoteClient.Disconnect() : Sending ClientDisconnectRequest(ClientId="Client_72095713-fda4-485e-a5e9-fedc2cb20bde") to pipe server...
[06.08 15:41:03,iexplore.exe(3152:1),Framework] BrowserRemoteClient.Disconnect() : Command pipe is already disconnected.
[06.08 15:41:04,ArtOfTest.Runner.exe(2512:5),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[06.08 15:41:05,ArtOfTest.Runner.exe(2512:12),UIAutomation] AutomationExtensions.RemoveStructureChangedEventHandler() : Removed the structure change handler on element System.Windows.Automation.AutomationElement scope Subtree.
