Skip to content

Instantly share code, notes, and snippets.

@dpgraham

dpgraham/web-checkbox-logs.txt

Created September 4, 2019 17:36
Show Gist options
  • Save dpgraham/00bcf5595e37048730551e08bf99819f to your computer and use it in GitHub Desktop.
Save dpgraham/00bcf5595e37048730551e08bf99819f to your computer and use it in GitHub Desktop.
Download ZIP
Raw
web-checkbox-logs.txt
info XCUITest XCUITestDriver server listening on http://localhost:4994
info HTTP --> POST /wd/hub/session
info HTTP {"desiredCapabilities":{"safariIgnoreFraudWarning":false,"showSafariConsoleLog":true,"safariInitialUrl":"http://localhost:4994/test/guinea-pig","nativeWebTap":true,"browserName":"Safari","platformName":"iOS","platformVersion":"13.0","deviceName":"iPhone X","automationName":"XCUITest","noReset":true,"maxTypingFrequency":30,"clearSystemFiles":true,"wdaLaunchTimeout":240000,"wdaConnectionTimeout":480000,"useNewWDA":true}}
dbug MJSONWP Calling XCUITestDriver.createSession() with args: [{"safariIgnoreFraudWarning":false,"showSafariConsoleLog":true,"safariInitialUrl":"http://localhost:4994/test/guinea-pig","nativeWebTap":true,"browserName":"Safari","platformName":"iOS","platformVersion":"13.0","deviceName":"iPhone X","automationName":"XCUITest","noReset":true,"maxTypingFrequency":30,"clearSystemFiles":true,"wdaLaunchTimeout":240000,"wdaConnectionTimeout":480000,"useNewWDA":true},null,null]
dbug XCUITest Executing command 'createSession'
dbug BaseDriver Event 'newSessionRequested' logged at 1567618200872 (10:30:00 GMT-0700 (Pacific Daylight Time))
dbug BaseDriver Creating session with MJSONWP desired capabilities: {
dbug BaseDriver "safariIgnoreFraudWarning": false,
dbug BaseDriver "showSafariConsoleLog": true,
dbug BaseDriver "safariInitialUrl": "http://localhost:4994/test/guinea-pig",
dbug BaseDriver "nativeWebTap": true,
dbug BaseDriver "browserName": "Safari",
dbug BaseDriver "platformName": "iOS",
dbug BaseDriver "platformVersion": "13.0",
dbug BaseDriver "deviceName": "iPhone X",
dbug BaseDriver "automationName": "XCUITest",
dbug BaseDriver "noReset": true,
dbug BaseDriver "maxTypingFrequency": 30,
dbug BaseDriver "clearSystemFiles": true,
dbug BaseDriver "wdaLaunchTimeout": 240000,
dbug BaseDriver "wdaConnectionTimeout": 480000,
dbug BaseDriver "useNewWDA": true
dbug BaseDriver }
info BaseDriver Session created with session id: 72cc574c-2034-4009-8828-d42349d7978e
dbug XCUITest Current user: 'Daniel-Graham-SL1298'
info XCUITest iOS SDK Version set to '13.0'
info XCUITest Simulator udid not provided
info XCUITest Using desired caps to create a new simulator
dbug simctl Creating simulator with name 'appiumTest-55542478-77F8-4BFA-AA01-E9DA67945BDC-iPhone X', device type id 'iPhone X' and runtime id 'com.apple.CoreSimulator.SimRuntime.iOS-13-0'
info iOSSim Constructing iOS simulator for Xcode version 11.0 with udid '05113010-1394-4CAA-9418-E8E189E13A7B'
info XCUITest Created simulator with udid '05113010-1394-4CAA-9418-E8E189E13A7B'.
info XCUITest Determining device to run tests on: udid: '05113010-1394-4CAA-9418-E8E189E13A7B', real device: false
dbug BaseDriver Event 'xcodeDetailsRetrieved' logged at 1567618201511 (10:30:01 GMT-0700 (Pacific Daylight Time))
info XCUITest Safari test requested
dbug BaseDriver Event 'appConfigured' logged at 1567618201511 (10:30:01 GMT-0700 (Pacific Daylight Time))
dbug BaseDriver Event 'resetStarted' logged at 1567618201511 (10:30:01 GMT-0700 (Pacific Daylight Time))
dbug XCUITest Reset: noReset is on. Leaving simulator as is
dbug BaseDriver Event 'resetComplete' logged at 1567618201511 (10:30:01 GMT-0700 (Pacific Daylight Time))
WARN XCUITest Continuing without capturing device logs: iOS Simulator with udid 05113010-1394-4CAA-9418-E8E189E13A7B is not running
info XCUITest Setting up simulator
dbug iOS No reason to set locale
dbug iOS Setting iOS and app preferences
dbug iOSSim Checking whether simulator has been run before: no
dbug iOS No simulator directories found.
dbug iOSSim Attempting to launch and quit the simulator, to create directory structure
dbug iOSSim Will launch with Safari? true
dbug iOSSim Setting common Simulator preferences to {"RotateWindowWhenSignaledByGuest":true}
dbug iOSSim Updated 05113010-1394-4CAA-9418-E8E189E13A7B Simulator preferences at '/Users/danielgraham/Library/Preferences/com.apple.iphonesimulator.plist' with {"RotateWindowWhenSignaledByGuest":true}
dbug iOSSim Got Simulator UI client PID: 40560
info iOSSim Booting Simulator with UDID 05113010-1394-4CAA-9418-E8E189E13A7B...
info iOSSim Simulator with UDID 05113010-1394-4CAA-9418-E8E189E13A7B booted in 32 seconds
dbug iOSSim Safari has successfully opened 'http://www.appium.io' in 4 seconds
dbug iOSSim Checking whether simulator has been run before: yes
dbug iOS Setting fraudulent website warning to 'true'
dbug iOSSim Updating Safari user settings
dbug iOSSim Checking whether simulator has been run before: yes
dbug iOSSim Building bundle path map
dbug iOS Updated settings. Rebooting the simulator if it is already open
dbug XCUITest Killing running processes 'xcodebuild.*05113010-1394-4CAA-9418-E8E189E13A7B, 05113010-1394-4CAA-9418-E8E189E13A7B.*XCTRunner' for the device 05113010-1394-4CAA-9418-E8E189E13A7B...
dbug XCUITest 'pgrep -ifn xcodebuild.*05113010-1394-4CAA-9418-E8E189E13A7B' didn't detect any matching processes. Return code: 1
dbug XCUITest 'pgrep -ifn 05113010-1394-4CAA-9418-E8E189E13A7B.*XCTRunner' didn't detect any matching processes. Return code: 1
dbug iOS No reason to set locale
dbug iOS Setting iOS and app preferences
dbug iOSSim Checking whether simulator has been run before: yes
dbug iOS Setting fraudulent website warning to 'true'
dbug iOSSim Updating Safari user settings
dbug iOS Setting did not need to be updated
dbug iOSSim Setting preferences of 05113010-1394-4CAA-9418-E8E189E13A7B Simulator to {"ConnectHardwareKeyboard":false}
dbug iOSSim Setting common Simulator preferences to {"RotateWindowWhenSignaledByGuest":true,"ConnectHardwareKeyboard":false}
dbug iOSSim Updated 05113010-1394-4CAA-9418-E8E189E13A7B Simulator preferences at '/Users/danielgraham/Library/Preferences/com.apple.iphonesimulator.plist' with {"DevicePreferences":{"05113010-1394-4CAA-9418-E8E189E13A7B":{"ConnectHardwareKeyboard":false}},"RotateWindowWhenSignaledByGuest":true,"ConnectHardwareKeyboard":false}
dbug iOSSim Got Simulator UI client PID: 40560
info iOSSim Booting Simulator with UDID 05113010-1394-4CAA-9418-E8E189E13A7B...
info iOSSim Simulator with UDID 05113010-1394-4CAA-9418-E8E189E13A7B booted in 12 seconds
dbug IDB Connecting idb service to '05113010-1394-4CAA-9418-E8E189E13A7B'
dbug IDB Disconnecting idb service from '05113010-1394-4CAA-9418-E8E189E13A7B'
dbug IDB idb daemon started on port 9889
info IDB Successfully established the connection to idb service for '05113010-1394-4CAA-9418-E8E189E13A7B'
dbug BaseDriver Event 'simStarted' logged at 1567618272970 (10:31:12 GMT-0700 (Pacific Daylight Time))
dbug IOSSimulatorLog Starting log capture for iOS Simulator with udid '05113010-1394-4CAA-9418-E8E189E13A7B', using 'xcrun simctl spawn 05113010-1394-4CAA-9418-E8E189E13A7B log stream --style compact'
dbug BaseDriver Event 'logCaptureStarted' logged at 1567618274246 (10:31:14 GMT-0700 (Pacific Daylight Time))
info XCUITest Using WDA path: '/Users/danielgraham/appium-xcuitest-driver/node_modules/appium-webdriveragent'
info XCUITest Using WDA agent: '/Users/danielgraham/appium-xcuitest-driver/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj'
dbug XCUITest No obsolete cached processes from previous WDA sessions listening on port 8100 have been found
dbug XCUITest Starting WebDriverAgent initialization with the synchronization key 'XCUITestDriver'
dbug XCUITest Capability 'useNewWDA' set to true, so uninstalling WDA before proceeding
info XCUITest Shutting down sub-processes
dbug iOSSim Building bundle path map
dbug XCUITest No WDAs on the device.
dbug BaseDriver Event 'wdaUninstalled' logged at 1567618274390 (10:31:14 GMT-0700 (Pacific Daylight Time))
dbug XCUITest Trying to start WebDriverAgent 2 times with 10000ms interval
dbug XCUITest These values can be customized by changing wdaStartupRetries/wdaStartupRetryInterval capabilities
dbug BaseDriver Event 'wdaStartAttempted' logged at 1567618274391 (10:31:14 GMT-0700 (Pacific Daylight Time))
info XCUITest Launching WebDriverAgent on the device
info WebDriverAgent Fetching dependencies
info WebDriverAgent Dependencies up-to-date
dbug XCUITest Killing running processes 'xcodebuild.*05113010-1394-4CAA-9418-E8E189E13A7B, 05113010-1394-4CAA-9418-E8E189E13A7B.*XCTRunner' for the device 05113010-1394-4CAA-9418-E8E189E13A7B...
dbug XCUITest 'pgrep -ifn xcodebuild.*05113010-1394-4CAA-9418-E8E189E13A7B' didn't detect any matching processes. Return code: 1
dbug XCUITest 'pgrep -ifn 05113010-1394-4CAA-9418-E8E189E13A7B.*XCTRunner' didn't detect any matching processes. Return code: 1
dbug XCUITest Beginning test with command 'xcodebuild build-for-testing test-without-building -project /Users/danielgraham/appium-xcuitest-driver/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj -scheme WebDriverAgentRunner -destination id=05113010-1394-4CAA-9418-E8E189E13A7B IPHONEOS_DEPLOYMENT_TARGET=13.0 GCC_TREAT_WARNINGS_AS_ERRORS=0 COMPILER_INDEX_STORE_ENABLE=NO' in directory '/Users/danielgraham/appium-xcuitest-driver/node_modules/appium-webdriveragent'
dbug XCUITest Output from xcodebuild will only be logged if any errors are present there. To change this, use 'showXcodeLog' desired capability
dbug XCUITest Waiting up to 240000ms for WebDriverAgent to start
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug XCUITest Log file for xcodebuild test: /Users/danielgraham/Library/Developer/Xcode/DerivedData/WebDriverAgent-gsarxbnghdckurdrxkxxwuwfvisl/Logs/Test/Test-WebDriverAgentRunner-2019.09.04_10-31-16--0700.xcresult/Staging/2_Test/Diagnostics/WebDriverAgentRunner-3A85E736-E430-438C-9D22-5255B32AA2B4/WebDriverAgentRunner-0F34C2F5-7DDC-4E44-9230-642765BE832F/Session-WebDriverAgentRunner-2019-09-04_103118-4vUvVD.log
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : {
dbug WD Proxy "message" : "WebDriverAgent is ready to accept commands",
dbug WD Proxy "state" : "success",
dbug WD Proxy "os" : {
dbug WD Proxy "name" : "iOS",
dbug WD Proxy "version" : "13.0",
dbug WD Proxy "sdkVersion" : "13.0"
dbug WD Proxy },
dbug WD Proxy "ios" : {
dbug WD Proxy "simulatorVersion" : "13.0",
dbug WD Proxy "ip" : "10.30.0.76"
dbug WD Proxy },
dbug WD Proxy "ready" : true,
dbug WD Proxy "build" : {
dbug WD Proxy "upgradedAt" : "1567562906809",
dbug WD Proxy "time" : "Sep 3 2019 19:08:34",
dbug WD Proxy "productBundleIdentifier" : "com.facebook.WebDriverAgentRunner"
dbug WD Proxy }
dbug WD Proxy },
dbug WD Proxy "sessionId" : "8DCA7883-1BA7-4777-A3CB-23010A4F3E07"
dbug WD Proxy }
dbug XCUITest WebDriverAgent information:
dbug XCUITest {
dbug XCUITest "message": "WebDriverAgent is ready to accept commands",
dbug XCUITest "state": "success",
dbug XCUITest "os": {
dbug XCUITest "name": "iOS",
dbug XCUITest "version": "13.0",
dbug XCUITest "sdkVersion": "13.0"
dbug XCUITest },
dbug XCUITest "ios": {
dbug XCUITest "simulatorVersion": "13.0",
dbug XCUITest "ip": "10.30.0.76"
dbug XCUITest },
dbug XCUITest "ready": true,
dbug XCUITest "build": {
dbug XCUITest "upgradedAt": "1567562906809",
dbug XCUITest "time": "Sep 3 2019 19:08:34",
dbug XCUITest "productBundleIdentifier": "com.facebook.WebDriverAgentRunner"
dbug XCUITest }
dbug XCUITest }
dbug XCUITest WebDriverAgent successfully started after 7708ms
dbug BaseDriver Event 'wdaSessionAttempted' logged at 1567618282200 (10:31:22 GMT-0700 (Pacific Daylight Time))
dbug XCUITest Sending createSession command to WDA
dbug WD Proxy Matched '/session' to command name 'createSession'
dbug 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":30,"shouldUseSingletonTestManager":true}],"alwaysMatch":{}}}
dbug WD Proxy Got response with status 200: {"value":{"sessionId":"600717F0-3172-4B80-8B75-F963BF00D300","capabilities":{"device":"iphone","browserName":"Safari","sdkVersion":"13.0","CFBundleIdentifier":"com.apple.mobilesafari"}},"sessionId":"600717F0-3172-4B80-8B75-F963BF00D300"}
info WD Proxy Determined the downstream protocol as 'W3C'
dbug BaseDriver Event 'wdaSessionStarted' logged at 1567618287762 (10:31:27 GMT-0700 (Pacific Daylight Time))
dbug XCUITest Parsed BUILD_DIR configuration value: '/Users/danielgraham/Library/Developer/Xcode/DerivedData/WebDriverAgent-gsarxbnghdckurdrxkxxwuwfvisl/Build/Products'
dbug XCUITest Got derived data root: '/Users/danielgraham/Library/Developer/Xcode/DerivedData/WebDriverAgent-gsarxbnghdckurdrxkxxwuwfvisl'
dbug BaseDriver Event 'wdaStarted' logged at 1567618294031 (10:31:34 GMT-0700 (Pacific Daylight Time))
info XCUITest Skipping setting of the initial display orientation. Set the "orientation" capability to either "LANDSCAPE" or "PORTRAIT", if this is an undesired behavior.
dbug BaseDriver Event 'orientationSet' logged at 1567618294033 (10:31:34 GMT-0700 (Pacific Daylight Time))
dbug XCUITest Waiting for initial webview
dbug iOS Navigating to most recently opened webview
dbug iOS Retrieving contexts and views
dbug XCUITest Selecting by url: true (expected url: 'http://localhost:4994/test/guinea-pig')
info RemoteDebugger Remote Debugger version 5.3.0
dbug RemoteDebugger useNewSafari --> false
dbug RemoteDebugger Checking which communication style to use (Safari on platform version '13.0')
dbug RemoteDebugger Platform version equal or higher than '12.2': true
WARN RemoteDebugger Setting communication protocol: using Target-based communication
dbug RemoteDebugger Connecting to remote debugger through unix domain socket: '/private/tmp/com.apple.launchd.unhYgOltLF/com.apple.webinspectord_sim.socket'
dbug RemoteDebugger Debugger socket connected
dbug RemoteDebugger Sending connection key request
dbug RemoteDebugger Sending '_rpc_reportIdentifier:' message (id: 0)
info HTTP --> GET /test/guinea-pig
info HTTP {}
dbug HTTP Sending guinea pig response with params: {"throwError":"","serverTime":1567618294,"userAgent":"Mozilla/5.0 (iPhone; CPU iPhone OS 13_0 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/13.0 Mobile/15E148 Safari/604.1","comment":"None"}
info HTTP <-- GET /test/guinea-pig 200 25 ms - 3566
info HTTP
info HTTP <-- GET /js/jquery.min.js 200 3 ms - 92630
info HTTP
info HTTP <-- GET /favicon.ico 200 1 ms - 1150
info HTTP
dbug RemoteDebugger Connected to application
dbug RemoteDebugger Selecting application
dbug RemoteDebugger Current applications available:
dbug RemoteDebugger Application: 'PID:41474'
dbug RemoteDebugger id: "PID:41474"
dbug RemoteDebugger isProxy: false
dbug RemoteDebugger name: "Safari"
dbug RemoteDebugger bundleId: "com.apple.mobilesafari"
dbug RemoteDebugger hostId: undefined
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger Found app id key 'PID:41474' for bundle 'com.apple.mobilesafari'
dbug RemoteDebugger Trying out the possible app ids: PID:41474
dbug RemoteDebugger Selecting app PID:41474 (try #1 of 20)
dbug RemoteDebugger Sending '_rpc_forwardGetListing:' message to app 'PID:41474' (id: 1)
dbug RemoteDebugger We were notified we might have connected to the wrong app. Using id PID:41476 instead of PID:41474
dbug RemoteDebugger Notified that new application 'PID:41476' has connected
dbug RemoteDebugger Found app id key 'PID:41474' for bundle 'com.apple.mobilesafari'
dbug RemoteDebugger Found separate bundleId 'process-com.apple.WebKit.WebContent' acting as proxy for 'com.apple.mobilesafari', with app id 'PID:41476'
dbug RemoteDebugger Using proxied app id 'PID:41476'
dbug RemoteDebugger Error checking application: 'New application has connected'. Retrying connection
dbug RemoteDebugger Received response from send (id: 1): '["PID:41474",{"1":{"WIRTitleKey":"I am a page title","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"http://localhost:4994/test/guinea-pig","WIRPageIdentifierKey":1}}]'
dbug RemoteDebugger Current applications available:
dbug RemoteDebugger Application: 'PID:41474'
dbug RemoteDebugger id: "PID:41474"
dbug RemoteDebugger isProxy: false
dbug RemoteDebugger name: "Safari"
dbug RemoteDebugger bundleId: "com.apple.mobilesafari"
dbug RemoteDebugger hostId: undefined
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray:
dbug RemoteDebugger - id: 1
dbug RemoteDebugger title: "I am a page title"
dbug RemoteDebugger url: "http://localhost:4994/test/guinea-pig"
dbug RemoteDebugger isKey: false
dbug RemoteDebugger Application: 'PID:41476'
dbug RemoteDebugger id: "PID:41476"
dbug RemoteDebugger isProxy: true
dbug RemoteDebugger name: "com.apple.WebKit.WebContent"
dbug RemoteDebugger bundleId: "process-com.apple.WebKit.WebContent"
dbug RemoteDebugger hostId: "PID:41474"
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray: 'Waiting for data'
dbug RemoteDebugger Page changed: {
dbug RemoteDebugger "1": {
dbug RemoteDebugger "WIRTitleKey": "I am a page title",
dbug RemoteDebugger "WIRTypeKey": "WIRTypeWeb",
dbug RemoteDebugger "WIRURLKey": "http://localhost:4994/test/guinea-pig",
dbug RemoteDebugger "WIRPageIdentifierKey": 1
dbug RemoteDebugger }
dbug RemoteDebugger }
dbug RemoteDebugger Received page change notice for app 'PID:41474' but listening for 'PID:41476'. Ignoring.
dbug RemoteDebugger Sending to Web Inspector took 62ms
dbug RemoteDebugger Current applications available:
dbug RemoteDebugger Application: 'PID:41474'
dbug RemoteDebugger id: "PID:41474"
dbug RemoteDebugger isProxy: false
dbug RemoteDebugger name: "Safari"
dbug RemoteDebugger bundleId: "com.apple.mobilesafari"
dbug RemoteDebugger hostId: undefined
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray:
dbug RemoteDebugger - id: 1
dbug RemoteDebugger title: "I am a page title"
dbug RemoteDebugger url: "http://localhost:4994/test/guinea-pig"
dbug RemoteDebugger isKey: false
dbug RemoteDebugger Application: 'PID:41476'
dbug RemoteDebugger id: "PID:41476"
dbug RemoteDebugger isProxy: true
dbug RemoteDebugger name: "com.apple.WebKit.WebContent"
dbug RemoteDebugger bundleId: "process-com.apple.WebKit.WebContent"
dbug RemoteDebugger hostId: "PID:41474"
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray: 'Waiting for data'
dbug RemoteDebugger Found app id key 'PID:41474' for bundle 'com.apple.mobilesafari'
dbug RemoteDebugger Found separate bundleId 'process-com.apple.WebKit.WebContent' acting as proxy for 'com.apple.mobilesafari', with app id 'PID:41476'
dbug RemoteDebugger Trying out the possible app ids: PID:41474, PID:41476
dbug RemoteDebugger Selecting app PID:41474 (try #1 of 20)
dbug RemoteDebugger Sending '_rpc_forwardGetListing:' message to app 'PID:41474' (id: 2)
dbug RemoteDebugger Received response from send (id: 2): '["PID:41474",{"1":{"WIRTitleKey":"I am a page title","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"http://localhost:4994/test/guinea-pig","WIRPageIdentifierKey":1}}]'
dbug RemoteDebugger Received page change notice for app 'PID:41474' but the listing has not changed. Ignoring.
dbug RemoteDebugger Sending to Web Inspector took 3ms
dbug RemoteDebugger Received altered app id, updating from 'PID:41476' to 'PID:41474'
dbug RemoteDebugger Current applications available:
dbug RemoteDebugger Application: 'PID:41474'
dbug RemoteDebugger id: "PID:41474"
dbug RemoteDebugger isProxy: false
dbug RemoteDebugger name: "Safari"
dbug RemoteDebugger bundleId: "com.apple.mobilesafari"
dbug RemoteDebugger hostId: undefined
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray:
dbug RemoteDebugger - id: 1
dbug RemoteDebugger title: "I am a page title"
dbug RemoteDebugger url: "http://localhost:4994/test/guinea-pig"
dbug RemoteDebugger isKey: false
dbug RemoteDebugger Application: 'PID:41476'
dbug RemoteDebugger id: "PID:41476"
dbug RemoteDebugger isProxy: true
dbug RemoteDebugger name: "com.apple.WebKit.WebContent"
dbug RemoteDebugger bundleId: "process-com.apple.WebKit.WebContent"
dbug RemoteDebugger hostId: "PID:41474"
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray: 'Waiting for data'
dbug RemoteDebugger Finally selecting app PID:41474: [{"id":1,"title":"I am a page title","url":"http://localhost:4994/test/guinea-pig","isKey":false}]
dbug RemoteDebugger Selected app after 561ms
dbug iOS Picking webview 'WEBVIEW_41474.1'
dbug XCUITest Attempting to set context to 'WEBVIEW_41474.1'
dbug RemoteDebugger Selecting page '1' on app 'PID:41474' and forwarding socket setup
dbug RemoteDebugger Sending '_rpc_forwardSocketSetup:' message to app 'PID:41474', page '1' (id: 3)
dbug RemoteDebugger Sending to Web Inspector took 4ms
dbug RemoteDebugger Sender key set
dbug RemoteDebugger Target created for app 'PID:41474' and page '1': {"targetId":"page-6","type":"page"}
dbug RemoteDebugger Current applications available:
dbug RemoteDebugger Application: 'PID:41474'
dbug RemoteDebugger id: "PID:41474"
dbug RemoteDebugger isProxy: false
dbug RemoteDebugger name: "Safari"
dbug RemoteDebugger bundleId: "com.apple.mobilesafari"
dbug RemoteDebugger hostId: undefined
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray:
dbug RemoteDebugger - id: 1
dbug RemoteDebugger title: "I am a page title"
dbug RemoteDebugger url: "http://localhost:4994/test/guinea-pig"
dbug RemoteDebugger isKey: true
dbug RemoteDebugger Application: 'PID:41476'
dbug RemoteDebugger id: "PID:41476"
dbug RemoteDebugger isProxy: true
dbug RemoteDebugger name: "com.apple.WebKit.WebContent"
dbug RemoteDebugger bundleId: "process-com.apple.WebKit.WebContent"
dbug RemoteDebugger hostId: "PID:41474"
dbug RemoteDebugger isActive: 2
dbug RemoteDebugger isAutomationEnabled: false
dbug RemoteDebugger pageArray: 'Waiting for data'
dbug RemoteDebugger Page changed: {
dbug RemoteDebugger "1": {
dbug RemoteDebugger "WIRTitleKey": "I am a page title",
dbug RemoteDebugger "WIRTypeKey": "WIRTypeWeb",
dbug RemoteDebugger "WIRURLKey": "http://localhost:4994/test/guinea-pig",
dbug RemoteDebugger "WIRPageIdentifierKey": 1,
dbug RemoteDebugger "WIRConnectionIdentifierKey": "5ad582e5-90f6-43c6-9ada-866a83700f31"
dbug RemoteDebugger }
dbug RemoteDebugger }
dbug iOS Remote debugger notified us of a new page listing: {"appIdKey":"41474","pageArray":[{"id":1,"title":"I am a page title","url":"http://localhost:4994/test/guinea-pig","isKey":true}]}
dbug iOS We do not appear to have window set yet, ignoring
dbug RemoteDebugger Notified that new application 'PID:41517' has connected
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 4)
dbug RemoteDebugger Received data response from send (id: 4): '{}'
dbug RemoteDebugger Sending to Web Inspector took 1008ms
dbug RemoteDebugger Enabled activity on page
dbug RemoteDebugger Checking document readyState
dbug RemoteDebugger Sending javascript command (function (){ return document.readyState; })()
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 5)
dbug RemoteDebugger Received data response from send (id: 5): 'complete'
dbug RemoteDebugger Sending to Web Inspector took 6ms
dbug RemoteDebugger Document readyState is 'complete'
dbug RemoteDebugger Selected page after 1021ms
dbug RemoteDebugger Starting to listen for JavaScript console
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 6)
dbug RemoteDebugger Received data response from send (id: 6): '{}'
dbug RemoteDebugger Sending to Web Inspector took 5ms
dbug RemoteDebugger Starting to listen for network events
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 7)
dbug RemoteDebugger Received data response from send (id: 7): '{}'
dbug RemoteDebugger Sending to Web Inspector took 34ms
dbug RemoteDebugger Unregistering from page readiness notifications
dbug BaseDriver Event 'initialWebviewNavigated' logged at 1567618297106 (10:31:37 GMT-0700 (Pacific Daylight Time))
dbug BaseDriver Event 'newSessionStarted' logged at 1567618297107 (10:31:37 GMT-0700 (Pacific Daylight Time))
dbug MJSONWP (72cc574c) Cached the protocol value 'MJSONWP' for the new session 72cc574c-2034-4009-8828-d42349d7978e
dbug MJSONWP (72cc574c) Responding to client with driver.createSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"Safari","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"safariIgnoreFraudWarning":false,"showSafariConsoleLog":true,"safariInitialUrl":"http://localhost:4994/test/guinea-pig","nativeWebTap":true,"platformName":"iOS","platformVersion":"13.0","deviceName":"iPhone X","automationName":"XCUITest","noReset":true,"maxTypingFrequency":30,"clearSystemFiles":true,"wdaLaunchTimeout":240000,"wdaConnectionTimeout":480000,"useNewWDA":true,"udid":"05113010-1394-4CAA-9418-E8E189E13A7B"}
info HTTP <-- POST /wd/hub/session 200 96236 ms - 695
info HTTP
element handling
info HTTP --> POST /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/url
info HTTP {"url":"http://localhost:4994/test/guinea-pig"}
dbug MJSONWP (72cc574c) Calling XCUITestDriver.setUrl() with args: ["http://localhost:4994/test/guinea-pig","72cc574c-2034-4009-8828-d42349d7978e"]
dbug XCUITest Executing command 'setUrl'
dbug iOS Attempting to set url 'http://localhost:4994/test/guinea-pig'
dbug RemoteDebugger Navigating to new URL: 'http://localhost:4994/test/guinea-pig'
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 8)
dbug RemoteDebugger Received data response from send (id: 8): '{}'
dbug RemoteDebugger Sending to Web Inspector took 27ms
info HTTP --> GET /test/guinea-pig
info HTTP {}
dbug HTTP Sending guinea pig response with params: {"throwError":"","serverTime":1567618297,"userAgent":"Mozilla/5.0 (iPhone; CPU iPhone OS 13_0 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/13.0 Mobile/15E148 Safari/604.1","comment":"None"}
info HTTP <-- GET /test/guinea-pig 200 7 ms - 3566
info HTTP
info HTTP <-- GET /js/jquery.min.js 304 1 ms - -
info HTTP
dbug SafariConsole [DEBUG][http://localhost:4994/test/guinea-pig 8:16] Hello from Appium
dbug SafariConsole [DEBUG][http://localhost:4994/test/guinea-pig 9:16] Loading guinea-pig page
dbug SafariConsole [DEBUG][http://localhost:4994/test/guinea-pig 10:16] Done
dbug RemoteDebugger Page loaded, verifying whether ready
dbug RemoteDebugger Received page change notice for app 'PID:41474' but the listing has not changed. Ignoring.
dbug RemoteDebugger Checking document readyState
dbug RemoteDebugger Sending javascript command (function (){ return document.readyState; })()
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 9)
dbug RemoteDebugger Received data response from send (id: 9): 'complete'
dbug RemoteDebugger Sending to Web Inspector took 4ms
dbug RemoteDebugger Document readyState is 'complete'
dbug RemoteDebugger Page is ready
dbug RemoteDebugger Waiting for frame navigated message...
dbug RemoteDebugger Frame navigated in 0.504 sec from source: timeout
dbug RemoteDebugger Waiting for dom...
dbug RemoteDebugger Page loaded, verifying whether ready
dbug RemoteDebugger Checking document readyState
dbug RemoteDebugger Sending javascript command (function (){ return document.readyState; })()
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 10)
dbug RemoteDebugger Received data response from send (id: 10): 'complete'
dbug RemoteDebugger Sending to Web Inspector took 12ms
dbug RemoteDebugger Document readyState is 'complete'
dbug RemoteDebugger Page is ready
dbug MJSONWP (72cc574c) Responding to client with driver.setUrl() result: null
info HTTP <-- POST /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/url 200 2087 ms - 76
info HTTP
info HTTP --> GET /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/title
info HTTP {}
dbug MJSONWP (72cc574c) Calling XCUITestDriver.title() with args: ["72cc574c-2034-4009-8828-d42349d7978e"]
dbug XCUITest Executing command 'title'
dbug RemoteDebugger Executing atom 'title'
dbug RemoteDebugger Executing 'title' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var g=this;functi...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 11)
dbug RemoteDebugger Received data response from send (id: 11): '{"status":0,"value":"I am a page title"}'
dbug RemoteDebugger Sending to Web Inspector took 33ms
dbug RemoteDebugger Received result for atom 'title' execution: "I am a page title"
dbug MJSONWP (72cc574c) Responding to client with driver.title() result: "I am a page title"
info HTTP <-- GET /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/title 200 49 ms - 91
info HTTP
info HTTP --> POST /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element
info HTTP {"using":"id","value":"unchecked_checkbox"}
dbug MJSONWP (72cc574c) Calling XCUITestDriver.findElement() with args: ["id","unchecked_checkbox","72cc574c-2034-4009-8828-d42349d7978e"]
dbug XCUITest Executing command 'findElement'
dbug BaseDriver Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
dbug BaseDriver Waiting up to 0 ms for condition
dbug RemoteDebugger Executing atom 'find_element'
dbug RemoteDebugger Executing 'find_element' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var k=this;functi...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 12)
dbug RemoteDebugger Received data response from send (id: 12): '{"status":0,"value":{"ELEMENT":":wdc:1567618299310"}}'
dbug RemoteDebugger Sending to Web Inspector took 41ms
dbug RemoteDebugger Received result for atom 'find_element' execution: {"ELEMENT":":wdc:1567618299310"}
dbug MJSONWP (72cc574c) Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"5000","ELEMENT":"5000"}
info HTTP <-- POST /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element 200 45 ms - 135
info HTTP
info HTTP --> GET /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element/5000/selected
info HTTP {}
dbug MJSONWP (72cc574c) Calling XCUITestDriver.elementSelected() with args: ["5000","72cc574c-2034-4009-8828-d42349d7978e"]
dbug XCUITest Executing command 'elementSelected'
dbug RemoteDebugger Executing atom 'is_selected'
dbug RemoteDebugger Executing 'is_selected' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var g=this;functi...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 13)
dbug RemoteDebugger Received data response from send (id: 13): '{"status":0,"value":false}'
dbug RemoteDebugger Sending to Web Inspector took 38ms
dbug RemoteDebugger Received result for atom 'is_selected' execution: false
dbug MJSONWP (72cc574c) Responding to client with driver.elementSelected() result: false
info HTTP <-- GET /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element/5000/selected 200 43 ms - 77
info HTTP
info HTTP --> POST /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element/5000/click
info HTTP {}
dbug MJSONWP (72cc574c) Calling XCUITestDriver.click() with args: ["5000","72cc574c-2034-4009-8828-d42349d7978e"]
dbug XCUITest Executing command 'click'
dbug XCUITest Using native web tap
dbug RemoteDebugger Executing atom 'get_text'
dbug RemoteDebugger Executing 'get_text' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var h,l=this;func...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 14)
dbug RemoteDebugger Received data response from send (id: 14): '{"status":0,"value":""}'
dbug RemoteDebugger Sending to Web Inspector took 43ms
dbug RemoteDebugger Received result for atom 'get_text' execution: ""
dbug RemoteDebugger Executing atom 'get_attribute_value'
dbug RemoteDebugger Executing 'get_attribute_value' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var g=this;functi...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 15)
dbug RemoteDebugger Received data response from send (id: 15): '{"status":0,"value":"on"}'
dbug RemoteDebugger Sending to Web Inspector took 8ms
dbug RemoteDebugger Received result for atom 'get_attribute_value' execution: "on"
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/elements' to command name 'findElements'
dbug WD Proxy Proxying [POST /elements] to [POST http://localhost:8100/session/600717F0-3172-4B80-8B75-F963BF00D300/elements] with body: {"using":"accessibility id","value":"on"}
dbug WD Proxy Got response with status 200: {"value":[],"sessionId":"600717F0-3172-4B80-8B75-F963BF00D300"}
WARN XCUITest Unable to do simple native web tap. Attempting to convert coordinates
dbug RemoteDebugger Executing atom 'get_size'
dbug RemoteDebugger Executing 'get_size' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var h=this;functi...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 16)
dbug RemoteDebugger Received data response from send (id: 16): '{"status":0,"value":{"width":16,"height":16}}'
dbug RemoteDebugger Sending to Web Inspector took 28ms
dbug RemoteDebugger Received result for atom 'get_size' execution: {"width":16,"height":16}
dbug RemoteDebugger Executing atom 'get_top_left_coordinates'
dbug RemoteDebugger Executing 'get_top_left_coordinates' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var h,l=this;func...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 17)
dbug RemoteDebugger Received data response from send (id: 17): '{"status":0,"value":{"x":10,"y":502.875,"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=Math.floor(this.x);this.y=Math.floor(this.y);return this}","round":"function (){this.x=Math.round(this.x);this.y=Math.round(this.y);return this}","scale":"function (a,b){b=aa(b)?b:a;this.x*=a;this.y*=b;return this}"}}'
dbug RemoteDebugger Sending to Web Inspector took 42ms
dbug RemoteDebugger Received result for atom 'get_top_left_coordinates' execution: {"x":10,"y":502.875}
dbug RemoteDebugger Executing atom 'get_size'
dbug RemoteDebugger Executing 'get_size' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var h=this;functi...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 18)
dbug RemoteDebugger Received data response from send (id: 18): '{"status":0,"value":{"width":16,"height":16}}'
dbug RemoteDebugger Sending to Web Inspector took 4ms
dbug RemoteDebugger Received result for atom 'get_size' execution: {"width":16,"height":16}
dbug RemoteDebugger Executing atom 'get_top_left_coordinates'
dbug RemoteDebugger Executing 'get_top_left_coordinates' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var h,l=this;func...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 19)
dbug RemoteDebugger Received data response from send (id: 19): '{"status":0,"value":{"x":10,"y":502.875,"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=Math.floor(this.x);this.y=Math.floor(this.y);return this}","round":"function (){this.x=Math.round(this.x);this.y=Math.round(this.y);return this}","scale":"function (a,b){b=aa(b)?b:a;this.x*=a;this.y*=b;return this}"}}'
dbug RemoteDebugger Sending to Web Inspector took 3ms
dbug RemoteDebugger Received result for atom 'get_top_left_coordinates' execution: {"x":10,"y":502.875}
dbug XCUITest Translating coordinates ({"x":18,"y":510.875}) to web coordinates
dbug BaseDriver Set implicit wait to 0ms
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element' to command name 'findElement'
dbug WD Proxy Proxying [POST /element] to [POST http://localhost:8100/session/600717F0-3172-4B80-8B75-F963BF00D300/element] with body: {"using":"class name","value":"XCUIElementTypeWebView"}
dbug WD Proxy Got response with status 200: {"value":{"ELEMENT":"4D000000-0000-0000-02A2-000000000000","element-6066-11e4-a52e-4f735466cecf":"4D000000-0000-0000-02A2-000000000000"},"sessionId":"600717F0-3172-4B80-8B75-F963BF00D300"}
dbug BaseDriver Set implicit wait to 0ms
dbug WD Proxy Matched '/element/4D000000-0000-0000-02A2-000000000000/rect' to command name 'getElementRect'
dbug WD Proxy Proxying [GET /element/4D000000-0000-0000-02A2-000000000000/rect] to [GET http://localhost:8100/session/600717F0-3172-4B80-8B75-F963BF00D300/element/4D000000-0000-0000-02A2-000000000000/rect] with no body
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : {
dbug WD Proxy "y" : 0,
dbug WD Proxy "x" : 0,
dbug WD Proxy "width" : 375,
dbug WD Proxy "height" : 812
dbug WD Proxy },
dbug WD Proxy "sessionId" : "600717F0-3172-4B80-8B75-F963BF00D300"
dbug WD Proxy }
dbug RemoteDebugger Sending javascript command (function () { return {w: window.innerWidth, h:...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 20)
dbug RemoteDebugger Received data response from send (id: 20): '{"w":980,"h":1659}'
dbug RemoteDebugger Sending to Web Inspector took 20ms
dbug RemoteDebugger Executing atom 'execute_script'
dbug RemoteDebugger Executing 'execute_script' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var e=this;
dbug RemoteDebugger funct...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 21)
dbug RemoteDebugger Received data response from send (id: 21): '{"status":0,"value":"Mozilla/5.0 (iPhone; CPU iPhone OS 13_0 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/13.0 Mobile/15E148 Safari/604.1"}'
dbug RemoteDebugger Sending to Web Inspector took 3ms
dbug RemoteDebugger Received result for atom 'execute_script' execution: "Mozilla/5.0 (iPhone; CPU iPhone OS 13_0 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) ...
dbug RemoteDebugger Executing atom 'execute_script'
dbug RemoteDebugger Executing 'execute_script' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var e=this;
dbug RemoteDebugger funct...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 22)
dbug RemoteDebugger Received data response from send (id: 22): '{"status":0,"value":{"height":812,"width":375}}'
dbug RemoteDebugger Sending to Web Inspector took 4ms
dbug RemoteDebugger Received result for atom 'execute_script' execution: {"height":812,"width":375}
dbug BaseDriver Set implicit wait to 0ms
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element' to command name 'findElement'
dbug WD Proxy Proxying [POST /element] to [POST http://localhost:8100/session/600717F0-3172-4B80-8B75-F963BF00D300/element] with body: {"using":"accessibility id","value":"ReloadButton"}
info WD Proxy Got an unexpected response with status 404: {"value":{"error":"no such element","message":"unable to find an element using 'accessibility id', value 'ReloadButton'","traceback":"(\n\t0 WebDriverAgentLib 0x000000010b3cf3cd FBNoSuchElementErrorResponseForRequest + 301\n\t1 WebDriverAgentLib 0x000000010b3cf179 +[FBFindElementCommands handleFindElement:] + 425\n\t2 WebDriverAgentLib 0x000000010b3ade36 -[FBRoute_TargetAction mountRequest:intoResponse:] + 182\n\t3 WebDriverAgentLib 0x000000010b39998b __37-[FBWebServer registerRouteHandlers:]_block_invoke + 555\n\t4 RoutingHTTPServer 0x000000010b507bfb -[RoutingHTTPServer handleRoute:withRequest:response:] + 136\n\t5 RoutingHTTPServer 0x000000010b50850e __72-[RoutingHTTPServer routeMethod:withPath:parameters:request:connection:]_block_invoke + 47\n\t6 libdispatch.dylib 0x00007fff511367f9 _dispatch_client_callout + 8\n\t7 libdispatch.dylib 0x00007fff...
dbug W3C Matched W3C error code 'no such element' to NoSuchElementError
dbug BaseDriver Set implicit wait to 0ms
dbug BaseDriver Set implicit wait to 0ms
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element' to command name 'findElement'
dbug WD Proxy Proxying [POST /element] to [POST http://localhost:8100/session/600717F0-3172-4B80-8B75-F963BF00D300/element] with body: {"using":"accessibility id","value":"Close app download offer"}
info WD Proxy Got an unexpected response with status 404: {"value":{"error":"no such element","message":"unable to find an element using 'accessibility id', value 'Close app download offer'","traceback":"(\n\t0 WebDriverAgentLib 0x000000010b3cf3cd FBNoSuchElementErrorResponseForRequest + 301\n\t1 WebDriverAgentLib 0x000000010b3cf179 +[FBFindElementCommands handleFindElement:] + 425\n\t2 WebDriverAgentLib 0x000000010b3ade36 -[FBRoute_TargetAction mountRequest:intoResponse:] + 182\n\t3 WebDriverAgentLib 0x000000010b39998b __37-[FBWebServer registerRouteHandlers:]_block_invoke + 555\n\t4 RoutingHTTPServer 0x000000010b507bfb -[RoutingHTTPServer handleRoute:withRequest:response:] + 136\n\t5 RoutingHTTPServer 0x000000010b50850e __72-[RoutingHTTPServer routeMethod:withPath:parameters:request:connection:]_block_invoke + 47\n\t6 libdispatch.dylib 0x00007fff511367f9 _dispatch_client_callout + 8\n\t7 libdispatch.dylib ...
dbug W3C Matched W3C error code 'no such element' to NoSuchElementError
dbug BaseDriver Set implicit wait to 0ms
dbug XCUITest Additional native web tap offset computed: 0
dbug XCUITest Converted coordinates: {"x":7,"y":295}
dbug XCUITest rect: {"y":0,"x":0,"width":375,"height":812}
dbug XCUITest wvPos: {"x":0,"y":65}
dbug XCUITest realDims: {"w":375,"h":747}
dbug XCUITest wvDims: {"w":980,"h":1659}
dbug XCUITest xRatio: 0.3826530612244898
dbug XCUITest yRatio: 0.45027124773960214
dbug XCUITest Converted web coords {"x":18,"y":510.875} into real coords {"x":7,"y":295}
dbug XCUITest Received the following touch action: tap(options={"x":7,"y":295})
dbug WD Proxy Proxying [POST /wda/touch/perform] to [POST http://localhost:8100/session/600717F0-3172-4B80-8B75-F963BF00D300/wda/touch/perform] with body: {"actions":[{"action":"tap","options":{"x":7,"y":295}}]}
dbug WD Proxy Got response with status 200: {"value":null,"sessionId":"600717F0-3172-4B80-8B75-F963BF00D300"}
dbug MJSONWP (72cc574c) Responding to client with driver.click() result: null
info HTTP <-- POST /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element/5000/click 200 1142 ms - 76
info HTTP
info HTTP --> GET /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element/5000/selected
info HTTP {}
dbug MJSONWP (72cc574c) Calling XCUITestDriver.elementSelected() with args: ["5000","72cc574c-2034-4009-8828-d42349d7978e"]
dbug XCUITest Executing command 'elementSelected'
dbug RemoteDebugger Executing atom 'is_selected'
dbug RemoteDebugger Executing 'is_selected' atom in default context
dbug RemoteDebugger Sending javascript command (function(){return function(){var g=this;functi...
dbug RemoteDebugger Sending '_rpc_forwardSocketData:' message to app 'PID:41474', page '1', target 'page-6' (id: 23)
dbug RemoteDebugger Received data response from send (id: 23): '{"status":0,"value":false}'
dbug RemoteDebugger Sending to Web Inspector took 38ms
dbug RemoteDebugger Received result for atom 'is_selected' execution: false
dbug MJSONWP (72cc574c) Responding to client with driver.elementSelected() result: false
info HTTP <-- GET /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e/element/5000/selected 200 42 ms - 77
info HTTP
1) should say whether an input is selected
info HTTP --> DELETE /wd/hub/session/72cc574c-2034-4009-8828-d42349d7978e
info HTTP {}
dbug MJSONWP (72cc574c) Calling XCUITestDriver.deleteSession() with args: ["72cc574c-2034-4009-8828-d42349d7978e"]
dbug XCUITest Executing command 'deleteSession'
dbug BaseDriver Event 'quitSessionRequested' logged at 1567618302585 (10:31:42 GMT-0700 (Pacific Daylight Time))
dbug IDB Disconnecting idb service from '05113010-1394-4CAA-9418-E8E189E13A7B'
dbug IDB Cleaning up 1 obsolete idb_companion process
dbug WD Proxy Matched '/session/72cc574c-2034-4009-8828-d42349d7978e' to command name 'deleteSession'
dbug WD Proxy Proxying [DELETE /session/72cc574c-2034-4009-8828-d42349d7978e] to [DELETE http://localhost:8100/session/600717F0-3172-4B80-8B75-F963BF00D300] with no body
dbug RemoteDebugger Application 'PID:41474' disconnected. Removing from app dictionary.
dbug RemoteDebugger Current app is PID:41474
dbug RemoteDebugger No longer have app id. Attempting to find new one.
dbug RemoteDebugger Application 'PID:41476' disconnected. Removing from app dictionary.
dbug RemoteDebugger Current app is undefined
dbug RemoteDebugger Application 'PID:41517' disconnected. Removing from app dictionary.
dbug RemoteDebugger Current app is undefined
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : null,
dbug WD Proxy "sessionId" : "3D0A4A79-D5F7-414E-82AE-0552031F0E49"
dbug WD Proxy }
info XCUITest Shutting down sub-processes
info XCUITest Shutting down xcodebuild process (pid 41439)
ERR! XCUITest xcodebuild exited with code 'null' and signal 'SIGTERM'
dbug XCUITest Started background XCTest logs cleanup: find -E /private/var/folders -regex '.*/Session-WebDriverAgentRunner.*\.log$|.*/StandardOutputAndStandardError\.txt$' -type f -exec sh -c 'echo "" > "{}"' \;
info XCUITest Cleaning test logs in '/Users/danielgraham/Library/Developer/Xcode/DerivedData/WebDriverAgent-gsarxbnghdckurdrxkxxwuwfvisl/Logs' folder
dbug iOS Clearing log files
dbug iOS Deleting '/Users/danielgraham/Library/Developer/Xcode/DerivedData/WebDriverAgent-gsarxbnghdckurdrxkxxwuwfvisl/Logs'. Freeing 16K.
dbug iOS Finished clearing log files
dbug XCUITest In a web session. Removing remote debugger
dbug RemoteDebugger Disconnecting from remote debugger
dbug RemoteDebugger Cleaning up listeners
dbug IOSSimulatorLog Stopping iOS log capture
dbug BaseDriver Event 'quitSessionFinished' logged at 1567618304050 (10:31:44 GMT-0700 (Pacific Daylight Time))
dbug MJSONWP (72cc574c) Received response: null
dbug MJSONWP (72cc574c) But deleting session, so not returning
dbug MJSONWP (72cc574c) Responding to client with driver.deleteSession() result: null
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment