Last login: Wed Oct 16 18:56:08 on ttys000 You have mail. system:~ user$ cd $appium system:appium user$ node . --address 127.0.0.6 -p 1239 -cp 1239 -bp 2350 [Appium] Welcome to Appium v1.15.0 [Appium] Non-default server args: [Appium] address: 127.0.0.6 [Appium] port: 1239 [Appium] callbackPort: 1239 [Appium] bootstrapPort: 2350 [Appium] Appium REST http interface listener started on 127.0.0.6:1239 [HTTP] --> POST /wd/hub/session [HTTP] {"desiredCapabilities":{"orientation":"LANDSCAPE","startIWDP":true,"deviceName":"iPad_1","wdaLaunchTimeout":90000,"webkitDebugProxyPort":27759,"newCommandTimeout":600,"platformVersion":"13.1.2","automationName":"XCUITest","browserName":"Safari","platformName":"iOS","udid":"3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a","wdaConnectionTimeout":90000},"capabilities":{"firstMatch":[{"appium:automationName":"XCUITest","browserName":"Safari","appium:deviceName":"iPad_1","appium:newCommandTimeout":600,"appium:orientation":"LANDSCAPE","platformName":"ios","appium:platformVersion":"13.1.2","appium:startIWDP":true,"appium:udid":"3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a","appium:wdaConnectionTimeout":90000,"appium:wdaLaunchTimeout":90000,"webkitDebugProxyPort":27759}]}} [debug] [W3C] Calling AppiumDriver.createSession() with args: [{"orientation":"LANDSCAPE","startIWDP":true,"deviceName":"iPad_1","wdaLaunchTimeout":90000,"webkitDebugProxyPort":27759,"newCommandTimeout":600,"platformVersion":"13.1.2","automationName":"XCUITest","browserName":"Safari","platformName":"iOS","udid":"3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a","wdaConnectionTimeout":90000},null,{"firstMatch":[{"appium:automationName":"XCUITest","browserName":"Safari","appium:deviceName":"iPad_1","appium:newCommandTimeout":600,"appium:orientation":"LANDSCAPE","platformName":"ios","appium:platformVersion":"13.1.2","appium:startIWDP":true,"appium:udid":"3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a","appium:wdaConnectionTimeout":90000,"appium:wdaLaunchTimeout":90000,"webkitDebugProxyPort":27759}]}] [debug] [BaseDriver] Event 'newSessionRequested' logged at 1571232622557 (19:00:22 GMT+0530 (India Standard Time)) [BaseDriver] The capabilities ["webkitDebugProxyPort"] are not standard capabilities and should have an extension prefix [Appium] Appium v1.15.0 creating new XCUITestDriver (v2.133.1) session [debug] [BaseDriver] W3C capabilities and MJSONWP desired capabilities were provided [debug] [BaseDriver] Creating session with W3C capabilities: { [debug] [BaseDriver] "alwaysMatch": { [debug] [BaseDriver] "browserName": "Safari", [debug] [BaseDriver] "platformName": "ios", [debug] [BaseDriver] "appium:webkitDebugProxyPort": 27759, [debug] [BaseDriver] "appium:automationName": "XCUITest", [debug] [BaseDriver] "appium:deviceName": "iPad_1", [debug] [BaseDriver] "appium:newCommandTimeout": 600, [debug] [BaseDriver] "appium:orientation": "LANDSCAPE", [debug] [BaseDriver] "appium:platformVersion": "13.1.2", [debug] [BaseDriver] "appium:startIWDP": true, [debug] [BaseDriver] "appium:udid": "3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a", [debug] [BaseDriver] "appium:wdaConnectionTimeout": 90000, [debug] [BaseDriver] "appium:wdaLaunchTimeout": 90000 [debug] [BaseDriver] }, [debug] [BaseDriver] "firstMatch": [ [debug] [BaseDriver] {} [debug] [BaseDriver] ] [debug] [BaseDriver] } [BaseDriver] Session created with session id: eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8 [debug] [XCUITest] Current user: 'user' [debug] [XCUITest] Available devices: 3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a [debug] [XCUITest] Creating iDevice object with udid '3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a' [XCUITest] Determining device to run tests on: udid: '3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a', real device: true [XCUITest] Normalized platformVersion capability value '13.1.2' to '13.1' [debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1571232623352 (19:00:23 GMT+0530 (India Standard Time)) [XCUITest] Safari test requested [debug] [BaseDriver] Event 'appConfigured' logged at 1571232623354 (19:00:23 GMT+0530 (India Standard Time)) [debug] [BaseDriver] Event 'resetStarted' logged at 1571232623354 (19:00:23 GMT+0530 (India Standard Time)) [debug] [XCUITest] Reset: running ios real device reset flow [debug] [BaseDriver] Event 'resetComplete' logged at 1571232623356 (19:00:23 GMT+0530 (India Standard Time)) [debug] [XCUITest] Crash reports root '/Users/user/Library/Logs/CrashReporter/MobileDevice/iPad_1' does not exist. Got nothing to gather. [debug] [BaseDriver] Event 'logCaptureStarted' logged at 1571232623630 (19:00:23 GMT+0530 (India Standard Time)) [XCUITest] Setting up real device [XCUITest] Using WDA path: '/Applications/Appium.app/Contents/Resources/app/node_modules/appium/node_modules/appium-webdriveragent' [XCUITest] Using WDA agent: '/Applications/Appium.app/Contents/Resources/app/node_modules/appium/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj' [debug] [XCUITest] No obsolete cached processes from previous WDA sessions listening on port 8100 have been found [DevCon Factory] Requesting connection for device 3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a on local port 8100, device port 8100 [debug] [DevCon Factory] Cached connections count: 0 [DevCon Factory] Port #8100 is busy [DevCon Factory] Successfully requested the connection for 3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a:8100 [debug] [XCUITest] Parsed BUILD_DIR configuration value: '/Users/user/Library/Developer/Xcode/DerivedData/WebDriverAgent-alwvnomvwrdtzoaxbbkniqrpcdpp/Build/Products' [debug] [XCUITest] Got derived data root: '/Users/user/Library/Developer/Xcode/DerivedData/WebDriverAgent-alwvnomvwrdtzoaxbbkniqrpcdpp' [debug] [XCUITest] Starting WebDriverAgent initialization with the synchronization key '/Users/user/Library/Developer/Xcode/DerivedData/WebDriverAgent-alwvnomvwrdtzoaxbbkniqrpcdpp' [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body [debug] [WD Proxy] Got response with status 200: { [debug] [WD Proxy] "value" : { [debug] [WD Proxy] "message" : "WebDriverAgent is ready to accept commands", [debug] [WD Proxy] "state" : "success", [debug] [WD Proxy] "os" : { [debug] [WD Proxy] "name" : "iOS", [debug] [WD Proxy] "version" : "13.1.2", [debug] [WD Proxy] "sdkVersion" : "13.0" [debug] [WD Proxy] }, [debug] [WD Proxy] "ios" : { [debug] [WD Proxy] "simulatorVersion" : "13.1.2", [debug] [WD Proxy] "ip" : "192.168.13.150" [debug] [WD Proxy] }, [debug] [WD Proxy] "ready" : true, [debug] [WD Proxy] "build" : { [debug] [WD Proxy] "upgradedAt" : "1570992359031", [debug] [WD Proxy] "time" : "Oct 16 2019 11:38:28", [debug] [WD Proxy] "productBundleIdentifier" : "com.facebook.WebDriverAgentRunner" [debug] [WD Proxy] } [debug] [WD Proxy] }, [debug] [WD Proxy] "sessionId" : "9BA8A90E-79EC-40E1-A6A5-88FB1679536E" [debug] [WD Proxy] } [debug] [XCUITest] Upgrade timestamp of the currently bundled WDA: 1570992359031 [debug] [XCUITest] Upgrade timestamp of the WDA on the device: 1570992359031 [XCUITest] Will reuse previously cached WDA instance at 'http://localhost:8100/' with 'com.facebook.WebDriverAgentRunner'. Set the wdaLocalPort capability to a value different from 8100 if this is an undesired behavior. [debug] [XCUITest] Trying to start WebDriverAgent 1 times with 10000ms interval [debug] [XCUITest] These values can be customized by changing wdaStartupRetries/wdaStartupRetryInterval capabilities [debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1571232628536 (19:00:28 GMT+0530 (India Standard Time)) [XCUITest] Using provided WebdriverAgent at 'http://localhost:8100/' [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body [debug] [WD Proxy] Got response with status 200: { [debug] [WD Proxy] "value" : { [debug] [WD Proxy] "message" : "WebDriverAgent is ready to accept commands", [debug] [WD Proxy] "state" : "success", [debug] [WD Proxy] "os" : { [debug] [WD Proxy] "name" : "iOS", [debug] [WD Proxy] "version" : "13.1.2", [debug] [WD Proxy] "sdkVersion" : "13.0" [debug] [WD Proxy] }, [debug] [WD Proxy] "ios" : { [debug] [WD Proxy] "simulatorVersion" : "13.1.2", [debug] [WD Proxy] "ip" : "192.168.13.150" [debug] [WD Proxy] }, [debug] [WD Proxy] "ready" : true, [debug] [WD Proxy] "build" : { [debug] [WD Proxy] "upgradedAt" : "1570992359031", [debug] [WD Proxy] "time" : "Oct 16 2019 11:38:28", [debug] [WD Proxy] "productBundleIdentifier" : "com.facebook.WebDriverAgentRunner" [debug] [WD Proxy] } [debug] [WD Proxy] }, [debug] [WD Proxy] "sessionId" : "9BA8A90E-79EC-40E1-A6A5-88FB1679536E" [debug] [WD Proxy] } [debug] [BaseDriver] Event 'wdaSessionAttempted' logged at 1571232628567 (19:00:28 GMT+0530 (India Standard Time)) [debug] [XCUITest] Sending createSession command to WDA [debug] [WD Proxy] Matched '/session' to command name 'createSession' [debug] [WD Proxy] Proxying [POST /session] to [POST http://localhost:8100/session] with body: {"capabilities":{"firstMatch":[{"bundleId":"com.apple.mobilesafari","arguments":[],"environment":{},"eventloopIdleDelaySec":0,"shouldWaitForQuiescence":true,"shouldUseTestManagerForVisibilityDetection":false,"maxTypingFrequency":60,"shouldUseSingletonTestManager":true}],"alwaysMatch":{}}} [debug] [WD Proxy] Got response with status 200: {"value":{"sessionId":"5A858A59-B6C7-4811-A2B5-2081697FC3E5","capabilities":{"device":"ipad","browserName":"Safari","sdkVersion":"13.1.2","CFBundleIdentifier":"com.apple.mobilesafari"}},"sessionId":"5A858A59-B6C7-4811-A2B5-2081697FC3E5"} [WD Proxy] Determined the downstream protocol as 'W3C' [debug] [BaseDriver] Event 'wdaSessionStarted' logged at 1571232635139 (19:00:35 GMT+0530 (India Standard Time)) [debug] [BaseDriver] Event 'wdaStarted' logged at 1571232635139 (19:00:35 GMT+0530 (India Standard Time)) [debug] [XCUITest] Setting initial orientation to 'LANDSCAPE' [debug] [WD Proxy] Matched '/orientation' to command name 'setOrientation' [debug] [WD Proxy] Proxying [POST /orientation] to [POST http://localhost:8100/session/5A858A59-B6C7-4811-A2B5-2081697FC3E5/orientation] with body: {"orientation":"LANDSCAPE"} [debug] [WD Proxy] Got response with status 200: {"value":null,"sessionId":"5A858A59-B6C7-4811-A2B5-2081697FC3E5"} [debug] [BaseDriver] Event 'orientationSet' logged at 1571232636688 (19:00:36 GMT+0530 (India Standard Time)) [debug] [XCUITest] Waiting for initial webview [debug] [iOS] Navigating to most recently opened webview [debug] [iOS] Retrieving contexts and views [debug] [XCUITest] Selecting by url: false [RemoteDebugger] Remote Debugger version 5.7.0 [debug] [RemoteDebugger] useNewSafari --> false [debug] [RemoteDebugger] Checking which communication style to use (Safari on platform version '13.1') [debug] [RemoteDebugger] Platform version equal or higher than '12.2': true [RemoteDebugger] Setting communication protocol: using Target-based communication [debug] [RemoteDebugger] Sending connection key request [debug] [RemoteDebugger] Sending '_rpc_reportIdentifier:' message (id: 0) [debug] [RemoteDebugger] Connected to application [debug] [RemoteDebugger] Selecting application [debug] [RemoteDebugger] No applications currently connected. [debug] [XCUITest] No web frames found. [iOS] Could not find any webviews yet, refreshing/retrying [debug] [RemoteDebugger] Notified that new application 'PID:480' has connected [debug] [RemoteDebugger] Found app id key 'PID:480' for bundle 'com.apple.mobilesafari' [debug] [RemoteDebugger] Notified that new application 'PID:482' has connected [debug] [RemoteDebugger] Current applications available: [debug] [RemoteDebugger] Application: 'PID:480' [debug] [RemoteDebugger] id: "PID:480" [debug] [RemoteDebugger] isProxy: false [debug] [RemoteDebugger] name: "Safari" [debug] [RemoteDebugger] bundleId: "com.apple.mobilesafari" [debug] [RemoteDebugger] hostId: undefined [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: [debug] [RemoteDebugger] - id: 1 [debug] [RemoteDebugger] title: "Project" [debug] [RemoteDebugger] url: "https://company.testfairy.com/join/yg6tgw56" [debug] [RemoteDebugger] isKey: false [debug] [RemoteDebugger] Application: 'PID:482' [debug] [RemoteDebugger] id: "PID:482" [debug] [RemoteDebugger] isProxy: true [debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent" [debug] [RemoteDebugger] bundleId: "process-com.apple.WebKit.WebContent" [debug] [RemoteDebugger] hostId: "PID:480" [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: 'Waiting for data' [debug] [RemoteDebugger] Page changed: { [debug] [RemoteDebugger] "1": { [debug] [RemoteDebugger] "WIRTitleKey": "Project", [debug] [RemoteDebugger] "WIRTypeKey": "WIRTypeWeb", [debug] [RemoteDebugger] "WIRURLKey": "https://company.testfairy.com/join/yg6tgw56", [debug] [RemoteDebugger] "WIRPageIdentifierKey": 1 [debug] [RemoteDebugger] } [debug] [RemoteDebugger] } [debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"480","pageArray":[{"id":1,"title":"Project","url":"https://company.testfairy.com/join/yg6tgw56","isKey":false}]} [debug] [iOS] No key id found. Choosing first id from page array [debug] [iOS] We do not appear to have window set yet, ignoring [debug] [iOS] Retrieving contexts and views [debug] [XCUITest] Selecting by url: false [debug] [RemoteDebugger] Selecting application [debug] [RemoteDebugger] Current applications available: [debug] [RemoteDebugger] Application: 'PID:480' [debug] [RemoteDebugger] id: "PID:480" [debug] [RemoteDebugger] isProxy: false [debug] [RemoteDebugger] name: "Safari" [debug] [RemoteDebugger] bundleId: "com.apple.mobilesafari" [debug] [RemoteDebugger] hostId: undefined [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: [debug] [RemoteDebugger] - id: 1 [debug] [RemoteDebugger] title: "Project" [debug] [RemoteDebugger] url: "https://company.testfairy.com/join/yg6tgw56" [debug] [RemoteDebugger] isKey: false [debug] [RemoteDebugger] Application: 'PID:482' [debug] [RemoteDebugger] id: "PID:482" [debug] [RemoteDebugger] isProxy: true [debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent" [debug] [RemoteDebugger] bundleId: "process-com.apple.WebKit.WebContent" [debug] [RemoteDebugger] hostId: "PID:480" [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: 'Waiting for data' [debug] [RemoteDebugger] Found app id key 'PID:480' for bundle 'com.apple.mobilesafari' [debug] [RemoteDebugger] Found separate bundleId 'process-com.apple.WebKit.WebContent' acting as proxy for 'com.apple.mobilesafari', with app id 'PID:482' [debug] [RemoteDebugger] Trying out the possible app ids: PID:480, PID:482 [debug] [RemoteDebugger] Selecting app PID:480 (try #1 of 20) [debug] [RemoteDebugger] Sending '_rpc_forwardGetListing:' message to app 'PID:480' (id: 1) [debug] [RemoteDebugger] Received response from send (id: 1): '["PID:480",{"1":{"WIRTitleKey":"Project","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://company.testfairy.com/join/yg6tgw56","WIRPageIdentifierKey":1}}]' [debug] [RemoteDebugger] Received page change notice for app 'PID:480' but the listing has not changed. Ignoring. [debug] [RemoteDebugger] Sending to Web Inspector took 11ms [debug] [RemoteDebugger] Current applications available: [debug] [RemoteDebugger] Application: 'PID:480' [debug] [RemoteDebugger] id: "PID:480" [debug] [RemoteDebugger] isProxy: false [debug] [RemoteDebugger] name: "Safari" [debug] [RemoteDebugger] bundleId: "com.apple.mobilesafari" [debug] [RemoteDebugger] hostId: undefined [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: [debug] [RemoteDebugger] - id: 1 [debug] [RemoteDebugger] title: "Project" [debug] [RemoteDebugger] url: "https://company.testfairy.com/join/yg6tgw56" [debug] [RemoteDebugger] isKey: false [debug] [RemoteDebugger] Application: 'PID:482' [debug] [RemoteDebugger] id: "PID:482" [debug] [RemoteDebugger] isProxy: true [debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent" [debug] [RemoteDebugger] bundleId: "process-com.apple.WebKit.WebContent" [debug] [RemoteDebugger] hostId: "PID:480" [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: 'Waiting for data' [debug] [RemoteDebugger] Finally selecting app PID:480: [{"id":1,"title":"Project","url":"https://company.testfairy.com/join/yg6tgw56","isKey":false}] [debug] [RemoteDebugger] Selected app after 27ms [debug] [iOS] Picking webview 'WEBVIEW_480.1' [debug] [XCUITest] Attempting to set context to 'WEBVIEW_480.1' [debug] [RemoteDebugger] Selecting page '1' on app 'PID:480' and forwarding socket setup [debug] [RemoteDebugger] Sending '_rpc_forwardSocketSetup:' message to app 'PID:480', page '1' (id: 2) [debug] [RemoteDebugger] Sending to Web Inspector took 5ms [debug] [RemoteDebugger] Sender key set [debug] [RemoteDebugger] Target created for app 'PID:480' and page '1': {"targetId":"page-6","type":"page"} [debug] [RemoteDebugger] Current applications available: [debug] [RemoteDebugger] Application: 'PID:480' [debug] [RemoteDebugger] id: "PID:480" [debug] [RemoteDebugger] isProxy: false [debug] [RemoteDebugger] name: "Safari" [debug] [RemoteDebugger] bundleId: "com.apple.mobilesafari" [debug] [RemoteDebugger] hostId: undefined [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: [debug] [RemoteDebugger] - id: 1 [debug] [RemoteDebugger] title: "Project" [debug] [RemoteDebugger] url: "https://company.testfairy.com/join/yg6tgw56" [debug] [RemoteDebugger] isKey: true [debug] [RemoteDebugger] Application: 'PID:482' [debug] [RemoteDebugger] id: "PID:482" [debug] [RemoteDebugger] isProxy: true [debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent" [debug] [RemoteDebugger] bundleId: "process-com.apple.WebKit.WebContent" [debug] [RemoteDebugger] hostId: "PID:480" [debug] [RemoteDebugger] isActive: 2 [debug] [RemoteDebugger] isAutomationEnabled: false [debug] [RemoteDebugger] pageArray: 'Waiting for data' [debug] [RemoteDebugger] Page changed: { [debug] [RemoteDebugger] "1": { [debug] [RemoteDebugger] "WIRTitleKey": "Project", [debug] [RemoteDebugger] "WIRTypeKey": "WIRTypeWeb", [debug] [RemoteDebugger] "WIRURLKey": "https://company.testfairy.com/join/yg6tgw56", [debug] [RemoteDebugger] "WIRPageIdentifierKey": 1, [debug] [RemoteDebugger] "WIRConnectionIdentifierKey": "21d4f479-14db-4763-be91-a4701a495c26" [debug] [RemoteDebugger] } [debug] [RemoteDebugger] } [debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"480","pageArray":[{"id":1,"title":"Project","url":"https://company.testfairy.com/join/yg6tgw56","isKey":true}]} [debug] [iOS] We do not appear to have window set yet, ignoring [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 3) [debug] [RemoteDebugger] Received data response from send (id: 3): '{}' [debug] [RemoteDebugger] Sending to Web Inspector took 1022ms [debug] [RemoteDebugger] Enabled activity on page [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 4) [debug] [RemoteDebugger] Received data response from send (id: 4): 'complete' [debug] [RemoteDebugger] Sending to Web Inspector took 49ms [debug] [RemoteDebugger] Document readyState is 'complete' [debug] [RemoteDebugger] Selected page after 1083ms [debug] [RemoteDebugger] Starting to listen for JavaScript console [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 5) [debug] [RemoteDebugger] Received data response from send (id: 5): '{}' [debug] [RemoteDebugger] Sending to Web Inspector took 10ms [debug] [RemoteDebugger] Starting to listen for network events [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 6) [debug] [RemoteDebugger] Received data response from send (id: 6): '{}' [debug] [RemoteDebugger] Sending to Web Inspector took 10ms [debug] [RemoteDebugger] Unregistering from page readiness notifications [debug] [BaseDriver] Event 'initialWebviewNavigated' logged at 1571232638574 (19:00:38 GMT+0530 (India Standard Time)) [debug] [iOS] Attempting to set url 'http://appium.io' [debug] [RemoteDebugger] Navigating to new URL: 'http://appium.io' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 7) [debug] [RemoteDebugger] Received data response from send (id: 7): '{}' [debug] [RemoteDebugger] Sending to Web Inspector took 35ms [debug] [RemoteDebugger] Notified that new application 'PID:483' has connected [debug] [RemoteDebugger] Received 'targetDestroyed' event with no target. Skipping [RemoteDebugger] Received 'targetCreated' event with no pending request: {"targetId":"page-6","type":"page"} [debug] [RemoteDebugger] Waiting for frame navigated message... [debug] [RemoteDebugger] Frame navigated in 0.503 sec from source: timeout [debug] [RemoteDebugger] Waiting for dom... [debug] [RemoteDebugger] Page loaded, verifying whether ready [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 8) [debug] [RemoteDebugger] Received data response from send (id: 8): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 18ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 9) [debug] [RemoteDebugger] Received data response from send (id: 9): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 14ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 10) [debug] [RemoteDebugger] Received data response from send (id: 10): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 14ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 11) [debug] [RemoteDebugger] Received data response from send (id: 11): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 13ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 12) [debug] [RemoteDebugger] Received data response from send (id: 12): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 15ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 13) [debug] [RemoteDebugger] Received data response from send (id: 13): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 12ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 14) [debug] [RemoteDebugger] Received data response from send (id: 14): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 16ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 15) [debug] [RemoteDebugger] Received data response from send (id: 15): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 14ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 16) [debug] [RemoteDebugger] Received data response from send (id: 16): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 12ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 17) [debug] [RemoteDebugger] Received data response from send (id: 17): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 13ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 18) [debug] [RemoteDebugger] Received data response from send (id: 18): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 13ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page was not ready, retrying [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 19) [debug] [RemoteDebugger] Received data response from send (id: 19): 'interactive' [debug] [RemoteDebugger] Sending to Web Inspector took 14ms [debug] [RemoteDebugger] Document readyState is 'interactive' [debug] [RemoteDebugger] Page is ready [Appium] New XCUITestDriver session created successfully, session eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8 added to master session list [debug] [BaseDriver] Event 'newSessionStarted' logged at 1571232646361 (19:00:46 GMT+0530 (India Standard Time)) [debug] [W3C (eb0a2b60)] Cached the protocol value 'W3C' for the new session eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8 [debug] [W3C (eb0a2b60)] Responding to client with driver.createSession() result: {"capabilities":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"Safari","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"platformName":"ios","webkitDebugProxyPort":27759,"automationName":"XCUITest","deviceName":"iPad_1","newCommandTimeout":600,"orientation":"LANDSCAPE","platformVersion":"13.1.2","startIWDP":true,"udid":"3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a","wdaConnectionTimeout":90000,"wdaLaunchTimeout":90000}} [HTTP] <-- POST /wd/hub/session 200 23812 ms - 593 [HTTP] [HTTP] --> GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8 [HTTP] {} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.getSession() with args: ["eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'getSession' [debug] [WD Proxy] Matched '/' to command name 'getSession' [debug] [WD Proxy] Proxying [GET /] to [GET http://localhost:8100/session/5A858A59-B6C7-4811-A2B5-2081697FC3E5] with no body [debug] [WD Proxy] Got response with status 200: { [debug] [WD Proxy] "value" : { [debug] [WD Proxy] "sessionId" : "5A858A59-B6C7-4811-A2B5-2081697FC3E5", [debug] [WD Proxy] "capabilities" : { [debug] [WD Proxy] "device" : "ipad", [debug] [WD Proxy] "browserName" : "Safari", [debug] [WD Proxy] "sdkVersion" : "13.1.2", [debug] [WD Proxy] "CFBundleIdentifier" : "com.apple.mobilesafari" [debug] [WD Proxy] } [debug] [WD Proxy] }, [debug] [WD Proxy] "sessionId" : "5A858A59-B6C7-4811-A2B5-2081697FC3E5" [debug] [WD Proxy] } [debug] [WD Proxy] Proxying [GET /wda/screen] to [GET http://localhost:8100/session/5A858A59-B6C7-4811-A2B5-2081697FC3E5/wda/screen] with no body [debug] [WD Proxy] Got response with status 200: { [debug] [WD Proxy] "value" : { [debug] [WD Proxy] "statusBarSize" : { [debug] [WD Proxy] "width" : 0, [debug] [WD Proxy] "height" : 0 [debug] [WD Proxy] }, [debug] [WD Proxy] "scale" : 2 [debug] [WD Proxy] }, [debug] [WD Proxy] "sessionId" : "5A858A59-B6C7-4811-A2B5-2081697FC3E5" [debug] [WD Proxy] } [debug] [RemoteDebugger] Executing atom 'get_window_size' [debug] [RemoteDebugger] Executing 'get_window_size' atom in default context [debug] [RemoteDebugger] Sending javascript command: '(function(){return function(){var c=this;var aa...' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 20) [debug] [RemoteDebugger] Received data response from send (id: 20): '{"width":1112,"height":834}' [debug] [RemoteDebugger] Sending to Web Inspector took 8ms [debug] [RemoteDebugger] Received result for atom 'get_window_size' execution: {"width":1112,"height":834} [XCUITest] Merging WDA caps over Appium caps for session detail response [debug] [W3C (eb0a2b60)] Responding to client with driver.getSession() result: {"udid":"3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a","browserName":"Safari","platformName":"ios","webkitDebugProxyPort":27759,"automationName":"XCUITest","deviceName":"iPad_1","newCommandTimeout":600,"orientation":"LANDSCAPE","platformVersion":"13.1.2","startIWDP":true,"wdaConnectionTimeout":90000,"wdaLaunchTimeout":90000,"device":"ipad","sdkVersion":"13.1.2","CFBundleIdentifier":"com.apple.mobilesafari","pixelRatio":2,"statBarHeight":0,"viewportRect":{"left":0,"top":0,"width":2224,"height":1668}} [HTTP] <-- GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8 200 241 ms - 524 [HTTP] [HTTP] --> GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8 [HTTP] {} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.getSession() with args: ["eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'getSession' [XCUITest] Merging WDA caps over Appium caps for session detail response [debug] [W3C (eb0a2b60)] Responding to client with driver.getSession() result: {"udid":"3fe3a47c90d8833964373c48dddddddd8ff05236e5f38929c268a","browserName":"Safari","platformName":"ios","webkitDebugProxyPort":27759,"automationName":"XCUITest","deviceName":"iPad_1","newCommandTimeout":600,"orientation":"LANDSCAPE","platformVersion":"13.1.2","startIWDP":true,"wdaConnectionTimeout":90000,"wdaLaunchTimeout":90000,"device":"ipad","sdkVersion":"13.1.2","CFBundleIdentifier":"com.apple.mobilesafari","pixelRatio":2,"statBarHeight":0,"viewportRect":{"left":0,"top":0,"width":2224,"height":1668}} [HTTP] <-- GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8 200 3 ms - 524 [HTTP] [HTTP] --> POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/appium/device/app_installed [HTTP] {"bundleId":"com..bundle_id123"} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.isAppInstalled() with args: ["com..bundle_id123","eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'isAppInstalled' [XCUITest] App 'com..bundle_id123' is installed [debug] [W3C (eb0a2b60)] Responding to client with driver.isAppInstalled() result: true [HTTP] <-- POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/appium/device/app_installed 200 243 ms - 14 [HTTP] [HTTP] --> POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/appium/device/terminate_app [HTTP] {"bundleId":"com..bundle_id123"} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.terminateApp() with args: ["com..bundle_id123",null,null,null,"eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'terminateApp' [debug] [WD Proxy] Proxying [POST /wda/apps/terminate] to [POST http://localhost:8100/session/5A858A59-B6C7-4811-A2B5-2081697FC3E5/wda/apps/terminate] with body: {"bundleId":"com..bundle_id123"} [debug] [WD Proxy] Got response with status 200: {"value":false,"sessionId":"5A858A59-B6C7-4811-A2B5-2081697FC3E5"} [debug] [W3C (eb0a2b60)] Responding to client with driver.terminateApp() result: false [HTTP] <-- POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/appium/device/terminate_app 200 19 ms - 15 [HTTP] [HTTP] --> POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/appium/device/terminate_app [HTTP] {"bundleId":"com..bundle_id123"} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.terminateApp() with args: ["com..bundle_id123",null,null,null,"eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'terminateApp' [debug] [WD Proxy] Proxying [POST /wda/apps/terminate] to [POST http://localhost:8100/session/5A858A59-B6C7-4811-A2B5-2081697FC3E5/wda/apps/terminate] with body: {"bundleId":"com..bundle_id123"} [debug] [WD Proxy] Got response with status 200: {"value":false,"sessionId":"5A858A59-B6C7-4811-A2B5-2081697FC3E5"} [debug] [W3C (eb0a2b60)] Responding to client with driver.terminateApp() result: false [HTTP] <-- POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/appium/device/terminate_app 200 12 ms - 15 [HTTP] [HTTP] --> GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/screenshot [HTTP] {} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.getScreenshot() with args: ["eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'getScreenshot' [debug] [XCUITest] Taking screenshot with WDA [debug] [WD Proxy] Matched '/screenshot' to command name 'getScreenshot' [debug] [WD Proxy] Proxying [GET /screenshot] to [GET http://localhost:8100/session/5A858A59-B6C7-4811-A2B5-2081697FC3E5/screenshot] with no body [debug] [WD Proxy] Got response with status 200: { [debug] [WD Proxy] "value" : "iVBORw0KGgoAAAANSUhEUgAACLAAAAaECAYAAADpT3WaAAAAAXNSR0IArs4c6QAA\r\nAERlWElmTU0AKgAAAAgAAYdpAAQAAAABAAAAGgAAAAAAA6ABAAMAAAABAAEAAKAC\r\nAAQAAAABAAAIsKADAAQAAAABAAAGhAAAAABF9EQhAAAAHGlET1QAAAACAAAAAAAA\r\nA0IAAAAoAAADQgAAA0IAC7hcpZGgzwAAQABJREFUeAHsvQeYX1W1\/k+xoffar72L\r\n5a8ghIReBFEuvRMCBBIMvVgARVCvXsWCAmmTThX1KtIEgUASEhLSQZpIJ6SRPpn6\r\nbVPWf332yfpymN9kJmYSQuSd59nPPmeXtdde+91nZs56z9pbFItFU5INhAFhQBgQ\r\nBoQBYUAYEAaEAWFAGBAGhAFhQBgQBoQBYUAYEAaEAWFAGBAGhAFhQBgQBoQBYUAY\r\nEAY2FQa22FQDa1yBXhgQBoQBYUAYEAaEAWFAGBAGhAFhQBgQBoQBYUAYEAaEAWFA\r\nGBAGhAFhQBgQBoQBYUAYEAaEAWEADIjAogg0isAjDAgDwoAwIAwIA8KAMCAMCAPC\r\ngDAgDAgDwoAwIAwIA8KAMCAMCAPCgDAgDAgDwoAwIAwIA8LAJsWACCwC4CYFoJh0\r\nYtIJA8KAMCAMCAPCgDAgDAgDwoAwIAwIA8KAMCAMCAPCgDAgDAgDwoAwIAwIA8KA\r\nMCAMCAPCQLcEllKpZKTGxkZrb2+3pqamdF+pVNaJ+EA\/2ra0tCQZ5XI55dwXCoWq\r\nDMpJgJLyGJe+zc3NKVFPOTpQFve05566aM+43FMe8qJ9yFuXDYCeMefoH2Pk5VBH\r\nYqzQj\/HpTzvqKKdvXV1dVffQIeqoR3faxzj5spgTOWNF\/\/XNkcFY6NnQ0GCtra1V\r\nW6IT5atXr062DL0Yi\/Gppy\/3XIetwy5Rt7660Y+5k9CThD6... [debug] [W3C (eb0a2b60)] Responding to client with driver.getScreenshot() result: "iVBORw0KGgoAAAANSUhEUgAACLAAAAaECAYAAADpT3WaAAAAAXNSR0IArs4c6QAA\r\nAERlWElmTU0AKgAAAAgAAYdpAAQAAAABAAAAGgAAAAAAA6ABAAMAAAABAAEAAKAC\r\nAAQAAAABAAAIsKADAAQAAAABAAAGhAAAAABF9EQhAAAAHGlET1QAAAACAAAAAAAA\r\nA0IAAAAoAAADQgAAA0IAC7hcpZGgzwAAQABJREFUeAHsvQeYX1W1/k+xoffar72L\r\n5a8ghIReBFEuvRMCBBIMvVgARVCvXsWCAmmTThX1KtIEgUASEhLSQZpIJ6SRPpn6\r\nbVPWf332yfpymN9kJmYSQuSd59nPPmeXtdde+91nZs56z9pbFItFU5INhAFhQBgQ\r\nBoQBYUAYEAaEAWFAGBAGhAFhQBgQBoQBYUAYEAaEAWFAGBAGhAFhQBgQBoQBYUAY\r\nEAY2FQa22FQDa1yBXhgQBoQBYUAYEAaEAWFAGBAGhAFhQBgQBoQBYUAYEAaEAWFA\r\nGBAGhAFhQBgQBoQBYUAYEAaEAWEADIjAogg0isAjDAgDwoAwIAwIA8KAMCAMCAPC\r\ngDAgDAgDwoAwIAwIA8KAMCAMCAPCgDAgDAgDwoAwIAwIA8LAJsWACCwC4CYFoJh0\r\nYtIJA8KAMCAMCAPCgDAgDAgDwoAwIAwIA8KAMCAMCAPCgDAgDAgDwoAwIAwIA8KA\r\nMCAMCAPCQLcEllKpZKTGxkZrb2+3pqamdF+pVNaJ+EA/2ra0tCQZ5XI55dwXCoWq\r\nDMpJgJLyGJe+zc3NKVFPOTpQFve05566aM+43FMe8qJ9yFuXDYCeMefoH2Pk5VBH\r\nYqzQj/HpTzvqKKdvXV1dVffQIeqoR3faxzj5spgTOWNF//XNkcFY6NnQ0GCtra1V\r\nW6IT5atXr062DL0Yi/Gppy/3XIetwy5Rt7660Y+5k9CThD6U53Vh7Kirr69P9ehA\r\n... [HTTP] <-- GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/screenshot 200 319 ms - 1998956 [HTTP] [HTTP] --> POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/url [HTTP] {"url":"https://company.testfairy.com/join/yg6tgw56"} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.setUrl() with args: ["https://company.testfairy.com/join/yg6tgw56","eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'setUrl' [debug] [iOS] Attempting to set url 'https://company.testfairy.com/join/yg6tgw56' [debug] [RemoteDebugger] Navigating to new URL: 'https://company.testfairy.com/join/yg6tgw56' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 21) [debug] [RemoteDebugger] Received data response from send (id: 21): '{}' [debug] [RemoteDebugger] Sending to Web Inspector took 43ms [debug] [RemoteDebugger] Notified that new application 'PID:486' has connected [debug] [RemoteDebugger] Waiting for frame navigated message... [debug] [RemoteDebugger] Received 'targetDestroyed' event with no target. Skipping [RemoteDebugger] Received 'targetCreated' event with no pending request: {"targetId":"page-6","type":"page"} [debug] [RemoteDebugger] Frame navigated in 0.502 sec from source: timeout [debug] [RemoteDebugger] Waiting for dom... [debug] [RemoteDebugger] Page loaded, verifying whether ready [debug] [RemoteDebugger] Checking document readyState [debug] [RemoteDebugger] Sending javascript command: '(function (){ return document.readyState; })()' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 22) [debug] [RemoteDebugger] Received data response from send (id: 22): 'complete' [debug] [RemoteDebugger] Sending to Web Inspector took 22ms [debug] [RemoteDebugger] Document readyState is 'complete' [debug] [RemoteDebugger] Page is ready [debug] [W3C (eb0a2b60)] Responding to client with driver.setUrl() result: null [HTTP] <-- POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/url 200 2085 ms - 14 [HTTP] [HTTP] --> POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/elements [HTTP] {"using":"xpath","value":"//span[text()='Download']/ancestor::a[1]"} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.findElements() with args: ["xpath","//span[text()='Download']/ancestor::a[1]","eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'findElements' [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id [debug] [BaseDriver] Waiting up to 0 ms for condition [debug] [RemoteDebugger] Executing atom 'find_elements' [debug] [RemoteDebugger] Executing 'find_elements' atom in default context [debug] [RemoteDebugger] Sending javascript command: '(function(){return function(){var k=this;functi...' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 23) [debug] [RemoteDebugger] Received data response from send (id: 23): '{"status":0,"value":[{"ELEMENT":":wdc:1571232650011"}]}' [debug] [RemoteDebugger] Sending to Web Inspector took 56ms [debug] [RemoteDebugger] Received result for atom 'find_elements' execution: [{"ELEMENT":":wdc:1571232650011"}] [debug] [W3C (eb0a2b60)] Responding to client with driver.findElements() result: [{"element-6066-11e4-a52e-4f735466cecf":"5000","ELEMENT":"5000"}] [HTTP] <-- POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/elements 200 68 ms - 75 [HTTP] [HTTP] --> GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element/5000/displayed [HTTP] {} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.elementDisplayed() with args: ["5000","eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'elementDisplayed' [debug] [RemoteDebugger] Executing atom 'is_displayed' [debug] [RemoteDebugger] Executing 'is_displayed' atom in default context [debug] [RemoteDebugger] Sending javascript command: '(function(){return function(){var h,l=this;func...' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 24) [debug] [RemoteDebugger] Received data response from send (id: 24): '{"status":0,"value":true}' [debug] [RemoteDebugger] Sending to Web Inspector took 40ms [debug] [RemoteDebugger] Received result for atom 'is_displayed' execution: true [debug] [W3C (eb0a2b60)] Responding to client with driver.elementDisplayed() result: true [HTTP] <-- GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element/5000/displayed 200 50 ms - 14 [HTTP] [HTTP] --> GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/screenshot [HTTP] {} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.getScreenshot() with args: ["eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'getScreenshot' [debug] [XCUITest] Taking screenshot with WDA [debug] [WD Proxy] Matched '/screenshot' to command name 'getScreenshot' [debug] [WD Proxy] Proxying [GET /screenshot] to [GET http://localhost:8100/session/5A858A59-B6C7-4811-A2B5-2081697FC3E5/screenshot] with no body [debug] [WD Proxy] Got response with status 200: { [debug] [WD Proxy] "value" : "iVBORw0KGgoAAAANSUhEUgAACLAAAAaECAYAAADpT3WaAAAAAXNSR0IArs4c6QAA\r\nAERlWElmTU0AKgAAAAgAAYdpAAQAAAABAAAAGgAAAAAAA6ABAAMAAAABAAEAAKAC\r\nAAQAAAABAAAIsKADAAQAAAABAAAGhAAAAABF9EQhAAAAHGlET1QAAAACAAAAAAAA\r\nA0IAAAAoAAADQgAAA0IAC+dV4W5Z8AAAQABJREFUeAHsnQe4nVWVvykW0BkVdexd\r\nRP9KCwm9CKIMSG8hQCDB0IsFGLGOjqLICKTddKrYpQkDBAIkpBeQLj0hjfSbW0+7\r\nZf3Xu7+7Dh+ZJPdObiAk+eV59vO1vddee+\/3O0nO+p21tygWi6aiORADYkAMiAEx\r\nIAbEgBgQA2JADIgBMSAGxIAYEANiQAyIATEgBsSAGBADYkAMiAExIAbEgBjYUAxs\r\nsaE6Vr+CXgyIATEgBsSAGBADYkAMiAExIAbEgBgQA2JADIgBMSAGxIAYEANiQAyI\r\nATEgBsSAGBADYgAGJGBRBhpl4BEDYkAMiAExIAbEgBgQA2JADIgBMSAGxIAYEANi\r\nQAyIATEgBsSAGBADYkAMiAExIAbEwAZlQAIWAbhBAZSSTko6MSAGxIAYEANiQAyI\r\nATEgBsSAGBADYkAMiAExIAbEgBgQA2JADIgBMSAGxIAYEANioFMBS6lUMkpjY6O1\r\nt7dbU1NTuq5UKl0SPtCOui0tLclGuVxOR64LhULVBvcpQMn96Je2zc3NqfCc+\/jA\r\nvbimPtc8i\/r0yzX3w17UD3tdeQHwM8Yc7aOPvB2eUegr\/KN\/2lOPZ9ynbV1dXdX3\r\n8CGe8RzfqR\/95O\/FmDjSV7Rf1yM26As\/GxoarLW1tTqX+MT9lStXprkMv+iL\/nlO\r\nW645j7mOeYln6+ob7Rg7BT8p+MP9vC\/0Hc\/q6+vTc3y... [debug] [W3C (eb0a2b60)] Responding to client with driver.getScreenshot() result: "iVBORw0KGgoAAAANSUhEUgAACLAAAAaECAYAAADpT3WaAAAAAXNSR0IArs4c6QAA\r\nAERlWElmTU0AKgAAAAgAAYdpAAQAAAABAAAAGgAAAAAAA6ABAAMAAAABAAEAAKAC\r\nAAQAAAABAAAIsKADAAQAAAABAAAGhAAAAABF9EQhAAAAHGlET1QAAAACAAAAAAAA\r\nA0IAAAAoAAADQgAAA0IAC+dV4W5Z8AAAQABJREFUeAHsnQe4nVWVvykW0BkVdexd\r\nRP9KCwm9CKIMSG8hQCDB0IsFGLGOjqLICKTddKrYpQkDBAIkpBeQLj0hjfSbW0+7\r\nZf3Xu7+7Dh+ZJPdObiAk+eV59vO1vddee+/3O0nO+p21tygWi6aiORADYkAMiAEx\r\nIAbEgBgQA2JADIgBMSAGxIAYEANiQAyIATEgBsSAGBADYkAMiAExIAbEgBjYUAxs\r\nsaE6Vr+CXgyIATEgBsSAGBADYkAMiAExIAbEgBgQA2JADIgBMSAGxIAYEANiQAyI\r\nATEgBsSAGBADYgAGJGBRBhpl4BEDYkAMiAExIAbEgBgQA2JADIgBMSAGxIAYEANi\r\nQAyIATEgBsSAGBADYkAMiAExIAbEwAZlQAIWAbhBAZSSTko6MSAGxIAYEANiQAyI\r\nATEgBsSAGBADYkAMiAExIAbEgBgQA2JADIgBMSAGxIAYEANioFMBS6lUMkpjY6O1\r\nt7dbU1NTuq5UKl0SPtCOui0tLclGuVxOR64LhULVBvcpQMn96Je2zc3NqfCc+/jA\r\nvbimPtc8i/r0yzX3w17UD3tdeQHwM8Yc7aOPvB2eUegr/KN/2lOPZ9ynbV1dXdX3\r\n8CGe8RzfqR/95O/FmDjSV7Rf1yM26As/GxoarLW1tTqX+MT9lStXprkMv+iL/nlO\r\nW645j7mOeYln6+ob7Rg7BT8p+MP9vC/0Hc/q6+vTc3ygHvfjGDa4jnsc29ra0tjD\r\n... [HTTP] <-- GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/screenshot 200 362 ms - 2345900 [HTTP] [HTTP] --> POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element [HTTP] {"using":"xpath","value":"//div[contains(text(),'Version')]"} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.findElement() with args: ["xpath","//div[contains(text(),'Version')]","eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'findElement' [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id [debug] [BaseDriver] Waiting up to 0 ms for condition [debug] [RemoteDebugger] Executing atom 'find_element' [debug] [RemoteDebugger] Executing 'find_element' atom in default context [debug] [RemoteDebugger] Sending javascript command: '(function(){return function(){var k=this;functi...' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 25) [debug] [RemoteDebugger] Received data response from send (id: 25): '{"status":0,"value":{"ELEMENT":":wdc:1571232650012"}}' [debug] [RemoteDebugger] Sending to Web Inspector took 47ms [debug] [RemoteDebugger] Received result for atom 'find_element' execution: {"ELEMENT":":wdc:1571232650012"} [debug] [W3C (eb0a2b60)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"5001","ELEMENT":"5001"} [HTTP] <-- POST /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element 200 60 ms - 73 [HTTP] [HTTP] --> GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element/5001/text [HTTP] {} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.getText() with args: ["5001","eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'getText' [debug] [RemoteDebugger] Executing atom 'get_text' [debug] [RemoteDebugger] Executing 'get_text' atom in default context [debug] [RemoteDebugger] Sending javascript command: '(function(){return function(){var h,l=this;func...' [debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to app 'PID:480', page '1', target 'page-6' (id: 26) [HTTP] <-- GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element/5001/text - - ms - - [HTTP] [HTTP] --> GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element/5001/text [HTTP] {} [debug] [W3C (eb0a2b60)] Calling AppiumDriver.getText() with args: ["5001","eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8"] [debug] [XCUITest] Executing command 'getText' [HTTP] <-- GET /wd/hub/session/eb0a2b60-a1b0-4a48-abcd-4f3238d86cd8/element/5001/text - - ms - - [HTTP]