Skip to content

Instantly share code, notes, and snippets.

@richlanc

richlanc/gist:822a684271c5e9dbf9eed41ef43a3082

Last active October 9, 2017 09:33
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save richlanc/822a684271c5e9dbf9eed41ef43a3082 to your computer and use it in GitHub Desktop.
Save richlanc/822a684271c5e9dbf9eed41ef43a3082 to your computer and use it in GitHub Desktop.
Download ZIP
Appium Xcuitest + iOS11 Simulator + Javascript dialog bug
Raw
gistfile1.txt
pinhead:~ scivisum$
pinhead:~ scivisum$ /sv/ios/appium/node_modules/.bin/appium -p 4723
[Appium] Welcome to Appium v1.7.1
[Appium] Appium REST http interface listener started on 0.0.0.0:4723
[HTTP] --> POST /wd/hub/session {"requiredCapabilities":{},"desiredCapabilities":{"deviceName":"iPhone2017-B","automationName":"XCUITest","browserName":"Safari","newCommandTimeout":0,"platformVersion":"11.0","platformName":"iOS"}}
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"deviceName":"iPhone2017-B","automationName":"XCUITest","browserName":"Safari","newCommandTimeout":0,"platformVersion":"11.0","platformName":"iOS"},{},null]
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1507541107517 (10:25:07 GMT+0100 (BST))
[Appium] Creating new XCUITestDriver (v2.51.1) session
[Appium] Capabilities:
[Appium] deviceName: 'iPhone2017-B'
[Appium] automationName: 'XCUITest'
[Appium] browserName: 'Safari'
[Appium] newCommandTimeout: 0
[Appium] platformVersion: '11.0'
[Appium] platformName: 'iOS'
[BaseDriver] Session created with session id: 5afa7a5f-4c1e-41c0-aa01-3f16c118b72b
[debug] [XCUITest] Xcode version set to '9.0' (tools v9.0.0.0.1.1504363082)
[debug] [XCUITest] iOS SDK Version set to '11.0'
[debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1507541107696 (10:25:07 GMT+0100 (BST))
[XCUITest] Simulator udid not provided, using desired caps to create a new simulator
[debug] [simctl] Creating simulator with name 'appiumTest-5afa7a5f-4c1e-41c0-aa01-3f16c118b72b', device type id 'iPhone2017-B' and runtime id '11.0'
[iOSSim] Constructing iOS simulator for Xcode version 9.0 with udid 'F0C5C4E0-33D1-468F-BC1F-C72BC674075D'
[XCUITest] Created simulator with udid 'F0C5C4E0-33D1-468F-BC1F-C72BC674075D'.
[XCUITest] Determining device to run tests on: udid: 'F0C5C4E0-33D1-468F-BC1F-C72BC674075D', real device: false
[XCUITest] Safari test requested
[debug] [BaseDriver] Event 'appConfigured' logged at 1507541108656 (10:25:08 GMT+0100 (BST))
[debug] [BaseDriver] Event 'resetStarted' logged at 1507541108656 (10:25:08 GMT+0100 (BST))
[simctl] Error: simctl error running 'terminate': An error was encountered processing the command (domain=com.apple.CoreSimulator.SimError, code=164):
Unable to lookup in current state: Shutdown
at Object.wrappedLogger.errorAndThrow (../../lib/logging.js:63:13)
at simCommand$ (../../lib/simctl.js:50:11)
at tryCatch (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:67:40)
at GeneratorFunctionPrototype.invoke [as _invoke] (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:315:22)
at GeneratorFunctionPrototype.prototype.(anonymous function) [as throw] (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
at GeneratorFunctionPrototype.invoke (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:136:37)
at <anonymous>
at process._tickCallback (internal/process/next_tick.js:188:7)
Error: simctl error running 'terminate': An error was encountered processing the command (domain=com.apple.CoreSimulator.SimError, code=164):
Unable to lookup in current state: Shutdown
at Object.wrappedLogger.errorAndThrow (../../lib/logging.js:63:13)
at simCommand$ (../../lib/simctl.js:50:11)
at tryCatch (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:67:40)
at GeneratorFunctionPrototype.invoke [as _invoke] (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:315:22)
at GeneratorFunctionPrototype.prototype.(anonymous function) [as throw] (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
at GeneratorFunctionPrototype.invoke (/sv/ios/appium/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:136:37)
at <anonymous>
at process._tickCallback (internal/process/next_tick.js:188:7)
[debug] [iOSSim] Cleaning mobile safari data files
[debug] [iOSSim] Checking whether simulator has been run before
[debug] [iOSSim] Simulator has not been run before
[iOSSim] Could not find Safari support directories to clean out old data. Probably there is nothing to clean out
[debug] [BaseDriver] Event 'resetComplete' logged at 1507541109106 (10:25:09 GMT+0100 (BST))
[debug] [iOSLog] Starting iOS 11.0 simulator log capture
[debug] [iOSLog] System log path: /Users/scivisum/Library/Logs/CoreSimulator/F0C5C4E0-33D1-468F-BC1F-C72BC674075D/system.log
[debug] [BaseDriver] Event 'logCaptureStarted' logged at 1507541109128 (10:25:09 GMT+0100 (BST))
[XCUITest] Setting up simulator
[debug] [iOS] No reason to set locale
[debug] [iOS] No iOS / app preferences to set
[debug] [iOSSim] Setting common Simulator preferences to {"ConnectHardwareKeyboard":false}
[debug] [iOSSim] Updated shared Simulator preferences at '/Users/scivisum/Library/Preferences/com.apple.iphonesimulator.plist' with {"ConnectHardwareKeyboard":false}
[debug] [iOSSim] The count of running Simulator UI client instances is 1
[iOSSim] Booting Simulator with UDID F0C5C4E0-33D1-468F-BC1F-C72BC674075D...
[iOSSim] Simulator with UDID F0C5C4E0-33D1-468F-BC1F-C72BC674075D booted in 45 seconds
[debug] [BaseDriver] Event 'simStarted' logged at 1507541154263 (10:25:54 GMT+0100 (BST))
[XCUITest] Using WDA path: '/sv/ios/appium/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent'
[XCUITest] Using WDA agent: '/sv/ios/appium/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent/WebDriverAgent.xcodeproj'
[debug] [XCUITest] Capability 'useNewWDA' set to false, so trying to reuse currently running WDA instance at 'http://localhost:8100/'
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [XCUITest] WDA is not listening at 'http://localhost:8100/'. Rebuilding...
[debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1507541154443 (10:25:54 GMT+0100 (BST))
[XCUITest] Launching WebDriverAgent on the device
[debug] [XCUITest] Carthage found: '/usr/local/bin/carthage'
[debug] [XCUITest] Killing running processes 'xcodebuild.*F0C5C4E0-33D1-468F-BC1F-C72BC674075D, iproxy 8100, F0C5C4E0-33D1-468F-BC1F-C72BC674075D.*XCTRunner' for the device F0C5C4E0-33D1-468F-BC1F-C72BC674075D...
[debug] [XCUITest] 'pgrep -nif xcodebuild.*F0C5C4E0-33D1-468F-BC1F-C72BC674075D' didn't detect any matching processes. Return code: 1
[debug] [XCUITest] 'pgrep -nif iproxy 8100' didn't detect any matching processes. Return code: 1
[debug] [XCUITest] 'pgrep -nif F0C5C4E0-33D1-468F-BC1F-C72BC674075D.*XCTRunner' didn't detect any matching processes. Return code: 1
[debug] [XCUITest] Using Xcode 9.0, so fixing WDA codebase
[debug] [XCUITest] Beginning test with command 'xcodebuild build-for-testing test-without-building -project /sv/ios/appium/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent/WebDriverAgent.xcodeproj -scheme WebDriverAgentRunner -destination id=F0C5C4E0-33D1-468F-BC1F-C72BC674075D IPHONEOS_DEPLOYMENT_TARGET=11.0' in directory '/sv/ios/appium/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent'
[debug] [XCUITest] Output from xcodebuild will not be logged. To see xcode logging, use 'showXcodeLog' desired capability
[debug] [XCUITest] Waiting up to 60000ms for WebDriverAgent to start
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [XCUITest] Log file for xcodebuild test: /var/folders/0g/by2z5wcx07n82jqt6sqtk9t80000gp/T/com.apple.dt.XCTest/IDETestRunSession-D64A7AD6-BBF9-4751-8CC0-1514741B5A95/WebDriverAgentRunner-92BB2A2A-D3AE-4050-A14D-35FA6957D3EF/Session-WebDriverAgentRunner-2017-10-09_102556-nOwfeB.log
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8100/status] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\n \"value\" : {\n \"state\" : \"success\",\n \"os\" : {\n \"name\" : \"iOS\",\n \"version\" : \"11.0\"\n },\n \"ios\" : {\n \"simulatorVersion\" : \"11.0\",\n \"ip\" : \"10.0.0.33\"\n },\n \"build\" : {\n \"time\" : \"Oct 5 2017 10:01:20\"\n }\n },\n \"sessionId\" : \"EDBB2BBE-41BB-46FE-A8EF-E6009B84A72D\",\n \"status\" : 0\n}"
[debug] [XCUITest] WebDriverAgent running on ip '10.0.0.33'
[debug] [XCUITest] WebDriverAgent successfully started after 7660ms
[debug] [BaseDriver] Event 'wdaSessionAttempted' logged at 1507541162409 (10:26:02 GMT+0100 (BST))
[debug] [XCUITest] Sending createSession command to WDA
[debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://localhost:8100/session] with body: {"desiredCapabilities":{"bundleId":"com.apple.mobilesafari","arguments":["-u","http://0.0.0.0:4723/welcome"],"shouldWaitForQuiescence":true,"shouldUseTestManagerForVisibilityDetection":false,"maxTypingFrequency":60,"shouldUseSingletonTestManager":true}}
[HTTP] --> GET /welcome {}
[debug] [HTTP] Sending welcome response with params: {"message":"Let's browse!"}
[HTTP] <-- GET /welcome 200 9 ms - 124
[debug] [JSONWP Proxy] Got response with status 200: {"value":{"sessionId":"66E52D1F-5A72-4317-B1F5-3F7FEB68805D","capabilities":{"device":"iphone","browserName":"Safari","sdkVersion":"11.0","CFBundleIdentifier":"com.apple.mobilesafari"}},"sessionId":"66E52D1F-5A72-4317-B1F5-3F7FEB68805D","status":0}
[debug] [BaseDriver] Event 'wdaSessionStarted' logged at 1507541165113 (10:26:05 GMT+0100 (BST))
[debug] [XCUITest] Cannot find a match for DerivedData folder path from lsof. Trying to access logs
[XCUITest] Setting '555' permissions to '/Users/scivisum/Library/Developer/Xcode/DerivedData/WebDriverAgent-efdizqcnzokteebakslcvzkdyadn/Logs/Test/Attachments' folder
[debug] [BaseDriver] Event 'wdaPermsAdjusted' logged at 1507541165485 (10:26:05 GMT+0100 (BST))
[debug] [BaseDriver] Event 'wdaStarted' logged at 1507541165485 (10:26:05 GMT+0100 (BST))
[debug] [XCUITest] Setting initial orientation to 'PORTRAIT'
[debug] [JSONWP Proxy] Proxying [POST /orientation] to [POST http://localhost:8100/session/66E52D1F-5A72-4317-B1F5-3F7FEB68805D/orientation] with body: {"orientation":"PORTRAIT"}
[debug] [JSONWP Proxy] Got response with status 200: {"value":{},"sessionId":"66E52D1F-5A72-4317-B1F5-3F7FEB68805D","status":0}
[debug] [BaseDriver] Event 'orientationSet' logged at 1507541166675 (10:26:06 GMT+0100 (BST))
[debug] [XCUITest] Waiting for initial webview
[debug] [iOS] Navigating to most recently opened webview
[debug] [iOS] Retrieving contexts and views
[debug] [iOS] Selecting by url: true (expected url: 'http://0.0.0.0:4723/welcome')
[debug] [RemoteDebugger] useNewSafari --> false
[debug] [RemoteDebugger] Debugger socket connected to ::1:27753
[debug] [RemoteDebugger] Sending connection key request
[debug] [RemoteDebugger] Sending '_rpc_reportIdentifier:' message to remote debugger
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRSimulatorProductVersionKey":"11.0","WIRSimulatorDeviceIdentifierKey":"F0C5C4E0-33D1-468F-BC1F-C72BC674075D","WIRSimulatorBuildKey":"15A372","WIRSimulatorNameKey":"iPhone"},"__selector":"_rpc_reportSetup:"}'
[debug] [RemoteDebugger] Received response from socket send: '["iPhone","15A372","11.0"]'
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationDictionaryKey":{"PID:51781":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":2,"WIRIsApplicationReadyKey":false,"WIRApplicationIdentifierKey":"PID:51781","WIRIsApplicationProxyKey":false,"WIRApplicationNameKey":"Safari","WIRApplicationBundleIdentifierKey":"com.apple.mobilesafari"}}},"__selector":"_rpc_reportConnectedApplicationList:"}'
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRDriverDictionaryKey":{}},"__selector":"_rpc_reportConnectedDriverList:"}'
[debug] [RemoteDebugger] Notified of connected drivers: {}.
[debug] [RemoteDebugger] Connected to application
[debug] [RemoteDebugger] Sim name: iPhone
[debug] [RemoteDebugger] Sim build: 15A372
[debug] [RemoteDebugger] Sim platform version: 11.0
[debug] [RemoteDebugger] Selecting application
[debug] [RemoteDebugger] Found app id key 'PID:51781' for bundle 'com.apple.mobilesafari'
[debug] [RemoteDebugger] Trying out the possible app ids: PID:51781
[debug] [RemoteDebugger] Selecting app PID:51781 (try #1 of 20)
[debug] [RemoteDebugger] Sending '_rpc_forwardGetListing:' message to remote debugger
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":1,"WIRIsApplicationReadyKey":false,"WIRApplicationIdentifierKey":"PID:51785","WIRIsApplicationProxyKey":true,"WIRApplicationNameKey":"com.apple.WebKit.WebContent","WIRApplicationBundleIdentifierKey":"com.apple.WebKit.WebContent","WIRHostApplicationIdentifierKey":"PID:51781"},"__selector":"_rpc_applicationConnected:"}'
[debug] [RemoteDebugger] We were notified we might have connected to the wrong app. Using id PID:51785 instead of PID:51781
[debug] [RemoteDebugger] Notified that new application 'PID:51785' has connected
[debug] [RemoteDebugger] Current applications available:
[debug] [RemoteDebugger] Application: 'PID:51781'
[debug] [RemoteDebugger] id: "PID:51781"
[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] Application: 'PID:51785'
[debug] [RemoteDebugger] id: "PID:51785"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: "Waiting for data"
[debug] [RemoteDebugger] Found app id key 'PID:51781' for bundle 'com.apple.mobilesafari'
[debug] [RemoteDebugger] Found separate bundleId 'com.apple.WebKit.WebContent' acting as proxy for 'com.apple.mobilesafari', with app id 'PID:51785'
[debug] [RemoteDebugger] Using proxied app id 'PID:51785'
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":1,"WIRIsApplicationReadyKey":false,"WIRApplicationIdentifierKey":"PID:51787","WIRIsApplicationProxyKey":true,"WIRApplicationNameKey":"com.apple.WebKit.WebContent","WIRApplicationBundleIdentifierKey":"com.apple.WebKit.WebContent","WIRHostApplicationIdentifierKey":"PID:51781"},"__selector":"_rpc_applicationConnected:"}'
[debug] [RemoteDebugger] We were notified we might have connected to the wrong app. Using id PID:51787 instead of PID:51781
[debug] [RemoteDebugger] Notified that new application 'PID:51787' has connected
[debug] [RemoteDebugger] Current applications available:
[debug] [RemoteDebugger] Application: 'PID:51781'
[debug] [RemoteDebugger] id: "PID:51781"
[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] Application: 'PID:51785'
[debug] [RemoteDebugger] id: "PID:51785"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: "Waiting for data"
[debug] [RemoteDebugger] Application: 'PID:51787'
[debug] [RemoteDebugger] id: "PID:51787"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: "Waiting for data"
[debug] [RemoteDebugger] Error checking application: 'New application has connected'. Retrying connection
[debug] [RemoteDebugger] Found app id key 'PID:51781' for bundle 'com.apple.mobilesafari'
[debug] [RemoteDebugger] Found separate bundleId 'com.apple.WebKit.WebContent' acting as proxy for 'com.apple.mobilesafari', with app id 'PID:51785'
[debug] [RemoteDebugger] Found separate bundleId 'com.apple.WebKit.WebContent' acting as proxy for 'com.apple.mobilesafari', with app id 'PID:51787'
[debug] [RemoteDebugger] Trying out the possible app ids: PID:51785, PID:51787
[debug] [RemoteDebugger] Selecting app PID:51785 (try #2 of 20)
[debug] [RemoteDebugger] Sending '_rpc_forwardGetListing:' message to remote debugger
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51781","WIRListingKey":{}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Received response from socket send: '["PID:51781",{}]'
[debug] [RemoteDebugger] Received response from socket send: '["PID:51781",{}]'
[debug] [RemoteDebugger] Received page change notice for app 'PID:51781' but listening for 'PID:51785'. Ignoring.
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":2,"WIRIsApplicationReadyKey":true,"WIRApplicationIdentifierKey":"PID:51781","WIRIsApplicationProxyKey":false,"WIRApplicationNameKey":"Safari","WIRApplicationBundleIdentifierKey":"com.apple.mobilesafari"},"__selector":"_rpc_applicationUpdated:"}'
[debug] [RemoteDebugger] Notified that application 'PID:51781' has been updated.
[debug] [RemoteDebugger] Current applications available:
[debug] [RemoteDebugger] Application: 'PID:51781'
[debug] [RemoteDebugger] id: "PID:51781"
[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] pageDict: []
[debug] [RemoteDebugger] Application: 'PID:51785'
[debug] [RemoteDebugger] id: "PID:51785"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: "Waiting for data"
[debug] [RemoteDebugger] Application: 'PID:51787'
[debug] [RemoteDebugger] id: "PID:51787"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: "Waiting for data"
[debug] [RemoteDebugger] Empty page dictionary received
[debug] [RemoteDebugger] Empty page dictionary received
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Appium/welcome","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"http://0.0.0.0:4723/welcome","WIRPageIdentifierKey":1}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Received response from socket send: '["PID:51785",{"1":{"WIRTitleKey":"Appium/welcom...'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Appium/welcome","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"http://0.0.0.0:4723/welcome","WIRPageIdentifierKey":1}}
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":1,"WIRIsApplicationReadyKey":true,"WIRApplicationIdentifierKey":"PID:51785","WIRIsApplicationProxyKey":true,"WIRApplicationNameKey":"com.apple.WebKit.WebContent","WIRApplicationBundleIdentifierKey":"com.apple.WebKit.WebContent","WIRHostApplicationIdentifierKey":"PID:51781"},"__selector":"_rpc_applicationUpdated:"}'
[debug] [RemoteDebugger] Notified that application 'PID:51785' has been updated.
[debug] [RemoteDebugger] Current applications available:
[debug] [RemoteDebugger] Application: 'PID:51781'
[debug] [RemoteDebugger] id: "PID:51781"
[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] pageDict: []
[debug] [RemoteDebugger] Application: 'PID:51785'
[debug] [RemoteDebugger] id: "PID:51785"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: [{"id":1,"title":"Appium/welcome","url":"http://0.0.0.0:4723/welcome","isKey":false}]
[debug] [RemoteDebugger] Application: 'PID:51787'
[debug] [RemoteDebugger] id: "PID:51787"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: "Waiting for data"
[debug] [RemoteDebugger] Error checking application: 'Error: Empty page dictionary received'. Retrying connection
[debug] [RemoteDebugger] Selecting app PID:51787 (try #2 of 20)
[debug] [RemoteDebugger] Sending '_rpc_forwardGetListing:' message to remote debugger
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51787","WIRListingKey":{"6":{"WIRTitleKey":"Yahoo","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://uk.yahoo.com/searchset?p=us","WIRPageIdentifierKey":6}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Received response from socket send: '["PID:51787",{"6":{"WIRTitleKey":"Yahoo","WIRTy...'
[debug] [RemoteDebugger] Received page change notice for app 'PID:51787' but listening for 'PID:51785'. Ignoring.
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":1,"WIRIsApplicationReadyKey":true,"WIRApplicationIdentifierKey":"PID:51787","WIRIsApplicationProxyKey":true,"WIRApplicationNameKey":"com.apple.WebKit.WebContent","WIRApplicationBundleIdentifierKey":"com.apple.WebKit.WebContent","WIRHostApplicationIdentifierKey":"PID:51781"},"__selector":"_rpc_applicationUpdated:"}'
[debug] [RemoteDebugger] Notified that application 'PID:51787' has been updated.
[debug] [RemoteDebugger] Current applications available:
[debug] [RemoteDebugger] Application: 'PID:51781'
[debug] [RemoteDebugger] id: "PID:51781"
[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] pageDict: []
[debug] [RemoteDebugger] Application: 'PID:51785'
[debug] [RemoteDebugger] id: "PID:51785"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: [{"id":1,"title":"Appium/welcome","url":"http://0.0.0.0:4723/welcome","isKey":false}]
[debug] [RemoteDebugger] Application: 'PID:51787'
[debug] [RemoteDebugger] id: "PID:51787"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: [{"id":6,"title":"Yahoo","url":"https://uk.yahoo.com/searchset?p=us","isKey":false}]
[debug] [RemoteDebugger] Finally selecting app PID:51785: [{"id":1,"title":"Appium/welcome","url":"http://0.0.0.0:4723/welcome","isKey":false}]
[debug] [iOS] Picking webview 'WEBVIEW_51785.1'
[debug] [iOS] Attempting to set context to 'WEBVIEW_51785.1'
[debug] [RemoteDebugger] Selecting page '1' on app 'PID:51785' and forwarding socket setup
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketSetup:' message to remote debugger
[debug] [RemoteDebugger] Sender key set
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: '{}'
[debug] [RemoteDebugger] Original command: enablePage
[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 remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Unregistering from page readiness notifications
[debug] [BaseDriver] Event 'initialWebviewNavigated' logged at 1507541166828 (10:26:06 GMT+0100 (BST))
[Appium] New XCUITestDriver session created successfully, session 5afa7a5f-4c1e-41c0-aa01-3f16c118b72b added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1507541166829 (10:26:06 GMT+0100 (BST))
[debug] [MJSONWP] Responding to client with driver.createSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"Safari","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"deviceName":"iPhone2017-B","automationName":"XCUITest","newCommandTimeout":0,"platformVersion":"11.0","platformName":"iOS","udid":"F0C5C4E0-33D1-468F-BC1F-C72BC674075D"}
[HTTP] <-- POST /wd/hub/session 200 59320 ms - 445
[HTTP] --> POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/url {"url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","sessionId":"5afa7a5f-4c1e-41c0-aa01-3f16c118b72b"}
[debug] [MJSONWP] Calling AppiumDriver.setUrl() with args: ["https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","5afa7a5f-4c1e-41c0-aa01-3f16c118b72b"]
[debug] [XCUITest] Executing command 'setUrl'
[debug] [iOS] Attempting to set url 'https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm'
[debug] [RemoteDebugger] Navigating to new URL: https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: '{}'
[debug] [RemoteDebugger] Original command: setUrl
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51787","WIRListingKey":{"6":{"WIRTitleKey":"Yahoo","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://uk.yahoo.com/searchset?p=us","WIRPageIdentifierKey":6}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Received page change notice for app 'PID:51787' but listening for 'PID:51785'. Ignoring.
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Appium/welcome","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"http://0.0.0.0:4723/welcome","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Appium/welcome","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"http://0.0.0.0:4723/welcome","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Appium/welcome","url":"http://0.0.0.0:4723/welcome","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":1,"WIRIsApplicationReadyKey":true,"WIRApplicationIdentifierKey":"PID:51785","WIRIsApplicationProxyKey":true,"WIRApplicationNameKey":"com.apple.WebKit.WebContent","WIRApplicationBundleIdentifierKey":"com.apple.WebKit.WebContent","WIRHostApplicationIdentifierKey":"PID:51781"},"__selector":"_rpc_applicationUpdated:"}'
[debug] [RemoteDebugger] Notified that application 'PID:51785' has been updated.
[debug] [RemoteDebugger] Current applications available:
[debug] [RemoteDebugger] Application: 'PID:51781'
[debug] [RemoteDebugger] id: "PID:51781"
[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] pageDict: []
[debug] [RemoteDebugger] Application: 'PID:51785'
[debug] [RemoteDebugger] id: "PID:51785"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: [{"id":1,"title":"Appium/welcome","url":"http://0.0.0.0:4723/welcome","isKey":true}]
[debug] [RemoteDebugger] Application: 'PID:51787'
[debug] [RemoteDebugger] id: "PID:51787"
[debug] [RemoteDebugger] isProxy: true
[debug] [RemoteDebugger] name: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] bundleId: "com.apple.WebKit.WebContent"
[debug] [RemoteDebugger] hostId: "PID:51781"
[debug] [RemoteDebugger] isActive: 1
[debug] [RemoteDebugger] isAutomationEnabled: false
[debug] [RemoteDebugger] pageDict: [{"id":6,"title":"Yahoo","url":"https://uk.yahoo.com/searchset?p=us","isKey":false}]
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Tryit Editor v3.5","url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Tryit Editor v3.5","url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRRemoteAutomationEnabledKey":false,"WIRIsApplicationActiveKey":1,"WIRIsApplicationReadyKey":true,"WIRApplicationIdentifierKey":"PID:51787","WIRIsApplicationProxyKey":true,"WIRApplicationNameKey":"com.apple.WebKit.WebContent","WIRApplicationBundleIdentifierKey":"com.apple.WebKit.WebContent","WIRHostApplicationIdentifierKey":"PID:51781"},"__selector":"_rpc_applicationDisconnected:"}'
[debug] [RemoteDebugger] Application 'PID:51787' disconnected. Removing from app dictionary.
[debug] [RemoteDebugger] Current app is PID:51785
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'interactive'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "interactive"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'interactive'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "interactive"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Tryit Editor v3.5","url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'interactive'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Tryit Editor v3.5","url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] readyState was "interactive"
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] No frame navigation callback set.
[debug] [RemoteDebugger] Waiting for frame navigated message...
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Frame navigated, unloading page
[debug] [RemoteDebugger] Frame navigated in 0.06 sec from source: remote-debugger
[debug] [RemoteDebugger] Waiting for dom...
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
[debug] [iOS] Redirected from 'https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm' to 'http://0.0.0.0:4723/welcome'
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Tryit Editor v3.5","url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[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 remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
[debug] [iOS] Redirected from 'http://0.0.0.0:4723/welcome' to 'https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm'
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Tryit Editor v3.5","url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[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 remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [MJSONWP] Responding to client with driver.setUrl() result: null
[HTTP] <-- POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/url 200 1606 ms - 76
[HTTP] --> POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/frame {"sessionId":"5afa7a5f-4c1e-41c0-aa01-3f16c118b72b","id":"iframeResult"}
[debug] [MJSONWP] Calling AppiumDriver.setFrame() with args: ["iframeResult","5afa7a5f-4c1e-41c0-aa01-3f16c118b72b"]
[debug] [XCUITest] Executing command 'setFrame'
[debug] [RemoteDebugger] Executing 'frame_by_id_or_name' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var k=this;functi...
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: '{"status":0,"value":{"WINDOW":":wdc:15075411684...'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Received result for atom 'frame_by_id_or_name' execution: {"WINDOW":":wdc:1507541168464"}
[debug] [iOS] Entering new web frame: ':wdc:1507541168464'
[debug] [MJSONWP] Responding to client with driver.setFrame() result: null
[HTTP] <-- POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/frame 200 17 ms - 76
[HTTP] --> POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/element {"using":"xpath","sessionId":"5afa7a5f-4c1e-41c0-aa01-3f16c118b72b","value":"//button"}
[debug] [MJSONWP] Calling AppiumDriver.findElement() with args: ["xpath","//button","5afa7a5f-4c1e-41c0-aa01-3f16c118b72b"]
[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] Wrapping script for frame ':wdc:1507541168464'
[debug] [RemoteDebugger] Sending javascript command (function (window) { var document = window.docu...
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: '{"status":0,"value":{"ELEMENT":":wdc:1507541168...'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Received result for atom 'find_element' execution: {"ELEMENT":":wdc:1507541168487"}
[debug] [MJSONWP] Responding to client with driver.findElement() result: {"ELEMENT":"5000"}
[HTTP] <-- POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/element 200 21 ms - 90
[HTTP] --> POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/element/5000/click {"sessionId":"5afa7a5f-4c1e-41c0-aa01-3f16c118b72b","id":"5000"}
[debug] [MJSONWP] Calling AppiumDriver.click() with args: ["5000","5afa7a5f-4c1e-41c0-aa01-3f16c118b72b"]
[debug] [XCUITest] Executing command 'click'
[debug] [RemoteDebugger] Wrapping script for frame ':wdc:1507541168464'
[debug] [RemoteDebugger] Sending javascript command (function (window) { var document = window.docu...
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Page readiness check timed out after 5000ms
[debug] [RemoteDebugger] Page was not ready, retrying
[debug] [RemoteDebugger] Page readiness check timed out after 5000ms
[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 remote debugger
[debug] [RemoteDebugger] Checking document readyState
[debug] [RemoteDebugger] Sending javascript command (function (){ return document.readyState; })()
[debug] [RemoteDebugger] Sending '_rpc_forwardSocketData:' message to remote debugger
[debug] [RemoteDebugger] Page readiness check timed out after 5000ms
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
[debug] [RemoteDebugger] Page readiness check timed out after 5000ms
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
[HTTP] <-- POST /wd/hub/session/5afa7a5f-4c1e-41c0-aa01-3f16c118b72b/element/5000/click - - ms - -
<< Attempting to quit >>
^C[Appium] Received SIGINT - shutting down
<< Stuck until I accept the dialog in the simulator>>
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: '{"status":0,"value":null}'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Received result for atom 'click' execution: null
[debug] [MJSONWP] Responding to client with driver.click() result: null
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] Receiving data from remote debugger: '{"__argument":{"WIRApplicationIdentifierKey":"PID:51785","WIRListingKey":{"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}},"__selector":"_rpc_applicationSentListing:"}'
[debug] [RemoteDebugger] Page changed: {"1":{"WIRTitleKey":"Tryit Editor v3.5","WIRTypeKey":"WIRTypeWeb","WIRURLKey":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","WIRPageIdentifierKey":1,"WIRConnectionIdentifierKey":"3a52265f-4c36-40ba-afa3-78a67e9f0030"}}
[debug] [iOS] Remote debugger notified us of a new page listing: {"appIdKey":"51785","pageArray":[{"id":1,"title":"Tryit Editor v3.5","url":"https://www.w3schools.com/jsref/tryit.asp?filename=tryjsref_confirm","isKey":true}]}
[debug] [iOS] Checking if page needs to load
[debug] [iOS] Page load needed. Loading.
[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 remote debugger
[debug] [RemoteDebugger] Received applicationSentData response
[debug] [RemoteDebugger] Found data handler for response
[debug] [RemoteDebugger] Received data response from socket send: 'complete'
[debug] [RemoteDebugger] Original command: sendJSCommand
[debug] [RemoteDebugger] readyState was "complete"
[debug] [RemoteDebugger] Page is ready
[debug] [iOS] New page listing is same as old, doing nothing
^C
pinhead:~ scivisum$
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment