appium / appium

Cross-platform automation framework for all kinds of apps, built on top of the W3C WebDriver protocol
http://appium.io/
Apache License 2.0
18.94k stars 6.08k forks source link

appium server throws Error -The target application appears to have died #5603

Closed vvvvaib closed 8 years ago

vvvvaib commented 9 years ago

Hi, I am using iOS 8.4 real device to test a webapp on safari. However I see error logs in appium server when I run the test case. I am attaching the description and server logs. Can somebody please tell me why this issue is appearing. Is this a bug?

Adding more details of the scenario- I navigate to a url of the webapp under test. Now on this page I have to click an element which opens another page in a different tab. As soon as this element is clicked and new tab starts loading - I see the target application died error. Now on this tab my test case can still find elements. That is not the issue but for my scenario I need to get the screenshot from this new tab. But screenshot_save doesn't captures any image.

This issue doesn't appear(80% of the times) if I clear safari history, cache etc from the device manually before running the test case. But if I just run this test case after another test case of if I run this test case twice then it fails. I am also not aware of any workaround to clear safari history and cache programatically from rela device.

Really looking forward to get some help from appium experts on this issue.

This error is received in the appium server logs -


�[36minfo�[39m: [debug] �[32m[INST] 2015-09-13 13:15:01 +0000 Fail: The target application appears to have died�[39m �[36minfo�[39m: [debug] �[33m[INST STDERR] 2015-09-13 15:15:01.382 instruments[74933:3435688] Attempting to set event horizon when core is not engaged, request ignored�[39m


Please find below the full logs-

logs-info: Welcome to Appium v1.4.8 (REV b6cfeec3a9d2d0269c952f81d8649231233c09ca) info: Appium REST http interface listener started on 10.148.4.24:5575 info: [debug] Non-default server args: {"udid":"6b933ce7b38a23ab88d52830626b7a6e5aaf6550","address":"10.148.4.24","port":5575,"bootstrapPort":5585,"fullReset":true,"localTimezone":true,"nodeconfig":"/Users/*****/Documents/MAF/iOS/mobileAppiumConfigIPad.json"} info: Console LogLevel: debug info: [debug] starting auto register thread for grid. Will try to register every 5000 ms. info: [debug] Appium successfully registered with the grid on 172.19.40.147:4444 info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"buiald":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: <-- GET /wd/hub/status 200 6.436 ms - 104 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: --> POST /wd/hub/session {"desiredCapabilities":{"newCommandTimeout":"100","platformVersion":"8.4","platform":"ANY","javascriptEnabled":true,"platformName":"iOS","deviceName":"6b933ce7b38a23ab88d52830626b7a6e5aaf6550","browserName":"Safari","name":"test_mobile.TestMobile.test_drag_and_drop","mobile_mode":"LANDSCAPE","version":""}} info: Client User-Agent string: Python-urllib/2.7 info: [debug] The following desired capabilities were provided, but not recognized by appium. They will be passed on to any other services running on this server. : platform, javascriptEnabled, name, mobile_mode, version info: [debug] Configuring Safari session info: [debug] Using local .zip from command line: /Users/awingu/appium/build/SafariLauncher/SafariLauncher.zip info: [debug] Copying local zip to tmp dir info: [debug] /Users/awingu/appium/build/SafariLauncher/SafariLauncher.zip copied to /var/folders/s7/29sgcjw506dgbcq71p_hm2sc0000gn/T/115813-74922-zz44s4/appium-app.zip info: [debug] Unzipping /var/folders/s7/29sgcjw506dgbcq71p_hm2sc0000gn/T/115813-74922-zz44s4/appium-app.zip info: [debug] Testing zip archive: /var/folders/s7/29sgcjw506dgbcq71p_hm2sc0000gn/T/115813-74922-zz44s4/appium-app.zip info: [debug] Zip archive tested clean info: [debug] Unzip successful info: [debug] Using locally extracted app: /var/folders/s7/29sgcjw506dgbcq71p_hm2sc0000gn/T/115813-74922-zz44s4/node_modules/safari-launcher/build/Release-iphoneos/SafariLauncher.app info: [debug] Creating new appium session bffa26af-37e0-4816-aa03-3342425c8b9d info: [debug] Removing any remaining instruments sockets info: [debug] Cleaned up instruments socket /tmp/instruments_sock info: [debug] Auto-detecting iOS udid... info: [debug] Not auto-detecting udid, running on sim info: [debug] Could not parse plist file (as binary) at /var/folders/s7/29sgcjw506dgbcq71p_hm2sc0000gn/T/115813-74922-zz44s4/node_modules/safari-launcher/build/Release-iphoneos/SafariLauncher.app/en.lproj/Localizable.strings info: Will try to parse the plist file as XML info: [debug] Could not parse plist file (as XML) at /var/folders/s7/29sgcjw506dgbcq71p_hm2sc0000gn/T/115813-74922-zz44s4/node_modules/safari-launcher/build/Release-iphoneos/SafariLauncher.app/en.lproj/Localizable.strings warn: Could not parse app Localizable.strings assuming it doesn't exist info: [debug] Getting bundle ID from app info: [debug] Parsed app Info.plist (as binary) info: [debug] Creating instruments info: [debug] Preparing uiauto bootstrap info: [debug] Dynamic bootstrap dir: /Users/awingu/Library/Application Support/appium/bootstrap info: [debug] Dynamic env: {"nodePath":"/usr/local/Cellar/node/0.12.7/bin/node","commandProxyClientPath":"/Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js","instrumentsSock":"/tmp/instruments_sock","interKeyDelay":null,"justLoopInfinitely":false,"autoAcceptAlerts":false,"autoDismissAlerts":false,"sendKeyStrategy":"grouped"} info: [debug] Dynamic bootstrap code: // This file is automatically generated. Do not manually modify! ... info: [debug] Dynamic bootstrap path: /Users/awingu/Library/Application Support/appium/bootstrap/bootstrap-f2e9c36bcb9f1092.js info: [debug] Reusing dynamic bootstrap: /Users/awingu/Library/Application Support/appium/bootstrap/bootstrap-f2e9c36bcb9f1092.js info: [debug] Attempting iOS device log capture via libimobiledevice idevicesyslog info: [debug] Creating iDevice object with udid 6b933ce7b38a23ab88d52830626b7a6e5aaf6550 info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 2.528 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] Starting command proxy. info: [debug] Instruments socket server started at /tmp/instruments_sock info: [debug] Starting instruments info: [debug] Instruments is at: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments info: Launching instruments info: [debug] Attempting to run app on real device with UDID 6b933ce7b38a23ab88d52830626b7a6e5aaf6550 info: [debug] Spawning instruments with command: /Applications/Xcode.app/Contents/Developer/usr/bin/instruments -t /Applications/Xcode.app/Contents/Applications/Instruments.app/Contents/PlugIns/AutomationInstrument.xrplugin/Contents/Resources/Automation.tracetemplate -D /tmp/appium-instruments/instrumentscli0.trace -w 6b933ce7b38a23ab88d52830626b7a6e5aaf6550 com.bytearc.SafariLauncher -e UIASCRIPT "/Users/awingu/Library/Application Support/appium/bootstrap/bootstrap-f2e9c36bcb9f1092.js" -e UIARESULTSPATH /tmp/appium-instruments info: [debug] And extra without-delay env: {} info: [debug] And launch timeouts (in ms): {"global":90000} info: [debug] [INST STDERR] 2015-09-13 15:13:19.989 instruments[74933:3435636] WebKit Threading Violation - initial use of WebKit from a secondary thread. info: Instruments is ready to receive commands info: [debug] Instruments launched. Starting poll loop for new commands. info: [debug] Setting bootstrap config keys/values info: [debug] Pushing command to appium work queue: "target = $.target();\nau = $;\n$.isVerbose = true;\n" info: [debug] Socket data received (2 bytes) info: [debug] Socket data being routed. info: [debug] Sending command to instruments: target = $.target(); au = $; $.isVerbose = true;

info: [debug] [INST] 2015-09-13 13:13:22 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:22 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:13:22 +0000 Debug: Running system command #1: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":true}... info: [debug] Socket data received (27 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":true} info: [debug] Not setting initial orientation because we're on SafariLauncher info: [debug] Waiting for app source to contain elements info: [debug] Pushing command to appium work queue: "au.mainApp().getTreeForXML()" info: [debug] Sending command to instruments: au.mainApp().getTreeForXML() info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.984 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [INST] 2015-09-13 13:13:24 +0000 Debug: Got new command 1 from instruments: au.mainApp().getTreeForXML() info: [debug] [INST] 2015-09-13 13:13:24 +0000 Debug: evaluating au.mainApp().getTreeForXML() info: [debug] [INST] 2015-09-13 13:13:24 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:24 +0000 Debug: responding with:abled":true,"valid":true,"visible":true,"hint":null,"path":"/0/0","x":0,"y":0,"width":768,"height":1024},">":[{"UIAStaticText":{"@":{"name":"Safari Launcher","label":"Safari Launcher","value":"Safari Launcher","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/0/0","x":192,"y":10,"width":768,"height":50},">":[]}},{"UIAButton":{"@":{"name":"launch safari","label":"launch safari","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/0/1","x":284,"y":482,"width":200,"height":60},">":[]}},{"UIAStaticText":{"@":{"name":" url: http://www.apple.com","label":" url: http://www.apple.com","value":" url: http://www.apple.com","dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/0/2","x":0,"y":974,"width":768,"height":50},">":[]}}]}},{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1","x":0,"y":0,"width":768,"height":1024},">":[{"UIAStatusBar":{"@":{"name":null,"label":null,"value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0/1/0","x":0,"y":0,"width":768,"height":20},">":[{"UIAElement":{"@":{"name":"No SIM","label":"No SIM","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/1/0/0","x":6,"y":0,"width":42,"height":20},">":[]}},{"UIAElement":{"@":{"name":"3 of 3 Wi-Fi bars","label":"3 of 3 Wi-Fi bars","value":"AWINGU_TRAINING","dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/1/0/1","x":53,"y":0,"width":13,"height":20},">":[]}},{"UIAElement":{"@":{"name":"15:13","label":"15:13","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/1/0/2","x":370,"y":0,"width":28,"height":20},">":[]}},{"UIAElement":{"@":{"name":"100% battery power, On AC Power","label":"100% battery power, On AC Power","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":"Swipe down with three fingers to reveal the notification center., Swipe up with three fingers to reveal the control center, Double-tap to scroll to top","path":"/0/1/0/3","x":695,"y":0,"width":68,"height":20},">":[]}}]}}]}}]}}} info: [debug] [INST] 2015-09-13 13:13:24 +0000 Debug: Running system command #2: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"UIAApplication":{"@":{"name":"SafariLauncher","label":"SafariLauncher","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"... info: [debug] Socket data received (2964 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":{"UIAApplication":{"@":{"name":"SafariLauncher","label":"SafariLauncher","value":null,"dom":null,"enabled":true,"valid":true,"visible":true,"hint":null,"path":"/0","x":0,"y":20,"width":768,"height":1004},">":[{"UIAWindow":{"@":{"name":null,"label":null,"value":null,"dom":null,"en info: [debug] On Safari Launcher. Tapping button to launch Safari info: [debug] Waiting up to 0ms for condition info: [debug] Pushing command to appium work queue: "au.getElementByAccessibilityId('launch safari')" info: [debug] Sending command to instruments: au.getElementByAccessibilityId('launch safari') info: [debug] [INST] 2015-09-13 13:13:25 +0000 Debug: Got new command 2 from instruments: au.getElementByAccessibilityId('launch safari') info: [debug] [INST] 2015-09-13 13:13:25 +0000 Debug: evaluating au.getElementByAccessibilityId('launch safari') info: [debug] [INST] 2015-09-13 13:13:25 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:25 +0000 Debug: Lookup returned [object UIAButton] with the name "launch safari" (id: 0). info: [debug] [INST] 2015-09-13 13:13:25 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:13:25 +0000 Debug: Running system command #3: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"ELEMENT":"0"}}... info: [debug] Socket data received (38 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":{"ELEMENT":"0"}} info: [debug] Pushing command to appium work queue: "au.tapById('0')" info: [debug] Sending command to instruments: au.tapById('0') info: [debug] [INST] 2015-09-13 13:13:26 +0000 Debug: Got new command 3 from instruments: au.tapById('0') info: [debug] [INST] 2015-09-13 13:13:26 +0000 Debug: evaluating au.tapById('0') info: [debug] [INST] 2015-09-13 13:13:26 +0000 Debug: UIAButton.tap() info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Clicked button, safari should be launching. info: [debug] Waiting for 3000 ms before navigating to view. info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.968 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] Navigating to most recently opened webview info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Picking webview WEBVIEW_1 info: [debug] Attempting to set context to 'WEBVIEW_1' info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/1] info: [debug] [REMOTE] Unregistering from page readiness notifications info: [debug] Waiting for 3000 ms before navigating to view. info: [debug] Navigating to most recently opened webview info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Picking webview WEBVIEW_1 info: [debug] Attempting to set context to 'WEBVIEW_1' info: [debug] [REMOTE] Disconnecting from remote debugger info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/1] info: [debug] [REMOTE] Unregistering from page readiness notifications info: [debug] Device launched! Ready for commands info: [debug] Setting command timeout to 100 secs info: [debug] Appium session started with sessionId bffa26af-37e0-4816-aa03-3342425c8b9d info: <-- POST /wd/hub/session 303 16074.188 ms - 74  info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d {} info: [debug] Responding to client with success: {"status":0,"value":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"Safari","platform":"ANY","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"warnings":{},"desired":{"newCommandTimeout":"100","platformVersion":"8.4","platform":"ANY","javascriptEnabled":true,"platformName":"iOS","deviceName":"6b933ce7b38a23ab88d52830626b7a6e5aaf6550","browserName":"Safari","name":"test_mobile.TestMobile.test_drag_and_drop","mobile_mode":"LANDSCAPE","version":""},"newCommandTimeout":"100","platformVersion":"8.4","platformName":"iOS","deviceName":"6b933ce7b38a23ab88d52830626b7a6e5aaf6550","name":"test_mobile.TestMobile.test_drag_and_drop","mobile_mode":"LANDSCAPE","version":"","safari":true},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d 200 2.020 ms - 814 {"status":0,"value":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"Safari","platform":"ANY","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"warnings":{},"desired":{"newCommandTimeout":"100","platformVersion":"8.4","platform":"ANY","javascriptEnabled":true,"platformName":"iOS","deviceName":"6b933ce7b38a23ab88d52830626b7a6e5aaf6550","browserName":"Safari","name":"test_mobile.TestMobile.test_drag_and_drop","mobile_mode":"LANDSCAPE","version":""},"newCommandTimeout":"100","platformVersion":"8.4","platformName":"iOS","deviceName":"6b933ce7b38a23ab88d52830626b7a6e5aaf6550","name":"test_mobile.TestMobile.test_drag_and_drop","mobile_mode":"LANDSCAPE","version":"","safari":true},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 2.610 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [REMOTE] Disconnecting from remote debugger info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.684 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 1.075 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","actions":[{"action":"press","options":{"y":80,"x":10}},{"action":"wait","options":{"ms":5}},{"action":"release","options":{}}]} info: [debug] Pushing command to appium work queue: "target.touch([{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.2},{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.20500000000000002}])" info: [debug] Sending command to instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:26 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:26 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:13:26 +0000 Debug: Running system command #4: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":""}... info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.651 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [INST] 2015-09-13 13:13:38 +0000 Debug: Got new command 4 from instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:38 +0000 Debug: evaluating target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:38 +0000 Debug: target.touch(NSCFArray) info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform 200 1128.905 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.662 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 1.043 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","actions":[{"action":"press","options":{"y":80,"x":10}},{"action":"wait","options":{"ms":5}},{"action":"release","options":{}}]} info: [debug] Pushing command to appium work queue: "target.touch([{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.2},{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.20500000000000002}])" info: [debug] Sending command to instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:38 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:38 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:13:38 +0000 Debug: Running system command #5: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":""}... info: [debug] [INST] 2015-09-13 13:13:44 +0000 Debug: Got new command 5 from instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:44 +0000 Debug: evaluating target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:44 +0000 Debug: target.touch(NSCFArray) info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform 200 1111.587 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.649 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 1.092 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","actions":[{"action":"press","options":{"y":80,"x":10}},{"action":"wait","options":{"ms":5}},{"action":"release","options":{}}]} info: [debug] Pushing command to appium work queue: "target.touch([{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.2},{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.20500000000000002}])" info: [debug] Sending command to instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:45 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:45 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:13:45 +0000 Debug: Running system command #6: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":""}... info: [debug] [INST] 2015-09-13 13:13:51 +0000 Debug: Got new command 6 from instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:51 +0000 Debug: evaluating target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:51 +0000 Debug: target.touch(NSCFArray) info: [debug] [INST] 2015-09-13 13:13:51 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:51 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:13:51 +0000 Debug: Running system command #7: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":""}... info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform 200 1267.890 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.983 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 1.132 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","actions":[{"action":"press","options":{"y":80,"x":10}},{"action":"wait","options":{"ms":5}},{"action":"release","options":{}}]} info: [debug] Pushing command to appium work queue: "target.touch([{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.2},{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.20500000000000002}])" info: [debug] Sending command to instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:57 +0000 Debug: Got new command 7 from instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:57 +0000 Debug: evaluating target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:57 +0000 Debug: target.touch(NSCFArray) info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform 200 1211.034 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 1.121 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 0.924 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","actions":[{"action":"press","options":{"y":80,"x":10}},{"action":"wait","options":{"ms":5}},{"action":"release","options":{}}]} info: [debug] Pushing command to appium work queue: "target.touch([{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.2},{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.20500000000000002}])" info: [debug] Sending command to instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:13:57 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:13:57 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:13:57 +0000 Debug: Running system command #8: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":""}... info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.674 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [INST] 2015-09-13 13:14:03 +0000 Debug: Got new command 8 from instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:14:03 +0000 Debug: evaluating target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:14:03 +0000 Debug: target.touch(NSCFArray) info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform 200 1257.366 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.943 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 1.116 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","actions":[{"action":"press","options":{"y":80,"x":10}},{"action":"wait","options":{"ms":5}},{"action":"release","options":{}}]} info: [debug] Pushing command to appium work queue: "target.touch([{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.2},{\"touch\":[{\"x\":10,\"y\":80}],\"time\":0.20500000000000002}])" info: [debug] Sending command to instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:14:04 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:14:04 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:14:04 +0000 Debug: Running system command #9: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":""}... info: [debug] [INST] 2015-09-13 13:14:10 +0000 Debug: Got new command 9 from instruments: target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:14:10 +0000 Debug: evaluating target.touch([{"touch":[{"x":10,"y":80}],"time":0.2},{"touch":[{"x":10,"y":80}],"time":0.20500000000000002}]) info: [debug] [INST] 2015-09-13 13:14:10 +0000 Debug: target.touch(NSCFArray) info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/touch/perform 200 1220.022 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["NATIVE_APP","WEBVIEW_1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts 200 2.880 ms - 98 {"status":0,"value":["NATIVE_APP","WEBVIEW_1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"WEBVIEW_1"} info: [debug] Attempting to set context to 'WEBVIEW_1' info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/1] info: [debug] Responding to client with success: {"status":0,"value":"WEBVIEW_1","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 14.678 ms - 83 {"status":0,"value":"WEBVIEW_1","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/timeouts/implicit_wait {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","ms":1000} info: [debug] Set iOS implicit wait to 1000ms info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/timeouts/implicit_wait 200 1.271 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/url {"url":"http://172.19.40.109","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [REMOTE] Navigating to new URL: http://172.19.40.109 info: [debug] [REMOTE] Remote debugger data sent [{"method":"Page.navigate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"url":"http://172.19.40.109"},"id":1}...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{},"id":1} info: [debug] [REMOTE] Debugger got a message for 'Page.navigate' and have no handler, doing nothing. info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.866 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [REMOTE] Waiting for frame navigated... info: [debug] [REMOTE] frame navigated timeout triggered info: [debug] [REMOTE] Frame navigated, calling cbs info: [debug] [REMOTE] frame navigated in 0.501 sec. info: [debug] [REMOTE] Waiting for dom... info: [debug] [REMOTE] Page loaded, verifying whether ready through readyState info: [debug] [REMOTE] Checking document readyState info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function (){return document.readyState;})()","ret...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"complete"},"wasThrown":false},"id":2} info: [debug] [REMOTE] readyState was complete info: [debug] [REMOTE] Page is ready, calling onload cbs info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/url 200 2047.191 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"NATIVE_APP"} info: [debug] Attempting to set context to 'NATIVE_APP' info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 1.980 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [REMOTE] Disconnecting from remote debugger info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/orientation {} info: [debug] Pushing command to appium work queue: "au.getScreenOrientation()" info: [debug] Sending command to instruments: au.getScreenOrientation() info: [debug] [INST] 2015-09-13 13:14:10 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:14:10 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:14:10 +0000 Debug: Running system command #10: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":""}... info: [debug] [INST] 2015-09-13 13:14:16 +0000 Debug: Got new command 10 from instruments: au.getScreenOrientation() info: [debug] [INST] 2015-09-13 13:14:16 +0000 Debug: evaluating au.getScreenOrientation() info: [debug] [INST] 2015-09-13 13:14:16 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:14:16 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:14:16 +0000 Debug: Running system command #11: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":"UNKNOWN"}... info: [debug] Socket data received (32 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":"UNKNOWN"} info: [debug] Setting internal orientation to UNKNOWN info: [debug] Responding to client with success: {"status":0,"value":"UNKNOWN","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/orientation 200 859.233 ms - 81 {"status":0,"value":"UNKNOWN","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/orientation {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","orientation":"LANDSCAPE"} info: [debug] Pushing command to appium work queue: "au.setScreenOrientation('LANDSCAPE')" info: [debug] Sending command to instruments: au.setScreenOrientation('LANDSCAPE') info: [debug] [INST] 2015-09-13 13:14:17 +0000 Debug: Got new command 11 from instruments: au.setScreenOrientation('LANDSCAPE') info: [debug] [INST] 2015-09-13 13:14:17 +0000 Debug: evaluating au.setScreenOrientation('LANDSCAPE') info: [debug] [INST] 2015-09-13 13:14:17 +0000 Debug: target.setDeviceOrientation("3") info: [debug] [INST] 2015-09-13 13:14:18 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:14:18 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:14:18 +0000 Debug: Running system command #12: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":"LANDSCAPE"}... info: [debug] Socket data received (34 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":"LANDSCAPE"} info: [debug] Responding to client with success: {"status":0,"value":"LANDSCAPE","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/orientation 200 1903.989 ms - 83 {"status":0,"value":"LANDSCAPE","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["NATIVE_APP","WEBVIEW_1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts 200 2.064 ms - 98 {"status":0,"value":["NATIVE_APP","WEBVIEW_1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"WEBVIEW_1"} info: [debug] Attempting to set context to 'WEBVIEW_1' info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/1] info: [debug] Responding to client with success: {"status":0,"value":"WEBVIEW_1","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 2.497 ms - 83 {"status":0,"value":"WEBVIEW_1","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//a[@href=\"#user-profile-popup\"]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":3} info: [debug] Waited for 59ms so far info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.811 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":4} info: [debug] Waited for 618ms so far info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":5} info: [debug] Condition unmet after 1175ms. Timing out. info: [debug] Responding to client with success: {"status":0,"value":[],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 1176.720 ms - 74 {"status":0,"value":[],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles 200 2.448 ms - 77 {"status":0,"value":["1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/frame {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","id":null} info: [debug] Leaving web frame and going back to default content info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/frame 200 1.213 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element {"using":"id","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"id_login"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_element' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"ELEMENT\":\":wdc:1442150059813\"}}"},"wasThrown":false},"id":6} info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"5000"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element 200 54.686 ms - 90 {"status":0,"value":{"ELEMENT":"5000"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5000/value {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","id":"5000","value":["u","s","e","r","5","3"]} info: [debug] [REMOTE] Executing 'click' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":7} info: [debug] [REMOTE] Executing 'type' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":8} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5000/value 200 306.458 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element {"using":"id","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"id_password"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_element' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"ELEMENT\":\":wdc:1442150059814\"}}"},"wasThrown":false},"id":9} info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"5001"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element 200 57.325 ms - 90 {"status":0,"value":{"ELEMENT":"5001"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5001/value {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","id":"5001","value":["R","0","0","t","3","r","!"]} info: [debug] [REMOTE] Executing 'click' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":10} info: [debug] [REMOTE] Executing 'type' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":11} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5001/value 200 330.683 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element {"using":"id","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"sign-in-btn"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_element' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"ELEMENT\":\":wdc:1442150059815\"}}"},"wasThrown":false},"id":12} info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"5002"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element 200 61.668 ms - 90 {"status":0,"value":{"ELEMENT":"5002"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5002/click {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","id":"5002"} info: [debug] [REMOTE] Executing 'click' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":13} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5002/click 200 305.047 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//a[@href=\"#user-profile-popup\"]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_element' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":14} info: [debug] Waited for 79ms so far info: [debug] [REMOTE] Executing 'find_element' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"ELEMENT\":\":wdc:1442150059816\"}}"},"wasThrown":false},"id":15} info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"5003"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element 200 1369.322 ms - 90 {"status":0,"value":{"ELEMENT":"5003"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//a[@href=\"#drives\"]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150059817\"}]}"},"wasThrown":false},"id":16} info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5004"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 63.966 ms - 92 {"status":0,"value":[{"ELEMENT":"5004"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5004/displayed {} info: [debug] [REMOTE] Executing 'is_displayed' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":17} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5004/displayed 200 65.834 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5004/enabled {} info: [debug] [REMOTE] Executing 'is_enabled' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":18} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5004/enabled 200 40.408 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//a[@href=\"#myapps\"]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150059818\"}]}"},"wasThrown":false},"id":19} info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5005"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 54.265 ms - 92 {"status":0,"value":[{"ELEMENT":"5005"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5005/displayed {} info: [debug] [REMOTE] Executing 'is_displayed' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":20} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5005/displayed 200 68.226 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5005/enabled {} info: [debug] [REMOTE] Executing 'is_enabled' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":21} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5005/enabled 200 38.293 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//a[@href=\"#shares\"]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.629 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150059819\"}]}"},"wasThrown":false},"id":22} info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5006"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 1412.863 ms - 92 {"status":0,"value":[{"ELEMENT":"5006"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5006/displayed {} info: [debug] [REMOTE] Executing 'is_displayed' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":23} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5006/displayed 200 65.880 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5006/enabled {} info: [debug] [REMOTE] Executing 'is_enabled' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":24} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5006/enabled 200 39.587 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"1"} info: [debug] [REMOTE] Disconnecting from remote debugger info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/1] info: [debug] Responding to client with success: {"status":0,"value":"1","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window 200 4.590 ms - 75 {"status":0,"value":"1","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//a[@href=\"#myapps\"]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150059818\"}]}"},"wasThrown":false},"id":25} info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5007"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 97.341 ms - 92 {"status":0,"value":[{"ELEMENT":"5007"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5007/displayed {} info: [debug] [REMOTE] Executing 'is_displayed' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":26} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5007/displayed 200 71.344 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5007/enabled {} info: [debug] [REMOTE] Executing 'is_enabled' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":27} info: [debug] Responding to client with success: {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5007/enabled 200 46.358 ms - 76 {"status":0,"value":true,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5007/click {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","id":"5007"} info: [debug] [REMOTE] Executing 'click' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":28} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5007/click 200 247.837 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//ul[@id=\"myapps-list\"]/li/a[contains(@class, \"li-main-a\")]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150059820\"},{\"ELEMENT\":\":wdc:1442150059821\"},{\"ELEMENT\":\":wdc:1442150059822\"},{\"ELEMENT\":\":wdc:1442150059823\"},{\"ELEMENT\":\":wdc:1442150059824\"},{\"ELEMENT\":\":wdc:1442150059825\"},{\"ELEM... info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5008"},{"ELEMENT":"5009"},{"ELEMENT":"5010"},{"ELEMENT":"5011"},{"ELEMENT":"5012"},{"ELEMENT":"5013"},{"ELEMENT":"5014"},{"ELEMENT":"5015"},{"ELEMENT":"5016"},{"ELEMENT":"5017"},{"ELEMENT":"5018"},{"ELEMENT":"5019"},{"ELEMENT":"5020"},{"ELEMENT":"5021"},{"ELEMENT":"5022"},{"ELEMENT":"5023"},{"ELEMENT":"5024"},{"ELEMENT":"5025"},{"ELEMENT":"5026"},{"ELEMENT":"5027"},{"ELEMENT":"5028"},{"ELEMENT":"5029"},{"ELEMENT":"5030"},{"ELEMENT":"5031"},{"ELEMENT":"5032"},{"ELEMENT":"5033"},{"ELEMENT":"5034"},{"ELEMENT":"5035"},{"ELEMENT":"5036"},{"ELEMENT":"5037"},{"ELEMENT":"5038"},{"ELEMENT":"5039"},{"ELEMENT":"5040"},{"ELEMENT":"5041"},{"ELEMENT":"5042"},{"ELEMENT":"5043"},{"ELEMENT":"5044"},{"ELEMENT":"5045"},{"ELEMENT":"5046"},{"ELEMENT":"5047"},{"ELEMENT":"5048"},{"ELEMENT":"5049"},{"ELEMENT":"5050"},{"ELEMENT":"5051"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 607.909 ms - 909 {"status":0,"value":[{"ELEMENT":"5008"},{"ELEMENT":"5009"},{"ELEMENT":"5010"},{"ELEMENT":"5011"},{"ELEMENT":"5012"},{"ELEMENT":"5013"},{"ELEMENT":"5014"},{"ELEMENT":"5015"},{"ELEMENT":"5016"},{"ELEMENT":"5017"},{"ELEMENT":"5018"},{"ELEMENT":"5019"},{"ELEMENT":"5020"},{"ELEMENT":"5021"},{"ELEMENT":"5022"},{"ELEMENT":"5023"},{"ELEMENT":"5024"},{"ELEMENT":"5025"},{"ELEMENT":"5026"},{"ELEMENT":"5027"},{"ELEMENT":"5028"},{"ELEMENT":"5029"},{"ELEMENT":"5030"},{"ELEMENT":"5031"},{"ELEMENT":"5032"},{"ELEMENT":"5033"},{"ELEMENT":"5034"},{"ELEMENT":"5035"},{"ELEMENT":"5036"},{"ELEMENT":"5037"},{"ELEMENT":"5038"},{"ELEMENT":"5039"},{"ELEMENT":"5040"},{"ELEMENT":"5041"},{"ELEMENT":"5042"},{"ELEMENT":"5043"},{"ELEMENT":"5044"},{"ELEMENT":"5045"},{"ELEMENT":"5046"},{"ELEMENT":"5047"},{"ELEMENT":"5048"},{"ELEMENT":"5049"},{"ELEMENT":"5050"},{"ELEMENT":"5051"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//ul[@id=\"myapps-list\"]/li/a[contains(@class, \"li-main-a\")]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150059820\"},{\"ELEMENT\":\":wdc:1442150059821\"},{\"ELEMENT\":\":wdc:1442150059822\"},{\"ELEMENT\":\":wdc:1442150059823\"},{\"ELEMENT\":\":wdc:1442150059824\"},{\"ELEMENT\":\":wdc:1442150059825\"},{\"ELEM... info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5052"},{"ELEMENT":"5053"},{"ELEMENT":"5054"},{"ELEMENT":"5055"},{"ELEMENT":"5056"},{"ELEMENT":"5057"},{"ELEMENT":"5058"},{"ELEMENT":"5059"},{"ELEMENT":"5060"},{"ELEMENT":"5061"},{"ELEMENT":"5062"},{"ELEMENT":"5063"},{"ELEMENT":"5064"},{"ELEMENT":"5065"},{"ELEMENT":"5066"},{"ELEMENT":"5067"},{"ELEMENT":"5068"},{"ELEMENT":"5069"},{"ELEMENT":"5070"},{"ELEMENT":"5071"},{"ELEMENT":"5072"},{"ELEMENT":"5073"},{"ELEMENT":"5074"},{"ELEMENT":"5075"},{"ELEMENT":"5076"},{"ELEMENT":"5077"},{"ELEMENT":"5078"},{"ELEMENT":"5079"},{"ELEMENT":"5080"},{"ELEMENT":"5081"},{"ELEMENT":"5082"},{"ELEMENT":"5083"},{"ELEMENT":"5084"},{"ELEMENT":"5085"},{"ELEMENT":"5086"},{"ELEMENT":"5087"},{"ELEMENT":"5088"},{"ELEMENT":"5089"},{"ELEMENT":"5090"},{"ELEMENT":"5091"},{"ELEMENT":"5092"},{"ELEMENT":"5093"},{"ELEMENT":"5094"},{"ELEMENT":"5095"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 129.484 ms - 909 {"status":0,"value":[{"ELEMENT":"5052"},{"ELEMENT":"5053"},{"ELEMENT":"5054"},{"ELEMENT":"5055"},{"ELEMENT":"5056"},{"ELEMENT":"5057"},{"ELEMENT":"5058"},{"ELEMENT":"5059"},{"ELEMENT":"5060"},{"ELEMENT":"5061"},{"ELEMENT":"5062"},{"ELEMENT":"5063"},{"ELEMENT":"5064"},{"ELEMENT":"5065"},{"ELEMENT":"5066"},{"ELEMENT":"5067"},{"ELEMENT":"5068"},{"ELEMENT":"5069"},{"ELEMENT":"5070"},{"ELEMENT":"5071"},{"ELEMENT":"5072"},{"ELEMENT":"5073"},{"ELEMENT":"5074"},{"ELEMENT":"5075"},{"ELEMENT":"5076"},{"ELEMENT":"5077"},{"ELEMENT":"5078"},{"ELEMENT":"5079"},{"ELEMENT":"5080"},{"ELEMENT":"5081"},{"ELEMENT":"5082"},{"ELEMENT":"5083"},{"ELEMENT":"5084"},{"ELEMENT":"5085"},{"ELEMENT":"5086"},{"ELEMENT":"5087"},{"ELEMENT":"5088"},{"ELEMENT":"5089"},{"ELEMENT":"5090"},{"ELEMENT":"5091"},{"ELEMENT":"5092"},{"ELEMENT":"5093"},{"ELEMENT":"5094"},{"ELEMENT":"5095"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles 200 4.584 ms - 77 {"status":0,"value":["1"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.796 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"xpath","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"//ul[@id=\"myapps-list\"]/li/a[contains(@class, \"li-main-a\")]"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150059820\"},{\"ELEMENT\":\":wdc:1442150059821\"},{\"ELEMENT\":\":wdc:1442150059822\"},{\"ELEMENT\":\":wdc:1442150059823\"},{\"ELEMENT\":\":wdc:1442150059824\"},{\"ELEMENT\":\":wdc:1442150059825\"},{\"ELEM... info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5096"},{"ELEMENT":"5097"},{"ELEMENT":"5098"},{"ELEMENT":"5099"},{"ELEMENT":"5100"},{"ELEMENT":"5101"},{"ELEMENT":"5102"},{"ELEMENT":"5103"},{"ELEMENT":"5104"},{"ELEMENT":"5105"},{"ELEMENT":"5106"},{"ELEMENT":"5107"},{"ELEMENT":"5108"},{"ELEMENT":"5109"},{"ELEMENT":"5110"},{"ELEMENT":"5111"},{"ELEMENT":"5112"},{"ELEMENT":"5113"},{"ELEMENT":"5114"},{"ELEMENT":"5115"},{"ELEMENT":"5116"},{"ELEMENT":"5117"},{"ELEMENT":"5118"},{"ELEMENT":"5119"},{"ELEMENT":"5120"},{"ELEMENT":"5121"},{"ELEMENT":"5122"},{"ELEMENT":"5123"},{"ELEMENT":"5124"},{"ELEMENT":"5125"},{"ELEMENT":"5126"},{"ELEMENT":"5127"},{"ELEMENT":"5128"},{"ELEMENT":"5129"},{"ELEMENT":"5130"},{"ELEMENT":"5131"},{"ELEMENT":"5132"},{"ELEMENT":"5133"},{"ELEMENT":"5134"},{"ELEMENT":"5135"},{"ELEMENT":"5136"},{"ELEMENT":"5137"},{"ELEMENT":"5138"},{"ELEMENT":"5139"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 66.256 ms - 909 {"status":0,"value":[{"ELEMENT":"5096"},{"ELEMENT":"5097"},{"ELEMENT":"5098"},{"ELEMENT":"5099"},{"ELEMENT":"5100"},{"ELEMENT":"5101"},{"ELEMENT":"5102"},{"ELEMENT":"5103"},{"ELEMENT":"5104"},{"ELEMENT":"5105"},{"ELEMENT":"5106"},{"ELEMENT":"5107"},{"ELEMENT":"5108"},{"ELEMENT":"5109"},{"ELEMENT":"5110"},{"ELEMENT":"5111"},{"ELEMENT":"5112"},{"ELEMENT":"5113"},{"ELEMENT":"5114"},{"ELEMENT":"5115"},{"ELEMENT":"5116"},{"ELEMENT":"5117"},{"ELEMENT":"5118"},{"ELEMENT":"5119"},{"ELEMENT":"5120"},{"ELEMENT":"5121"},{"ELEMENT":"5122"},{"ELEMENT":"5123"},{"ELEMENT":"5124"},{"ELEMENT":"5125"},{"ELEMENT":"5126"},{"ELEMENT":"5127"},{"ELEMENT":"5128"},{"ELEMENT":"5129"},{"ELEMENT":"5130"},{"ELEMENT":"5131"},{"ELEMENT":"5132"},{"ELEMENT":"5133"},{"ELEMENT":"5134"},{"ELEMENT":"5135"},{"ELEMENT":"5136"},{"ELEMENT":"5137"},{"ELEMENT":"5138"},{"ELEMENT":"5139"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5096/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Browser Check\"}"},"wasThrown":false},"id":32} info: [debug] Responding to client with success: {"status":0,"value":"Browser Check","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5096/attribute/title 200 40.014 ms - 87 {"status":0,"value":"Browser Check","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5097/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Explorer (app2008)\"}"},"wasThrown":false},"id":33} info: [debug] Responding to client with success: {"status":0,"value":"Explorer (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5097/attribute/title 200 45.178 ms - 92 {"status":0,"value":"Explorer (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5098/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Explorer (app2012)\"}"},"wasThrown":false},"id":34} info: [debug] Responding to client with success: {"status":0,"value":"Explorer (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5098/attribute/title 200 120.249 ms - 92 {"status":0,"value":"Explorer (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5099/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Explorer RDP (app2008)\"}"},"wasThrown":false},"id":35} info: [debug] Responding to client with success: {"status":0,"value":"Explorer RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5099/attribute/title 200 42.753 ms - 96 {"status":0,"value":"Explorer RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5100/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Explorer RDP (app2012)\"}"},"wasThrown":false},"id":36} info: [debug] Responding to client with success: {"status":0,"value":"Explorer RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5100/attribute/title 200 42.824 ms - 96 {"status":0,"value":"Explorer RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5101/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Google Calendar\"}"},"wasThrown":false},"id":37} info: [debug] Responding to client with success: {"status":0,"value":"Google Calendar","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5101/attribute/title 200 38.848 ms - 89 {"status":0,"value":"Google Calendar","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5102/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Google Docs\"}"},"wasThrown":false},"id":38} info: [debug] Responding to client with success: {"status":0,"value":"Google Docs","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5102/attribute/title 200 39.614 ms - 85 {"status":0,"value":"Google Docs","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5103/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Google Drive\"}"},"wasThrown":false},"id":39} info: [debug] Responding to client with success: {"status":0,"value":"Google Drive","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5103/attribute/title 200 41.365 ms - 86 {"status":0,"value":"Google Drive","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5104/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Google Mail\"}"},"wasThrown":false},"id":40} info: [debug] Responding to client with success: {"status":0,"value":"Google Mail","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5104/attribute/title 200 40.600 ms - 85 {"status":0,"value":"Google Mail","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5105/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Google Sheets\"}"},"wasThrown":false},"id":41} info: [debug] Responding to client with success: {"status":0,"value":"Google Sheets","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5105/attribute/title 200 40.177 ms - 87 {"status":0,"value":"Google Sheets","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5106/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Google Slides\"}"},"wasThrown":false},"id":42} info: [debug] Responding to client with success: {"status":0,"value":"Google Slides","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5106/attribute/title 200 40.558 ms - 87 {"status":0,"value":"Google Slides","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5107/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Holiday Pictures (app2008)\"}"},"wasThrown":false},"id":43} info: [debug] Responding to client with success: {"status":0,"value":"Holiday Pictures (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5107/attribute/title 200 39.408 ms - 100 {"status":0,"value":"Holiday Pictures (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5108/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Holiday Pictures (app2012)\"}"},"wasThrown":false},"id":44} info: [debug] Responding to client with success: {"status":0,"value":"Holiday Pictures (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5108/attribute/title 200 40.771 ms - 100 {"status":0,"value":"Holiday Pictures (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5109/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Holiday Pictures RDP (app2008)\"}"},"wasThrown":false},"id":45} info: [debug] Responding to client with success: {"status":0,"value":"Holiday Pictures RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5109/attribute/title 200 41.475 ms - 104 {"status":0,"value":"Holiday Pictures RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5110/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Holiday Pictures RDP (app2012)\"}"},"wasThrown":false},"id":46} info: [debug] Responding to client with success: {"status":0,"value":"Holiday Pictures RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5110/attribute/title 200 39.876 ms - 104 {"status":0,"value":"Holiday Pictures RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5111/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"KeyJedi (app2008)\"}"},"wasThrown":false},"id":47} info: [debug] Responding to client with success: {"status":0,"value":"KeyJedi (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5111/attribute/title 200 41.670 ms - 91 {"status":0,"value":"KeyJedi (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5112/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"KeyJedi (app2012)\"}"},"wasThrown":false},"id":48} info: [debug] Responding to client with success: {"status":0,"value":"KeyJedi (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5112/attribute/title 200 40.715 ms - 91 {"status":0,"value":"KeyJedi (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5113/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"KeyJedi RDP (app2008)\"}"},"wasThrown":false},"id":49} info: [debug] Responding to client with success: {"status":0,"value":"KeyJedi RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5113/attribute/title 200 39.403 ms - 95 {"status":0,"value":"KeyJedi RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5114/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"KeyJedi RDP (app2012)\"}"},"wasThrown":false},"id":50} info: [debug] Responding to client with success: {"status":0,"value":"KeyJedi RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5114/attribute/title 200 40.837 ms - 95 {"status":0,"value":"KeyJedi RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.529 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5115/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Microsoft Excel (app2008)\"}"},"wasThrown":false},"id":51} info: [debug] Responding to client with success: {"status":0,"value":"Microsoft Excel (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5115/attribute/title 200 40.102 ms - 99 {"status":0,"value":"Microsoft Excel (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5116/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Microsoft Excel (app2012)\"}"},"wasThrown":false},"id":52} info: [debug] Responding to client with success: {"status":0,"value":"Microsoft Excel (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5116/attribute/title 200 39.607 ms - 99 {"status":0,"value":"Microsoft Excel (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5117/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Microsoft Excel RDP (app2008)\"}"},"wasThrown":false},"id":53} info: [debug] Responding to client with success: {"status":0,"value":"Microsoft Excel RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5117/attribute/title 200 39.452 ms - 103 {"status":0,"value":"Microsoft Excel RDP (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5118/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Microsoft Excel RDP (app2012)\"}"},"wasThrown":false},"id":54} info: [debug] Responding to client with success: {"status":0,"value":"Microsoft Excel RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5118/attribute/title 200 39.082 ms - 103 {"status":0,"value":"Microsoft Excel RDP (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5119/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Microsoft Powerpoint (app2008)\"}"},"wasThrown":false},"id":55} info: [debug] Responding to client with success: {"status":0,"value":"Microsoft Powerpoint (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5119/attribute/title 200 39.508 ms - 104 {"status":0,"value":"Microsoft Powerpoint (app2008)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/attribute/title {} info: [debug] [REMOTE] Executing 'get_attribute_value' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function f(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":\"Microsoft Powerpoint (app2012)\"}"},"wasThrown":false},"id":56} info: [debug] Responding to client with success: {"status":0,"value":"Microsoft Powerpoint (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/attribute/title 200 42.110 ms - 104 {"status":0,"value":"Microsoft Powerpoint (app2012)","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.618 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/size {} info: [debug] [REMOTE] Executing 'get_size' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function g(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"width\":631,\"height\":44}}"},"wasThrown":false},"id":57} info: [debug] Responding to client with success: {"status":0,"value":{"width":631,"height":44},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/size 200 52.892 ms - 97 {"status":0,"value":{"width":631,"height":44},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/size {} info: [debug] [REMOTE] Executing 'get_size' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function g(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"width\":631,\"height\":44}}"},"wasThrown":false},"id":58} info: [debug] Responding to client with success: {"status":0,"value":{"width":631,"height":44},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/size 200 50.300 ms - 97 {"status":0,"value":{"width":631,"height":44},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/moveto {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","element":"5120","xoffset":315,"yoffset":22} info: [debug] [REMOTE] Executing 'get_top_left_coordinates' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"x\":64,\"y\":-0.3125,\"toString\":\"function () {return\"(\"+this.x+\", \"+this.y+\")\";}\",\"ceil\":\"function () {this.x=Math.ceil(this.x);this.y=Math.ceil(this.y);return this;}\",\"floor\":\"function () {this.x=M... info: [debug] [REMOTE] Executing 'move_mouse' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":60} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/moveto 200 216.895 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/moveto {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","element":"5120","xoffset":315,"yoffset":22} info: [debug] [REMOTE] Executing 'get_top_left_coordinates' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"x\":64,\"y\":43.6875,\"toString\":\"function () {return\"(\"+this.x+\", \"+this.y+\")\";}\",\"ceil\":\"function () {this.x=Math.ceil(this.x);this.y=Math.ceil(this.y);return this;}\",\"floor\":\"function () {this.x=M... info: [debug] [REMOTE] Executing 'move_mouse' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":62} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/moveto 200 158.606 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/moveto {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","element":"5120"} info: [debug] [REMOTE] Executing 'get_top_left_coordinates' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"x\":64,\"y\":43.6875,\"toString\":\"function () {return\"(\"+this.x+\", \"+this.y+\")\";}\",\"ceil\":\"function () {this.x=Math.ceil(this.x);this.y=Math.ceil(this.y);return this;}\",\"floor\":\"function () {this.x=M... info: [debug] [REMOTE] Executing 'move_mouse' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":64} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/moveto 200 162.870 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/click {"button":0,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] Pushing command to appium work queue: "au.getElementsByType('webview')" info: [debug] Sending command to instruments: au.getElementsByType('webview') info: [debug] [INST] 2015-09-13 13:14:42 +0000 Debug: Got new command 12 from instruments: au.getElementsByType('webview') info: [debug] [INST] 2015-09-13 13:14:42 +0000 Debug: evaluating au.getElementsByType('webview') info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.788 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [INST] 2015-09-13 13:14:44 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:14:44 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:14:44 +0000 Debug: Running system command #13: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":[{"ELEMENT":"1"}]}... info: [debug] Socket data received (40 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":[{"ELEMENT":"1"}]} info: [debug] Pushing command to appium work queue: "au.getElement('1').rect()" info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function () { return {w: document.width, h: docum...] info: [debug] Sending command to instruments: au.getElement('1').rect() info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"object","value":{"w":1024,"h":704}},"wasThrown":false},"id":65} info: [debug] [INST] 2015-09-13 13:14:45 +0000 Debug: Got new command 13 from instruments: au.getElement('1').rect() info: [debug] [INST] 2015-09-13 13:14:45 +0000 Debug: evaluating au.getElement('1').rect() info: [debug] [INST] 2015-09-13 13:14:45 +0000 Debug: evaluation finished info: [debug] [INST] 2015-09-13 13:14:45 +0000 Debug: responding with: info: [debug] [INST] 2015-09-13 13:14:45 +0000 Debug: Running system command #14: /usr/local/Cellar/node/0.12.7/bin/node /Users/awingu/appium/node_modules/appium-uiauto/bin/command-proxy-client.js /tmp/instruments_sock 2,{"status":0,"value":{"origin":{"x":0,"y":64},"size":{"width":1024,"height":704}}}... info: [debug] Socket data received (83 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":{"origin":{"x":0,"y":64},"size":{"width":1024,"height":704}}} info: [debug] Converted web coords {"x":64.5,"y":44.1875}into real coords {"x":65,"y":148} info: [debug] Pushing command to appium work queue: "au.complexTap({\"x\":65,\"y\":148,\"tapCount\":1,\"duration\":0.3,\"touchCount\":1})" info: [debug] Sending command to instruments: au.complexTap({"x":65,"y":148,"tapCount":1,"duration":0.3,"touchCount":1}) info: [debug] [INST] 2015-09-13 13:14:46 +0000 Debug: Got new command 14 from instruments: au.complexTap({"x":65,"y":148,"tapCount":1,"duration":0.3,"touchCount":1}) info: [debug] [INST] 2015-09-13 13:14:46 +0000 Debug: evaluating au.complexTap({"x":65,"y":148,"tapCount":1,"duration":0.3,"touchCount":1}) info: [debug] [INST] 2015-09-13 13:14:46 +0000 Debug: target.tapWithOptions({x:"65", y:"148"}, {touchCount:"1", duration:"0.3", tapCount:"1"}) info: [debug] Socket data received (25 bytes) info: [debug] Socket data being routed. info: [debug] Got result from instruments: {"status":0,"value":""} info: [debug] Responding to client with success: {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/click 200 4982.894 ms - 74 {"status":0,"value":"","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/click {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","id":"5120"} info: [debug] [REMOTE] Executing 'click' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":null}"},"wasThrown":false},"id":66} info: [debug] Responding to client with success: {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element/5120/click 200 681.800 ms - 76 {"status":0,"value":null,"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.716 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["1","2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles 200 1.978 ms - 81 {"status":0,"value":["1","2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["NATIVE_APP","WEBVIEW_1","WEBVIEW_2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts 200 2.254 ms - 110 {"status":0,"value":["NATIVE_APP","WEBVIEW_1","WEBVIEW_2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"WEBVIEW_2"} info: [debug] Attempting to set context to 'WEBVIEW_2' info: [debug] [REMOTE] Disconnecting from remote debugger info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/2] info: [debug] Responding to client with success: {"status":0,"value":"WEBVIEW_2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 3.085 ms - 83 {"status":0,"value":"WEBVIEW_2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.550 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"2"} info: [debug] [REMOTE] Disconnecting from remote debugger info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/2] info: [debug] Responding to client with success: {"status":0,"value":"2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window 200 3.180 ms - 75 {"status":0,"value":"2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"2"} info: [debug] Remote debugger is already connected to window [2] info: [debug] Responding to client with success: {"status":0,"value":"2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window 200 0.894 ms - 75 {"status":0,"value":"2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["NATIVE_APP","WEBVIEW_1","WEBVIEW_2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/contexts 200 2.063 ms - 110 {"status":0,"value":["NATIVE_APP","WEBVIEW_1","WEBVIEW_2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context {"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","name":"WEBVIEW_2"} info: [debug] Attempting to set context to 'WEBVIEW_2' info: [debug] [REMOTE] Disconnecting from remote debugger info: [debug] [REMOTE] Debugger web socket connected to url [ws://localhost:27753/devtools/page/2] info: [debug] Responding to client with success: {"status":0,"value":"WEBVIEW_2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/context 200 2.608 ms - 83 {"status":0,"value":"WEBVIEW_2","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements {"using":"id","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"wsinput"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_elements' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1442150098421\"}]}"},"wasThrown":false},"id":67} info: [debug] Responding to client with success: {"status":0,"value":[{"ELEMENT":"5140"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/elements 200 689.587 ms - 92 {"status":0,"value":[{"ELEMENT":"5140"}],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element {"using":"id","sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d","value":"wsinput"} info: [debug] Waiting up to 1000ms for condition info: [debug] [REMOTE] Executing 'find_element' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){function h(a){return...] info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.590 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [INST] 2015-09-13 13:15:01 +0000 Fail: The target application appears to have died info: [debug] [INST STDERR] 2015-09-13 15:15:01.382 instruments[74933:3435688] Attempting to set event horizon when core is not engaged, request ignored info: [debug] [INST STDERR] 2015-09-13 15:15:01.383 instruments[74933:3435688] Attempting to set event horizon when core is not engaged, request ignored info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":{\"ELEMENT\":\":wdc:1442150098421\"}}"},"wasThrown":false},"id":68} info: [debug] Responding to client with success: {"status":0,"value":{"ELEMENT":"5141"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- POST /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/element 200 3906.887 ms - 90 {"status":0,"value":{"ELEMENT":"5141"},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] [INST] Instruments Trace Complete (Duration : 102.219109s; Output : /tmp/appium-instruments/instrumentscli0.trace) info: [debug] [INSTSERVER] Instruments exited with code 0 info: [debug] Cleaning up after instruments exit info: [debug] Not worrying about instruments exit since we're using SafariLauncher info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.610 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles {} info: [debug] [REMOTE] Getting WebKitRemoteDebugger pageArray info: [debug] Responding to client with success: {"status":0,"value":["1","2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/window_handles 200 1.927 ms - 81 {"status":0,"value":["1","2"],"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/session/bffa26af-37e0-4816-aa03-3342425c8b9d/screenshot {} info: [debug] Pushing command to appium work queue: "au.getScreenOrientation()" info: [debug] Sending command to instruments: au.getScreenOrientation() info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.655 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.561 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 1.015 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.849 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.588 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.580 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.693 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.728 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 1.046 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.858 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.860 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.603 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 1.006 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 1.401 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 2.885 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.843 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.658 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 0.992 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: <-- GET /wd/hub/status 200 1.139 ms - 178 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false},"sessionId":"bffa26af-37e0-4816-aa03-3342425c8b9d"} info: [debug] Didn't get a new command in 100 secs, shutting down... info: Shutting down appium session info: [debug] Stopping safariLauncher info: [debug] Stopping iOS log capture info: [debug] [REMOTE] Executing 'execute_script' atom in default context info: [debug] [REMOTE] Sending javascript command info: [debug] [REMOTE] Remote debugger data sent [{"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var g=this;\nfunctio...] info: [debug] Running ios sim reset flow info: [debug] Killing the simulator process info: [debug] Killing any other simulator daemons info: [debug] Killall iOS Simulator info: [debug] fullReset requested. Will try to uninstall the app. info: [debug] [REMOTE] Debugger web socket received data: {"result":{"result":{"type":"object","value":{"status":0,"value":null}},"wasThrown":false},"id":69} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false}} info: <-- GET /wd/hub/status 200 1.119 ms - 127 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"},"isShuttingDown":false}} info: [debug] [REMOTE] Disconnecting from remote debugger info: [debug] Cleaning up appium session info: [debug] We shut down because no new commands came in info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: <-- GET /wd/hub/status 200 0.650 ms - 104 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: <-- GET /wd/hub/status 200 0.701 ms - 104 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: <-- GET /wd/hub/status 200 0.658 ms - 104 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: --> GET /wd/hub/status {} info: [debug] Responding to client with success: {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}} info: <-- GET /wd/hub/status 200 0.625 ms - 104 {"status":0,"value":{"build":{"version":"1.4.8","revision":"b6cfeec3a9d2d0269c952f81d8649231233c09ca"}}}

Cagy commented 9 years ago

I have this issue together with vvvvaib.

Is there any way of doing a safari (cache) reset so our tests can run succesfully (almost) every time? Running a second test will always fail as mentioned above.

scottdixon-zz commented 8 years ago

@cagy @vvvvaib does this issue persist in Appium 1.5?

vvvvaib commented 8 years ago

@scottdixon didn't test on 1.5. We finally had to settle with simulators for iOS because of this crazy issue:(. No more working on that project.

SrinivasanTarget commented 8 years ago

@triager please close

lock[bot] commented 5 years ago

This thread has been automatically locked since there has not been any recent activity after it was closed. Please open a new issue for related bugs.