Skip to content

Instantly share code, notes, and snippets.

@koichirok

koichirok/iedriver32.log

Created July 13, 2017 07:11
Show Gist options
  • Save koichirok/1f5b6debcb85d30ebd4f7120ef513b60 to your computer and use it in GitHub Desktop.
Save koichirok/1f5b6debcb85d30ebd4f7120ef513b60 to your computer and use it in GitHub Desktop.
Download ZIP
IEDriverServer (32bit)'s trace log (https://github.com/SeleniumHQ/selenium/issues/4288)
Raw
iedriver32.log
I 2017-07-13 16:04:30:737 server.cc(86) Starting WebDriver server on port: '36390' on host: ''
T 2017-07-13 16:04:30:737 server.cc(630) Entering Server::PopulateCommandRepository
T 2017-07-13 16:04:30:737 IEServer.cpp(32) Entering IEServer::IEServer
I 2017-07-13 16:04:30:737 IEServer.cpp(33) Driver version: 3.4.0.0 (32-bit)
T 2017-07-13 16:04:30:737 server.cc(121) Entering Server::Start
D 2017-07-13 16:04:30:737 server.cc(148) Civetweb ACL is -0.0.0.0/0,+127.0.0.1
T 2017-07-13 16:04:31:146 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:31:146 server.cc(183) Process request with: URI: /status HTTP verb: GET
body: {}
T 2017-07-13 16:04:31:146 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:31:146 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:31:147 server.cc(281) Command: GET /status {}
T 2017-07-13 16:04:31:147 IEServer.cpp(50) Entering IEServer::GetStatus
T 2017-07-13 16:04:31:147 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:31:147 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:31:147 response.cc(51) Entering Response::Serialize
D 2017-07-13 16:04:31:147 server.cc(355) Response: {"sessionId":"","status":0,"value":{"build":{"version":"3.4.0.0 (32-bit)"},"os":{"arch":"x64","name":"windows","version":"10.0.15063.0 (WinBuild.160101.0800)"}}}
T 2017-07-13 16:04:31:147 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:31:147 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:31:147 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:31:269 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:31:269 server.cc(238) Entering Server::ReadRequestBody
T 2017-07-13 16:04:31:269 server.cc(183) Process request with: URI: /session HTTP verb: POST
body: {
"desiredCapabilities": {
"ensureCleanSession": true,
"se:ieOptions": {},
"browserName": "internet explorer",
"version": "",
"platform": "WINDOWS"
},
"requiredCapabilities": {},
"capabilities": {
"desiredCapabilities": {
"ensureCleanSession": true,
"se:ieOptions": {},
"browserName": "internet explorer",
"version": "",
"platform": "WINDOWS"
},
"requiredCapabilities": {},
"alwaysMatch": {
"se:ieOptions": {}
},
"firstMatch": [
{
"browserName": "internet explorer"
}
]
}
}
T 2017-07-13 16:04:31:269 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:31:269 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:31:270 server.cc(281) Command: POST /session {
"desiredCapabilities": {
"ensureCleanSession": true,
"se:ieOptions": {},
"browserName": "internet explorer",
"version": "",
"platform": "WINDOWS"
},
"requiredCapabilities": {},
"capabilities": {
"desiredCapabilities": {
"ensureCleanSession": true,
"se:ieOptions": {},
"browserName": "internet explorer",
"version": "",
"platform": "WINDOWS"
},
"requiredCapabilities": {},
"alwaysMatch": {
"se:ieOptions": {}
},
"firstMatch": [
{
"browserName": "internet explorer"
}
]
}
}
T 2017-07-13 16:04:31:270 IEServer.cpp(41) Entering IEServer::InitializeSession
T 2017-07-13 16:04:31:270 IESession.cpp(38) Entering IESession::Initialize
D 2017-07-13 16:04:31:270 IESession.cpp(53) Mutex acquired for session initalization
T 2017-07-13 16:04:31:270 IECommandExecutor.cpp(391) Entering IECommandExecutor::ThreadProc
T 2017-07-13 16:04:31:273 IECommandExecutor.cpp(47) Entering IECommandExecutor::OnCreate
T 2017-07-13 16:04:31:273 IECommandExecutor.cpp(753) Entering IECommandExecutor::PopulateElementFinderMethods
T 2017-07-13 16:04:31:273 InputManager.cpp(40) Entering InputManager::InputManager
T 2017-07-13 16:04:31:273 InputManager.cpp(68) Entering InputManager::Initialize
T 2017-07-13 16:04:31:273 BrowserFactory.cpp(998) Entering BrowserFactory::GetExecutableLocation
T 2017-07-13 16:04:31:273 BrowserFactory.cpp(1039) Entering BrowserFactory::GetIEVersion
T 2017-07-13 16:04:31:274 CommandHandlerRepository.cpp(114) Entering CommandHandlerRepository::PopulateCommandHandlers
T 2017-07-13 16:04:31:274 IESession.cpp(99) Created thread for command executor returns HWND: '00400304'
T 2017-07-13 16:04:31:274 IESession.cpp(103) Session id is retrived from command executor window: '47a865a0-04d7-41e1-8f95-3c4220efd28b'
D 2017-07-13 16:04:31:274 IESession.cpp(109) Releasing session initialization mutex
T 2017-07-13 16:04:31:274 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:31:274 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:31:274 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:31:274 command.cc(36) Raw JSON command: { "name" : "newSession", "locator" : { }, "parameters" : {
"desiredCapabilities": {
"ensureCleanSession": true,
"se:ieOptions": {},
"browserName": "internet explorer",
"version": "",
"platform": "WINDOWS"
},
"requiredCapabilities": {},
"capabilities": {
"desiredCapabilities": {
"ensureCleanSession": true,
"se:ieOptions": {},
"browserName": "internet explorer",
"version": "",
"platform": "WINDOWS"
},
"requiredCapabilities": {},
"alwaysMatch": {
"se:ieOptions": {}
},
"firstMatch": [
{
"browserName": "internet explorer"
}
]
}
} }
T 2017-07-13 16:04:31:274 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:31:274 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:31:274 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:31:274 BrowserFactory.cpp(113) Entering BrowserFactory::Initialize
T 2017-07-13 16:04:31:275 IECommandExecutor.cpp(628) Entering IECommandExecutor::CreateNewBrowser
T 2017-07-13 16:04:31:275 BrowserFactory.cpp(142) Entering BrowserFactory::LaunchBrowserProcess
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(146) Ignoring Protected Mode Settings: 0
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(149) Checking validity of Protected Mode settings.
T 2017-07-13 16:04:31:275 BrowserFactory.cpp(1058) Entering BrowserFactory::ProtectedModeSettingsAreValid
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(1061) Detected IE version: 11, Windows version supports Protected Mode: 1
T 2017-07-13 16:04:31:275 BrowserFactory.cpp(1135) Entering BrowserFactory::GetZoneProtectedModeSetting
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(1152) Found Protected Mode setting value of 0 for zone 1
T 2017-07-13 16:04:31:275 BrowserFactory.cpp(1135) Entering BrowserFactory::GetZoneProtectedModeSetting
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(1152) Found Protected Mode setting value of 0 for zone 2
T 2017-07-13 16:04:31:275 BrowserFactory.cpp(1135) Entering BrowserFactory::GetZoneProtectedModeSetting
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(1152) Found Protected Mode setting value of 0 for zone 3
T 2017-07-13 16:04:31:275 BrowserFactory.cpp(1135) Entering BrowserFactory::GetZoneProtectedModeSetting
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(1152) Found Protected Mode setting value of 0 for zone 4
D 2017-07-13 16:04:31:275 BrowserFactory.cpp(152) Has Valid Protected Mode Settings: 1
T 2017-07-13 16:04:31:275 BrowserFactory.cpp(226) Entering BrowserFactory::IsIELaunchURLAvailable
T 2017-07-13 16:04:31:281 BrowserFactory.cpp(130) Entering BrowserFactory::ClearCache
T 2017-07-13 16:04:31:281 BrowserFactory.cpp(247) Entering BrowserFactory::LaunchBrowserUsingIELaunchURL
D 2017-07-13 16:04:31:281 BrowserFactory.cpp(248) Starting IE using the IELaunchURL API
D 2017-07-13 16:04:31:511 BrowserFactory.cpp(202) IE launched successfully with process ID 77916
D 2017-07-13 16:04:31:511 BrowserFactory.cpp(208) Process with ID 77916 is executing iexplore.exe
T 2017-07-13 16:04:31:511 BrowserFactory.cpp(365) Entering BrowserFactory::AttachToBrowser
D 2017-07-13 16:04:31:511 BrowserFactory.cpp(375) Using Active Accessibility to find IWebBrowser2 interface
T 2017-07-13 16:04:31:511 BrowserFactory.cpp(414) Entering BrowserFactory::AttachToBrowserUsingActiveAccessibility
T 2017-07-13 16:04:32:609 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:32:609 server.cc(183) Process request with: URI: / HTTP verb: GET
body: {}
T 2017-07-13 16:04:32:609 server.cc(462) Entering Server::SendHttpOk
D 2017-07-13 16:04:32:765 BrowserFactory.cpp(434) Found window handle 000E09E0 for window with class 'Internet Explorer_Server' belonging to process with id 77916
T 2017-07-13 16:04:32:765 BrowserFactory.cpp(329) Entering BrowserFactory::GetDocumentFromWindowHandle
D 2017-07-13 16:04:32:806 BrowserFactory.cpp(396) Ignoring zoom setting: 0
T 2017-07-13 16:04:32:806 BrowserFactory.cpp(574) Entering BrowserFactory::GetBrowserZoomLevel
T 2017-07-13 16:04:32:815 BrowserFactory.cpp(614) Entering BrowserFactory::GetZoomLevel
D 2017-07-13 16:04:32:825 BrowserFactory.cpp(694) Browser zoom level is 100%
I 2017-07-13 16:04:32:828 IECommandExecutor.cpp(650) Persistent hovering set to: 1
T 2017-07-13 16:04:32:828 ProxyManager.cpp(95) ProxyManager::SetProxySettings
D 2017-07-13 16:04:32:829 ProxyManager.cpp(111) Using existing system proxy settings.
T 2017-07-13 16:04:32:829 DocumentHost.cpp(33) Entering DocumentHost::DocumentHost
T 2017-07-13 16:04:32:829 CookieManager.cpp(49) Entering CookieManager::Initialize
T 2017-07-13 16:04:32:829 Browser.cpp(33) Entering Browser::Browser
T 2017-07-13 16:04:32:829 Browser.cpp(293) Entering Browser::AttachEvents
T 2017-07-13 16:04:32:831 IECommandExecutor.cpp(618) Entering IECommandExecutor::AddManagedBrowser
T 2017-07-13 16:04:32:831 IECommandExecutor.cpp(622) Setting current browser id to d539bff9-cca3-4bb3-a92f-28a838e405b5
T 2017-07-13 16:04:32:832 response.cc(84) Entering Response::SetNewSessionResponse
T 2017-07-13 16:04:32:832 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:32:832 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:32:832 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:32:832 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:32:839 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:32:839 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:32:839 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
T 2017-07-13 16:04:32:839 response.cc(36) Entering Response::Deserialize
D 2017-07-13 16:04:32:839 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":{"browserName":"internet explorer","javascriptEnabled":true,"pageLoadStrategy":"normal","platform":"WINDOWS","se:ieOptions":{"browserAttachTimeout":0,"elementScrollBehavior":0,"enableElementCacheCleanup":true,"enablePersistentHover":true,"ie.browserCommandLineSwitches":"","ie.enableFullPageScreenshot":true,"ie.ensureCleanSession":false,"ie.fileUploadDialogTimeout":3000,"ie.forceCreateProcessApi":false,"ie.forceShellWindowsApi":false,"ie.useLegacyFileUploadDialogHandling":false,"ignoreProtectedModeSettings":false,"ignoreZoomSetting":false,"initialBrowserUrl":"http://localhost:36390/","nativeEvents":true,"requireWindowFocus":false},"unexpectedAlertBehaviour":"dismiss","version":"11"}}
T 2017-07-13 16:04:32:839 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:32:839 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:32:839 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:32:877 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:32:877 server.cc(238) Entering Server::ReadRequestBody
T 2017-07-13 16:04:32:877 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/url HTTP verb: POST
body: {"url":"www.seleniumhq.org"}
T 2017-07-13 16:04:32:877 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:32:877 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:32:877 server.cc(281) Command: POST /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/url {"url":"www.seleniumhq.org"}
T 2017-07-13 16:04:32:877 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:32:877 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:32:877 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:32:877 command.cc(36) Raw JSON command: { "name" : "get", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {"url":"www.seleniumhq.org"} }
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:32:877 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:32:877 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:32:877 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:32:877 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:32:877 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:32:877 Browser.cpp(318) Entring Browser::NavigateToUrl
T 2017-07-13 16:04:32:878 DocumentHost.cpp(132) Entering DocumentHost::SetFocusedFrameByElement
T 2017-07-13 16:04:32:878 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:32:878 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:32:878 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:32:878 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:32:878 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:32:879 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:32:879 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:32:879 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:32:879 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:32:879 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:32:879 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:32:879 Browser.cpp(206) Entering Browser::GetContentWindowHandle
T 2017-07-13 16:04:32:879 Browser.cpp(50) Entering Browser::BeforeNavigate2
D 2017-07-13 16:04:32:879 Browser.cpp(484) Browser ReadyState is not at least '4'; it was 1
T 2017-07-13 16:04:32:879 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:33:080 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:33:080 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:33:080 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:33:080 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:33:080 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:33:080 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:33:080 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:33:081 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:33:081 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:33:282 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:33:282 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:33:282 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:33:282 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:33:282 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:33:282 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:33:282 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:33:283 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:33:283 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:33:484 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:33:484 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:33:484 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:33:484 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:33:484 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:33:484 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:33:484 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:33:485 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:33:486 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:33:687 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:33:687 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:33:687 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:33:688 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:33:688 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:33:688 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:33:688 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:33:689 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:33:690 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:33:692 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:33:692 server.cc(183) Process request with: URI: /favicon.ico HTTP verb: GET
body: {}
T 2017-07-13 16:04:33:692 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:33:692 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:33:692 server.cc(281) Command: GET /favicon.ico {}
D 2017-07-13 16:04:33:692 server.cc(355) Response: { "status" : 404, "sessionId" : "<no session>", "value" : "Command not found: GET /favicon.ico" }
T 2017-07-13 16:04:33:692 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:33:692 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:33:692 server.cc(519) Entering Server::SendHttpNotFound
T 2017-07-13 16:04:33:891 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:33:891 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:33:891 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:33:891 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:33:891 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:33:891 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:33:891 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:33:893 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:33:893 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:34:094 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:34:094 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:34:094 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:34:094 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:34:094 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:34:094 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:34:094 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:34:096 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:34:096 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:34:297 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:34:297 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:34:297 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:34:297 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:34:297 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:34:297 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:34:297 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:34:297 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:34:298 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:34:500 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:34:500 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:34:500 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:34:500 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:34:500 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:34:500 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:34:500 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:34:501 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:34:501 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:34:702 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:34:702 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:34:702 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:34:702 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:34:702 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:34:702 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:34:703 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:34:703 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:34:704 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:34:905 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:34:905 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:34:905 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:34:905 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:34:905 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:34:905 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:34:905 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:34:905 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:34:906 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:34:965 Browser.cpp(96) Entering Browser::DocumentComplete
D 2017-07-13 16:04:34:965 ElementRepository.cpp(113) Refreshing managed element cache. Found 0 to remove from cache.
T 2017-07-13 16:04:35:106 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:35:106 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:106 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:106 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:35:106 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:35:106 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:106 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:108 Browser.cpp(508) Waiting for document to complete...
T 2017-07-13 16:04:35:108 Browser.cpp(522) Entering Browser::IsDocumentNavigating
D 2017-07-13 16:04:35:120 Browser.cpp(513) Not in navigating state
T 2017-07-13 16:04:35:129 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:35:129 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:35:130 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:35:130 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":null}
T 2017-07-13 16:04:35:130 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:35:130 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:35:130 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:35:137 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:35:137 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window_handle HTTP verb: GET
body: {}
T 2017-07-13 16:04:35:137 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:35:137 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:35:137 server.cc(281) Command: GET /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window_handle {}
T 2017-07-13 16:04:35:137 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:35:137 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:35:138 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:35:138 command.cc(36) Raw JSON command: { "name" : "getWindowHandle", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {} }
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:35:138 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:35:138 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:138 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:138 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:138 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:35:138 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:138 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:138 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:35:148 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:35:149 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:35:149 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:35:149 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":"d539bff9-cca3-4bb3-a92f-28a838e405b5"}
T 2017-07-13 16:04:35:149 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:35:149 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:35:149 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:35:154 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:35:154 server.cc(238) Entering Server::ReadRequestBody
T 2017-07-13 16:04:35:154 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/element HTTP verb: POST
body: {"using":"link text","value":"Download"}
T 2017-07-13 16:04:35:154 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:35:154 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:35:154 server.cc(281) Command: POST /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/element {"using":"link text","value":"Download"}
T 2017-07-13 16:04:35:154 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:35:154 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:35:154 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:35:154 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:35:154 command.cc(36) Raw JSON command: { "name" : "findElement", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {"using":"link text","value":"Download"} }
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:155 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:35:155 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:155 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:155 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(712) Entering IECommandExecutor::LocateElement
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(695) Entering IECommandExecutor::GetElementFindMethod
T 2017-07-13 16:04:35:155 ElementFinder.cpp(43) Entering ElementFinder::FindElement
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:155 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
D 2017-07-13 16:04:35:155 ElementFinder.cpp(60) Using FindElement atom to locate element having linkText = Download
T 2017-07-13 16:04:35:155 Browser.cpp(126) Entering Browser::GetDocument
I 2017-07-13 16:04:35:155 Browser.cpp(130) No child frame focus. Focus is on top-level frame
T 2017-07-13 16:04:35:167 Browser.cpp(613) Entering Browser::GetDocumentFromWindow
T 2017-07-13 16:04:35:173 Script.cpp(49) Entering Script::Initialize
T 2017-07-13 16:04:35:173 Script.cpp(70) Entering Script::AddArgument(std::wstring)
T 2017-07-13 16:04:35:173 Script.cpp(105) Entering Script::AddArgument(VARIANT)
T 2017-07-13 16:04:35:173 Script.cpp(70) Entering Script::AddArgument(std::wstring)
T 2017-07-13 16:04:35:173 Script.cpp(105) Entering Script::AddArgument(VARIANT)
T 2017-07-13 16:04:35:173 Script.cpp(169) Entering Script::Execute
T 2017-07-13 16:04:35:173 Script.cpp(477) Entering Script::CreateAnonymousFunction
T 2017-07-13 16:04:35:212 Script.cpp(426) Entering Script::ConvertResultToJsonValue
D 2017-07-13 16:04:35:216 VariantUtilities.cpp(100) Result type is JScriptTypeInfo
T 2017-07-13 16:04:35:218 VariantUtilities.cpp(258) Entering Script::GetPropertyNameList
I 2017-07-13 16:04:35:228 VariantUtilities.cpp(184) Unknown type of dispatch is found in result, assuming IHTMLElement
T 2017-07-13 16:04:35:230 IECommandExecutor.cpp(677) Entering IECommandExecutor::AddManagedElement
T 2017-07-13 16:04:35:230 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:230 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:230 ElementRepository.cpp(49) Entering ElementRepository::AddManagedElement
D 2017-07-13 16:04:35:230 ElementRepository.cpp(69) Element is not yet managed
T 2017-07-13 16:04:35:230 Browser.cpp(206) Entering Browser::GetContentWindowHandle
T 2017-07-13 16:04:35:230 Element.cpp(44) Entering Element::Element
T 2017-07-13 16:04:35:230 Element.cpp(79) Entering Element::ConvertToJson
T 2017-07-13 16:04:35:231 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:35:231 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:35:231 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:231 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:231 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:35:235 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:35:235 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:35:235 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:35:236 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":{"ELEMENT":"34e7ab19-28ea-4551-8ce8-ea0e1f26cad6","element-6066-11e4-a52e-4f735466cecf":"34e7ab19-28ea-4551-8ce8-ea0e1f26cad6"}}
T 2017-07-13 16:04:35:236 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:35:236 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:35:236 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:35:244 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:35:244 server.cc(238) Entering Server::ReadRequestBody
T 2017-07-13 16:04:35:244 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/element/34e7ab19-28ea-4551-8ce8-ea0e1f26cad6/value HTTP verb: POST
body: {"id":"34e7ab19-28ea-4551-8ce8-ea0e1f26cad6","value":[""]}
T 2017-07-13 16:04:35:244 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:35:244 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:35:244 server.cc(281) Command: POST /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/element/34e7ab19-28ea-4551-8ce8-ea0e1f26cad6/value {"id":"34e7ab19-28ea-4551-8ce8-ea0e1f26cad6","value":[""]}
T 2017-07-13 16:04:35:244 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:35:244 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:35:244 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:35:244 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:35:244 command.cc(36) Raw JSON command: { "name" : "sendKeys", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b", "id" : "34e7ab19-28ea-4551-8ce8-ea0e1f26cad6" }, "parameters" : {"id":"34e7ab19-28ea-4551-8ce8-ea0e1f26cad6","value":[""]} }
T 2017-07-13 16:04:35:244 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:35:244 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:35:244 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:35:244 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:244 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:244 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:35:244 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:244 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:245 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:35:245 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:245 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:245 Browser.cpp(206) Entering Browser::GetContentWindowHandle
T 2017-07-13 16:04:35:245 Browser.cpp(416) Entering Browser::GetTopLevelWindowHandle
T 2017-07-13 16:04:35:245 IECommandHandler.cpp(45) Entering IECommandHandler::GetElement
T 2017-07-13 16:04:35:245 IECommandExecutor.cpp(671) Entering IECommandExecutor::GetManagedElement
T 2017-07-13 16:04:35:245 ElementRepository.cpp(34) Entering ElementRepository::GetManagedElement
T 2017-07-13 16:04:35:253 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:253 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:253 Browser.cpp(126) Entering Browser::GetDocument
I 2017-07-13 16:04:35:253 Browser.cpp(130) No child frame focus. Focus is on top-level frame
T 2017-07-13 16:04:35:261 Browser.cpp(613) Entering Browser::GetDocumentFromWindow
T 2017-07-13 16:04:35:265 Element.cpp(312) Entering Element::GetLocationOnceScrolledIntoView
T 2017-07-13 16:04:35:265 Element.cpp(443) Entering Element::GetLocation
T 2017-07-13 16:04:35:266 Element.cpp(579) Entering Element::IsInline
D 2017-07-13 16:04:35:270 Element.cpp(485) Element is inline with one client rect, using IHTMLElement2::getBoundingClientRect
T 2017-07-13 16:04:35:272 Element.cpp(600) Entering Element::RectHasNonZeroDimensions
T 2017-07-13 16:04:35:274 Element.cpp(616) Entering Element::GetFrameDetails
T 2017-07-13 16:04:35:274 Element.cpp(906) Entering Element::GetContainingDocument
D 2017-07-13 16:04:35:290 Element.cpp(566) Element is not in a frame
T 2017-07-13 16:04:35:290 Element.cpp(855) Entering Element::CalculateClickPoint
T 2017-07-13 16:04:35:290 Element.cpp(794) Entering Element::GetClickableViewPortLocation
T 2017-07-13 16:04:35:290 Element.cpp(906) Entering Element::GetContainingDocument
T 2017-07-13 16:04:35:292 DocumentHost.cpp(271) Entering DocumentHost::GetDocumentMode
T 2017-07-13 16:04:35:303 Element.cpp(881) Entering Element::IsLocationInViewPort
T 2017-07-13 16:04:35:303 Element.cpp(794) Entering Element::GetClickableViewPortLocation
T 2017-07-13 16:04:35:303 Element.cpp(906) Entering Element::GetContainingDocument
T 2017-07-13 16:04:35:305 DocumentHost.cpp(271) Entering DocumentHost::GetDocumentMode
T 2017-07-13 16:04:35:316 Element.cpp(379) Entering Element::IsHiddenByOverflow
T 2017-07-13 16:04:35:316 Element.cpp(906) Entering Element::GetContainingDocument
T 2017-07-13 16:04:35:317 Script.cpp(49) Entering Script::Initialize
T 2017-07-13 16:04:35:317 Script.cpp(99) Entering Script::AddArgument(IHTMLElement*)
T 2017-07-13 16:04:35:317 Script.cpp(105) Entering Script::AddArgument(VARIANT)
T 2017-07-13 16:04:35:317 Script.cpp(169) Entering Script::Execute
T 2017-07-13 16:04:35:317 Script.cpp(477) Entering Script::CreateAnonymousFunction
T 2017-07-13 16:04:35:345 Script.cpp(433) Entering Script::ConvertResultToString
D 2017-07-13 16:04:35:345 Script.cpp(444) Result type is string
D 2017-07-13 16:04:35:345 Element.cpp(358) (x, y, w, h): 563, 84, 89, 24
T 2017-07-13 16:04:35:346 Element.cpp(91) Entering Element::IsDisplayed
T 2017-07-13 16:04:35:346 Element.cpp(906) Entering Element::GetContainingDocument
T 2017-07-13 16:04:35:347 Script.cpp(49) Entering Script::Initialize
T 2017-07-13 16:04:35:347 Script.cpp(99) Entering Script::AddArgument(IHTMLElement*)
T 2017-07-13 16:04:35:347 Script.cpp(105) Entering Script::AddArgument(VARIANT)
T 2017-07-13 16:04:35:347 Script.cpp(88) Entering Script::AddArgument(bool)
T 2017-07-13 16:04:35:347 Script.cpp(105) Entering Script::AddArgument(VARIANT)
T 2017-07-13 16:04:35:347 Script.cpp(169) Entering Script::Execute
T 2017-07-13 16:04:35:347 Script.cpp(477) Entering Script::CreateAnonymousFunction
T 2017-07-13 16:04:35:378 Element.cpp(135) Entering Element::IsEnabled
T 2017-07-13 16:04:35:379 Element.cpp(906) Entering Element::GetContainingDocument
T 2017-07-13 16:04:35:381 Script.cpp(49) Entering Script::Initialize
T 2017-07-13 16:04:35:381 Script.cpp(99) Entering Script::AddArgument(IHTMLElement*)
T 2017-07-13 16:04:35:381 Script.cpp(105) Entering Script::AddArgument(VARIANT)
T 2017-07-13 16:04:35:381 Script.cpp(169) Entering Script::Execute
T 2017-07-13 16:04:35:381 Script.cpp(477) Entering Script::CreateAnonymousFunction
T 2017-07-13 16:04:35:418 InputManager.cpp(73) Entering InputManager::PerformInputSequence
D 2017-07-13 16:04:35:418 InputManager.cpp(94) Mutex acquired for user interaction.
T 2017-07-13 16:04:35:419 InputManager.cpp(540) Entering InputManager::SendKeystrokes
T 2017-07-13 16:04:35:419 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:419 InputManager.cpp(567) Using SendMessage method for sending keys
T 2017-07-13 16:04:35:419 HookProcessor.cpp(93) Entering HookProcessor::Initialize
T 2017-07-13 16:04:35:419 HookProcessor.cpp(103) Entering HookProcessor::Initialize
T 2017-07-13 16:04:35:419 HookProcessor.cpp(166) Entering HookProcessor::InstallWindowsHook
T 2017-07-13 16:04:35:433 Browser.cpp(63) Entering Browser::NewWindow3
T 2017-07-13 16:04:35:433 IECommandExecutor.cpp(218) Entering IECommandExecutor::OnBrowserNewWindow
T 2017-07-13 16:04:35:433 BrowserFactory.cpp(699) Entering BrowserFactory::CreateBrowser
T 2017-07-13 16:04:35:647 DocumentHost.cpp(33) Entering DocumentHost::DocumentHost
T 2017-07-13 16:04:35:647 CookieManager.cpp(49) Entering CookieManager::Initialize
T 2017-07-13 16:04:35:648 Browser.cpp(33) Entering Browser::Browser
T 2017-07-13 16:04:35:648 Browser.cpp(293) Entering Browser::AttachEvents
T 2017-07-13 16:04:35:654 Browser.cpp(659) Entering Browser::GetBrowserWindowHandle
T 2017-07-13 16:04:35:655 ProxyManager.cpp(95) ProxyManager::SetProxySettings
D 2017-07-13 16:04:35:655 ProxyManager.cpp(111) Using existing system proxy settings.
T 2017-07-13 16:04:35:655 IECommandExecutor.cpp(618) Entering IECommandExecutor::AddManagedBrowser
T 2017-07-13 16:04:35:675 Browser.cpp(50) Entering Browser::BeforeNavigate2
T 2017-07-13 16:04:35:690 HookProcessor.cpp(243) Entering HookProcessor::Dispose
T 2017-07-13 16:04:35:690 HookProcessor.cpp(196) Entering HookProcessor::UninstallWindowsHook
T 2017-07-13 16:04:35:691 HookProcessor.cpp(243) Entering HookProcessor::Dispose
T 2017-07-13 16:04:35:691 HookProcessor.cpp(93) Entering HookProcessor::Initialize
T 2017-07-13 16:04:35:691 HookProcessor.cpp(103) Entering HookProcessor::Initialize
T 2017-07-13 16:04:35:691 HookProcessor.cpp(166) Entering HookProcessor::InstallWindowsHook
T 2017-07-13 16:04:35:692 HookProcessor.cpp(243) Entering HookProcessor::Dispose
T 2017-07-13 16:04:35:692 HookProcessor.cpp(196) Entering HookProcessor::UninstallWindowsHook
T 2017-07-13 16:04:35:692 HookProcessor.cpp(243) Entering HookProcessor::Dispose
T 2017-07-13 16:04:35:692 HookProcessor.cpp(243) Entering HookProcessor::Dispose
T 2017-07-13 16:04:35:692 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:35:692 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:35:692 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:692 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:692 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:35:696 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:35:696 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:35:696 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:35:696 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":null}
T 2017-07-13 16:04:35:696 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:35:696 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:35:696 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:35:701 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:35:701 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window_handles HTTP verb: GET
body: {}
T 2017-07-13 16:04:35:701 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:35:701 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:35:701 server.cc(281) Command: GET /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window_handles {}
T 2017-07-13 16:04:35:701 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:35:701 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:35:702 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:35:702 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:35:702 command.cc(36) Raw JSON command: { "name" : "getWindowHandles", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {} }
T 2017-07-13 16:04:35:702 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:35:702 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:35:702 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:35:702 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:702 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:702 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:35:702 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:702 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:702 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:35:702 IECommandExecutor.cpp(604) Entering IECommandExecutor::GetManagedBrowserHandles
T 2017-07-13 16:04:35:702 Browser.cpp(425) Entering Browser::IsValidWindow
T 2017-07-13 16:04:35:702 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:702 Browser.cpp(206) Entering Browser::GetContentWindowHandle
T 2017-07-13 16:04:35:702 Browser.cpp(425) Entering Browser::IsValidWindow
T 2017-07-13 16:04:35:702 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:702 Browser.cpp(206) Entering Browser::GetContentWindowHandle
I 2017-07-13 16:04:35:702 Browser.cpp(214) Flushing window handle as it is no longer valid
I 2017-07-13 16:04:35:702 Browser.cpp(219) Restore window handle from tab
T 2017-07-13 16:04:35:702 Browser.cpp(659) Entering Browser::GetBrowserWindowHandle
T 2017-07-13 16:04:35:720 DocumentHost.cpp(255) Entering DocumentHost::FindContentWindowHandle
T 2017-07-13 16:04:35:720 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:35:720 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:35:720 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:720 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:720 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:35:722 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:35:723 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:35:723 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:35:723 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":["d539bff9-cca3-4bb3-a92f-28a838e405b5","8355a7c2-d725-45cd-a0d1-9e0a224155bd"]}
T 2017-07-13 16:04:35:723 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:35:723 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:35:723 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:35:731 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:35:731 server.cc(238) Entering Server::ReadRequestBody
T 2017-07-13 16:04:35:731 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window HTTP verb: POST
body: {"name":"8355a7c2-d725-45cd-a0d1-9e0a224155bd"}
T 2017-07-13 16:04:35:731 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:35:731 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:35:732 server.cc(281) Command: POST /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window {"name":"8355a7c2-d725-45cd-a0d1-9e0a224155bd"}
T 2017-07-13 16:04:35:732 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:35:732 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:35:732 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:35:732 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:35:732 command.cc(36) Raw JSON command: { "name" : "switchToWindow", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {"name":"8355a7c2-d725-45cd-a0d1-9e0a224155bd"} }
T 2017-07-13 16:04:35:732 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:35:732 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:35:732 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:732 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:732 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:35:732 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:35:732 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:732 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:733 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:35:733 IECommandExecutor.cpp(604) Entering IECommandExecutor::GetManagedBrowserHandles
T 2017-07-13 16:04:35:733 Browser.cpp(425) Entering Browser::IsValidWindow
T 2017-07-13 16:04:35:733 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:733 Browser.cpp(206) Entering Browser::GetContentWindowHandle
T 2017-07-13 16:04:35:734 Browser.cpp(425) Entering Browser::IsValidWindow
T 2017-07-13 16:04:35:734 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:734 Browser.cpp(206) Entering Browser::GetContentWindowHandle
I 2017-07-13 16:04:35:734 Browser.cpp(214) Flushing window handle as it is no longer valid
I 2017-07-13 16:04:35:734 Browser.cpp(219) Restore window handle from tab
T 2017-07-13 16:04:35:734 Browser.cpp(659) Entering Browser::GetBrowserWindowHandle
T 2017-07-13 16:04:35:776 DocumentHost.cpp(255) Entering DocumentHost::FindContentWindowHandle
T 2017-07-13 16:04:35:778 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:778 Browser.cpp(232) Entering Browser::GetWindowName
W 2017-07-13 16:04:35:789 Browser.cpp(262) Unable to get window name, IHTMLWindow2::get_name failed or returned a NULL value
T 2017-07-13 16:04:35:792 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:792 Browser.cpp(232) Entering Browser::GetWindowName
W 2017-07-13 16:04:35:812 Browser.cpp(262) Unable to get window name, IHTMLWindow2::get_name failed or returned a NULL value
T 2017-07-13 16:04:35:924 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:924 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:924 DocumentHost.cpp(132) Entering DocumentHost::SetFocusedFrameByElement
T 2017-07-13 16:04:35:924 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:924 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:924 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:35:924 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:35:924 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:924 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:924 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:35:925 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:35:925 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:35:925 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:35:925 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:35:925 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:35:925 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:35:925 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:35:926 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:35:926 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:36:127 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:36:127 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:127 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:127 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:36:127 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:36:127 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:36:127 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:36:131 Browser.cpp(464) Browser busy property is true.
T 2017-07-13 16:04:36:131 IECommandExecutor.cpp(382) Entering IECommandExecutor::WaitThreadProc
T 2017-07-13 16:04:36:158 Browser.cpp(96) Entering Browser::DocumentComplete
D 2017-07-13 16:04:36:163 ElementRepository.cpp(113) Refreshing managed element cache. Found 0 to remove from cache.
T 2017-07-13 16:04:36:332 IECommandExecutor.cpp(175) Entering IECommandExecutor::OnWait
T 2017-07-13 16:04:36:332 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:332 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:332 Browser.cpp(438) Entering Browser::Wait
D 2017-07-13 16:04:36:332 Browser.cpp(448) Navigate Events Completed.
T 2017-07-13 16:04:36:332 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:36:332 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:36:335 Browser.cpp(508) Waiting for document to complete...
T 2017-07-13 16:04:36:335 Browser.cpp(522) Entering Browser::IsDocumentNavigating
D 2017-07-13 16:04:36:348 Browser.cpp(513) Not in navigating state
T 2017-07-13 16:04:36:355 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:36:355 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:36:355 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:36:355 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":null}
T 2017-07-13 16:04:36:355 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:36:355 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:36:355 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:36:359 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:36:359 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window_handle HTTP verb: GET
body: {}
T 2017-07-13 16:04:36:359 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:36:359 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:36:360 server.cc(281) Command: GET /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/window_handle {}
T 2017-07-13 16:04:36:360 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:36:360 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:36:360 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:36:360 command.cc(36) Raw JSON command: { "name" : "getWindowHandle", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {} }
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:36:360 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:36:360 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:36:360 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:36:360 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:360 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:36:360 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:360 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:360 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:36:371 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:36:371 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:36:371 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:36:371 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":"8355a7c2-d725-45cd-a0d1-9e0a224155bd"}
T 2017-07-13 16:04:36:371 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:36:371 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:36:371 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:36:375 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:36:375 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/url HTTP verb: GET
body: {}
T 2017-07-13 16:04:36:375 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:36:375 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:36:375 server.cc(281) Command: GET /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/url {}
T 2017-07-13 16:04:36:375 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:36:375 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:36:375 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:36:375 command.cc(36) Raw JSON command: { "name" : "getCurrentUrl", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {} }
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:36:375 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:36:375 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:36:375 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:36:375 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:375 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:375 Browser.cpp(126) Entering Browser::GetDocument
I 2017-07-13 16:04:36:375 Browser.cpp(130) No child frame focus. Focus is on top-level frame
T 2017-07-13 16:04:36:386 Browser.cpp(613) Entering Browser::GetDocumentFromWindow
T 2017-07-13 16:04:36:390 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:36:390 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:36:391 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:391 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:391 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:36:397 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:36:397 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:36:397 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:36:397 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":"http://www.seleniumhq.org/download/"}
T 2017-07-13 16:04:36:397 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:36:397 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:36:397 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:36:401 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:36:401 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/title HTTP verb: GET
body: {}
T 2017-07-13 16:04:36:401 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:36:401 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:36:401 server.cc(281) Command: GET /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/title {}
T 2017-07-13 16:04:36:402 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:36:402 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:36:402 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:36:402 command.cc(36) Raw JSON command: { "name" : "getTitle", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {} }
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:402 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:36:402 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:36:402 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:36:402 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:402 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:402 Browser.cpp(162) Entering Browser::GetTitle
T 2017-07-13 16:04:36:407 response.cc(63) Entering Response::SetSuccessResponse
T 2017-07-13 16:04:36:407 response.cc(69) Entering Response::SetResponse
T 2017-07-13 16:04:36:407 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:407 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:407 response.cc(51) Entering Response::Serialize
T 2017-07-13 16:04:36:413 IESession.cpp(221) Found non-zero response length
T 2017-07-13 16:04:36:413 IECommandExecutor.cpp(159) Entering IECommandExecutor::OnGetResponse
T 2017-07-13 16:04:36:413 IECommandExecutor.cpp(288) Entering IECommandExecutor::OnIsSessionValid
D 2017-07-13 16:04:36:413 server.cc(355) Response: {"sessionId":"47a865a0-04d7-41e1-8f95-3c4220efd28b","status":0,"value":"Downloads"}
T 2017-07-13 16:04:36:413 server.cc(408) Entering Server::SendResponseToClient
T 2017-07-13 16:04:36:413 response.cc(36) Entering Response::Deserialize
T 2017-07-13 16:04:36:413 server.cc(462) Entering Server::SendHttpOk
T 2017-07-13 16:04:36:418 server.cc(174) Entering Server::ProcessRequest
T 2017-07-13 16:04:36:418 server.cc(183) Process request with: URI: /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/cookie HTTP verb: GET
body: {}
T 2017-07-13 16:04:36:418 server.cc(272) Entering Server::DispatchCommand
T 2017-07-13 16:04:36:418 server.cc(579) Entering Server::LookupCommand
D 2017-07-13 16:04:36:418 server.cc(281) Command: GET /session/47a865a0-04d7-41e1-8f95-3c4220efd28b/cookie {}
T 2017-07-13 16:04:36:418 server.cc(395) Entering Server::LookupSession
T 2017-07-13 16:04:36:418 IESession.cpp(191) Entering IESession::ExecuteCommand
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(125) Entering IECommandExecutor::OnSetCommand
T 2017-07-13 16:04:36:418 command.cc(31) Entering Command::Deserialize
D 2017-07-13 16:04:36:418 command.cc(36) Raw JSON command: { "name" : "getCookie", "locator" : { "sessionid" : "47a865a0-04d7-41e1-8f95-3c4220efd28b" }, "parameters" : {} }
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(136) Entering IECommandExecutor::OnExecCommand
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(459) Entering IECommandExecutor::DispatchCommand
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(530) Entering IECommandExecutor::IsAlertActive
T 2017-07-13 16:04:36:418 IESession.cpp(212) Beginning wait for response length to be not zero
T 2017-07-13 16:04:36:418 Browser.cpp(713) Entering Browser::GetActiveDialogWindowHandle
T 2017-07-13 16:04:36:418 Browser.cpp(206) Entering Browser::GetContentWindowHandle
D 2017-07-13 16:04:36:418 IECommandExecutor.cpp(544) No alert handle is found
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(574) Entering IECommandExecutor::GetCurrentBrowser
T 2017-07-13 16:04:36:418 IECommandExecutor.cpp(580) Entering IECommandExecutor::GetManagedBrowser
T 2017-07-13 16:04:36:418 DocumentHost.cpp(73) Entering DocumentHost::GetCurrentUrl
T 2017-07-13 16:04:36:418 Browser.cpp(126) Entering Browser::GetDocument
I 2017-07-13 16:04:36:418 Browser.cpp(130) No child frame focus. Focus is on top-level frame
T 2017-07-13 16:04:36:430 Browser.cpp(613) Entering Browser::GetDocumentFromWindow
T 2017-07-13 16:04:36:435 CookieManager.cpp(86) Entering CookieManager::GetCookies
T 2017-07-13 16:04:36:435 HookProcessor.cpp(103) Entering HookProcessor::Initialize
T 2017-07-13 16:04:36:435 HookProcessor.cpp(203) Entering HookProcessor::CreateReturnPipe
D 2017-07-13 16:04:36:435 HookProcessor.cpp(238) Created named pipe \\.\pipe\IEDriverPipe64452
T 2017-07-13 16:04:36:435 HookProcessor.cpp(166) Entering HookProcessor::InstallWindowsHook
T 2017-07-13 16:04:36:435 CookieManager.cpp(369) Entering CookieManager::SendGetCookieMessage
T 2017-07-13 16:04:36:435 HookProcessor.cpp(260) Entering HookProcessor::PushData
T 2017-07-13 16:04:36:436 HookProcessor.cpp(286) Entering HookProcessor::PullData
D 2017-07-13 16:04:36:436 HookProcessor.cpp(292) Waiting for connection from browser via named pipe
T 2017-07-13 16:04:36:436 CookieManager.cpp(398) Entering CookieManager::ThreadProc
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment