2022-05-10 11:24:37.415 [Appium] Welcome to Appium v2.0.0-beta.18
2022-05-10 11:24:37.416 [Appium] Non-default server args:
2022-05-10 11:24:37.416 [Appium] port: 54611
2022-05-10 11:24:37.416 [Appium] sessionOverride: true
2022-05-10 11:24:37.417 [Appium] logNoColors: true
2022-05-10 11:24:37.417 [Appium] tmpDir: C:\Users\yiann\AppData\Local\Temp
2022-05-10 11:24:37.417 [Appium] allowInsecure: {
2022-05-10 11:24:37.417 [Appium] 0: adb_shell
2022-05-10 11:24:37.417 [Appium] }
2022-05-10 11:24:37.417 [Appium] Attempting to load driver uiautomator2...
2022-05-10 11:24:38.209 [Appium] Attempting to load driver xcuitest...
2022-05-10 11:24:39.063 [Appium] Appium REST http interface listener started on 0.0.0.0:54611
2022-05-10 11:24:39.063 [Appium] Available drivers:
2022-05-10 11:24:39.063 [Appium] - [email protected] (automationName 'UiAutomator2')
2022-05-10 11:24:39.063 [Appium] - [email protected] (automationName 'XCUITest')
2022-05-10 11:24:39.063 [Appium] No plugins have been installed. Use the "appium plugin" command to install the one(s) you want to use.
2022-05-10 11:24:45.790 [HTTP] -GET /status
2022-05-10 11:24:45.790 [HTTP] {}
2022-05-10 11:24:45.791 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:24:45.791 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:24:45.795 [HTTP]
- GET /status 200 3 ms - 75 2022-05-10 11:24:45.795 [HTTP]
2022-05-10 11:24:54.623 [HTTP] -GET /status
2022-05-10 11:24:54.623 [HTTP] {}
2022-05-10 11:24:54.623 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:24:54.623 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:24:54.624 [HTTP]
- GET /status 200 1 ms - 75 2022-05-10 11:24:54.625 [HTTP]
2022-05-10 11:24:54.666 [HTTP] -GET /status
2022-05-10 11:24:54.666 [HTTP] {}
2022-05-10 11:24:54.666 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:24:54.666 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:24:54.667 [HTTP]
- GET /status 200 1 ms - 75 2022-05-10 11:24:54.667 [HTTP]
2022-05-10 11:24:55.472 [debug] [HTTP] Request idempotency key: fce2f120-9e22-426c-9eec-f6ae97d8994a
2022-05-10 11:24:55.494 [HTTP] -POST /session
2022-05-10 11:24:55.494 [HTTP] {"capabilities":{"firstMatch":[{}],"alwaysMatch":{"appium:ScaleFactor":2,"appium:automationName":"XCuiTest","appium:bundleId":"com.eight.ap-stage","appium:deviceName":"iPhone SE (2nd generation)","appium:forceAppLaunch":true,"appium:newCommandTimeout":0,"appium:noReset":true,"appium:platformVersion":"15.3.1","appium:realDevice":true,"appium:shouldTerminateApp":true,"appium:simpleIsVisibleCheck":true,"appium:skipDeviceDetect":true,"appium:udid":"00008030-001954993633402E","appium:useExternalWDA":true,"appium:usePrebuiltWDA":true,"appium:waitForQuiescence":false,"appium:webDriverAgentUrl":"http://localhost:54682","platformName":"ios"}}}
2022-05-10 11:24:55.494 [debug] [W3C] Calling AppiumDriver.createSession() with args: [null,null,{"firstMatch":[{}],"alwaysMatch":{"appium:ScaleFactor":2,"appium:automationName":"XCuiTest","appium:bundleId":"com.eight.ap-stage","appium:deviceName":"iPhone SE (2nd generation)","appium:forceAppLaunch":true,"appium:newCommandTimeout":0,"appium:noReset":true,"appium:platformVersion":"15.3.1","appium:realDevice":true,"appium:shouldTerminateApp":true,"appium:simpleIsVisibleCheck":true,"appium:skipDeviceDetect":true,"appium:udid":"00008030-001954993633402E","appium:useExternalWDA":true,"appium:usePrebuiltWDA":true,"appium:waitForQuiescence":false,"appium:webDriverAgentUrl":"http://localhost:54682","platformName":"ios"}}]
2022-05-10 11:24:55.497 [debug] [BaseDriver] Event 'newSessionRequested' logged at 1652171095494 (11:24:55 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:55.498 [Appium] Attempting to find matching driver for automationName 'XCuiTest' and platformName 'ios'
2022-05-10 11:24:55.498 [Appium] The 'xcuitest' driver was installed and matched caps.
2022-05-10 11:24:55.498 [Appium] Will require it at C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver
2022-05-10 11:24:55.499 [Appium] Appium v2.0.0-beta.18 creating new XCUITestDriver (v3.52.1-TP) session
2022-05-10 11:24:55.499 [Appium] Checking BaseDriver versions for Appium and XCUITestDriver
2022-05-10 11:24:55.499 [Appium] Appium's BaseDriver version is 8.1.1
2022-05-10 11:24:55.499 [Appium] Could not determine XCUITestDriver's BaseDriver version
2022-05-10 11:24:55.499 [debug] [Appium] There are no active sessions for cleanup
2022-05-10 11:24:55.501 [Appium] Explicitly enabling use of insecure features:
2022-05-10 11:24:55.501 [Appium] adb_shell
2022-05-10 11:24:55.501 [debug] [BaseDriver] Creating session with W3C capabilities: {
2022-05-10 11:24:55.501 [debug] [BaseDriver] "alwaysMatch": {
2022-05-10 11:24:55.502 [debug] [BaseDriver] "platformName": "ios",
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:ScaleFactor": 2,
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:automationName": "XCuiTest",
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:bundleId": "com.eight.ap-stage",
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:deviceName": "iPhone SE (2nd generation)",
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:forceAppLaunch": true,
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:newCommandTimeout": 0,
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:noReset": true,
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:platformVersion": "15.3.1",
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:realDevice": true,
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:shouldTerminateApp": true,
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:simpleIsVisibleCheck": true,
2022-05-10 11:24:55.502 [debug] [BaseDriver] "appium:skipDeviceDetect": true,
2022-05-10 11:24:55.503 [debug] [BaseDriver] "appium:udid": "00008030-001954993633402E",
2022-05-10 11:24:55.503 [debug] [BaseDriver] "appium:useExternalWDA": true,
2022-05-10 11:24:55.503 [debug] [BaseDriver] "appium:usePrebuiltWDA": true,
2022-05-10 11:24:55.503 [debug] [BaseDriver] "appium:waitForQuiescence": false,
2022-05-10 11:24:55.503 [debug] [BaseDriver] "appium:webDriverAgentUrl": "http://localhost:54682"
2022-05-10 11:24:55.503 [debug] [BaseDriver] },
2022-05-10 11:24:55.503 [debug] [BaseDriver] "firstMatch": [
2022-05-10 11:24:55.503 [debug] [BaseDriver] {}
2022-05-10 11:24:55.503 [debug] [BaseDriver] ]
2022-05-10 11:24:55.504 [debug] [BaseDriver] }
2022-05-10 11:24:55.511 [BaseDriver] The following capabilities were provided, but are not recognized by Appium:
2022-05-10 11:24:55.511 [BaseDriver] ScaleFactor
2022-05-10 11:24:55.512 [BaseDriver] realDevice
2022-05-10 11:24:55.514 [BaseDriver] Session created with session id: 7c3bec9b-2fee-4d3f-9c79-0aead7603830
2022-05-10 11:24:55.533 [debug] [XCUITest] Current user: 'logan\yiann'
2022-05-10 11:24:55.533 [XCUITest] Determining device to run tests on: udid: '00008030-001954993633402E', real device: true
2022-05-10 11:24:55.533 [XCUITest] Normalized platformVersion capability value '15.3.1' to '15.3'
2022-05-10 11:24:55.536 [debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1652171095536 (11:24:55 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:55.537 [debug] [BaseDriver] Event 'appConfigured' logged at 1652171095536 (11:24:55 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:55.537 [debug] [BaseDriver] Event 'resetStarted' logged at 1652171095537 (11:24:55 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:55.537 [debug] [XCUITest] Reset: fullReset not set. Leaving as is
2022-05-10 11:24:55.537 [debug] [BaseDriver] Event 'resetComplete' logged at 1652171095537 (11:24:55 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:55.537 [WebDriverAgent] Using WDA path: 'C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-webdriveragent'
2022-05-10 11:24:55.537 [WebDriverAgent] Using WDA agent: 'C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-webdriveragent\WebDriverAgent.xcodeproj'
2022-05-10 11:24:55.539 [XCUITest] Setting up real device
2022-05-10 11:24:55.540 [DevCon Factory] Requesting connection for device 00008030-001954993633402E on local port 54682
2022-05-10 11:24:55.541 [debug] [DevCon Factory] Cached connections count: 0
2022-05-10 11:24:55.541 [DevCon Factory] Successfully requested the connection for 00008030-001954993633402E:54682
2022-05-10 11:24:55.594 [WebDriverAgent] Cannot retrieve WDA build settings. Original error: spawn xcodebuild ENOENT
2022-05-10 11:24:55.596 [debug] [XCUITest] Starting WebDriverAgent initialization with the synchronization key 'XCUITestDriver'
2022-05-10 11:24:55.596 [debug] [XCUITest] Trying to start WebDriverAgent 1 times with 10000ms interval
2022-05-10 11:24:55.596 [debug] [XCUITest] These values can be customized by changing wdaStartupRetries/wdaStartupRetryInterval capabilities
2022-05-10 11:24:55.596 [debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1652171095596 (11:24:55 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:55.597 [WebDriverAgent] Using provided WebdriverAgent at 'http://localhost:54682'
2022-05-10 11:24:55.598 [debug] [WD Proxy] Matched '/status' to command name 'getStatus'
2022-05-10 11:24:55.599 [debug] [WD Proxy] Proxying [GET /status] to [GET http://localhost:54682/status] with no body
2022-05-10 11:24:55.616 [debug] [WD Proxy] Got response with status 200: {"value":{"message":"WebDriverAgent is ready to accept commands","state":"success","os":{"testmanagerdVersion":28,"name":"iOS","sdkVersion":"11.2","version":"15.3.1"},"ios":{"ip":"10.154.1.134"},"ready":true,"build":{"time":"Aug 25 2021 14:20:10","productBundleIdentifier":"com.facebook.WebDriverAgentRunner"}},"sessionId":"F3CE42FA-481D-48BD-864A-919C14928AD6"}
2022-05-10 11:24:55.616 [debug] [BaseDriver] Event 'wdaSessionAttempted' logged at 1652171095617 (11:24:55 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:55.617 [debug] [XCUITest] Sending createSession command to WDA
2022-05-10 11:24:55.617 [debug] [WD Proxy] Matched '/session' to command name 'createSession'
2022-05-10 11:24:55.618 [debug] [WD Proxy] Proxying [POST /session] to [POST http://localhost:54682/session] with body: {"capabilities":{"firstMatch":[{"bundleId":"com.eight.ap-stage","arguments":[],"environment":{},"eventloopIdleDelaySec":0,"shouldWaitForQuiescence":false,"shouldUseTestManagerForVisibilityDetection":true,"maxTypingFrequency":60,"shouldUseSingletonTestManager":true,"shouldTerminateApp":true,"forceAppLaunch":true,"useNativeCachingStrategy":true,"forceSimulatorSoftwareKeyboardPresence":true}],"alwaysMatch":{}}}
2022-05-10 11:24:57.121 [debug] [WD Proxy] Got response with status 200: {"value":{"sessionId":"A0A25355-6596-48A8-B161-1EBD6B00963D","capabilities":{"device":"iphone","browserName":"WeAre8","sdkVersion":"15.3.1","CFBundleIdentifier":"com.eight.ap-stage"}},"sessionId":"A0A25355-6596-48A8-B161-1EBD6B00963D"}
2022-05-10 11:24:57.121 [WD Proxy] Determined the downstream protocol as 'W3C'
2022-05-10 11:24:57.121 [debug] [BaseDriver] Event 'wdaSessionStarted' logged at 1652171097122 (11:24:57 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:57.121 [debug] [BaseDriver] Event 'wdaStarted' logged at 1652171097122 (11:24:57 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:57.122 [XCUITest] Skipping setting of the initial display orientation. Set the "orientation" capability to either "LANDSCAPE" or "PORTRAIT", if this is an undesired behavior.
2022-05-10 11:24:57.122 [debug] [BaseDriver] Event 'orientationSet' logged at 1652171097122 (11:24:57 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:57.122 [debug] [BaseDriver] The value of 'elementResponseAttributes' setting did not change. Skipping the update for it
2022-05-10 11:24:57.122 [debug] [BaseDriver] The value of 'shouldUseCompactResponses' setting did not change. Skipping the update for it
2022-05-10 11:24:57.122 [Appium] New XCUITestDriver session created successfully, session 7c3bec9b-2fee-4d3f-9c79-0aead7603830 added to master session list
2022-05-10 11:24:57.123 [debug] [BaseDriver] Event 'newSessionStarted' logged at 1652171097123 (11:24:57 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:24:57.123 [debug] [W3C (7c3bec9b)] Cached the protocol value 'W3C' for the new session 7c3bec9b-2fee-4d3f-9c79-0aead7603830
2022-05-10 11:24:57.123 [debug] [W3C (7c3bec9b)] Responding to client with driver.createSession() result: {"capabilities":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"platformName":"ios","ScaleFactor":2,"automationName":"XCuiTest","bundleId":"com.eight.ap-stage","deviceName":"iPhone SE (2nd generation)","forceAppLaunch":true,"newCommandTimeout":0,"noReset":true,"platformVersion":"15.3.1","realDevice":true,"shouldTerminateApp":true,"simpleIsVisibleCheck":true,"skipDeviceDetect":true,"udid":"00008030-001954993633402E","useExternalWDA":true,"usePrebuiltWDA":true,"waitForQuiescence":false,"webDriverAgentUrl":"http://localhost:54682"}}
2022-05-10 11:24:57.124 [HTTP]
- POST /session 200 1631 ms - 746 2022-05-10 11:24:57.125 [HTTP]
2022-05-10 11:24:57.196 [HTTP] -GET /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/window/rect
2022-05-10 11:24:57.196 [HTTP] {}
2022-05-10 11:24:57.201 [debug] [W3C (7c3bec9b)] Calling AppiumDriver.getWindowRect() with args: ["7c3bec9b-2fee-4d3f-9c79-0aead7603830"]
2022-05-10 11:24:57.201 [debug] [XCUITest] Executing command 'getWindowRect'
2022-05-10 11:24:57.211 [debug] [WD Proxy] Proxying [GET /window/size] to [GET http://localhost:54682/session/A0A25355-6596-48A8-B161-1EBD6B00963D/window/size] with no body
2022-05-10 11:24:57.261 [debug] [WD Proxy] Got response with status 200: {"value":{"width":375,"height":667},"sessionId":"A0A25355-6596-48A8-B161-1EBD6B00963D"}
2022-05-10 11:24:57.262 [debug] [W3C (7c3bec9b)] Responding to client with driver.getWindowRect() result: {"width":375,"height":667,"x":0,"y":0}
2022-05-10 11:24:57.262 [HTTP]
- GET /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/window/rect 200 66 ms - 48 2022-05-10 11:24:57.262 [HTTP]
2022-05-10 11:24:57.269 [HTTP] -POST /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/appium/device/app_state
2022-05-10 11:24:57.269 [HTTP] {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:24:57.273 [debug] [W3C (7c3bec9b)] Calling AppiumDriver.queryAppState() with args: ["com.eight.ap-stage","7c3bec9b-2fee-4d3f-9c79-0aead7603830"]
2022-05-10 11:24:57.273 [debug] [XCUITest] Executing command 'queryAppState'
2022-05-10 11:24:57.274 [debug] [WD Proxy] Proxying [POST /wda/apps/state] to [POST http://localhost:54682/session/A0A25355-6596-48A8-B161-1EBD6B00963D/wda/apps/state] with body: {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:24:57.280 [debug] [WD Proxy] Got response with status 200: {"value":4,"sessionId":"A0A25355-6596-48A8-B161-1EBD6B00963D"}
2022-05-10 11:24:57.280 [debug] [W3C (7c3bec9b)] Responding to client with driver.queryAppState() result: 4
2022-05-10 11:24:57.281 [HTTP]
- POST /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/appium/device/app_state 200 12 ms - 11 2022-05-10 11:24:57.281 [HTTP]
2022-05-10 11:24:57.287 [HTTP] -GET /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/window/rect
2022-05-10 11:24:57.287 [HTTP] {}
2022-05-10 11:24:57.289 [debug] [W3C (7c3bec9b)] Calling AppiumDriver.getWindowRect() with args: ["7c3bec9b-2fee-4d3f-9c79-0aead7603830"]
2022-05-10 11:24:57.289 [debug] [XCUITest] Executing command 'getWindowRect'
2022-05-10 11:24:57.290 [debug] [WD Proxy] Proxying [GET /window/size] to [GET http://localhost:54682/session/A0A25355-6596-48A8-B161-1EBD6B00963D/window/size] with no body
2022-05-10 11:24:57.351 [debug] [WD Proxy] Got response with status 200: {"value":{"width":375,"height":667},"sessionId":"A0A25355-6596-48A8-B161-1EBD6B00963D"}
2022-05-10 11:24:57.352 [debug] [W3C (7c3bec9b)] Responding to client with driver.getWindowRect() result: {"width":375,"height":667,"x":0,"y":0}
2022-05-10 11:24:57.352 [HTTP]
- GET /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/window/rect 200 66 ms - 48 2022-05-10 11:24:57.352 [HTTP]
2022-05-10 11:26:21.316 [HTTP] -GET /status
2022-05-10 11:26:21.316 [HTTP] {}
2022-05-10 11:26:21.316 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:26:21.316 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:26:21.317 [HTTP]
- GET /status 200 1 ms - 75 2022-05-10 11:26:21.318 [HTTP]
2022-05-10 11:28:53.388 [HTTP] -GET /status
2022-05-10 11:28:53.388 [HTTP] {}
2022-05-10 11:28:53.388 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:28:53.388 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:28:53.389 [HTTP]
- GET /status 200 1 ms - 75 2022-05-10 11:28:53.389 [HTTP]
2022-05-10 11:29:02.388 [HTTP] -GET /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/window/rect
2022-05-10 11:29:02.388 [HTTP] {}
2022-05-10 11:29:02.388 [debug] [W3C (7c3bec9b)] Calling AppiumDriver.getWindowRect() with args: ["7c3bec9b-2fee-4d3f-9c79-0aead7603830"]
2022-05-10 11:29:02.388 [debug] [XCUITest] Executing command 'getWindowRect'
2022-05-10 11:29:02.390 [debug] [WD Proxy] Proxying [GET /window/size] to [GET http://localhost:54682/session/A0A25355-6596-48A8-B161-1EBD6B00963D/window/size] with no body
2022-05-10 11:29:02.391 [WD Proxy] connect ECONNREFUSED 127.0.0.1:54682
2022-05-10 11:29:02.405 [debug] [W3C (7c3bec9b)] Encountered internal error running command: UnknownError: An unknown server-side error occurred while processing the command. Original error: Could not proxy command to the remote server. Original error: connect ECONNREFUSED 127.0.0.1:54682
2022-05-10 11:29:02.406 [debug] [W3C (7c3bec9b)] at JWProxy.command (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-base-driver\lib\jsonwp-proxy\proxy.js:274:13)
2022-05-10 11:29:02.406 [debug] [W3C (7c3bec9b)] at processTicksAndRejections (internal/process/task_queues.js:95:5)
2022-05-10 11:29:02.406 [debug] [W3C (7c3bec9b)] at XCUITestDriver.proxyCommand (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver\lib\commands\proxy-helper.js:96:12)
2022-05-10 11:29:02.406 [debug] [W3C (7c3bec9b)] at XCUITestDriver.getWindowSizeNative (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver\lib\commands\general.js:78:10)
2022-05-10 11:29:02.406 [debug] [W3C (7c3bec9b)] at XCUITestDriver.getWindowSize (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver\lib\commands\general.js:87:12)
2022-05-10 11:29:02.406 [debug] [W3C (7c3bec9b)] at XCUITestDriver.getWindowRect (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver\lib\commands\general.js:160:27)
2022-05-10 11:29:02.407 [HTTP]
- GET /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830/window/rect 500 18 ms - 1332 2022-05-10 11:29:02.407 [HTTP]
2022-05-10 11:29:02.413 [HTTP] -DELETE /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830
2022-05-10 11:29:02.413 [HTTP] {}
2022-05-10 11:29:02.413 [debug] [W3C (7c3bec9b)] Calling AppiumDriver.deleteSession() with args: ["7c3bec9b-2fee-4d3f-9c79-0aead7603830"]
2022-05-10 11:29:02.414 [debug] [BaseDriver] Event 'quitSessionRequested' logged at 1652171342414 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.414 [Appium] Removing session 7c3bec9b-2fee-4d3f-9c79-0aead7603830 from our master session list
2022-05-10 11:29:02.414 [debug] [WD Proxy] Matched '/session/7c3bec9b-2fee-4d3f-9c79-0aead7603830' to command name 'deleteSession'
2022-05-10 11:29:02.414 [debug] [WD Proxy] Proxying [DELETE /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830] to [DELETE http://localhost:54682/session/A0A25355-6596-48A8-B161-1EBD6B00963D] with no body
2022-05-10 11:29:02.416 [WD Proxy] connect ECONNREFUSED 127.0.0.1:54682
2022-05-10 11:29:02.416 [debug] [XCUITest] Unable to DELETE session on WDA: 'An unknown server-side error occurred while processing the command. Original error: Could not proxy command to the remote server. Original error: connect ECONNREFUSED 127.0.0.1:54682'. Continuing shutdown.
2022-05-10 11:29:02.416 [DevCon Factory] Releasing connections for 00008030-001954993633402E device on any port number
2022-05-10 11:29:02.416 [DevCon Factory] Found cached connections to release: ["00008030-001954993633402E:54682"]
2022-05-10 11:29:02.416 [debug] [DevCon Factory] Cached connections count: 0
2022-05-10 11:29:02.417 [debug] [BaseDriver] Event 'quitSessionFinished' logged at 1652171342417 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.417 [debug] [W3C (7c3bec9b)] Received response: null
2022-05-10 11:29:02.417 [debug] [W3C (7c3bec9b)] But deleting session, so not returning
2022-05-10 11:29:02.417 [debug] [W3C (7c3bec9b)] Responding to client with driver.deleteSession() result: null
2022-05-10 11:29:02.418 [HTTP]
- DELETE /session/7c3bec9b-2fee-4d3f-9c79-0aead7603830 200 5 ms - 14 2022-05-10 11:29:02.418 [HTTP]
2022-05-10 11:29:02.589 [HTTP] -GET /status
2022-05-10 11:29:02.590 [HTTP] {}
2022-05-10 11:29:02.590 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:29:02.590 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:29:02.590 [HTTP]
- GET /status 200 1 ms - 75 2022-05-10 11:29:02.590 [HTTP]
2022-05-10 11:29:02.596 [HTTP] -GET /status
2022-05-10 11:29:02.596 [HTTP] {}
2022-05-10 11:29:02.596 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:29:02.596 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:29:02.597 [HTTP]
- GET /status 200 1 ms - 75 2022-05-10 11:29:02.597 [HTTP]
2022-05-10 11:29:02.607 [debug] [HTTP] Request idempotency key: e34d0f0f-1dda-4c77-9065-d40cff13a535
2022-05-10 11:29:02.608 [HTTP] -POST /session
2022-05-10 11:29:02.608 [HTTP] {"capabilities":{"firstMatch":[{}],"alwaysMatch":{"appium:ScaleFactor":2,"appium:automationName":"XCuiTest","appium:bundleId":"com.eight.ap-stage","appium:deviceName":"iPhone SE (2nd generation)","appium:forceAppLaunch":true,"appium:newCommandTimeout":0,"appium:noReset":true,"appium:platformVersion":"15.3.1","appium:realDevice":true,"appium:shouldTerminateApp":true,"appium:simpleIsVisibleCheck":true,"appium:skipDeviceDetect":true,"appium:udid":"00008030-001954993633402E","appium:useExternalWDA":true,"appium:usePrebuiltWDA":true,"appium:waitForQuiescence":false,"appium:webDriverAgentUrl":"http://localhost:54920","platformName":"ios"}}}
2022-05-10 11:29:02.608 [debug] [W3C] Calling AppiumDriver.createSession() with args: [null,null,{"firstMatch":[{}],"alwaysMatch":{"appium:ScaleFactor":2,"appium:automationName":"XCuiTest","appium:bundleId":"com.eight.ap-stage","appium:deviceName":"iPhone SE (2nd generation)","appium:forceAppLaunch":true,"appium:newCommandTimeout":0,"appium:noReset":true,"appium:platformVersion":"15.3.1","appium:realDevice":true,"appium:shouldTerminateApp":true,"appium:simpleIsVisibleCheck":true,"appium:skipDeviceDetect":true,"appium:udid":"00008030-001954993633402E","appium:useExternalWDA":true,"appium:usePrebuiltWDA":true,"appium:waitForQuiescence":false,"appium:webDriverAgentUrl":"http://localhost:54920","platformName":"ios"}}]
2022-05-10 11:29:02.608 [debug] [BaseDriver] Event 'newSessionRequested' logged at 1652171342608 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.610 [Appium] Attempting to find matching driver for automationName 'XCuiTest' and platformName 'ios'
2022-05-10 11:29:02.610 [Appium] The 'xcuitest' driver was installed and matched caps.
2022-05-10 11:29:02.610 [Appium] Will require it at C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver
2022-05-10 11:29:02.610 [Appium] Appium v2.0.0-beta.18 creating new XCUITestDriver (v3.52.1-TP) session
2022-05-10 11:29:02.610 [Appium] Checking BaseDriver versions for Appium and XCUITestDriver
2022-05-10 11:29:02.610 [Appium] Appium's BaseDriver version is 8.1.1
2022-05-10 11:29:02.610 [Appium] Could not determine XCUITestDriver's BaseDriver version
2022-05-10 11:29:02.610 [debug] [Appium] There are no active sessions for cleanup
2022-05-10 11:29:02.611 [Appium] Explicitly enabling use of insecure features:
2022-05-10 11:29:02.611 [Appium] adb_shell
2022-05-10 11:29:02.611 [debug] [BaseDriver] Creating session with W3C capabilities: {
2022-05-10 11:29:02.611 [debug] [BaseDriver] "alwaysMatch": {
2022-05-10 11:29:02.611 [debug] [BaseDriver] "platformName": "ios",
2022-05-10 11:29:02.611 [debug] [BaseDriver] "appium:ScaleFactor": 2,
2022-05-10 11:29:02.611 [debug] [BaseDriver] "appium:automationName": "XCuiTest",
2022-05-10 11:29:02.611 [debug] [BaseDriver] "appium:bundleId": "com.eight.ap-stage",
2022-05-10 11:29:02.611 [debug] [BaseDriver] "appium:deviceName": "iPhone SE (2nd generation)",
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:forceAppLaunch": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:newCommandTimeout": 0,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:noReset": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:platformVersion": "15.3.1",
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:realDevice": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:shouldTerminateApp": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:simpleIsVisibleCheck": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:skipDeviceDetect": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:udid": "00008030-001954993633402E",
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:useExternalWDA": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:usePrebuiltWDA": true,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:waitForQuiescence": false,
2022-05-10 11:29:02.612 [debug] [BaseDriver] "appium:webDriverAgentUrl": "http://localhost:54920"
2022-05-10 11:29:02.612 [debug] [BaseDriver] },
2022-05-10 11:29:02.612 [debug] [BaseDriver] "firstMatch": [
2022-05-10 11:29:02.612 [debug] [BaseDriver] {}
2022-05-10 11:29:02.612 [debug] [BaseDriver] ]
2022-05-10 11:29:02.612 [debug] [BaseDriver] }
2022-05-10 11:29:02.617 [BaseDriver] The following capabilities were provided, but are not recognized by Appium:
2022-05-10 11:29:02.617 [BaseDriver] ScaleFactor
2022-05-10 11:29:02.617 [BaseDriver] realDevice
2022-05-10 11:29:02.617 [BaseDriver] Session created with session id: 9ccb3750-e5b7-4fa5-b3b2-783c21450bbc
2022-05-10 11:29:02.627 [debug] [XCUITest] Current user: 'logan\yiann'
2022-05-10 11:29:02.628 [XCUITest] Determining device to run tests on: udid: '00008030-001954993633402E', real device: true
2022-05-10 11:29:02.628 [XCUITest] Normalized platformVersion capability value '15.3.1' to '15.3'
2022-05-10 11:29:02.628 [debug] [BaseDriver] Event 'xcodeDetailsRetrieved' logged at 1652171342628 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.628 [debug] [BaseDriver] Event 'appConfigured' logged at 1652171342628 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.628 [debug] [BaseDriver] Event 'resetStarted' logged at 1652171342628 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.628 [debug] [XCUITest] Reset: fullReset not set. Leaving as is
2022-05-10 11:29:02.628 [debug] [BaseDriver] Event 'resetComplete' logged at 1652171342628 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.628 [WebDriverAgent] Using WDA path: 'C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-webdriveragent'
2022-05-10 11:29:02.629 [WebDriverAgent] Using WDA agent: 'C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-webdriveragent\WebDriverAgent.xcodeproj'
2022-05-10 11:29:02.630 [XCUITest] Setting up real device
2022-05-10 11:29:02.630 [DevCon Factory] Requesting connection for device 00008030-001954993633402E on local port 54920
2022-05-10 11:29:02.630 [debug] [DevCon Factory] Cached connections count: 0
2022-05-10 11:29:02.630 [DevCon Factory] Successfully requested the connection for 00008030-001954993633402E:54920
2022-05-10 11:29:02.633 [WebDriverAgent] Cannot retrieve WDA build settings. Original error: spawn xcodebuild ENOENT
2022-05-10 11:29:02.633 [debug] [XCUITest] Starting WebDriverAgent initialization with the synchronization key 'XCUITestDriver'
2022-05-10 11:29:02.633 [debug] [XCUITest] Trying to start WebDriverAgent 1 times with 10000ms interval
2022-05-10 11:29:02.633 [debug] [XCUITest] These values can be customized by changing wdaStartupRetries/wdaStartupRetryInterval capabilities
2022-05-10 11:29:02.633 [debug] [BaseDriver] Event 'wdaStartAttempted' logged at 1652171342633 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.633 [WebDriverAgent] Using provided WebdriverAgent at 'http://localhost:54920'
2022-05-10 11:29:02.633 [debug] [WD Proxy] Matched '/status' to command name 'getStatus'
2022-05-10 11:29:02.634 [debug] [WD Proxy] Proxying [GET /status] to [GET http://localhost:54920/status] with no body
2022-05-10 11:29:02.681 [debug] [WD Proxy] Got response with status 200: {"value":{"message":"WebDriverAgent is ready to accept commands","state":"success","os":{"testmanagerdVersion":28,"name":"iOS","sdkVersion":"11.2","version":"15.3.1"},"ios":{"ip":"10.154.1.134"},"ready":true,"build":{"time":"Aug 25 2021 14:20:10","productBundleIdentifier":"com.facebook.WebDriverAgentRunner"}},"sessionId":"E45DC546-9520-4615-AEBA-A650675103E5"}
2022-05-10 11:29:02.681 [debug] [BaseDriver] Event 'wdaSessionAttempted' logged at 1652171342681 (11:29:02 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:02.681 [debug] [XCUITest] Sending createSession command to WDA
2022-05-10 11:29:02.681 [debug] [WD Proxy] Matched '/session' to command name 'createSession'
2022-05-10 11:29:02.681 [debug] [WD Proxy] Proxying [POST /session] to [POST http://localhost:54920/session] with body: {"capabilities":{"firstMatch":[{"bundleId":"com.eight.ap-stage","arguments":[],"environment":{},"eventloopIdleDelaySec":0,"shouldWaitForQuiescence":false,"shouldUseTestManagerForVisibilityDetection":true,"maxTypingFrequency":60,"shouldUseSingletonTestManager":true,"shouldTerminateApp":true,"forceAppLaunch":true,"useNativeCachingStrategy":true,"forceSimulatorSoftwareKeyboardPresence":true}],"alwaysMatch":{}}}
2022-05-10 11:29:03.924 [debug] [WD Proxy] Got response with status 200: {"value":{"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35","capabilities":{"device":"iphone","browserName":"WeAre8","sdkVersion":"15.3.1","CFBundleIdentifier":"com.eight.ap-stage"}},"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:03.925 [WD Proxy] Determined the downstream protocol as 'W3C'
2022-05-10 11:29:03.925 [debug] [BaseDriver] Event 'wdaSessionStarted' logged at 1652171343925 (11:29:03 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:03.925 [debug] [BaseDriver] Event 'wdaStarted' logged at 1652171343925 (11:29:03 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:03.925 [XCUITest] Skipping setting of the initial display orientation. Set the "orientation" capability to either "LANDSCAPE" or "PORTRAIT", if this is an undesired behavior.
2022-05-10 11:29:03.925 [debug] [BaseDriver] Event 'orientationSet' logged at 1652171343925 (11:29:03 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:03.925 [debug] [BaseDriver] The value of 'elementResponseAttributes' setting did not change. Skipping the update for it
2022-05-10 11:29:03.925 [debug] [BaseDriver] The value of 'shouldUseCompactResponses' setting did not change. Skipping the update for it
2022-05-10 11:29:03.925 [Appium] New XCUITestDriver session created successfully, session 9ccb3750-e5b7-4fa5-b3b2-783c21450bbc added to master session list
2022-05-10 11:29:03.925 [debug] [BaseDriver] Event 'newSessionStarted' logged at 1652171343926 (11:29:03 GMT+0300 (Eastern European Summer Time))
2022-05-10 11:29:03.925 [debug] [W3C (9ccb3750)] Cached the protocol value 'W3C' for the new session 9ccb3750-e5b7-4fa5-b3b2-783c21450bbc
2022-05-10 11:29:03.926 [debug] [W3C (9ccb3750)] Responding to client with driver.createSession() result: {"capabilities":{"webStorageEnabled":false,"locationContextEnabled":false,"browserName":"","platform":"MAC","javascriptEnabled":true,"databaseEnabled":false,"takesScreenshot":true,"networkConnectionEnabled":false,"platformName":"ios","ScaleFactor":2,"automationName":"XCuiTest","bundleId":"com.eight.ap-stage","deviceName":"iPhone SE (2nd generation)","forceAppLaunch":true,"newCommandTimeout":0,"noReset":true,"platformVersion":"15.3.1","realDevice":true,"shouldTerminateApp":true,"simpleIsVisibleCheck":true,"skipDeviceDetect":true,"udid":"00008030-001954993633402E","useExternalWDA":true,"usePrebuiltWDA":true,"waitForQuiescence":false,"webDriverAgentUrl":"http://localhost:54920"}}
2022-05-10 11:29:03.926 [HTTP]
- POST /session 200 1319 ms - 746 2022-05-10 11:29:03.926 [HTTP]
2022-05-10 11:29:03.947 [HTTP] -GET /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/window/rect
2022-05-10 11:29:03.947 [HTTP] {}
2022-05-10 11:29:03.948 [debug] [W3C (9ccb3750)] Calling AppiumDriver.getWindowRect() with args: ["9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:03.948 [debug] [XCUITest] Executing command 'getWindowRect'
2022-05-10 11:29:03.950 [debug] [WD Proxy] Proxying [GET /window/size] to [GET http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/window/size] with no body
2022-05-10 11:29:03.985 [debug] [WD Proxy] Got response with status 200: {"value":{"width":375,"height":667},"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:03.986 [debug] [W3C (9ccb3750)] Responding to client with driver.getWindowRect() result: {"width":375,"height":667,"x":0,"y":0}
2022-05-10 11:29:03.986 [HTTP]
- GET /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/window/rect 200 39 ms - 48 2022-05-10 11:29:03.987 [HTTP]
2022-05-10 11:29:03.990 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/appium/device/app_state
2022-05-10 11:29:03.990 [HTTP] {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:29:03.990 [debug] [W3C (9ccb3750)] Calling AppiumDriver.queryAppState() with args: ["com.eight.ap-stage","9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:03.990 [debug] [XCUITest] Executing command 'queryAppState'
2022-05-10 11:29:03.991 [debug] [WD Proxy] Proxying [POST /wda/apps/state] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/wda/apps/state] with body: {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:29:04.003 [debug] [WD Proxy] Got response with status 200: {"value":4,"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:04.003 [debug] [W3C (9ccb3750)] Responding to client with driver.queryAppState() result: 4
2022-05-10 11:29:04.004 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/appium/device/app_state 200 14 ms - 11 2022-05-10 11:29:04.004 [HTTP]
2022-05-10 11:29:04.006 [HTTP] -GET /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/window/rect
2022-05-10 11:29:04.006 [HTTP] {}
2022-05-10 11:29:04.007 [debug] [W3C (9ccb3750)] Calling AppiumDriver.getWindowRect() with args: ["9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:04.007 [debug] [XCUITest] Executing command 'getWindowRect'
2022-05-10 11:29:04.008 [debug] [WD Proxy] Proxying [GET /window/size] to [GET http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/window/size] with no body
2022-05-10 11:29:04.070 [debug] [WD Proxy] Got response with status 200: {"value":{"width":375,"height":667},"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:04.070 [debug] [W3C (9ccb3750)] Responding to client with driver.getWindowRect() result: {"width":375,"height":667,"x":0,"y":0}
2022-05-10 11:29:04.071 [HTTP]
- GET /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/window/rect 200 64 ms - 48 2022-05-10 11:29:04.071 [HTTP]
2022-05-10 11:29:11.434 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts
2022-05-10 11:29:11.434 [HTTP] {"implicit":15000}
2022-05-10 11:29:11.434 [debug] [W3C (9ccb3750)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,15000,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:11.434 [debug] [XCUITest] Executing command 'timeouts'
2022-05-10 11:29:11.435 [debug] [BaseDriver] W3C timeout argument: {"implicit":15000}}
2022-05-10 11:29:11.435 [debug] [BaseDriver] Set implicit wait to 15000ms
2022-05-10 11:29:11.435 [debug] [W3C (9ccb3750)] Responding to client with driver.timeouts() result: null
2022-05-10 11:29:11.436 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts 200 2 ms - 14 2022-05-10 11:29:11.436 [HTTP]
2022-05-10 11:29:11.439 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/appium/device/terminate_app
2022-05-10 11:29:11.439 [HTTP] {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:29:11.440 [debug] [W3C (9ccb3750)] Calling AppiumDriver.terminateApp() with args: ["com.eight.ap-stage",null,null,null,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:11.440 [debug] [XCUITest] Executing command 'terminateApp'
2022-05-10 11:29:11.441 [debug] [WD Proxy] Proxying [POST /wda/apps/terminate] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/wda/apps/terminate] with body: {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:29:11.448 [debug] [WD Proxy] Got response with status 200: {"value":false,"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:11.449 [debug] [W3C (9ccb3750)] Responding to client with driver.terminateApp() result: false
2022-05-10 11:29:11.450 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/appium/device/terminate_app 200 9 ms - 15 2022-05-10 11:29:11.450 [HTTP]
2022-05-10 11:29:11.452 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/appium/device/activate_app
2022-05-10 11:29:11.452 [HTTP] {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:29:11.452 [debug] [W3C (9ccb3750)] Calling AppiumDriver.activateApp() with args: ["com.eight.ap-stage",null,null,null,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:11.452 [debug] [XCUITest] Executing command 'activateApp'
2022-05-10 11:29:11.453 [debug] [WD Proxy] Proxying [POST /wda/apps/launch] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/wda/apps/launch] with body: {"bundleId":"com.eight.ap-stage"}
2022-05-10 11:29:12.680 [debug] [WD Proxy] Got response with status 200: {"value":null,"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:12.680 [debug] [W3C (9ccb3750)] Responding to client with driver.activateApp() result: null
2022-05-10 11:29:12.681 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/appium/device/activate_app 200 1230 ms - 14 2022-05-10 11:29:12.681 [HTTP]
2022-05-10 11:29:12.693 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts
2022-05-10 11:29:12.694 [HTTP] {"implicit":0}
2022-05-10 11:29:12.694 [debug] [W3C (9ccb3750)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,0,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:12.694 [debug] [XCUITest] Executing command 'timeouts'
2022-05-10 11:29:12.694 [debug] [BaseDriver] W3C timeout argument: {"implicit":0}}
2022-05-10 11:29:12.694 [debug] [BaseDriver] Set implicit wait to 0ms
2022-05-10 11:29:12.694 [debug] [W3C (9ccb3750)] Responding to client with driver.timeouts() result: null
2022-05-10 11:29:12.695 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts 200 1 ms - 14 2022-05-10 11:29:12.695 [HTTP]
2022-05-10 11:29:14.454 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts
2022-05-10 11:29:14.455 [HTTP] {"implicit":15000}
2022-05-10 11:29:14.455 [debug] [W3C (9ccb3750)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,15000,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:14.455 [debug] [XCUITest] Executing command 'timeouts'
2022-05-10 11:29:14.455 [debug] [BaseDriver] W3C timeout argument: {"implicit":15000}}
2022-05-10 11:29:14.455 [debug] [BaseDriver] Set implicit wait to 15000ms
2022-05-10 11:29:14.455 [debug] [W3C (9ccb3750)] Responding to client with driver.timeouts() result: null
2022-05-10 11:29:14.456 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts 200 1 ms - 14 2022-05-10 11:29:14.456 [HTTP]
2022-05-10 11:29:14.967 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts
2022-05-10 11:29:14.967 [HTTP] {"implicit":15000}
2022-05-10 11:29:14.967 [debug] [W3C (9ccb3750)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,15000,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:14.967 [debug] [XCUITest] Executing command 'timeouts'
2022-05-10 11:29:14.967 [debug] [BaseDriver] W3C timeout argument: {"implicit":15000}}
2022-05-10 11:29:14.968 [debug] [BaseDriver] Set implicit wait to 15000ms
2022-05-10 11:29:14.968 [debug] [W3C (9ccb3750)] Responding to client with driver.timeouts() result: null
2022-05-10 11:29:14.969 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts 200 2 ms - 14 2022-05-10 11:29:14.969 [HTTP]
2022-05-10 11:29:14.978 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/elements
2022-05-10 11:29:14.978 [HTTP] {"using":"-ios predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:14.979 [debug] [W3C (9ccb3750)] Calling AppiumDriver.findElements() with args: ["-ios predicate string","type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1","9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:14.979 [debug] [XCUITest] Executing command 'findElements'
2022-05-10 11:29:14.979 [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id, css selector
2022-05-10 11:29:14.979 [debug] [BaseDriver] Waiting up to 15000 ms for condition
2022-05-10 11:29:14.980 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:14.980 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:15.188 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:15.188 [debug] [BaseDriver] Waited for 209 ms so far
2022-05-10 11:29:15.692 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:15.692 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:15.831 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:15.831 [debug] [BaseDriver] Waited for 852 ms so far
2022-05-10 11:29:16.341 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:16.341 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:16.488 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:16.488 [debug] [BaseDriver] Waited for 1510 ms so far
2022-05-10 11:29:16.998 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:16.999 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:17.155 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:17.155 [debug] [BaseDriver] Waited for 2177 ms so far
2022-05-10 11:29:17.671 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:17.671 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:17.808 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:17.808 [debug] [BaseDriver] Waited for 2830 ms so far
2022-05-10 11:29:18.321 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:18.322 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:18.459 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:18.459 [debug] [BaseDriver] Waited for 3480 ms so far
2022-05-10 11:29:18.969 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:18.970 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:19.114 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:19.114 [debug] [BaseDriver] Waited for 4135 ms so far
2022-05-10 11:29:19.629 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:19.629 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:19.778 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:19.779 [debug] [BaseDriver] Waited for 4800 ms so far
2022-05-10 11:29:20.295 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:20.295 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:20.459 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:20.459 [debug] [BaseDriver] Waited for 5480 ms so far
2022-05-10 11:29:20.967 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:20.967 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:21.107 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:21.107 [debug] [BaseDriver] Waited for 6129 ms so far
2022-05-10 11:29:21.618 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:21.619 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:21.762 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:21.762 [debug] [BaseDriver] Waited for 6783 ms so far
2022-05-10 11:29:22.269 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:22.269 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:22.440 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:22.440 [debug] [BaseDriver] Waited for 7461 ms so far
2022-05-10 11:29:22.953 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:22.954 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:23.095 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:23.095 [debug] [BaseDriver] Waited for 8116 ms so far
2022-05-10 11:29:23.608 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:23.609 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:23.755 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:23.755 [debug] [BaseDriver] Waited for 8777 ms so far
2022-05-10 11:29:24.262 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:24.263 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:24.768 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:24.768 [debug] [BaseDriver] Waited for 9790 ms so far
2022-05-10 11:29:25.276 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:25.277 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:25.447 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:25.447 [debug] [BaseDriver] Waited for 10468 ms so far
2022-05-10 11:29:25.961 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:25.962 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:26.588 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:26.589 [debug] [BaseDriver] Waited for 11610 ms so far
2022-05-10 11:29:27.100 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:27.100 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:27.153 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:27.153 [debug] [BaseDriver] Waited for 12174 ms so far
2022-05-10 11:29:27.660 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:27.661 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:27.866 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:27.866 [debug] [BaseDriver] Waited for 12887 ms so far
2022-05-10 11:29:28.379 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:28.379 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:28.442 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:28.442 [debug] [BaseDriver] Waited for 13463 ms so far
2022-05-10 11:29:28.957 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:28.957 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:29.291 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:29.291 [debug] [BaseDriver] Waited for 14312 ms so far
2022-05-10 11:29:29.797 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:29.798 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:29.865 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:29.865 [debug] [BaseDriver] Waited for 14886 ms so far
2022-05-10 11:29:29.988 [debug] [WD Proxy] Matched '/elements' to command name 'findElements'
2022-05-10 11:29:29.988 [debug] [WD Proxy] Proxying [POST /elements] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/elements] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:30.047 [debug] [WD Proxy] Got response with status 200: {"value":[],"sessionId":"29F212B8-0451-4C54-A966-8D7FE95F2A35"}
2022-05-10 11:29:30.047 [debug] [W3C (9ccb3750)] Responding to client with driver.findElements() result: []
2022-05-10 11:29:30.048 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/elements 200 15070 ms - 12 2022-05-10 11:29:30.048 [HTTP]
2022-05-10 11:29:30.054 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts
2022-05-10 11:29:30.054 [HTTP] {"implicit":0}
2022-05-10 11:29:30.054 [debug] [W3C (9ccb3750)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,0,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:30.055 [debug] [XCUITest] Executing command 'timeouts'
2022-05-10 11:29:30.055 [debug] [BaseDriver] W3C timeout argument: {"implicit":0}}
2022-05-10 11:29:30.055 [debug] [BaseDriver] Set implicit wait to 0ms
2022-05-10 11:29:30.055 [debug] [W3C (9ccb3750)] Responding to client with driver.timeouts() result: null
2022-05-10 11:29:30.056 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts 200 1 ms - 14 2022-05-10 11:29:30.056 [HTTP]
2022-05-10 11:29:30.059 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/element
2022-05-10 11:29:30.059 [HTTP] {"using":"-ios predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:30.059 [debug] [W3C (9ccb3750)] Calling AppiumDriver.findElement() with args: ["-ios predicate string","type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1","9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:30.059 [debug] [XCUITest] Executing command 'findElement'
2022-05-10 11:29:30.060 [debug] [BaseDriver] Valid locator strategies for this request: xpath, id, name, class name, -ios predicate string, -ios class chain, accessibility id, css selector
2022-05-10 11:29:30.060 [debug] [BaseDriver] Waiting up to 0 ms for condition
2022-05-10 11:29:30.060 [debug] [WD Proxy] Matched '/element' to command name 'findElement'
2022-05-10 11:29:30.060 [debug] [WD Proxy] Proxying [POST /element] to [POST http://localhost:54920/session/29F212B8-0451-4C54-A966-8D7FE95F2A35/element] with body: {"using":"predicate string","value":"type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1"}
2022-05-10 11:29:30.144 [WD Proxy] Got response with status 404: {"value":{"error":"no such element","message":"unable to find an element using 'predicate string', value 'type == 'XCUIElementTypeStaticText' AND label == 'Log in' AND visible == 1'","traceback":"(\n\t0 WebDriverAgentLib 0x000000010b2bbe88 FBNoSuchElementErrorResponseForRequest + 252\n\t1 WebDriverAgentLib 0x000000010b2bbd48 +[FBFindElementCommands handleFindElement:] + 452\n\t2 WebDriverAgentLib 0x000000010b29632c -[FBRoute_TargetAction mountRequest:intoResponse:] + 132\n\t3 WebDriverAgentLib 0x000000010b28777c __37-[FBWebServer registerRouteHandlers:]_block_invoke + 364\n\t4 WebDriverAgentLib 0x000000010b2aa570 -[RoutingHTTPServer handleRoute:withRequest:response:] + 156\n\t5 WebDriverAgentLib 0x000000010b2aadd8 __72-[RoutingHTTPServer routeMethod:withPath:parameters:request:connection:]_block_invoke + 44\n\t6 libdispatch.dylib 0x00000001811cb670 BD02A625-8475-3FD6-8...
2022-05-10 11:29:30.145 [debug] [W3C] Matched W3C error code 'no such element' to NoSuchElementError
2022-05-10 11:29:30.150 [debug] [W3C (9ccb3750)] Encountered internal error running command: NoSuchElementError: An element could not be located on the page using the given search parameters.
2022-05-10 11:29:30.150 [debug] [W3C (9ccb3750)] at XCUITestDriver.doNativeFind (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver\lib\commands\find.js:130:11)
2022-05-10 11:29:30.150 [debug] [W3C (9ccb3750)] at processTicksAndRejections (internal/process/task_queues.js:95:5)
2022-05-10 11:29:30.150 [debug] [W3C (9ccb3750)] at XCUITestDriver.findNativeElementOrElements (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver\lib\commands\find.js:90:10)
2022-05-10 11:29:30.150 [debug] [W3C (9ccb3750)] at XCUITestDriver.findElOrEls (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-xcuitest-driver\lib\commands\find.js:23:12)
2022-05-10 11:29:30.150 [debug] [W3C (9ccb3750)] at XCUITestDriver.findElOrElsWithProcessing (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-base-driver\lib\basedriver\commands\find.js:33:12)
2022-05-10 11:29:30.151 [debug] [W3C (9ccb3750)] at XCUITestDriver.findElement (C:\snapshot\appium\drivers\appium-xcuitest-driver\node_modules\appium-base-driver\lib\basedriver\commands\find.js:53:10)
2022-05-10 11:29:30.151 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/element 404 91 ms - 1158 2022-05-10 11:29:30.151 [HTTP]
2022-05-10 11:29:30.157 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts
2022-05-10 11:29:30.157 [HTTP] {"implicit":15000}
2022-05-10 11:29:30.158 [debug] [W3C (9ccb3750)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,15000,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:30.158 [debug] [XCUITest] Executing command 'timeouts'
2022-05-10 11:29:30.158 [debug] [BaseDriver] W3C timeout argument: {"implicit":15000}}
2022-05-10 11:29:30.158 [debug] [BaseDriver] Set implicit wait to 15000ms
2022-05-10 11:29:30.158 [debug] [W3C (9ccb3750)] Responding to client with driver.timeouts() result: null
2022-05-10 11:29:30.159 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts 200 1 ms - 14 2022-05-10 11:29:30.159 [HTTP]
2022-05-10 11:29:30.175 [HTTP] -POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts
2022-05-10 11:29:30.175 [HTTP] {"implicit":0}
2022-05-10 11:29:30.175 [debug] [W3C (9ccb3750)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,0,"9ccb3750-e5b7-4fa5-b3b2-783c21450bbc"]
2022-05-10 11:29:30.175 [debug] [XCUITest] Executing command 'timeouts'
2022-05-10 11:29:30.176 [debug] [BaseDriver] W3C timeout argument: {"implicit":0}}
2022-05-10 11:29:30.176 [debug] [BaseDriver] Set implicit wait to 0ms
2022-05-10 11:29:30.176 [debug] [W3C (9ccb3750)] Responding to client with driver.timeouts() result: null
2022-05-10 11:29:30.177 [HTTP]
- POST /session/9ccb3750-e5b7-4fa5-b3b2-783c21450bbc/timeouts 200 2 ms - 14 2022-05-10 11:29:30.177 [HTTP]
2022-05-10 11:32:06.269 [HTTP] -GET /status
2022-05-10 11:32:06.269 [HTTP] {}
2022-05-10 11:32:06.269 [debug] [GENERIC] Calling AppiumDriver.getStatus() with args: []
2022-05-10 11:32:06.270 [debug] [GENERIC] Responding to client with driver.getStatus() result: {"build":{"version":"2.0.0-beta.18"}}
2022-05-10 11:32:06.271 [HTTP]
- GET /status 200 1 ms - 75 2022-05-10 11:32:06.271 [HTTP]

Edit
Pub: 10 May 2022 10:15 UTC
Views: 55