Skip to content

Instantly share code, notes, and snippets.

@imurchie

imurchie/appium-logs.txt

Created September 11, 2019 17:00
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 imurchie/df3a0959ef758ed1ecc3227080aae7db to your computer and use it in GitHub Desktop.
Save imurchie/df3a0959ef758ed1ecc3227080aae7db to your computer and use it in GitHub Desktop.
Download ZIP
Visibility fails to be updated
Raw
appium-logs.txt
PLATFORM_VERSION=13.0 DEVICE_NAME="iPhone 8" npm run e2e-test:basic
> appium-xcuitest-driver@2.129.0 e2e-test:basic /Users/isaac/code/appium-xcuitest-driver
> npm run build && _FORCE_LOGS=1 npm run mocha -- -t 0 -R spec build/test/functional/basic --exit
> appium-xcuitest-driver@2.129.0 build /Users/isaac/code/appium-xcuitest-driver
> gulp transpile
[12:48:37] Using gulpfile ~/code/appium-xcuitest-driver/gulpfile.js
[12:48:37] Starting 'transpile'...
[12:48:40] Finished 'transpile' after 3.72 s
> appium-xcuitest-driver@2.129.0 mocha /Users/isaac/code/appium-xcuitest-driver
> mocha "-t" "0" "-R" "spec" "build/test/functional/basic" "--exit"
XCUITestDriver - gestures
dynamic gestures
info XCUITest XCUITestDriver server listening on http://localhost:4994
info HTTP --> POST /wd/hub/session
info HTTP {"desiredCapabilities":{"app":"/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app","platformName":"iOS","platformVersion":"13.0","deviceName":"iPhone 8","automationName":"XCUITest","noReset":true,"maxTypingFrequency":30,"clearSystemFiles":true,"wdaLaunchTimeout":240000,"wdaConnectionTimeout":480000,"useNewWDA":true}}
dbug MJSONWP Calling XCUITestDriver.createSession() with args: [{"app":"/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app","platformName":"iOS","platformVersion":"13.0","deviceName":"iPhone 8","automationName":"XCUITest","noReset":true,"maxTypingFrequency":30,"clearSystemFiles":true,"wdaLaunchTimeout":240000,"wdaConnectionTimeout":480000,"useNewWDA":true},null,null]
dbug XCUITest Executing command 'createSession'
dbug BaseDriver Event 'newSessionRequested' logged at 1568220522941 (12:48:42 GMT-0400 (Eastern Daylight Time))
dbug BaseDriver Creating session with MJSONWP desired capabilities: {
dbug BaseDriver "app": "/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app",
dbug BaseDriver "platformName": "iOS",
dbug BaseDriver "platformVersion": "13.0",
dbug BaseDriver "deviceName": "iPhone 8",
dbug BaseDriver "automationName": "XCUITest",
dbug BaseDriver "noReset": true,
dbug BaseDriver "maxTypingFrequency": 30,
dbug BaseDriver "clearSystemFiles": true,
dbug BaseDriver "wdaLaunchTimeout": 240000,
dbug BaseDriver "wdaConnectionTimeout": 480000,
dbug BaseDriver "useNewWDA": true
dbug BaseDriver }
info BaseDriver Session created with session id: f917da6b-e16d-4fb3-9899-467449f6167a
dbug XCUITest Current user: 'isaac'
info XCUITest iOS SDK Version set to '13.0'
info XCUITest Simulator udid not provided
info XCUITest Using desired caps to create a new simulator
dbug simctl Creating simulator with name 'appiumTest-9AD70309-6550-4850-A91F-2FE7F5BB94E9-iPhone 8', device type id 'iPhone 8' and runtime id 'com.apple.CoreSimulator.SimRuntime.iOS-13-0'
info iOSSim Constructing iOS simulator for Xcode version 11.0 with udid 'E03BAB28-C370-4147-9A8A-45084CF3367F'
info XCUITest Created simulator with udid 'E03BAB28-C370-4147-9A8A-45084CF3367F'.
info XCUITest Determining device to run tests on: udid: 'E03BAB28-C370-4147-9A8A-45084CF3367F', real device: false
dbug BaseDriver Event 'xcodeDetailsRetrieved' logged at 1568220524067 (12:48:44 GMT-0400 (Eastern Daylight Time))
info BaseDriver Using local app '/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app'
dbug BaseDriver Event 'appConfigured' logged at 1568220524071 (12:48:44 GMT-0400 (Eastern Daylight Time))
dbug XCUITest Checking whether app '/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app' is actually present on file system
dbug XCUITest App is present
dbug iOS Getting bundle ID from app '/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app': 'com.example.apple-samplecode.UICatalog'
dbug BaseDriver Event 'resetStarted' logged at 1568220524074 (12:48:44 GMT-0400 (Eastern Daylight Time))
dbug XCUITest Reset: noReset is on. Leaving simulator as is
dbug BaseDriver Event 'resetComplete' logged at 1568220524074 (12:48:44 GMT-0400 (Eastern Daylight Time))
WARN XCUITest Continuing without capturing device logs: iOS Simulator with udid E03BAB28-C370-4147-9A8A-45084CF3367F is not running
info XCUITest Setting up simulator
dbug iOS No reason to set locale
dbug iOS No iOS / app preferences to set
dbug iOS Setting did not need to be updated
dbug iOSSim Setting preferences of E03BAB28-C370-4147-9A8A-45084CF3367F Simulator to {"ConnectHardwareKeyboard":false}
dbug iOSSim Setting common Simulator preferences to {"RotateWindowWhenSignaledByGuest":true,"ConnectHardwareKeyboard":false}
dbug iOSSim Updated E03BAB28-C370-4147-9A8A-45084CF3367F Simulator preferences at '/Users/isaac/Library/Preferences/com.apple.iphonesimulator.plist' with {"DevicePreferences":{"E03BAB28-C370-4147-9A8A-45084CF3367F":{"ConnectHardwareKeyboard":false}},"RotateWindowWhenSignaledByGuest":true,"ConnectHardwareKeyboard":false}
dbug iOSSim Got Simulator UI client PID: 5595
info iOSSim Booting Simulator with UDID E03BAB28-C370-4147-9A8A-45084CF3367F...
info iOSSim Simulator with UDID E03BAB28-C370-4147-9A8A-45084CF3367F booted in 34 seconds
dbug IDB Connecting idb service to 'E03BAB28-C370-4147-9A8A-45084CF3367F'
info XCUITest idb will not be used for Simulator interaction. Original error: 'idb_companion' has not been found in PATH. Is it installed? Read https://www.fbidb.io for more details
dbug BaseDriver Event 'simStarted' logged at 1568220558863 (12:49:18 GMT-0400 (Eastern Daylight Time))
dbug IOSSimulatorLog Starting log capture for iOS Simulator with udid 'E03BAB28-C370-4147-9A8A-45084CF3367F', using 'xcrun simctl spawn E03BAB28-C370-4147-9A8A-45084CF3367F log stream --style compact'
dbug BaseDriver Event 'logCaptureStarted' logged at 1568220560428 (12:49:20 GMT-0400 (Eastern Daylight Time))
dbug XCUITest Verifying application platform
dbug XCUITest CFBundleSupportedPlatforms: ["iPhoneSimulator"]
dbug XCUITest Cleaning installd cache to save the disk space
dbug XCUITest Installing '/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app' on Simulator with UUID 'E03BAB28-C370-4147-9A8A-45084CF3367F'...
dbug XCUITest The app has been installed successfully.
dbug BaseDriver Event 'appInstalled' logged at 1568220563990 (12:49:23 GMT-0400 (Eastern Daylight Time))
info XCUITest Using WDA path: '/Users/isaac/code/appium-xcuitest-driver/node_modules/appium-webdriveragent'
info XCUITest Using WDA agent: '/Users/isaac/code/appium-xcuitest-driver/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj'
dbug XCUITest No obsolete cached processes from previous WDA sessions listening on port 8100 have been found
dbug XCUITest Starting WebDriverAgent initialization with the synchronization key 'XCUITestDriver'
dbug XCUITest Capability 'useNewWDA' set to true, so uninstalling WDA before proceeding
info XCUITest Shutting down sub-processes
dbug iOSSim Building bundle path map
dbug iOSSim The simulator has '' which have 'WebDriverAgentRunner-Runner' as their 'CFBundleName'
dbug XCUITest No WDAs on the device.
dbug BaseDriver Event 'wdaUninstalled' logged at 1568220564402 (12:49:24 GMT-0400 (Eastern Daylight Time))
dbug XCUITest Trying to start WebDriverAgent 2 times with 10000ms interval
dbug XCUITest These values can be customized by changing wdaStartupRetries/wdaStartupRetryInterval capabilities
dbug BaseDriver Event 'wdaStartAttempted' logged at 1568220564403 (12:49:24 GMT-0400 (Eastern Daylight Time))
info XCUITest Launching WebDriverAgent on the device
info WebDriverAgent Fetching dependencies
info WebDriverAgent Dependencies up-to-date
dbug XCUITest Killing running processes 'xcodebuild.*E03BAB28-C370-4147-9A8A-45084CF3367F, E03BAB28-C370-4147-9A8A-45084CF3367F.*XCTRunner' for the device E03BAB28-C370-4147-9A8A-45084CF3367F...
dbug XCUITest 'pgrep -ifn xcodebuild.*E03BAB28-C370-4147-9A8A-45084CF3367F' didn't detect any matching processes. Return code: 1
dbug XCUITest 'pgrep -ifn E03BAB28-C370-4147-9A8A-45084CF3367F.*XCTRunner' didn't detect any matching processes. Return code: 1
dbug XCUITest Beginning test with command 'xcodebuild build-for-testing test-without-building -project /Users/isaac/code/appium-xcuitest-driver/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj -scheme WebDriverAgentRunner -destination id=E03BAB28-C370-4147-9A8A-45084CF3367F IPHONEOS_DEPLOYMENT_TARGET=13.0 GCC_TREAT_WARNINGS_AS_ERRORS=0 COMPILER_INDEX_STORE_ENABLE=NO' in directory '/Users/isaac/code/appium-xcuitest-driver/node_modules/appium-webdriveragent'
dbug XCUITest Output from xcodebuild will only be logged if any errors are present there. To change this, use 'showXcodeLog' desired capability
dbug XCUITest Waiting up to 240000ms for WebDriverAgent to start
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug XCUITest Log file for xcodebuild test: /Users/isaac/Library/Developer/Xcode/DerivedData/WebDriverAgent-geiyisutagwhcneklwigesubxcrw/Logs/Test/Test-WebDriverAgentRunner-2019.09.11_12-49-27--0400.xcresult/Staging/2_Test/Diagnostics/WebDriverAgentRunner-E12E7839-2D26-49FA-8EF8-5CF5B1B78803/WebDriverAgentRunner-89E7EB99-849B-4C3B-92FD-DD0495DD34DD/Session-WebDriverAgentRunner-2019-09-11_124930-GnqXfd.log
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
info WD Proxy Got an unexpected response with status undefined: {"errno":"ECONNREFUSED","code":"ECONNREFUSED","syscall":"connect","address":"127.0.0.1","port":8100}
dbug WD Proxy Matched '/status' to command name 'getStatus'
dbug WD Proxy Proxying [GET /status] to [GET http://localhost:8100/status] with no body
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : {
dbug WD Proxy "message" : "WebDriverAgent is ready to accept commands",
dbug WD Proxy "state" : "success",
dbug WD Proxy "os" : {
dbug WD Proxy "name" : "iOS",
dbug WD Proxy "version" : "13.0",
dbug WD Proxy "sdkVersion" : "13.0"
dbug WD Proxy },
dbug WD Proxy "ios" : {
dbug WD Proxy "simulatorVersion" : "13.0",
dbug WD Proxy "ip" : "192.168.86.66"
dbug WD Proxy },
dbug WD Proxy "ready" : true,
dbug WD Proxy "build" : {
dbug WD Proxy "upgradedAt" : "1568210001181",
dbug WD Proxy "time" : "Sep 11 2019 09:53:38",
dbug WD Proxy "productBundleIdentifier" : "com.facebook.WebDriverAgentRunner"
dbug WD Proxy }
dbug WD Proxy },
dbug WD Proxy "sessionId" : "BC05FFCF-DA9E-4B0B-8936-3021A4F84552"
dbug WD Proxy }
dbug XCUITest WebDriverAgent information:
dbug XCUITest {
dbug XCUITest "message": "WebDriverAgent is ready to accept commands",
dbug XCUITest "state": "success",
dbug XCUITest "os": {
dbug XCUITest "name": "iOS",
dbug XCUITest "version": "13.0",
dbug XCUITest "sdkVersion": "13.0"
dbug XCUITest },
dbug XCUITest "ios": {
dbug XCUITest "simulatorVersion": "13.0",
dbug XCUITest "ip": "192.168.86.66"
dbug XCUITest },
dbug XCUITest "ready": true,
dbug XCUITest "build": {
dbug XCUITest "upgradedAt": "1568210001181",
dbug XCUITest "time": "Sep 11 2019 09:53:38",
dbug XCUITest "productBundleIdentifier": "com.facebook.WebDriverAgentRunner"
dbug XCUITest }
dbug XCUITest }
dbug XCUITest WebDriverAgent successfully started after 16660ms
dbug BaseDriver Event 'wdaSessionAttempted' logged at 1568220581292 (12:49:41 GMT-0400 (Eastern Daylight Time))
dbug XCUITest Sending createSession command to WDA
dbug WD Proxy Matched '/session' to command name 'createSession'
dbug WD Proxy Proxying [POST /session] to [POST http://localhost:8100/session] with body: {"capabilities":{"firstMatch":[{"bundleId":"com.example.apple-samplecode.UICatalog","arguments":[],"environment":{},"eventloopIdleDelaySec":0,"shouldWaitForQuiescence":true,"shouldUseTestManagerForVisibilityDetection":false,"maxTypingFrequency":30,"shouldUseSingletonTestManager":true}],"alwaysMatch":{}}}
dbug WD Proxy Got response with status 200: {"value":{"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9","capabilities":{"device":"iphone","browserName":"UIKitCatalog","sdkVersion":"13.0","CFBundleIdentifier":"com.example.apple-samplecode.UICatalog"}},"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"}
info WD Proxy Determined the downstream protocol as 'W3C'
dbug BaseDriver Event 'wdaSessionStarted' logged at 1568220583219 (12:49:43 GMT-0400 (Eastern Daylight Time))
dbug XCUITest Parsed BUILD_DIR configuration value: '/Users/isaac/Library/Developer/Xcode/DerivedData/WebDriverAgent-geiyisutagwhcneklwigesubxcrw/Build/Products'
dbug XCUITest Got derived data root: '/Users/isaac/Library/Developer/Xcode/DerivedData/WebDriverAgent-geiyisutagwhcneklwigesubxcrw'
dbug BaseDriver Event 'wdaStarted' logged at 1568220586746 (12:49:46 GMT-0400 (Eastern Daylight Time))
info XCUITest Skipping setting of the initial display orientation. Set the "orientation" capability to either "LANDSCAPE" or "PORTRAIT", if this is an undesired behavior.
dbug BaseDriver Event 'orientationSet' logged at 1568220586747 (12:49:46 GMT-0400 (Eastern Daylight Time))
dbug BaseDriver Event 'newSessionStarted' logged at 1568220586749 (12:49:46 GMT-0400 (Eastern Daylight Time))
dbug MJSONWP (f917da6b) Cached the protocol value 'MJSONWP' for the new session f917da6b-e16d-4fb3-9899-467449f6167a
dbug MJSONWP (f917da6b) Responding to client with driver.createSession() result: {"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"app":"/Users/isaac/code/appium-xcuitest-driver/node_modules/ios-uicatalog/UIKitCatalog/build/Release-iphonesimulator/UIKitCatalog-iphonesimulator.app","platformName":"iOS","platformVersion":"13.0","deviceName":"iPhone 8","automationName":"XCUITest","noReset":true,"maxTypingFrequency":30,"clearSystemFiles":true,"wdaLaunchTimeout":240000,"wdaConnectionTimeout":480000,"useNewWDA":true,"udid":"E03BAB28-C370-4147-9A8A-45084CF3367F"}
info HTTP <-- POST /wd/hub/session 200 63869 ms - 701
info HTTP
info HTTP --> POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/back
info HTTP {}
dbug MJSONWP (f917da6b) Calling XCUITestDriver.back() with args: ["f917da6b-e16d-4fb3-9899-467449f6167a"]
dbug XCUITest Executing command 'back'
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element' to command name 'findElement'
dbug WD Proxy Proxying [POST /element] to [POST http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element] with body: {"using":"class name","value":"XCUIElementTypeNavigationBar"}
dbug WD Proxy Got response with status 200: {"value":{"ELEMENT":"0D000000-0000-0000-351B-000000000000","element-6066-11e4-a52e-4f735466cecf":"0D000000-0000-0000-351B-000000000000"},"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"}
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element/0D000000-0000-0000-351B-000000000000/elements' to command name 'findElementsFromElement'
dbug WD Proxy Proxying [POST /element/0D000000-0000-0000-351B-000000000000/elements] to [POST http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element/0D000000-0000-0000-351B-000000000000/elements] with body: {"using":"class name","value":"XCUIElementTypeButton"}
dbug WD Proxy Got response with status 200: {"value":[],"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"}
ERR! XCUITest Unable to find navigation bar and back button: No buttons found in navigation bar
dbug MJSONWP (f917da6b) Responding to client with driver.back() result: null
info HTTP <-- POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/back 200 732 ms - 76
info HTTP
info HTTP --> POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element
info HTTP {"using":"accessibility id","value":"Activity Indicators"}
dbug MJSONWP (f917da6b) Calling XCUITestDriver.findElement() with args: ["accessibility id","Activity Indicators","f917da6b-e16d-4fb3-9899-467449f6167a"]
dbug XCUITest Executing command 'findElement'
dbug BaseDriver Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element' to command name 'findElement'
dbug WD Proxy Proxying [POST /element] to [POST http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element] with body: {"using":"accessibility id","value":"Activity Indicators"}
dbug WD Proxy Got response with status 200: {"value":{"ELEMENT":"25000000-0000-0000-351B-000000000000","element-6066-11e4-a52e-4f735466cecf":"25000000-0000-0000-351B-000000000000"},"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"}
dbug MJSONWP (f917da6b) Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"25000000-0000-0000-351B-000000000000","ELEMENT":"25000000-0000-0000-351B-000000000000"}
info HTTP <-- POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element 200 615 ms - 199
info HTTP
info HTTP --> POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element
info HTTP {"using":"accessibility id","value":"Progress Views"}
dbug MJSONWP (f917da6b) Calling XCUITestDriver.findElement() with args: ["accessibility id","Progress Views","f917da6b-e16d-4fb3-9899-467449f6167a"]
dbug XCUITest Executing command 'findElement'
dbug BaseDriver Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element' to command name 'findElement'
dbug WD Proxy Proxying [POST /element] to [POST http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element] with body: {"using":"accessibility id","value":"Progress Views"}
dbug WD Proxy Got response with status 200: {"value":{"ELEMENT":"4F000000-0000-0000-351B-000000000000","element-6066-11e4-a52e-4f735466cecf":"4F000000-0000-0000-351B-000000000000"},"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"}
dbug MJSONWP (f917da6b) Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"4F000000-0000-0000-351B-000000000000","ELEMENT":"4F000000-0000-0000-351B-000000000000"}
info HTTP <-- POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element 200 712 ms - 199
info HTTP
info HTTP --> POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element
info HTTP {"using":"accessibility id","value":"Web View"}
dbug MJSONWP (f917da6b) Calling XCUITestDriver.findElement() with args: ["accessibility id","Web View","f917da6b-e16d-4fb3-9899-467449f6167a"]
dbug XCUITest Executing command 'findElement'
dbug BaseDriver Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id
dbug BaseDriver Waiting up to 0 ms for condition
dbug WD Proxy Matched '/element' to command name 'findElement'
dbug WD Proxy Proxying [POST /element] to [POST http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element] with body: {"using":"accessibility id","value":"Web View"}
dbug WD Proxy Got response with status 200: {"value":{"ELEMENT":"8E000000-0000-0000-351B-000000000000","element-6066-11e4-a52e-4f735466cecf":"8E000000-0000-0000-351B-000000000000"},"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"}
dbug MJSONWP (f917da6b) Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"8E000000-0000-0000-351B-000000000000","ELEMENT":"8E000000-0000-0000-351B-000000000000"}
info HTTP <-- POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element 200 753 ms - 199
info HTTP
info HTTP --> GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed
info HTTP {}
info MJSONWP (f917da6b) Driver proxy active, passing request on via HTTP proxy
dbug XCUITest Executing command 'proxyReqRes'
dbug WD Proxy Matched '/wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed' to command name 'elementDisplayed'
dbug WD Proxy Proxying [GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed] to [GET http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element/8E000000-0000-0000-351B-000000000000/displayed] with body: {}
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : false,
dbug WD Proxy "sessionId" : "73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"
dbug WD Proxy }
info WD Proxy Replacing sessionId 73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9 with f917da6b-e16d-4fb3-9899-467449f6167a
info HTTP <-- GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed 200 572 ms - 77
info HTTP
info HTTP --> POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/touch/perform
info HTTP {"actions":[{"action":"press","options":{"element":"4F000000-0000-0000-351B-000000000000"}},{"action":"wait","options":{"ms":500}},{"action":"moveTo","options":{"element":"25000000-0000-0000-351B-000000000000"}},{"action":"release","options":{}}]}
dbug MJSONWP (f917da6b) Calling XCUITestDriver.performTouch() with args: [[{"action":"press","options":{"element":"4F000000-0000-0000-351B-000000000000"}},{"action":"wait","options":{"ms":500}},{"action":"moveTo","options":{"element":"25000000-0000-0000-351B-000000000000"}},{"action":"release","options":{}}],"f917da6b-e16d-4fb3-9899-467449f6167a"]
dbug XCUITest Executing command 'performTouch'
dbug XCUITest Received the following touch action: press(options={"element":"4F000000-0000-0000-351B-000000000000"})-wait(options={"ms":500})-moveTo(options={"element":"25000000-0000-0000-351B-000000000000"})-release(options={})
dbug WD Proxy Proxying [POST /wda/touch/perform] to [POST http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/wda/touch/perform] with body: {"actions":[{"action":"press","options":{"element":"4F000000-0000-0000-351B-000000000000"}},{"action":"wait","options":{"ms":500}},{"action":"moveTo","options":{"element":"25000000-0000-0000-351B-000000000000"}},{"action":"release","options":{}}]}
dbug WD Proxy Got response with status 200: {"value":null,"sessionId":"73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"}
dbug MJSONWP (f917da6b) Responding to client with driver.performTouch() result: null
info HTTP <-- POST /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/touch/perform 200 1155 ms - 76
info HTTP
info HTTP --> GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed
info HTTP {}
info MJSONWP (f917da6b) Driver proxy active, passing request on via HTTP proxy
dbug XCUITest Executing command 'proxyReqRes'
dbug WD Proxy Matched '/wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed' to command name 'elementDisplayed'
dbug WD Proxy Proxying [GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed] to [GET http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element/8E000000-0000-0000-351B-000000000000/displayed] with body: {}
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : false,
dbug WD Proxy "sessionId" : "73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"
dbug WD Proxy }
info WD Proxy Replacing sessionId 73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9 with f917da6b-e16d-4fb3-9899-467449f6167a
info HTTP <-- GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed 200 3825 ms - 77
info HTTP
info HTTP --> GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed
info HTTP {}
info MJSONWP (f917da6b) Driver proxy active, passing request on via HTTP proxy
dbug XCUITest Executing command 'proxyReqRes'
dbug WD Proxy Matched '/wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed' to command name 'elementDisplayed'
dbug WD Proxy Proxying [GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed] to [GET http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element/8E000000-0000-0000-351B-000000000000/displayed] with body: {}
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : false,
dbug WD Proxy "sessionId" : "73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"
dbug WD Proxy }
info WD Proxy Replacing sessionId 73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9 with f917da6b-e16d-4fb3-9899-467449f6167a
info HTTP <-- GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed 200 3189 ms - 77
info HTTP
info HTTP --> GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed
info HTTP {}
info MJSONWP (f917da6b) Driver proxy active, passing request on via HTTP proxy
dbug XCUITest Executing command 'proxyReqRes'
dbug WD Proxy Matched '/wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed' to command name 'elementDisplayed'
dbug WD Proxy Proxying [GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed] to [GET http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element/8E000000-0000-0000-351B-000000000000/displayed] with body: {}
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : false,
dbug WD Proxy "sessionId" : "73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"
dbug WD Proxy }
info WD Proxy Replacing sessionId 73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9 with f917da6b-e16d-4fb3-9899-467449f6167a
info HTTP <-- GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed 200 3629 ms - 77
info HTTP
info HTTP --> GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed
info HTTP {}
info MJSONWP (f917da6b) Driver proxy active, passing request on via HTTP proxy
dbug XCUITest Executing command 'proxyReqRes'
dbug WD Proxy Matched '/wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed' to command name 'elementDisplayed'
dbug WD Proxy Proxying [GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed] to [GET http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element/8E000000-0000-0000-351B-000000000000/displayed] with body: {}
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : false,
dbug WD Proxy "sessionId" : "73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"
dbug WD Proxy }
info WD Proxy Replacing sessionId 73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9 with f917da6b-e16d-4fb3-9899-467449f6167a
info HTTP <-- GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed 200 3858 ms - 77
info HTTP
info HTTP --> GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed
info HTTP {}
info MJSONWP (f917da6b) Driver proxy active, passing request on via HTTP proxy
dbug XCUITest Executing command 'proxyReqRes'
dbug WD Proxy Matched '/wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed' to command name 'elementDisplayed'
dbug WD Proxy Proxying [GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed] to [GET http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9/element/8E000000-0000-0000-351B-000000000000/displayed] with body: {}
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : false,
dbug WD Proxy "sessionId" : "73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9"
dbug WD Proxy }
info WD Proxy Replacing sessionId 73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9 with f917da6b-e16d-4fb3-9899-467449f6167a
info HTTP <-- GET /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a/element/8E000000-0000-0000-351B-000000000000/displayed 200 3419 ms - 77
info HTTP
1) should scroll using touch actions
info HTTP --> DELETE /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a
info HTTP {}
dbug MJSONWP (f917da6b) Calling XCUITestDriver.deleteSession() with args: ["f917da6b-e16d-4fb3-9899-467449f6167a"]
dbug XCUITest Executing command 'deleteSession'
dbug BaseDriver Event 'quitSessionRequested' logged at 1568220621159 (12:50:21 GMT-0400 (Eastern Daylight Time))
dbug WD Proxy Matched '/session/f917da6b-e16d-4fb3-9899-467449f6167a' to command name 'deleteSession'
dbug WD Proxy Proxying [DELETE /session/f917da6b-e16d-4fb3-9899-467449f6167a] to [DELETE http://localhost:8100/session/73ED29F7-E8CB-4E9F-BB4D-8E3391335AB9] with no body
dbug WD Proxy Got response with status 200: {
dbug WD Proxy "value" : null,
dbug WD Proxy "sessionId" : "0C49191D-124A-4216-8A86-7EFEA31CA9A3"
dbug WD Proxy }
info XCUITest Shutting down sub-processes
info XCUITest Shutting down xcodebuild process (pid 6934)
ERR! XCUITest xcodebuild exited with code 'null' and signal 'SIGTERM'
dbug XCUITest Started background XCTest logs cleanup: find -E /private/var/folders -regex '.*/Session-WebDriverAgentRunner.*\.log$|.*/StandardOutputAndStandardError\.txt$' -type f -exec sh -c 'echo "" > "{}"' \;
info XCUITest Cleaning test logs in '/Users/isaac/Library/Developer/Xcode/DerivedData/WebDriverAgent-geiyisutagwhcneklwigesubxcrw/Logs' folder
dbug iOS Clearing log files
dbug iOS Deleting '/Users/isaac/Library/Developer/Xcode/DerivedData/WebDriverAgent-geiyisutagwhcneklwigesubxcrw/Logs'. Freeing 16K.
dbug iOS Finished clearing log files
dbug IOSSimulatorLog Stopping iOS log capture
dbug BaseDriver Event 'quitSessionFinished' logged at 1568220622431 (12:50:22 GMT-0400 (Eastern Daylight Time))
dbug MJSONWP (f917da6b) Received response: null
dbug MJSONWP (f917da6b) But deleting session, so not returning
dbug MJSONWP (f917da6b) Responding to client with driver.deleteSession() result: null
info HTTP <-- DELETE /wd/hub/session/f917da6b-e16d-4fb3-9899-467449f6167a 200 1275 ms - 76
info HTTP
0 passing (2m)
1 failing
1) XCUITestDriver - gestures
dynamic gestures
should scroll using touch actions:
AssertionError: expected false to be true
+ expected - actual
-false
+true
npm ERR! code ELIFECYCLE
npm ERR! errno 1
npm ERR! appium-xcuitest-driver@2.129.0 mocha: `mocha "-t" "0" "-R" "spec" "build/test/functional/basic" "--exit"`
npm ERR! Exit status 1
npm ERR!
npm ERR! Failed at the appium-xcuitest-driver@2.129.0 mocha script.
npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
npm ERR! A complete log of this run can be found in:
npm ERR! /Users/isaac/.npm/_logs/2019-09-11T16_50_22_611Z-debug.log
npm ERR! code ELIFECYCLE
npm ERR! errno 1
npm ERR! appium-xcuitest-driver@2.129.0 e2e-test:basic: `npm run build && _FORCE_LOGS=1 npm run mocha -- -t 0 -R spec build/test/functional/basic --exit`
npm ERR! Exit status 1
npm ERR!
npm ERR! Failed at the appium-xcuitest-driver@2.129.0 e2e-test:basic script.
npm ERR! This is probably not a problem with npm. There is likely additional logging output above.
npm ERR! A complete log of this run can be found in:
npm ERR! /Users/isaac/.npm/_logs/2019-09-11T16_50_22_673Z-debug.log
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment