Last login: Tue Feb 28 10:15:11 on console taoruiying@CN-L-KTX4T6RG2X ~ % appium [Appium] Welcome to Appium v1.22.3 [Appium] Appium REST http interface listener started on 0.0.0.0:4723 [HTTP] --> GET /wd/hub/sessions [HTTP] {} [debug] [GENERIC] Calling AppiumDriver.getSessions() with args: [] [debug] [GENERIC] Responding to client with driver.getSessions() result: [] [HTTP] <-- GET /wd/hub/sessions 304 9 ms - - [HTTP] [HTTP] --> GET /wd/hub/sessions [HTTP] {} [debug] [GENERIC] Calling AppiumDriver.getSessions() with args: [] [debug] [GENERIC] Responding to client with driver.getSessions() result: [] [HTTP] <-- GET /wd/hub/sessions 304 1 ms - - [HTTP] [HTTP] --> POST /wd/hub/session [HTTP] {"capabilities":{"alwaysMatch":{"platformName":"iOS","appium:platformVersion":"16.2","appium:deviceName":"Drivetune_spider_iPhone13","appium:udid":"00008110-00011CDC36E3801E","appium:app":"com.abb.drivetune.debug","appium:includeSafariInWebviews":true,"appium:newCommandTimeout":3600,"appium:connectHardwareKeyboard":true},"firstMatch":[{}]},"desiredCapabilities":{"platformName":"iOS","appium:platformVersion":"16.2","appium:deviceName":"Drivetune_spider_iPhone13","appium:udid":"00008110-00011CDC36E3801E","appium:app":"com.abb.drivetune.debug","appium:includeSafariInWebviews":true,"appium:newCommandTimeout":3600,"appium:connectHardwareKeyboard":true}} [debug] [W3C] Calling AppiumDriver.createSession() with args: [{"platformName":"iOS","appium:platformVersion":"16.2","appium:deviceName":"Drivetune_spider_iPhone13","appium:udid":"00008110-00011CDC36E3801E","appium:app":"com.abb.drivetune.debug","appium:includeSafariInWebviews":true,"appium:newCommandTimeout":3600,"appium:connectHardwareKeyboard":true},null,{"alwaysMatch":{"platformName":"iOS","appium:platformVersion":"16.2","appium:deviceName":"Drivetune_spider_iPhone13","appium:udid":"00008110-00011CDC36E3801E","appium:app":"com.abb.drivetune.debug","appium:includeSafariInWebviews":true,"appium:newCommandTimeout":3600,"appium:connectHardwareKeyboard":true},"firstMatch":[{}]}] [debug] [BaseDriver] Event 'newSessionRequested' logged at 1677550734922 (10:18:54 GMT+0800 (China Standard Time)) [Appium] DeprecationWarning: 'automationName' capability was not provided. Future versions of Appium will require 'automationName' capability to be set for iOS sessions. [Appium] Requested iOS support with version >= 10, using 'XCUITest' driver instead of UIAutomation-based driver, since the latter is unsupported on iOS 10 and up. [Appium] Appium v1.22.3 creating new XCUITestDriver (v3.59.0) session [debug] [BaseDriver] W3C capabilities and MJSONWP desired capabilities were provided [debug] [BaseDriver] Creating session with W3C capabilities: { [debug] [BaseDriver] "alwaysMatch": { [debug] [BaseDriver] "platformName": "iOS", [debug] [BaseDriver] "appium:platformVersion": "16.2", [debug] [BaseDriver] "appium:deviceName": "Drivetune_spider_iPhone13", [debug] [BaseDriver] "appium:udid": "00008110-00011CDC36E3801E", [debug] [BaseDriver] "appium:app": "com.abb.drivetune.debug", [debug] [BaseDriver] "appium:includeSafariInWebviews": true, [debug] [BaseDriver] "appium:newCommandTimeout": 3600, [debug] [BaseDriver] "appium:connectHardwareKeyboard": true [debug] [BaseDriver] }, [debug] [BaseDriver] "firstMatch": [ [debug] [BaseDriver] {} [debug] [BaseDriver] ] [debug] [BaseDriver] } [BaseDriver] Session created with session id: 9e30ccb8-ddbf-47a0-a2d4-916d30b31411 [debug] [XCUITest] Current user: 'taoruiying' [debug] [XCUITest] Available devices: 00008110-00011CDC36E3801E [debug] [XCUITest] Creating iDevice object with udid '00008110-00011CDC36E3801E' [XCUITest] Determining device to run tests on: udid: '00008110-00011CDC36E3801E', real device: true [debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1677550735146 (10:18:55 GMT+0800 (China Standard Time)) [debug] [XCUITest] App is an iOS bundle, will attempt to run as pre-existing [debug] [BaseDriver] Event 'appConfigured' logged at 1677550735147 (10:18:55 GMT+0800 (China Standard Time)) [debug] [BaseDriver] Event 'resetStarted' logged at 1677550735147 (10:18:55 GMT+0800 (China Standard Time)) [debug] [XCUITest] Reset: running ios real device reset flow [debug] [BaseDriver] Event 'resetComplete' logged at 1677550735147 (10:18:55 GMT+0800 (China Standard Time)) [WebDriverAgent] Using WDA path: '/opt/homebrew/lib/node_modules/appium/node_modules/appium-webdriveragent' [WebDriverAgent] Using WDA agent: '/opt/homebrew/lib/node_modules/appium/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj' [debug] [XCUITest] Crash reports root '/Users/CNTOTAO4/Library/Logs/CrashReporter/MobileDevice/Drivetune_spider_iPhone13' does not exist. Got nothing to gather. [debug] [BaseDriver] Event 'logCaptureStarted' logged at 1677550735478 (10:18:55 GMT+0800 (China Standard Time)) [XCUITest] Setting up real device [debug] [WebDriverAgent] No obsolete cached processes from previous WDA sessions listening on port 8100 have been found [DevCon Factory] Requesting connection for device 00008110-00011CDC36E3801E on local port 8100, device port 8100 [debug] [DevCon Factory] Cached connections count: 0 [DevCon Factory] Successfully requested the connection for 00008110-00011CDC36E3801E:8100 [debug] [XCUITest] Starting WebDriverAgent initialization with the synchronization key 'XCUITestDriver' [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8100/status] with no body [debug] [WebDriverAgent] Parsed BUILD_DIR configuration value: '/Users/CNTOTAO4/Library/Developer/Xcode/DerivedData/WebDriverAgent-fxmsedpwfaalxlbcwefbceeuodem/Build/Products' [debug] [WebDriverAgent] Got derived data root: '/Users/CNTOTAO4/Library/Developer/Xcode/DerivedData/WebDriverAgent-fxmsedpwfaalxlbcwefbceeuodem' [WD Proxy] Error: timeout of 3000ms exceeded [WD Proxy] at createError (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/core/createError.js:16:15) [WD Proxy] at RedirectableRequest.handleRequestTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/adapters/http.js:280:16) [WD Proxy] at RedirectableRequest.emit (node:events:513:28) [WD Proxy] at Timeout._onTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/follow-redirects/index.js:166:12) [WD Proxy] at listOnTimeout (node:internal/timers:564:17) [WD Proxy] at processTimers (node:internal/timers:507:7) [debug] [WebDriverAgent] WDA is not listening at 'http://127.0.0.1:8100/' [debug] [WebDriverAgent] WDA is currently not running. There is nothing to cache [debug] [XCUITest] Trying to start WebDriverAgent 1 times with 10000ms interval [debug] [XCUITest] These values can be customized by changing wdaStartupRetries/wdaStartupRetryInterval capabilities [debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1677550738843 (10:18:58 GMT+0800 (China Standard Time)) [WebDriverAgent] Launching WebDriverAgent on the device [WebDriverAgent] WebDriverAgent does not need a cleanup. The sources are up to date (1671073754646 >= 1671073754646) [debug] [WebDriverAgent] Killing running processes 'xcodebuild.*00008110-00011CDC36E3801E' for the device 00008110-00011CDC36E3801E... [debug] [WebDriverAgent] 'pgrep -if xcodebuild.*00008110-00011CDC36E3801E' didn't detect any matching processes. Return code: 1 [debug] [WebDriverAgent] Beginning test with command 'xcodebuild build-for-testing test-without-building -project /opt/homebrew/lib/node_modules/appium/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj -scheme WebDriverAgentRunner -derivedDataPath /Users/CNTOTAO4/Library/Developer/Xcode/DerivedData/WebDriverAgent-fxmsedpwfaalxlbcwefbceeuodem -destination id=00008110-00011CDC36E3801E IPHONEOS_DEPLOYMENT_TARGET=16.2 GCC_TREAT_WARNINGS_AS_ERRORS=0 COMPILER_INDEX_STORE_ENABLE=NO' in directory '/opt/homebrew/lib/node_modules/appium/node_modules/appium-webdriveragent' [debug] [WebDriverAgent] Output from xcodebuild will only be logged if any errors are present there. To change this, use 'showXcodeLog' desired capability [debug] [WebDriverAgent] Waiting up to 60000ms for WebDriverAgent to start [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8100/status] with no body [WD Proxy] Error: timeout of 1000ms exceeded [WD Proxy] at createError (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/core/createError.js:16:15) [WD Proxy] at RedirectableRequest.handleRequestTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/adapters/http.js:280:16) [WD Proxy] at RedirectableRequest.emit (node:events:513:28) [WD Proxy] at Timeout._onTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/follow-redirects/index.js:166:12) [WD Proxy] at listOnTimeout (node:internal/timers:564:17) [WD Proxy] at processTimers (node:internal/timers:507:7) [debug] [iProxy@00008110:8100] Failed to receive any data within the timeout: 5000 [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8100/status] with no body [WebDriverAgent] xcodebuild exited with code '65' and signal 'null' [WebDriverAgent] Launching WebDriverAgent on the device [WebDriverAgent] WebDriverAgent does not need a cleanup. The sources are up to date (1671073754646 >= 1671073754646) [debug] [WebDriverAgent] Killing running processes 'xcodebuild.*00008110-00011CDC36E3801E' for the device 00008110-00011CDC36E3801E... [debug] [WebDriverAgent] 'pgrep -if xcodebuild.*00008110-00011CDC36E3801E' didn't detect any matching processes. Return code: 1 [debug] [WebDriverAgent] Beginning test with command 'xcodebuild build-for-testing test-without-building -project /opt/homebrew/lib/node_modules/appium/node_modules/appium-webdriveragent/WebDriverAgent.xcodeproj -scheme WebDriverAgentRunner -derivedDataPath /Users/CNTOTAO4/Library/Developer/Xcode/DerivedData/WebDriverAgent-fxmsedpwfaalxlbcwefbceeuodem -destination id=00008110-00011CDC36E3801E IPHONEOS_DEPLOYMENT_TARGET=16.2 GCC_TREAT_WARNINGS_AS_ERRORS=0 COMPILER_INDEX_STORE_ENABLE=NO' in directory '/opt/homebrew/lib/node_modules/appium/node_modules/appium-webdriveragent' [debug] [WebDriverAgent] Output from xcodebuild will only be logged if any errors are present there. To change this, use 'showXcodeLog' desired capability [WD Proxy] Error: timeout of 1000ms exceeded [WD Proxy] at createError (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/core/createError.js:16:15) [WD Proxy] at RedirectableRequest.handleRequestTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/adapters/http.js:280:16) [WD Proxy] at RedirectableRequest.emit (node:events:513:28) [WD Proxy] at Timeout._onTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/follow-redirects/index.js:166:12) [WD Proxy] at listOnTimeout (node:internal/timers:564:17) [WD Proxy] at processTimers (node:internal/timers:507:7) [debug] [WebDriverAgent] Waiting up to 60000ms for WebDriverAgent to start [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8100/status] with no body [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8100/status] with no body [WD Proxy] Error: timeout of 1000ms exceeded [WD Proxy] at createError (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/core/createError.js:16:15) [WD Proxy] at RedirectableRequest.handleRequestTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/adapters/http.js:280:16) [WD Proxy] at RedirectableRequest.emit (node:events:513:28) [WD Proxy] at Timeout._onTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/follow-redirects/index.js:166:12) [WD Proxy] at listOnTimeout (node:internal/timers:564:17) [WD Proxy] at processTimers (node:internal/timers:507:7) [debug] [iProxy@00008110:8100] Failed to receive any data within the timeout: 5000 [WD Proxy] Error: timeout of 1000ms exceeded [WD Proxy] at createError (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/core/createError.js:16:15) [WD Proxy] at RedirectableRequest.handleRequestTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/adapters/http.js:280:16) [WD Proxy] at RedirectableRequest.emit (node:events:513:28) [WD Proxy] at Timeout._onTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/follow-redirects/index.js:166:12) [WD Proxy] at listOnTimeout (node:internal/timers:564:17) [WD Proxy] at processTimers (node:internal/timers:507:7) [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8100/status] with no body [debug] [WD Proxy] Matched '/status' to command name 'getStatus' [debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8100/status] with no body [WD Proxy] Error: timeout of 1000ms exceeded [WD Proxy] at createError (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/core/createError.js:16:15) [WD Proxy] at RedirectableRequest.handleRequestTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/adapters/http.js:280:16) [WD Proxy] at RedirectableRequest.emit (node:events:513:28) [WD Proxy] at Timeout._onTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/follow-redirects/index.js:166:12) [WD Proxy] at listOnTimeout (node:internal/timers:564:17) [WD Proxy] at processTimers (node:internal/timers:507:7) [WebDriverAgent] xcodebuild exited with code '65' and signal 'null' [debug] [BaseDriver] Event 'wdaStartFailed' logged at 1677550745892 (10:19:05 GMT+0800 (China Standard Time)) [debug] [XCUITest] Unable to launch WebDriverAgent because of xcodebuild failure: xcodebuild failed with code 65 [debug] [XCUITest] xcodebuild error message: [debug] [XCUITest] . Make sure you follow the tutorial at https://github.com/appium/appium-xcuitest-driver/blob/master/docs/real-device-config.md. Try to remove the WebDriverAgentRunner application from the device if it is installed and reboot the device. [XCUITest] Quitting and uninstalling WebDriverAgent [WebDriverAgent] Shutting down sub-processes [debug] [iProxy@00008110:8100] Failed to receive any data within the timeout: 5000 [WD Proxy] Error: timeout of 1000ms exceeded [WD Proxy] at createError (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/core/createError.js:16:15) [WD Proxy] at RedirectableRequest.handleRequestTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/axios/lib/adapters/http.js:280:16) [WD Proxy] at RedirectableRequest.emit (node:events:513:28) [WD Proxy] at Timeout._onTimeout (/opt/homebrew/lib/node_modules/appium/node_modules/follow-redirects/index.js:166:12) [WD Proxy] at listOnTimeout (node:internal/timers:564:17) [WD Proxy] at processTimers (node:internal/timers:507:7) [debug] [WebDriverAgent] Uninstalling WDAs: 'com.abb32.WebDriverAgentRunner.xctrunner' [XCUITest] {} [DevCon Factory] Releasing connections for 00008110-00011CDC36E3801E device on any port number [DevCon Factory] Found cached connections to release: ["00008110-00011CDC36E3801E:8100"] [DevCon Factory] Releasing the listener for '00008110-00011CDC36E3801E:8100' [debug] [iProxy@00008110:8100] Closing the connection [debug] [DevCon Factory] Cached connections count: 0 [debug] [XCUITest] Not clearing log files. Use `clearSystemFiles` capability to turn on. [debug] [BaseDriver] Event 'newSessionStarted' logged at 1677550746976 (10:19:06 GMT+0800 (China Standard Time)) [debug] [W3C] Encountered internal error running command: Error: Unable to launch WebDriverAgent because of xcodebuild failure: xcodebuild failed with code 65 [debug] [W3C] xcodebuild error message: [debug] [W3C] . Make sure you follow the tutorial at https://github.com/appium/appium-xcuitest-driver/blob/master/docs/real-device-config.md. Try to remove the WebDriverAgentRunner application from the device if it is installed and reboot the device. [debug] [W3C] at quitAndUninstall (/opt/homebrew/lib/node_modules/appium/node_modules/appium-xcuitest-driver/lib/driver.js:585:15) [debug] [W3C] at /opt/homebrew/lib/node_modules/appium/node_modules/appium-xcuitest-driver/lib/driver.js:620:11 [debug] [W3C] at wrapped (/opt/homebrew/lib/node_modules/appium/node_modules/asyncbox/lib/asyncbox.js:60:13) [debug] [W3C] at retry (/opt/homebrew/lib/node_modules/appium/node_modules/asyncbox/lib/asyncbox.js:43:13) [debug] [W3C] at retryInterval (/opt/homebrew/lib/node_modules/appium/node_modules/asyncbox/lib/asyncbox.js:70:10) [debug] [W3C] at /opt/homebrew/lib/node_modules/appium/node_modules/appium-xcuitest-driver/lib/driver.js:600:7 [HTTP] <-- POST /wd/hub/session 500 12077 ms - 1219 [HTTP] [debug] [iProxy@00008110:8100] Failed to receive any data within the timeout: 5000 [debug] [iProxy@00008110:8100] Failed to receive any data within the timeout: 5000 [debug] [iProxy@00008110:8100] Unexpected data: {"header":{"length":294,"version":1,"type":8,"tag":1},"payload":{"MessageType":"Result","Number":2}} [debug] [iProxy@00008110:8100] Failed to receive any data within the timeout: 5000 [iProxy@00008110:8100] The connection has been closed