Skip to content

Instantly share code, notes, and snippets.

@shapovalovei
Last active May 18, 2017 18:08
Show Gist options
  • Save shapovalovei/2175a48a82aa5137281e22fe2e884d3a to your computer and use it in GitHub Desktop.
Save shapovalovei/2175a48a82aa5137281e22fe2e884d3a to your computer and use it in GitHub Desktop.
-------------------------------------------------------
T E S T S
-------------------------------------------------------
objc[8295]: Class JavaLaunchHelper is implemented in both /Library/Java/JavaVirtualMachines/jdk1.8.0_121.jdk/Contents/Home/jre/bin/java (0x1063ee4c0) and /Library/Java/JavaVirtualMachines/jdk1.8.0_121.jdk/Contents/Home/jre/lib/libinstrument.dylib (0x1064e84e0). One of the two will be used. Which one is undefined.
Running TestSuite
[INFO] 21:04:08: [SuiteListener] All Tests
[INFO] 21:04:09: [DriverFactory] Look for the launched iOS proxy on port: 27763
[INFO] 21:04:09: [DriverFactory] Port: 27763 is free
[INFO] 21:04:09: [DriverFactory] Execute command: [ios_webkit_debug_proxy, -c, f2b87b1ace53f97344a6c46ba67f33c60fb46cd1:27763, -F]
[INFO] 21:04:11: [DriverFactory] iOS Proxy started.
[INFO] 21:04:11: [DriverFactory] Look for the launched appium server on port: 4733
[INFO] 21:04:11: [DriverFactory] Port: 4733 is free
[INFO] 21:04:11: [DriverFactory]
[INFO] 21:04:11: [DriverFactory] ******************************* STARTING APPIUM SERVICE ****************************
[INFO] 21:04:11: [DriverFactory] APPIUM PORT: 4733
[INFO] 21:04:11: [DriverFactory] IOS WEB PROXY PORT: 27763
[INFO] 21:04:11: [DriverFactory] VERBOSE LOGGING: true
[INFO] 21:04:11: [DriverFactory] PROJECT TRACKING:
[Appium] Welcome to Appium v1.6.5-beta
[Appium] Non-default server args:
[Appium] port: 4733
[Appium] webkitDebugProxyPort: 27763
[Appium] Appium REST http interface listener started on 0.0.0.0:4733
[HTTP] --> GET /wd/hub/status {}
[debug] [MJSONWP] Calling AppiumDriver.getStatus() with args: []
[debug] [MJSONWP] Responding to client with driver.getStatus() result: {"build":{"version":"1.6.5-beta","revision":null}}
[HTTP] <-- GET /wd/hub/status 200 14 ms - 88
[INFO] 21:04:16: [DriverFactory] APPIUM URL: http://0.0.0.0:4733/wd/hub
[INFO] 21:04:16: [DriverFactory] ***********************************************************************************
[INFO] 21:04:16: [DriverFactory]
[INFO] 21:04:16: [DriverFactory]
[INFO] 21:04:16: [DriverFactory] **************************** CREATING REMOTE WEB DRIVER ***************************
[INFO] 21:04:16: [DriverFactory] PLATFORM NAME: iOS
[INFO] 21:04:16: [DriverFactory] PLATFORM VERSION: 10.3.1
[INFO] 21:04:16: [DriverFactory] DEVICE NAME: iPhone 6
[INFO] 21:04:16: [DriverFactory] DEVICE BROWSER: Safari
[INFO] 21:04:16: [DriverFactory] DEVICE UDID: f2b87b1ace53f97344a6c46ba67f33c60fb46cd1
[INFO] 21:04:16: [DriverFactory] DEVICE USB PORT: 8111
[INFO] 21:04:16: [DriverFactory] APPIUM URL: http://0.0.0.0:4733/wd/hub
[INFO] 21:04:16: [DriverFactory] ***********************************************************************************
[INFO] 21:04:16: [DriverFactory]
[HTTP] --> POST /wd/hub/session {"capabilities":{"desiredCapabilities":{"platformVersion":"10.3.1","xcodeOrgId":"Y95G5M3Q84","automationName":"XCUITest","useNewWDA":true,"browserName":"Safari","platformName":"iOS","udid":"f2b87b1ace53f97344a6c46ba67f33c60fb46cd1","deviceName":"iPhone 6","launchTimeout":500000,"updatedWDABundleId":"com.moovweb.WebDriverAgentRunner","xcodeSigningId":"iPhone Developer","wdaLocalPort":8111},"requiredCapabilities":{}},"desiredCapabilities":{"platformVersion":"10.3.1","xcodeOrgId":"Y95G5M3Q84","automationName":"XCUITest","useNewWDA":true,"browserName":"Safari","platformName":"iOS","udid":"f2b87b1ace53f97344a6c46ba67f33c60fb46cd1","deviceName":"iPhone 6","launchTimeout":500000,"updatedWDABundleId":"com.moovweb.WebDriverAgentRunner","xcodeSigningId":"iPhone Developer","wdaLocalPort":8111},"requiredCapabilities":{}}
[debug] [MJSONWP] Calling AppiumDriver.createSession() with args: [{"platformVersion":"10.3.1","xcodeOrgId":"Y95G5M3Q84","automationName":"XCUITest","useNewWDA":true,"browserName":"Safari","platformName":"iOS","udid":"f2b87b1ace53f97344a6c46ba67f33c60fb46cd1","deviceName":"iPhone 6","launchTimeout":500000,"updatedWDABundleId":"com.moovweb.WebDriverAgentRunner","xcodeSigningId":"iPhone Developer","wdaLocalPort":8111},{},{"desiredCapabilities":{"platformVersion":"10.3.1","xcodeOrgId":"Y95G5M3Q84","automationName":"XCUITest","useNewWDA":true,"browserName":"Safari","platformName":"iOS","udid":"f2b87b1ace53f97344a6c46ba67f33c60fb46cd1","deviceName":"iPhone 6","launchTimeout":500000,"updatedWDABundleId":"com.moovweb.WebDriverAgentRunner","xcodeSigningId":"iPhone Developer","wdaLocalPort":8111},"requiredCapabilities":{}}]
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1495130656724 (21:04:16 GMT+0300 (EEST))
[Appium] Creating new XCUITestDriver (v2.30.0) session
[Appium] Capabilities:
[Appium] platformVersion: '10.3.1'
[Appium] xcodeOrgId: 'XXXXXXXXX'
[Appium] automationName: 'XCUITest'
[Appium] useNewWDA: true
[Appium] browserName: 'Safari'
[Appium] platformName: 'iOS'
[Appium] udid: 'f2b87b1ace53f97344a6c46ba67f33c60fb46cd1'
[Appium] deviceName: 'iPhone 6'
[Appium] launchTimeout: 500000
[Appium] updatedWDABundleId: 'com.moovweb.WebDriverAgentRunner'
[Appium] xcodeSigningId: 'iPhone Developer'
[Appium] wdaLocalPort: 8111
[debug] [XCUITest] XCUITestDriver version: 2.30.0
[BaseDriver] Session created with session id: b061c1e2-d78f-4f85-8d22-7d5387ca3a09
[debug] [XCUITest] Xcode version set to '8.3.2' (tools v8.3.2.0.1.1492020469)
[debug] [XCUITest] iOS SDK Version set to '10.3'
[debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1495130656874 (21:04:16 GMT+0300 (EEST))
[debug] [XCUITest] Available devices: f2b87b1ace53f97344a6c46ba67f33c60fb46cd1, f2b87b1ace53f97344a6c46ba67f33c60fb46cd1
[debug] [XCUITest] Creating iDevice object with udid 'f2b87b1ace53f97344a6c46ba67f33c60fb46cd1'
[XCUITest] Determining device to run tests on: udid: 'f2b87b1ace53f97344a6c46ba67f33c60fb46cd1', real device: true
[XCUITest] Safari test requested
[debug] [BaseDriver] Event 'appConfigured' logged at 1495130656986 (21:04:16 GMT+0300 (EEST))
[debug] [BaseDriver] Event 'resetStarted' logged at 1495130656987 (21:04:16 GMT+0300 (EEST))
[debug] [XCUITest] Reset: running ios real device reset flow
[debug] [BaseDriver] Event 'resetComplete' logged at 1495130656989 (21:04:16 GMT+0300 (EEST))
[debug] [iOSLog] Attempting iOS device log capture via libimobiledevice idevicesyslog
[debug] [iOSLog] Found idevicesyslog: '/usr/local/bin/idevicesyslog'
[debug] [BaseDriver] Event 'logCaptureStarted' logged at 1495130657129 (21:04:17 GMT+0300 (EEST))
[XCUITest] Setting up real device
[debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1495130657131 (21:04:17 GMT+0300 (EEST))
[XCUITest] Using WDA path: '/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent'
[XCUITest] Using WDA agent: '/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent/WebDriverAgent.xcodeproj'
[debug] [XCUITest] Capability 'useNewWDA' set, so uninstalling WDA before proceeding
[debug] [XCUITest] Removing WDA application from device
[debug] [BaseDriver] Event 'wdaUninstalled' logged at 1495130657347 (21:04:17 GMT+0300 (EEST))
[XCUITest] Launching WebDriverAgent on the device
[debug] [XCUITest] Carthage found: '/usr/local/bin/carthage'
[debug] [XCUITest] Successfully updated '/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent/WebDriverAgent.xcodeproj/project.pbxproj' with bundle id 'com.moovweb.WebDriverAgentRunner'
[debug] [XCUITest] Killing hanging processes
[debug] [XCUITest] Generating xcode config file for orgId 'Y95G5M3Q84' and signingId 'iPhone Developer'
[debug] [XCUITest] Writing xcode config file to /var/folders/3y/gsn5sxq97yg8xx_0rb7nygk40000gn/T/2017418-8362-qu8aog.czcucjtt9/appium-temp.xcconfig
[debug] [XCUITest] Using Xcode configuration file: '/var/folders/3y/gsn5sxq97yg8xx_0rb7nygk40000gn/T/2017418-8362-qu8aog.czcucjtt9/appium-temp.xcconfig'
[debug] [XCUITest] Beginning test with command 'xcodebuild build-for-testing test-without-building -project /usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent/WebDriverAgent.xcodeproj -scheme WebDriverAgentRunner -destination id=f2b87b1ace53f97344a6c46ba67f33c60fb46cd1 -configuration Debug IPHONEOS_DEPLOYMENT_TARGET=10.3 -xcconfig /var/folders/3y/gsn5sxq97yg8xx_0rb7nygk40000gn/T/2017418-8362-qu8aog.czcucjtt9/appium-temp.xcconfig' in directory '/usr/local/lib/node_modules/appium/node_modules/appium-xcuitest-driver/WebDriverAgent'
[debug] [XCUITest] Output from xcodebuild will not be logged
[debug] [XCUITest] Starting iproxy to forward traffic from local port 8111 to device port 8100 over USB
[debug] [XCUITest] Waiting up to 60000ms for WebDriverAgent to start
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [XCUITest] Log file for xcodebuild test: /Users/eugene/Library/Developer/Xcode/DerivedData/WebDriverAgent-brdadhpuduowllgivnnvuygpwhzy/Logs/Test/0A720780-04C1-48D7-9CE2-DEB310A5E68A/Session-WebDriverAgentRunner-2017-05-18_210424-kffGE4.log
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Proxying [GET /status] to [GET http://localhost:8111/status] with no body
[debug] [JSONWP Proxy] Got response with status 200: "{\n \"value\" : {\n \"state\" : \"success\",\n \"os\" : {\n \"name\" : \"iOS\",\n \"version\" : \"10.3.1\"\n },\n \"ios\" : {\n \"simulatorVersion\" : \"10.3.1\",\n \"ip\" : \"192.168.1.10\"\n },\n \"build\" : {\n \"time\" : \"May 18 2017 21:03:32\"\n }\n },\n \"sessionId\" : \"FCD1D802-A9F5-4B29-847E-E5E37EBC6752\",\n \"status\" : 0\n}"
[debug] [XCUITest] WebDriverAgent running on ip '192.168.1.10'
[debug] [XCUITest] WebDriverAgent successfully started after 10004ms
[debug] [BaseDriver] Event 'wdaSessionAttempted' logged at 1495130672509 (21:04:32 GMT+0300 (EEST))
[debug] [XCUITest] Sending createSession command to WDA
[debug] [JSONWP Proxy] Proxying [POST /session] to [POST http://localhost:8111/session] with body: {"desiredCapabilities":{"bundleId":"com.apple.mobilesafari","arguments":["-u","http://appium.io"],"shouldWaitForQuiescence":true,"shouldUseTestManagerForVisibilityDetection":false,"maxTypingFrequency":60,"shouldUseSingletonTestManager":true}}
[debug] [JSONWP Proxy] Got response with status 200: {"value":{"sessionId":"79D67E2F-F03E-4BA8-8564-476AF9B10F50","capabilities":{"device":"iphone","browserName":"Safari","sdkVersion":"10.3.1","CFBundleIdentifier":"com.apple.mobilesafari"}},"sessionId":"79D67E2F-F03E-4BA8-8564-476AF9B10F50","status":0}
[debug] [BaseDriver] Event 'wdaSessionStarted' logged at 1495130676624 (21:04:36 GMT+0300 (EEST))
[debug] [XCUITest] Found WDA derived data folder: '/Users/eugene/Library/Developer/Xcode/DerivedData/WebDriverAgent-brdadhpuduowllgivnnvuygpwhzy'
[XCUITest] Setting '555' permissions to '/Users/eugene/Library/Developer/Xcode/DerivedData/WebDriverAgent-brdadhpuduowllgivnnvuygpwhzy/Logs/Test/Attachments' folder
[debug] [BaseDriver] Event 'wdaPermsAdjusted' logged at 1495130676628 (21:04:36 GMT+0300 (EEST))
[debug] [BaseDriver] Event 'wdaStarted' logged at 1495130676628 (21:04:36 GMT+0300 (EEST))
[debug] [XCUITest] Setting initial orientation to 'PORTRAIT'
[debug] [JSONWP Proxy] Proxying [POST /orientation] to [POST http://localhost:8111/session/79D67E2F-F03E-4BA8-8564-476AF9B10F50/orientation] with body: {"orientation":"PORTRAIT"}
[debug] [JSONWP Proxy] Got response with status 200: {"value":{},"sessionId":"79D67E2F-F03E-4BA8-8564-476AF9B10F50","status":0}
[debug] [BaseDriver] Event 'orientationSet' logged at 1495130677159 (21:04:37 GMT+0300 (EEST))
[debug] [XCUITest] Waiting for initial webview
[debug] [iOS] Waiting for 3000 ms before navigating to view.
[debug] [iOS] Navigating to most recently opened webview
[debug] [iOS] Retrieving contexts and views
[debug] [iOS] Selecting by url: true (expected url: 'http://appium.io')
[debug] [RemoteDebugger] Getting WebKitRemoteDebugger pageArray: localhost, 27763
[debug] [RemoteDebugger] Sending request to: http://localhost:27763/json
[debug] [RemoteDebugger] Page element JSON: [{"devtoolsFrontendUrl":"","faviconUrl":"","thumbnailUrl":"/thumb/http://appium.io/","title":"Appium: Mobile App Automation Made Awesome.","url":"http://appium.io/","webSocketDebuggerUrl":"ws://localhost:27763/devtools/page/1","appId":"PID:4301"}]
[debug] [iOS] Retrieving contexts and views
[debug] [iOS] Selecting by url: true (expected url: 'http://appium.io')
[debug] [RemoteDebugger] Getting WebKitRemoteDebugger pageArray: localhost, 27763
[debug] [RemoteDebugger] Sending request to: http://localhost:27763/json
[debug] [RemoteDebugger] Page element JSON: [{"devtoolsFrontendUrl":"","faviconUrl":"","thumbnailUrl":"/thumb/http://appium.io/","title":"Appium: Mobile App Automation Made Awesome.","url":"http://appium.io/","webSocketDebuggerUrl":"ws://localhost:27763/devtools/page/1","appId":"PID:4301"}]
[debug] [iOS] Picking webview 'WEBVIEW_1'
[debug] [iOS] Attempting to set context to 'WEBVIEW_1'
[debug] [RemoteDebugger] WebKit debugger web socket connected to url: ws://localhost:27763/devtools/page/1
[debug] [RemoteDebugger] Unregistering from page readiness notifications
[debug] [BaseDriver] Event 'initialWebviewNavigated' logged at 1495130680187 (21:04:40 GMT+0300 (EEST))
[Appium] New XCUITestDriver session created successfully, session b061c1e2-d78f-4f85-8d22-7d5387ca3a09 added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1495130680188 (21:04:40 GMT+0300 (EEST))
[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,"platformVersion":"10.3.1","xcodeOrgId":"Y95G5M3Q84","automationName":"XCUITest","useNewWDA":true,"platformName":"iOS","udid":"f2b87b1ace53f97344a6c46ba67f33c60fb46cd1","deviceName":"iPhone 6","launchTimeout":500000,"updatedWDABundleId":"com.moovweb.WebDriverAgentRunner","xcodeSigningId":"iPhone Developer","wdaLocalPort":8111}
[HTTP] <-- POST /wd/hub/session 200 23468 ms - 603
May 18, 2017 9:04:40 PM org.openqa.selenium.remote.ProtocolHandshake createSession
INFO: Detected dialect: OSS
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/timeouts {"type":"implicit","ms":30000}
[debug] [MJSONWP] Calling AppiumDriver.timeouts() with args: ["implicit",30000,"b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'timeouts'
[debug] [BaseDriver] Set implicit wait to 30000ms
[debug] [MJSONWP] Responding to client with driver.timeouts() result: null
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/timeouts 200 16 ms - 76
[INFO] 21:04:40: [CommonFunctions] Running: flick video -a start -p ios -u f2b87b1ace53f97344a6c46ba67f33c60fb46cd1 -e true
[INFO] 21:04:40: [CommonFunctions] Command executed. Exit code: 0
[INFO] 21:04:40: [CommonFunctions] Message:
Starting Recoder!!!
Process will stop after 500 screenshots.
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url {"url":"https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f"}
[debug] [MJSONWP] Calling AppiumDriver.setUrl() with args: ["https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'setUrl'
[debug] [iOS] Attempting to set url 'https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f'
[debug] [RemoteDebugger] Navigating to new URL: https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Page.navigate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"url":"https://mstage.pepboys.com/eserve/appointment/?_mwexperie...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{},"id":1}
[debug] [RemoteDebugger] Found handler for message '1'
[debug] [RemoteDebugger] Received page navigated message: {"result":{},"id":1}
[debug] [RemoteDebugger] Waiting for dom...
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Not connected to an application. Ignoring page load
[debug] [MJSONWP] Responding to client with driver.setUrl() result: null
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url 200 1581 ms - 76
[INFO] 21:04:42: [WebDriverEvent] Navigated to: https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f
[HTTP] --> GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url {}
[debug] [MJSONWP] Calling AppiumDriver.getUrl() with args: ["b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'getUrl'
[debug] [RemoteDebugger] Sending javascript command window.location.href
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"window.location.href","returnByValue":true}}
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"http://appium.io/"},"wasThrown":false},"id":2}
[debug] [RemoteDebugger] Found handler for message '2'
[debug] [MJSONWP] Responding to client with driver.getUrl() result: "http://appium.io/"
[HTTP] <-- GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url 200 208 ms - 91
[INFO] 21:04:42: [PepBoysMakeAppointmentPage] Browser url changed: false. Current url: http://appium.io/
[HTTP] --> GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url {}
[debug] [MJSONWP] Calling AppiumDriver.getUrl() with args: ["b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'getUrl'
[debug] [RemoteDebugger] Sending javascript command window.location.href
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"window.location.href","returnByValue":true}}
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"http://appium.io/"},"wasThrown":false},"id":3}
[debug] [RemoteDebugger] Found handler for message '3'
[debug] [MJSONWP] Responding to client with driver.getUrl() result: "http://appium.io/"
[HTTP] <-- GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url 200 11 ms - 91
[INFO] 21:04:43: [PepBoysMakeAppointmentPage] Browser url changed: false. Current url: http://appium.io/
[HTTP] --> GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url {}
[debug] [MJSONWP] Calling AppiumDriver.getUrl() with args: ["b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'getUrl'
[debug] [RemoteDebugger] Sending javascript command window.location.href
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"window.location.href","returnByValue":true}}
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f"},"wasThrown":false},"id":4}
[debug] [RemoteDebugger] Found handler for message '4'
[debug] [MJSONWP] Responding to client with driver.getUrl() result: "https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f"
[HTTP] <-- GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url 200 12 ms - 173
[INFO] 21:04:43: [PepBoysMakeAppointmentPage] Browser url changed: true. Current url: https://mstage.pepboys.com/eserve/appointment/?_mwexperienceid=75b123b0-6444-4893-9825-1303473bc59f
[INFO] 21:04:43: [PepBoysMakeAppointmentPage] Waiting 60s for element: 'By.id: locationForm' visible
[INFO] 21:04:43: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":5}
[debug] [RemoteDebugger] Found handler for message '5'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 34 ms - 74
[INFO] 21:04:44: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":6}
[debug] [RemoteDebugger] Found handler for message '6'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 42 ms - 74
[INFO] 21:04:44: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":7}
[debug] [RemoteDebugger] Found handler for message '7'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 19 ms - 74
[INFO] 21:04:45: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":8}
[debug] [RemoteDebugger] Found handler for message '8'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 19 ms - 74
[INFO] 21:04:45: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":9}
[debug] [RemoteDebugger] Found handler for message '9'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 52 ms - 74
[INFO] 21:04:46: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":10}
[debug] [RemoteDebugger] Found handler for message '10'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 21 ms - 74
[INFO] 21:04:46: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":11}
[debug] [RemoteDebugger] Found handler for message '11'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 23 ms - 74
[INFO] 21:04:47: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":12}
[debug] [RemoteDebugger] Found handler for message '12'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 50 ms - 74
[INFO] 21:04:47: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[]}"},"wasThrown":false},"id":13}
[debug] [RemoteDebugger] Found handler for message '13'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: []
[debug] [MJSONWP] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 16 ms - 74
[INFO] 21:04:48: [WebDriverEvent] Trying to find Element By: By.id: locationForm
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"id","value":"locationForm"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["id","locationForm","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":[{\"ELEMENT\":\":wdc:1495130688966\"}]}"},"wasThrown":false},"id":14}
[debug] [RemoteDebugger] Found handler for message '14'
[debug] [RemoteDebugger] Received result for atom 'find_elements' execution: [{"ELEMENT":":wdc:1495130688966"}]
[debug] [MJSONWP] Responding to client with driver.findElements() result: [{"ELEMENT":"5000"}]
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements 200 614 ms - 92
[HTTP] --> GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/element/5000/displayed {}
[debug] [MJSONWP] Calling AppiumDriver.elementDisplayed() with args: ["5000","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'elementDisplayed'
[debug] [RemoteDebugger] Executing 'is_displayed' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var h,ba="functio...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var h,ba=\"functi...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"string","value":"{\"status\":0,\"value\":true}"},"wasThrown":false},"id":15}
[debug] [RemoteDebugger] Found handler for message '15'
[debug] [RemoteDebugger] Received result for atom 'is_displayed' execution: true
[debug] [MJSONWP] Responding to client with driver.elementDisplayed() result: true
[HTTP] <-- GET /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/element/5000/displayed 200 103 ms - 76
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute {"script":"return typeof jQuery !== 'undefined'","args":[]}
[debug] [MJSONWP] Calling AppiumDriver.execute() with args: ["return typeof jQuery !== 'undefined'",[],"b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'execute'
[debug] [RemoteDebugger] Executing 'execute_script' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){for(var aa="funct...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){for(var aa=\"func...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"object","value":{"status":0,"value":true}},"wasThrown":false},"id":16}
[debug] [RemoteDebugger] Found handler for message '16'
[debug] [RemoteDebugger] Received result for atom 'execute_script' execution: true
[debug] [MJSONWP] Responding to client with driver.execute() result: true
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute 200 44 ms - 76
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute {"script":"return jQuery.active === 0 && jQuery.isReady && document.readyState == 'complete'","args":[]}
[debug] [MJSONWP] Calling AppiumDriver.execute() with args: ["return jQuery.active === 0 && jQuery.isReady && document.readyState == 'complete'",[],"b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'execute'
[debug] [RemoteDebugger] Executing 'execute_script' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){for(var aa="funct...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){for(var aa=\"func...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"object","value":{"status":0,"value":false}},"wasThrown":false},"id":17}
[debug] [RemoteDebugger] Found handler for message '17'
[debug] [RemoteDebugger] Received result for atom 'execute_script' execution: false
[debug] [MJSONWP] Responding to client with driver.execute() result: false
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute 200 22 ms - 77
[INFO] 21:04:49: [PepBoysMakeAppointmentPage] jQuery not active: false
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute {"script":"return typeof jQuery !== 'undefined'","args":[]}
[debug] [MJSONWP] Calling AppiumDriver.execute() with args: ["return typeof jQuery !== 'undefined'",[],"b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'execute'
[debug] [RemoteDebugger] Executing 'execute_script' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){for(var aa="funct...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){for(var aa=\"func...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"object","value":{"status":0,"value":true}},"wasThrown":false},"id":18}
[debug] [RemoteDebugger] Found handler for message '18'
[debug] [RemoteDebugger] Received result for atom 'execute_script' execution: true
[debug] [MJSONWP] Responding to client with driver.execute() result: true
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute 200 84 ms - 76
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute {"script":"return jQuery.active === 0 && jQuery.isReady && document.readyState == 'complete'","args":[]}
[debug] [MJSONWP] Calling AppiumDriver.execute() with args: ["return jQuery.active === 0 && jQuery.isReady && document.readyState == 'complete'",[],"b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'execute'
[debug] [RemoteDebugger] Executing 'execute_script' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){for(var aa="funct...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){for(var aa=\"func...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"object","value":{"status":0,"value":true}},"wasThrown":false},"id":19}
[debug] [RemoteDebugger] Found handler for message '19'
[debug] [RemoteDebugger] Received result for atom 'execute_script' execution: true
[debug] [MJSONWP] Responding to client with driver.execute() result: true
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute 200 1742 ms - 76
[INFO] 21:04:51: [PepBoysMakeAppointmentPage] jQuery not active: true
[INFO] 21:04:51: [PepBoysMakeAppointmentPage]
var data = JSON.stringify({
"storeKeys": [
"00847"
]
});
var xhr = new XMLHttpRequest();
xhr.withCredentials = true;
xhr.addEventListener("readystatechange", function () {
if (this.readyState === 4) {
console.log(this.responseText);
}
});
xhr.open("POST", "https://mstage.pepboys.com/api/store/select");
xhr.setRequestHeader("content-type", "application/json");
xhr.setRequestHeader("accept", "application/json, text/javascript, */*; q=0.01");
xhr.setRequestHeader("x-requested-with", "XMLHttpRequest");
xhr.setRequestHeader("cache-control", "no-cache");
xhr.send(data);
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute {"script":"var data = JSON.stringify({\n \"storeKeys\": [\n \"00847\"\n ]\n});\n\nvar xhr = new XMLHttpRequest();\nxhr.withCredentials = true;\n\nxhr.addEventListener(\"readystatechange\", function () {\n if (this.readyState === 4) {\n console.log(this.responseText);\n }\n});\n\nxhr.open(\"POST\", \"https://mstage.pepboys.com/api/store/select\");\nxhr.setRequestHeader(\"content-type\", \"application/json\");\nxhr.setRequestHeader(\"accept\", \"application/json, text/javascript, */*; q=0.01\");\nxhr.setRequestHeader(\"x-requested-with\", \"XMLHttpRequest\");\nxhr.setRequestHeader(\"cache-control\", \"no-cache\");\n\nxhr.send(data);","args":[]}
[debug] [MJSONWP] Calling AppiumDriver.execute() with args: ["var data = JSON.stringify({\n \"storeKeys\": [\n \"00847\"\n ]\n});\n\nvar xhr = new XMLHttpRequest();\nxhr.withCredentials = true;\n\nxhr.addEventListener(\"readystatechange\", function () {\n if (this.readyState === 4) {\n console.log(this.responseText);\n }\n});\n\nxhr.open(\"POST\", \"https://mstage.pepboys.com/api/store/select\");\nxhr.setRequestHeader(\"content-type\", \"application/json\");\nxhr.setRequestHeader(\"accept\", \"application/json, text/javascript, */*; q=0.01\");\nxhr.setRequestHeader(\"x-requested-with\", \"XMLHttpRequest\");\nxhr.setRequestHeader(\"cache-control\", \"no-cache\");\n\nxhr.send(data);",[],"b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'execute'
[debug] [RemoteDebugger] Executing 'execute_script' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){for(var aa="funct...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){for(var aa=\"func...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"object","value":{"status":0,"value":null}},"wasThrown":false},"id":20}
[debug] [RemoteDebugger] Found handler for message '20'
[debug] [RemoteDebugger] Received result for atom 'execute_script' execution: null
[debug] [MJSONWP] Responding to client with driver.execute() result: null
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/execute 200 936 ms - 76
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url {"url":"https://mstage.pepboys.com/product/details/8536668
"}
[debug] [MJSONWP] Calling AppiumDriver.setUrl() with args: ["https://mstage.pepboys.com/product/details/8536668
","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'setUrl'
[debug] [iOS] Attempting to set url 'https://mstage.pepboys.com/product/details/8536668
'
[debug] [RemoteDebugger] Navigating to new URL: https://mstage.pepboys.com/product/details/8536668

[debug] [RemoteDebugger] Sending WebKit data: {"method":"Page.navigate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"url":"https://mstage.pepboys.com/product/details/8536668
"}}
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{},"id":21}
[debug] [RemoteDebugger] Found handler for message '21'
[debug] [RemoteDebugger] Received page navigated message: {"result":{},"id":21}
[debug] [RemoteDebugger] Waiting for dom...
[debug] [RemoteDebugger] Page loaded, verifying whether ready
[debug] [RemoteDebugger] Not connected to an application. Ignoring page load
[debug] [MJSONWP] Responding to client with driver.setUrl() result: null
[HTTP] <-- POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/url 200 1672 ms - 76
[INFO] 21:04:54: [WebDriverEvent] Navigated to: https://mstage.pepboys.com/product/details/8536668

[INFO] 21:04:56: [PepBoysProductPage] Checking if element: 'By.xpath: (//div[@class='mw-note-value' and text()='8536668
'])[1]' visible
[INFO] 21:04:56: [WebDriverEvent] Trying to find Element By: By.xpath: (//div[@class='mw-note-value' and text()='8536668
'])[1]
[HTTP] --> POST /wd/hub/session/b061c1e2-d78f-4f85-8d22-7d5387ca3a09/elements {"using":"xpath","value":"(//div[@class='mw-note-value' and text()='8536668
'])[1]"}
[debug] [MJSONWP] Calling AppiumDriver.findElements() with args: ["xpath","(//div[@class='mw-note-value' and text()='8536668
'])[1]","b061c1e2-d78f-4f85-8d22-7d5387ca3a09"]
[debug] [XCUITest] Executing command 'findElements'
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
[debug] [BaseDriver] Waiting up to 30000 ms for condition
[debug] [RemoteDebugger] Executing 'find_elements' atom in default context
[debug] [RemoteDebugger] Sending javascript command (function(){return function(){var aa="function"...
[debug] [RemoteDebugger] Sending WebKit data: {"method":"Runtime.evaluate","params":{"objectGroup":"console","includeCommandLineAPI":true,"doNotPauseOnExceptionsAndMuteConsole":true,"expression":"(function(){return function(){var aa=\"function...
[debug] [RemoteDebugger] Webkit response timeout: 5000
[debug] [RemoteDebugger] Receiving WebKit data: {"result":{"result":{"type":"object","objectId":"{\"injectedScriptId\":3,\"id\":1}","subtype":"error","className":"SyntaxError","description":"SyntaxError: Unexpected EOF"},"wasThrown":true},"id":22}
[debug] [RemoteDebugger] Found handler for message '22'
[MJSONWP] Encountered internal error running command: Error: Error while executing atom: {"type":"object","objectId":"{\"injectedScriptId\":3,\"id\":1}","subtype":"error","className":"SyntaxError","description":"SyntaxError: Unexpected EOF"}
at XCUITestDriver.callee$0$0$ (../../../lib/commands/web.js:79:11)
at tryCatch (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:67:40)
at GeneratorFunctionPrototype.invoke [as _invoke] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:315:22)
at GeneratorFunctionPrototype.prototype.(anonymous function) [as throw] (/usr/local/lib/node_modules/appium/node_modules/babel-runtime/regenerator/runtime.js:100:21)
at GeneratorFunctionPrototype.invoke (/usr/local/lib/n[HTTP]ode_modul <-- POST /wdes/appium/node_mod/hub/session/bules/babel-runtim061c1e2-d78f-e/re4f85-8d22-7generator/runtime.js:13d53876:ca3a09/element37)
s 500 36 ms - 379
[INFO] 21:04:56: [WebDriverEvent]
[INFO] 21:04:56: [WebDriverEvent] Exception occurred:
org.openqa.selenium.WebDriverException: An unknown server-side error occurred while processing the command. Original error: Error while executing atom: {"type":"object","objectId":"{\"injectedScriptId\":3,\"id\":1}","subtype":"error","className":"SyntaxError","description":"SyntaxError: Unexpected EOF"} (WARNING: The server did not provide any stacktrace information)
Command duration or timeout: 50 milliseconds
Build info: version: '3.2.0', revision: '8c03df6b79', time: '2017-02-23 10:51:31 +0000'
System info: host: 'MacBook-Pro-Eugene.local', ip: 'fe80:0:0:0:14a4:17bc:13bf:4442%en0', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.12.4', java.version: '1.8.0_121'
Driver info: org.openqa.selenium.remote.RemoteWebDriver
Capabilities [{networkConnectionEnabled=false, xcodeOrgId=Y95G5M3Q84, databaseEnabled=false, deviceName=iPhone 6, launchTimeout=500000, updatedWDABundleId=com.moovweb.WebDriverAgentRunner, xcodeSigningId=iPhone Developer, platform=MAC, wdaLocalPort=8111, platformVersion=10.3.1, webStorageEnabled=false, locationContextEnabled=false, automationName=XCUITest, useNewWDA=true, browserName=Safari, takesScreenshot=true, javascriptEnabled=true, platformName=iOS, udid=f2b87b1ace53f97344a6c46ba67f33c60fb46cd1}]
Session ID: b061c1e2-d78f-4f85-8d22-7d5387ca3a09
*** Element info: {Using=xpath, value=(//div[@class='mw-note-value' and text()='8536668
'])[1]}
[INFO] 21:04:56: [WebDriverEvent]
May 18, 2017 9:04:56 PM org.openqa.selenium.support.ui.ExpectedConditions findElement
WARNING: WebDriverException thrown by findElement(By.xpath: (//div[@class='mw-note-value' and text()='8536668
'])[1])
org.openqa.selenium.WebDriverException: An unknown server-side error occurred while processing the command. Original error: Error while executing atom: {"type":"object","objectId":"{\"injectedScriptId\":3,\"id\":1}","subtype":"error","className":"SyntaxError","description":"SyntaxError: Unexpected EOF"} (WARNING: The server did not provide any stacktrace information)
Command duration or timeout: 50 milliseconds
Build info: version: '3.2.0', revision: '8c03df6b79', time: '2017-02-23 10:51:31 +0000'
System info: host: 'MacBook-Pro-Eugene.local', ip: 'fe80:0:0:0:14a4:17bc:13bf:4442%en0', os.name: 'Mac OS X', os.arch: 'x86_64', os.version: '10.12.4', java.version: '1.8.0_121'
Driver info: org.openqa.selenium.remote.RemoteWebDriver
Capabilities [{networkConnectionEnabled=false, xcodeOrgId=Y95G5M3Q84, databaseEnabled=false, deviceName=iPhone 6, launchTimeout=500000, updatedWDABundleId=com.moovweb.WebDriverAgentRunner, xcodeSigningId=iPhone Developer, platform=MAC, wdaLocalPort=8111, platformVersion=10.3.1, webStorageEnabled=false, locationContextEnabled=false, automationName=XCUITest, useNewWDA=true, browserName=Safari, takesScreenshot=true, javascriptEnabled=true, platformName=iOS, udid=f2b87b1ace53f97344a6c46ba67f33c60fb46cd1}]
Session ID: b061c1e2-d78f-4f85-8d22-7d5387ca3a09
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment