search

AppiumTestDistribution / appium-device-farm

This is an Appium 2.0 plugin designed to manage and create driver sessions on available devices.
https://devicefarm.org
Apache License 2.0
292 stars 90 forks source link

Unable to peform actions on remote device #1208

Closed SubbuLomada closed 1 week ago

SubbuLomada commented 1 week ago

Hi Team,

While trying to perform actions on android device manually while streaming it's giving error

Create a GIST which is a paste of your full Appium logs, and link them here. Do NOT paste your full Appium logs here, as it will make this issue very long and hard to read! If you are reporting a bug, always include Appium logs!

Environment

  1. Appium version (or git revision) that exhibits the issue: 2.10.3
  2. Last Appium version that did not exhibit the issue (if applicable):
  3. Node.js version (unless using Appium.app|exe):20.x
  4. Npm or Yarn package manager:
  5. Mobile platform/version under test: 14
  6. Real device or emulator/simulator: real device
  7. Appium CLI or Appium.app|exe:appium CLI
  8. Appium device farm version: 8.4.7-rc.45
saikrishna321 commented 1 week ago

@SubbuLomada Please provide steps you have tried and also full server logs.

sudharsan-selvaraj commented 1 week ago

@SubbuLomada it would be also great if you can share the version of appium and uiautomator2 driver that you are using? Also share the full server log/screenshots of the browser during manual interactions for us to debug the issue better.

I could see the below errors from the issue description, but eventually need additional data to further rootcause.

[device-farm-main] Proxying request to appium {"method":"post","url":"http://127.0.0.1:4723/wd/hub/session/7a8b2836-0cf7-4aab-b83c-646f343cc586/actions","timeout":60000,"headers":{"Content-Type":"application/json"},"data":{"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]}}
[HTTP] --> POST /wd/hub/session/7a8b2836-0cf7-4aab-b83c-646f343cc586/actions
[HTTP] {"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]}
[device-farm-main] Updating lastCmdExecutedAt for device RZCW9010000 in session 7a8b2836-0cf7-4aab-b83c-646f343cc586
[AndroidUiautomator2Driver@78ff (7a8b2836)] Calling AppiumDriver.performActions() with args: [[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}],"7a8b2836-0cf7-4aab-b83c-646f343cc586"]
[AppiumDriver@f86a] Clearing new command timeout pre-emptively since plugin(s) will handle this command
[AppiumDriver@f86a] Plugins which can handle cmd 'performActions': device-farm
[AppiumDriver@f86a] Plugin device-farm is now handling cmd 'performActions'
[AppiumDriver@f86a] Executing default handling behavior for command 'performActions'
[AndroidUiautomator2Driver@78ff (7a8b2836)] Preprocessed actions: [
[AndroidUiautomator2Driver@78ff (7a8b2836)]   {
[AndroidUiautomator2Driver@78ff (7a8b2836)]     "type": "pointer",
[AndroidUiautomator2Driver@78ff (7a8b2836)]     "id": "finger1",
[AndroidUiautomator2Driver@78ff (7a8b2836)]     "parameters": {
[AndroidUiautomator2Driver@78ff (7a8b2836)]       "pointerType": "touch"
[AndroidUiautomator2Driver@78ff (7a8b2836)]     },
[AndroidUiautomator2Driver@78ff (7a8b2836)]     "actions": [
[AndroidUiautomator2Driver@78ff (7a8b2836)]       {
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "type": "pointerMove",
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "duration": 0,
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "x": null,
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "y": null
[AndroidUiautomator2Driver@78ff (7a8b2836)]       },
[AndroidUiautomator2Driver@78ff (7a8b2836)]       {
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "type": "pointerDown",
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "button": 0
[AndroidUiautomator2Driver@78ff (7a8b2836)]       },
[AndroidUiautomator2Driver@78ff (7a8b2836)]       {
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "type": "pause",
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "duration": 0
[AndroidUiautomator2Driver@78ff (7a8b2836)]       },
[AndroidUiautomator2Driver@78ff (7a8b2836)]       {
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "type": "pointerMove",
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "duration": 100,
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "origin": "viewport",
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "x": null,
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "y": null
[AndroidUiautomator2Driver@78ff (7a8b2836)]       },
[AndroidUiautomator2Driver@78ff (7a8b2836)]       {
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "type": "pointerUp",
[AndroidUiautomator2Driver@78ff (7a8b2836)]         "button": 0
[AndroidUiautomator2Driver@78ff (7a8b2836)]       }
[AndroidUiautomator2Driver@78ff (7a8b2836)]     ]
[AndroidUiautomator2Driver@78ff (7a8b2836)]   }
[AndroidUiautomator2Driver@78ff (7a8b2836)] ]
[AndroidUiautomator2Driver@78ff (7a8b2836)] Matched '/actions' to command name 'performActions'
[AndroidUiautomator2Driver@78ff (7a8b2836)] Proxying [POST /actions] to [POST http://127.0.0.1:60699/session/bd9649ad-cc9b-458b-a5f1-705ab922a818/actions] with body: {"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]}
[device-farm-main] Updating lastCmdExecutedAt for device RZCW9010000 in session 7a8b2836-0cf7-4aab-b83c-646f343cc586
[AndroidUiautomator2Driver@78ff (7a8b2836)] Got response with status 400: {"sessionId":"bd9649ad-cc9b-458b-a5f1-705ab922a818","value":{"error":"invalid argument","message":"Both coordinates must be be set for action item 'pointerMove' #1 of action 'finger1'","stacktrace":"io.appium.uiautomator2.utils.w3c.ActionsParseException: Both coordinates must be be set for action item 'pointerMove' #1 of action 'finger1'\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:277)\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:260)\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.applyPointerActionToEventsMapping(ActionsTokenizer.java:452)\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.tokenize(ActionsTokenizer.java:574)\n\tat io.appium.uiautomator2.handler.W3CActions.safeHandle(W3CActions.java:78)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:59)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:259)\n\...
[W3C] Matched W3C error code 'invalid argument' to InvalidArgumentError
[AndroidUiautomator2Driver@78ff (7a8b2836)] Encountered internal error running command: io.appium.uiautomator2.utils.w3c.ActionsParseException: Both coordinates must be be set for action item 'pointerMove' #1 of action 'finger1'
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:277)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:260)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.applyPointerActionToEventsMapping(ActionsTokenizer.java:452)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.tokenize(ActionsTokenizer.java:574)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.handler.W3CActions.safeHandle(W3CActions.java:78)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:59)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:259)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:253)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:77)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.handler.codec.MessageToMessageDecoder.channelRead(MessageToMessageDecoder.java:102)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.CombinedChannelDuplexHandler$DelegatingChannelHandlerContext.fireChannelRead(CombinedChannelDuplexHandler.java:435)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:293)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:267)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.CombinedChannelDuplexHandler.channelRead(CombinedChannelDuplexHandler.java:250)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:266)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1294)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:911)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:131)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:611)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:552)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:466)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:438)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:140)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at io.netty.util.concurrent.DefaultThreadFactory$DefaultRunnableDecorator.run(DefaultThreadFactory.java:144)
[AndroidUiautomator2Driver@78ff (7a8b2836)]     at java.lang.Thread.run(Thread.java:1012)
[AndroidUiautomator2Driver@78ff (7a8b2836)] 
[HTTP] <-- POST /wd/hub/session/7a8b2836-0cf7-4aab-b83c-646f343cc586/actions 400 55 ms - 4192
[HTTP] 
[device-farm-main] ******  UnhandledRejection ******
[device-farm-main] Reason:  
AxiosError: Request failed with status code 400
    at settle (/Users/userID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/settle.js:19:12)
    at IncomingMessage.handleStreamEnd (/Users/userID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/adapters/http.js:589:11)
    at IncomingMessage.emit (node:events:532:35)
    at endReadableNT (node:internal/streams/readable:1696:12)
    at processTicksAndRejections (node:internal/process/task_queues:82:21)
    at Axios.request (/Users/userID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/Axios.js:45:41)
    at processTicksAndRejections (node:internal/process/task_queues:95:5) {
  code: 'ERR_BAD_REQUEST',
SubbuLomada commented 1 week ago

Hi @sudharsan-selvaraj ,

I am using using appium 2.6.0 Uiautomator2 3.5.6

Logs [Appium] Attempting to load plugin device-farm... [Appium] Requiring plugin at /Users/USERID/.appium/node_modules/appium-device-farm/lib/src/main.js { DeviceFarmProLoader: [class I], default: [class I] } [Appium] iM has been successfully loaded in 1.408s [Appium] Welcome to Appium v2.6.0 (REV f8b1d1f56cb19212b89e385e000ca3921912abeb) [Appium] Non-default server args: [Appium] { [Appium] basePath: '/wd/hub', [Appium] keepAliveTimeout: 800, [Appium] usePlugins: [ [Appium] 'device-farm' [Appium] ] [Appium] } [Appium] The autodetected Appium home path: /Users/USERID/.appium [Appium] Attempting to load driver xcuitest... [Appium] Attempting to load driver uiautomator2... [Appium] Requiring driver at /Users/USERID/.appium/node_modules/appium-uiautomator2-driver/build/index.js [Appium] AndroidUiautomator2Driver has been successfully loaded in 0.999s [Appium] Requiring driver at /Users/USERID/.appium/node_modules/appium-xcuitest-driver/build/index.js [Appium] XCUITestDriver has been successfully loaded in 1.858s [device-farm-main] 📱 Update server with CLI Args: {"subcommand":"server","address":"0.0.0.0","basePath":"/wd/hub","keepAliveTimeout":800,"port":4723,"usePlugins":["device-farm"],"plugin":{"device-farm":{"platform":"android","androidDeviceType":"both","iosDeviceType":"both"}},"extraArgs":[],"allowCors":false,"allowInsecure":[],"callbackPort":4723,"debugLogSpacing":false,"denyInsecure":[],"localTimezone":false,"loglevel":"debug","logNoColors":false,"logTimestamp":false,"pluginsImportChunkSize":7,"driversImportChunkSize":3,"longStacktrace":false,"noPermsCheck":false,"relaxedSecurityEnabled":false,"sessionOverride":false,"strictCaps":false,"useDrivers":[],"driver":{"xcuitest":{"wdaLocalPort":8100}},"tmpDir":"/tmp"} { DeviceFarmProLoader: [class I], default: [class I] } [ADB] Found 4 'build-tools' folders under '/Users/USERID/Library/Android/sdk' (newest first): [ADB] /Users/USERID/Library/Android/sdk/build-tools/33.0.0-rc2 [ADB] /Users/USERID/Library/Android/sdk/build-tools/32.1.0-rc1 [ADB] /Users/USERID/Library/Android/sdk/build-tools/32.0.0 [ADB] /Users/USERID/Library/Android/sdk/build-tools/30.0.3 [ADB] Using 'adb' from '/Users/USERID/Library/Android/sdk/platform-tools/adb' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 start-server' [device-farm-main] Cli Args: {"subcommand":"server","address":"0.0.0.0","basePath":"/wd/hub","keepAliveTimeout":800,"port":4723,"usePlugins":["device-farm"],"plugin":{"device-farm":{"platform":"android","androidDeviceType":"both","iosDeviceType":"both"}},"extraArgs":[],"allowCors":false,"allowInsecure":[],"callbackPort":4723,"debugLogSpacing":false,"denyInsecure":[],"localTimezone":false,"loglevel":"debug","logNoColors":false,"logTimestamp":false,"pluginsImportChunkSize":7,"driversImportChunkSize":3,"longStacktrace":false,"noPermsCheck":false,"relaxedSecurityEnabled":false,"sessionOverride":false,"strictCaps":false,"useDrivers":[],"driver":{"xcuitest":{"wdaLocalPort":8100}},"tmpDir":"/tmp"} [device-farm-main] 📱 Update server with Plugin Args: {"platform":"android","iosDeviceType":"both","androidDeviceType":"both","skipChromeDownload":true,"maxSessions":8,"adbRemote":[],"emulators":[],"simulators":[],"deviceAvailabilityTimeoutMs":300000,"deviceAvailabilityQueryIntervalMs":10000,"sendNodeDevicesToHubIntervalMs":30000,"checkStaleDevicesIntervalMs":30000,"checkBlockedDevicesIntervalMs":30000,"newCommandTimeoutSec":60,"bindHostOrIp":"192.198.1.115","enableDashboard":false,"removeDevicesFromDatabaseBeforeRunningThePlugin":false,"remoteConnectionTimeout":60000,"liveStreaming":false,"wdaBundleId":"","preBuildWDAPath":""} [device-farm-main] Initializing storage [device-farm-main] Initializing database [device-farm-main] Creating new database: ./temp-appium/db.json [device-farm-main] Database loaded [device-farm-main] proxy is not required for axios [device-farm-main] Registering proxy middleware [device-farm-main] Registering websocket handler for Android Streaming [device-farm-main] 📣📣📣 I'm a hub and I'm listening on 192.198.1.115:4723 [device-farm-main] Found 0 device candidates to be released [device-farm-main] Hub will clean pending sessions every 30000 ms with pending session timeout: 310000 ms [ADB] Using 'adb' from '/Users/USERID/Library/Android/sdk/platform-tools/adb' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 start-server' [ADB] Getting connected devices [ADB] Connected devices: [{"udid":"RZCW90100FF","state":"device"}] [device-farm-main] fetchAndroidDevices from host: undefined. Found 1 android devices [device-farm-main] Android Device details for RZCW90100FF not available. So querying now. [device-farm-main] skipChromeDownload server arg is set; skipping Chromedriver installation. [device-farm-main] Android web/hybrid testing will not be possible without Chromedriver. [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell getprop ro.build.version.release' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell getprop ro.build.characteristics' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell wm size' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell getprop ro.product.name' [device-farm-main] Found 1 android devices [device-farm-main] Added 1 new devices to local database [device-farm-main] 📣📣📣 Device Farm Plugin will be served at 🔗 http://192.198.1.115:4723/device-farm with id 3fd41c3e-b712-4dba-9ca1-3cf424e61670 [Appium] Appium REST http interface listener started on http://0.0.0.0:4723/wd/hub [Appium] You can provide the following URLs in your client code to connect to this server: [Appium] http://127.0.0.1:4723/wd/hub (only accessible from the same host) [Appium] http://192.198.1.115:4723/wd/hub [Appium] http://192.168.1.104:4723/wd/hub [Appium] Available drivers: [Appium] - xcuitest@7.17.6 (automationName 'XCUITest') [Appium] - uiautomator2@3.5.6 (automationName 'UiAutomator2') [Appium] Available plugins: [Appium] - appium-dashboard@v2.0.2 [Appium] - appium-interceptor@1.0.0-beta.8 [Appium] - device-farm@8.4.7-rc.45 (ACTIVE) [HTTP] --> GET /device-farm/ [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/ 304 7 ms - - [HTTP] [HTTP] --> GET /device-farm/api/device [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/device. So, not proxying it to downstream. [HTTP] --> GET /device-farm/ui-assets/index-DkzDA3O0.js [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/ui-assets/index-DkzDA3O0.js. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/ui-assets/index-DkzDA3O0.js 304 1 ms - - [HTTP] [HTTP] --> GET /device-farm/ui-assets/index-BqgeQvg2.css [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/ui-assets/index-BqgeQvg2.css. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/ui-assets/index-BqgeQvg2.css 304 0 ms - - [HTTP] [HTTP] --> GET /dashboard/api/ping [HTTP] {} [device-farm-main] Received non-webdriver request with url /dashboard/api/ping. So, not proxying it to downstream. [HTTP] No route found for /dashboard/api/ping [HTTP] <-- GET /dashboard/api/ping 404 1 ms - 211 [HTTP] [HTTP] <-- GET /device-farm/api/device 200 53 ms - 491 [HTTP] [HTTP] --> GET /device-farm/api/queue/length [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/queue/length. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/queue/length 304 1 ms - - [HTTP] [HTTP] --> GET /device-farm/api/device [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/device. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/device 304 1 ms - - [HTTP] [HTTP] --> GET /device-farm/ui-assets/device-farm-logo-nn1d6kPf.png [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/ui-assets/device-farm-logo-nn1d6kPf.png. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/ui-assets/device-farm-logo-nn1d6kPf.png 304 1 ms - - [HTTP] [HTTP] --> GET /device-farm/api/queue/length [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/queue/length. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/queue/length 304 1 ms - - [HTTP] [HTTP] --> POST /device-farm/api/block [HTTP] {"udid":"RZCW90100FF","host":"http://192.198.1.115:4723"} [device-farm-main] Received non-webdriver request with url /device-farm/api/block. So, not proxying it to downstream. [device-farm-main] Updated devices with filter: {"udid":{"$in":"RZCW90100FF"}} [HTTP] <-- POST /device-farm/api/block 200 4 ms - 16 [HTTP] [HTTP] --> POST /device-farm/api/dashboard/appiumSession [HTTP] {"udid":"RZCW90100FF","systemPort":59159,"origin":"http://192.198.1.115:4723"} [device-farm-main] Received non-webdriver request with url /device-farm/api/dashboard/appiumSession. So, not proxying it to downstream. [device-farm-main] Updated devices with filter: {"udid":{"$in":["RZCW90100FF"]}} [HTTP] --> POST /wd/hub/session [HTTP] {"capabilities":{"alwaysMatch":{"platformName":"android","appium:automationName":"UIAutomator2","appium:newCommandTimeout":120,"appium:waitForIdleTimeout":10,"appium:udid":"RZCW90100FF","df:skipReport":true,"appium:systemPort":59159,"appium:adbExecTimeout":80000,"appium:uiautomator2ServerLaunchTimeout":60000},"firstMatch":[{}]},"desiredCapabilities":{"platformName":"android","appium:automationName":"UIAutomator2","appium:newCommandTimeout":120,"appium:waitForIdleTimeout":10,"appium:udid":"RZCW90100FF","df:skipReport":true,"appium:systemPort":59159}} [AppiumDriver@39c0] Calling AppiumDriver.createSession() with args: [{"platformName":"android","appium:automationName":"UIAutomator2","appium:newCommandTimeout":120,"appium:waitForIdleTimeout":10,"appium:udid":"RZCW90100FF","df:skipReport":true,"appium:systemPort":59159},null,{"alwaysMatch":{"platformName":"android","appium:automationName":"UIAutomator2","appium:newCommandTimeout":120,"appium:waitForIdleTimeout":10,"appium:udid":"RZCW90100FF","df:skipReport":true,"appium:systemPort":59159,"appium:adbExecTimeout":80000,"appium:uiautomator2ServerLaunchTimeout":60000},"firstMatch":[{}]}] [device-farm-main] 📱 Plugin Args: {"platform":"android","androidDeviceType":"both","iosDeviceType":"both"} [AppiumDriver@39c0] Plugins which can handle cmd 'createSession': device-farm [AppiumDriver@39c0] Plugin device-farm is now handling cmd 'createSession' [device-farm-main] 📱 pluginArgs: {"platform":"android","iosDeviceType":"both","androidDeviceType":"both","skipChromeDownload":true,"maxSessions":8,"adbRemote":[],"emulators":[],"simulators":[],"deviceAvailabilityTimeoutMs":300000,"deviceAvailabilityQueryIntervalMs":10000,"sendNodeDevicesToHubIntervalMs":30000,"checkStaleDevicesIntervalMs":30000,"checkBlockedDevicesIntervalMs":30000,"newCommandTimeoutSec":60,"bindHostOrIp":"192.198.1.115","enableDashboard":false,"removeDevicesFromDatabaseBeforeRunningThePlugin":false,"remoteConnectionTimeout":60000,"liveStreaming":false,"wdaBundleId":"","preBuildWDAPath":""} [device-farm-main] Receiving session request at host: 192.198.1.115 [device-farm-main] 📱 Creating temporary session capability_id: 92472e1d-f119-4f8e-b6fd-38f8d3c35e4f [device-farm-main] Max session count: 8, Busy device count: 0 [device-farm-main] Waiting for free device. Filter: {"platform":"android","udid":"RZCW90100FF","busy":false,"userBlocked":false}} [device-farm-main] Updated devices with filter: {"platform":"android","udid":{"$in":"RZCW90100FF"}} [device-farm-main] Updated devices with filter: {"platform":"android","udid":{"$in":"RZCW90100FF"}} [device-farm-main] 📱 Blocking device RZCW90100FF at host http://192.198.1.115:4723 for new session [device-farm-main] Updating allocated device: "{"userBlocked":true,"offline":false,"adbPort":5037,"systemPort":59159,"sdk":"14","realDevice":true,"name":"dm3qxxx","busy":false,"state":"device","udid":"RZCW90100FF","platform":"android","deviceType":"real","host":"http://192.198.1.115:4723","totalUtilizationTimeMilliSec":5186853,"sessionStartTime":0,"width":"unknown","height":"unknown","liveStreaming":false,"tags":[],"nodeId":"3fd41c3e-b712-4dba-9ca1-3cf424e61670","meta":{"revision":1,"created":1719236329596,"version":0,"updated":1719236334623},"$loki":1}" [device-farm-main] Updated allocated device: "[{"userBlocked":true,"offline":false,"adbPort":5037,"systemPort":59159,"sdk":"14","realDevice":true,"name":"dm3qxxx","busy":true,"state":"device","udid":"RZCW90100FF","platform":"android","deviceType":"real","host":"http://192.198.1.115:4723","totalUtilizationTimeMilliSec":5186853,"sessionStartTime":0,"width":"unknown","height":"unknown","liveStreaming":false,"tags":[],"nodeId":"3fd41c3e-b712-4dba-9ca1-3cf424e61670","meta":{"revision":3,"created":1719236329596,"version":0,"updated":1719236334641},"$loki":1,"newCommandTimeout":120}]" [device-farm-main] device.host: http://192.198.1.115:4723 and pluginArgs.bindHostOrIp: 192.198.1.115 [device-farm-main] 📱 Creating session on the same node [AppiumDriver@39c0] Executing default handling behavior for command 'createSession' [AppiumDriver@39c0] Event 'newSessionRequested' logged at 1719236334642 (19:08:54 GMT+0530 (India Standard Time)) [Appium] Attempting to find matching driver for automationName 'UIAutomator2' and platformName 'android' [Appium] The 'uiautomator2' driver was installed and matched caps. [Appium] Will require it at /Users/USERID/.appium/node_modules/appium-uiautomator2-driver [Appium] Requiring driver at /Users/USERID/.appium/node_modules/appium-uiautomator2-driver/build/index.js [AppiumDriver@39c0] Appium v2.6.0 creating new AndroidUiautomator2Driver (v3.5.6) session [AppiumDriver@39c0] Checking BaseDriver versions for Appium and AndroidUiautomator2Driver [AppiumDriver@39c0] Appium's BaseDriver version is 9.7.0 [AppiumDriver@39c0] AndroidUiautomator2Driver's BaseDriver version is 9.7.0 [AndroidUiautomator2Driver@04fd] Creating session with W3C capabilities: { [AndroidUiautomator2Driver@04fd] "alwaysMatch": { [AndroidUiautomator2Driver@04fd] "platformName": "android", [AndroidUiautomator2Driver@04fd] "df:skipReport": true, [AndroidUiautomator2Driver@04fd] "appium:automationName": "UIAutomator2", [AndroidUiautomator2Driver@04fd] "appium:newCommandTimeout": 120, [AndroidUiautomator2Driver@04fd] "appium:waitForIdleTimeout": 10, [AndroidUiautomator2Driver@04fd] "appium:adbExecTimeout": 80000, [AndroidUiautomator2Driver@04fd] "appium:uiautomator2ServerLaunchTimeout": 60000, [AndroidUiautomator2Driver@04fd] "appium:udid": "RZCW90100FF", [AndroidUiautomator2Driver@04fd] "appium:systemPort": 59209, [AndroidUiautomator2Driver@04fd] "appium:chromeDriverPort": 59210, [AndroidUiautomator2Driver@04fd] "appium:adbPort": 5037, [AndroidUiautomator2Driver@04fd] "appium:mjpegServerPort": 59211 [AndroidUiautomator2Driver@04fd] }, [AndroidUiautomator2Driver@04fd] "firstMatch": [ [AndroidUiautomator2Driver@04fd] {} [AndroidUiautomator2Driver@04fd] ] [AndroidUiautomator2Driver@04fd] } [AndroidUiautomator2Driver@04fd] The following provided capabilities were not recognized by this driver: [AndroidUiautomator2Driver@04fd] df:skipReport [AndroidUiautomator2Driver@04fd] waitForIdleTimeout [AndroidUiautomator2Driver@04fd] chromeDriverPort [AndroidUiautomator2Driver@04fd] adbRemoteHost [AndroidUiautomator2Driver@04fd (b91a2b42)] Session created with session id: b91a2b42-1bb0-4732-9f2a-44073cc1ef17 [ADB] Found 4 'build-tools' folders under '/Users/USERID/Library/Android/sdk' (newest first): [ADB] /Users/USERID/Library/Android/sdk/build-tools/33.0.0-rc2 [ADB] /Users/USERID/Library/Android/sdk/build-tools/32.1.0-rc1 [ADB] /Users/USERID/Library/Android/sdk/build-tools/32.0.0 [ADB] /Users/USERID/Library/Android/sdk/build-tools/30.0.3 [ADB] Using 'adb' from '/Users/USERID/Library/Android/sdk/platform-tools/adb' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 start-server' [AndroidUiautomator2Driver@04fd (b91a2b42)] Retrieving device list [ADB] Trying to find connected Android devices [ADB] Getting connected devices [ADB] Connected devices: [{"udid":"RZCW90100FF","state":"device"}] [AndroidUiautomator2Driver@04fd (b91a2b42)] Using device: RZCW90100FF [ADB] Using 'adb' from '/Users/USERID/Library/Android/sdk/platform-tools/adb' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 start-server' [ADB] Setting device id to RZCW90100FF [AndroidUiautomator2Driver@04fd (b91a2b42)] Neither 'app' nor 'appPackage' was set. Starting UiAutomator2 without the target application [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell getprop ro.build.version.sdk' [ADB] Current device property 'ro.build.version.sdk': 34 [ADB] Getting device platform version [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell getprop ro.build.version.release' [ADB] Current device property 'ro.build.version.release': 14 [ADB] Device API level: 34 [AndroidUiautomator2Driver@04fd (b91a2b42)] Relaxing hidden api policy [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell 'settings put global hidden_api_policy_pre_p_apps 1;settings put global hidden_api_policy_p_apps 1;settings put global hidden_api_policy 1'' [AndroidUiautomator2Driver@04fd (b91a2b42)] No app sent in, not parsing package/activity [AndroidUiautomator2Driver@04fd (b91a2b42)] Pushing settings apk to the device... [ADB] Getting package info for 'io.appium.settings' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell dumpsys package io.appium.settings' [ADB] The version name of the installed 'io.appium.settings' is greater or equal to the application version name ('5.12.3' >= '5.12.3') [ADB] There is no need to install/upgrade '/Users/USERID/.appium/node_modules/appium-uiautomator2-driver/node_modules/io.appium.settings/apks/settings_apk-debug.apk' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell dumpsys activity services io.appium.settings' [AndroidUiautomator2Driver@04fd (b91a2b42)] io.appium.settings is already running. There is no need to reset its permissions. [Logcat] Starting logs capture with command: /Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF logcat -v threadtime [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell appops set io.appium.settings android:mock_location allow' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell "[ -e '/data/local/tmp/mock_apps.json' ] && echo PASS"' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell cat /data/local/tmp/mock_apps.json' [AndroidUiautomator2Driver@04fd (b91a2b42)] Forwarding UiAutomator2 Server port 6790 to local port 59209 [AndroidUiautomator2Driver@04fd (b91a2b42)] MJPEG broadcasting requested, forwarding MJPEG server port 7810 to local port 59211 [ADB] Forwarding system: 59211 to device: 7810 [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF forward tcp:59211 tcp:7810' [ADB] Forwarding system: 59209 to device: 6790 [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF forward tcp:59209 tcp:6790' [ADB] Getting package info for 'io.appium.uiautomator2.server' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell dumpsys package io.appium.uiautomator2.server' [ADB] Getting install status for io.appium.uiautomator2.server.test [AndroidUiautomator2Driver@04fd (b91a2b42)] No app capability. Assuming it is already on the device [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell cmd package list packages' [ADB] 'io.appium.uiautomator2.server.test' is installed [ADB] The version name of the installed 'io.appium.uiautomator2.server' is greater or equal to the application version name ('7.0.14' >= '7.0.14') [AndroidUiautomator2Driver@04fd (b91a2b42)] Server packages status: [{"installState":"sameVersionInstalled","appPath":"/Users/USERID/.appium/node_modules/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v7.0.14.apk","appId":"io.appium.uiautomator2.server"},{"installState":"sameVersionInstalled","appPath":"/Users/USERID/.appium/node_modules/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk","appId":"io.appium.uiautomator2.server.test"}] [AndroidUiautomator2Driver@04fd (b91a2b42)] Server packages are not going to be (re)installed [AndroidUiautomator2Driver@04fd (b91a2b42)] Waiting up to 30000ms for services to be available [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell pm list instrumentation' [AndroidUiautomator2Driver@04fd (b91a2b42)] Instrumentation target 'io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner' is available [ADB] Adding packages ["io.appium.settings","io.appium.uiautomator2.server","io.appium.uiautomator2.server.test"] to Doze whitelist [ADB] Got the following command chunks to execute: [["dumpsys","deviceidle","whitelist","+io.appium.settings",";","dumpsys","deviceidle","whitelist","+io.appium.uiautomator2.server",";","dumpsys","deviceidle","whitelist","+io.appium.uiautomator2.server.test",";"]] [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell dumpsys deviceidle whitelist +io.appium.settings ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server.test ;' [AndroidUiautomator2Driver@04fd (b91a2b42)] Performing shallow cleanup of automation leftovers [AndroidUiautomator2Driver@04fd (b91a2b42)] No obsolete sessions have been detected (socket hang up) [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell am force-stop io.appium.uiautomator2.server.test' [AndroidUiautomator2Driver@04fd (b91a2b42)] Starting UIAutomator2 server 7.0.14 [AndroidUiautomator2Driver@04fd (b91a2b42)] Using UIAutomator2 server from '/Users/USERID/.appium/node_modules/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v7.0.14.apk' and test from '/Users/USERID/.appium/node_modules/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk' [AndroidUiautomator2Driver@04fd (b91a2b42)] Waiting up to 60000ms for UiAutomator2 to be online... [ADB] Creating ADB subprocess with args: ["-P","5037","-s","RZCW90100FF","shell","am","instrument","-w","-e","disableAnalytics","true","io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"] [AndroidUiautomator2Driver@04fd (b91a2b42)] Matched '/status' to command name 'getStatus' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [GET /status] to [GET http://127.0.0.1:59209/status] with no body [AndroidUiautomator2Driver@04fd (b91a2b42)] socket hang up [Instrumentation] io.appium.uiautomator2.server.test.AppiumUiAutomator2Server: [AndroidUiautomator2Driver@04fd (b91a2b42)] Matched '/status' to command name 'getStatus' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [GET /status] to [GET http://127.0.0.1:59209/status] with no body [AndroidUiautomator2Driver@04fd (b91a2b42)] socket hang up [AndroidUiautomator2Driver@04fd (b91a2b42)] Matched '/status' to command name 'getStatus' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [GET /status] to [GET http://127.0.0.1:59209/status] with no body [AndroidUiautomator2Driver@04fd (b91a2b42)] Got response with status 200: {"sessionId":"None","value":{"message":"UiAutomator2 Server is ready to accept commands","ready":true}} [AndroidUiautomator2Driver@04fd (b91a2b42)] The initialization of the instrumentation process took 2101ms [AndroidUiautomator2Driver@04fd (b91a2b42)] Matched '/session' to command name 'createSession' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [POST /session] to [POST http://127.0.0.1:59209/session] with body: {"capabilities":{"firstMatch":[{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211,"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211},"deviceName":"RZCW90100FF","deviceUDID":"RZCW90100FF"}],"alwaysMatch":{}}} [AndroidUiautomator2Driver@04fd (b91a2b42)] Got response with status 200: {"sessionId":"6cbded05-7ddf-44f1-a27a-e08022dc906a","value":{"capabilities":{"firstMatch":[{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211,"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211},"deviceName":"RZCW90100FF","deviceUDID":"RZCW90100FF"}],"alwaysMatch":{}},"sessionId":"6cbded05-7ddf-44f1-a27a-e08022dc906a"}} [AndroidUiautomator2Driver@04fd (b91a2b42)] Determined the downstream protocol as 'W3C' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [GET /appium/device/pixel_ratio] to [GET http://127.0.0.1:59209/session/6cbded05-7ddf-44f1-a27a-e08022dc906a/appium/device/pixel_ratio] with no body [AndroidUiautomator2Driver@04fd (b91a2b42)] Matched '/appium/device/system_bars' to command name 'getSystemBars' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [GET /appium/device/system_bars] to [GET http://127.0.0.1:59209/session/6cbded05-7ddf-44f1-a27a-e08022dc906a/appium/device/system_bars] with no body [AndroidUiautomator2Driver@04fd (b91a2b42)] Matched '/window/current/size' to command name 'getWindowSize' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [GET /window/current/size] to [GET http://127.0.0.1:59209/session/6cbded05-7ddf-44f1-a27a-e08022dc906a/window/current/size] with no body [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [GET /appium/device/info] to [GET http://127.0.0.1:59209/session/6cbded05-7ddf-44f1-a27a-e08022dc906a/appium/device/info] with no body [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell dumpsys window' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell dumpsys power' [AndroidUiautomator2Driver@04fd (b91a2b42)] Got response with status 200: {"sessionId":"6cbded05-7ddf-44f1-a27a-e08022dc906a","value":2.8125} [AndroidUiautomator2Driver@04fd (b91a2b42)] Got response with status 200: {"sessionId":"6cbded05-7ddf-44f1-a27a-e08022dc906a","value":{"statusBar":75}} [AndroidUiautomator2Driver@04fd (b91a2b42)] Got response with status 200: {"sessionId":"6cbded05-7ddf-44f1-a27a-e08022dc906a","value":{"height":2316,"width":1080}} [AndroidUiautomator2Driver@04fd (b91a2b42)] Got response with status 200: {"sessionId":"6cbded05-7ddf-44f1-a27a-e08022dc906a","value":{"androidId":"1c0dfe199b2d1e04","apiVersion":"34","bluetooth":{"state":"ON"},"brand":"samsung","carrierName":"","displayDensity":450,"locale":"en_IN","manufacturer":"samsung","model":"SM-S918B","networks":[{"capabilities":{"SSID":null,"linkDownBandwidthKbps":7332,"linkUpstreamBandwidthKbps":1934,"networkCapabilities":"NET_CAPABILITY_NOT_METERED,NET_CAPABILITY_INTERNET,NET_CAPABILITY_NOT_RESTRICTED,NET_CAPABILITY_TRUSTED,NET_CAPABILITY_NOT_VPN,NET_CAPABILITY_VALIDATED,NET_CAPABILITY_NOT_ROAMING,NET_CAPABILITY_FOREGROUND,NET_CAPABILITY_NOT_CONGESTED,NET_CAPABILITY_NOT_SUSPENDED","signalStrength":-38,"transportTypes":"TRANSPORT_WIFI"},"detailedState":"CONNECTED","extraInfo":"","isAvailable":true,"isConnected":true,"isFailover":false,"isRoaming":false,"state":"CONNECTED","subtype":-1,"subtypeName":"","type":1,"typeName":"WIFI"}],"platformVersion":"14","realDisplaySize":"1080x2316","timeZone":"Asia/Kolkata"}} [AndroidUiautomator2Driver@04fd (b91a2b42)] Screen already unlocked, doing nothing [AppiumDriver@39c0] New AndroidUiautomator2Driver session created successfully, session b91a2b42-1bb0-4732-9f2a-44073cc1ef17 added to master session list [AppiumDriver@39c0] Event 'newSessionStarted' logged at 1719236338151 (19:08:58 GMT+0530 (India Standard Time)) [device-farm-main] 📱 92472e1d-f119-4f8e-b6fd-38f8d3c35e4f Session response: {"protocol":"W3C","value":["b91a2b42-1bb0-4732-9f2a-44073cc1ef17",{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211,"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211},"deviceName":"RZCW90100FF","deviceUDID":"RZCW90100FF","pixelRatio":"2.8125","statBarHeight":75,"viewportRect":{"left":0,"top":75,"width":1080,"height":2241},"deviceApiLevel":34,"platformVersion":"14","deviceManufacturer":"samsung","deviceModel":"SM-S918B","deviceScreenSize":"1080x2316","deviceScreenDensity":450},"W3C"]} [device-farm-main] 📱 Removing pending session with capability_id: 92472e1d-f119-4f8e-b6fd-38f8d3c35e4f [device-farm-main] 92472e1d-f119-4f8e-b6fd-38f8d3c35e4f 📱 Session response is CreateSessionResponseInternal [device-farm-main] 📱 92472e1d-f119-4f8e-b6fd-38f8d3c35e4f ----- Device UDID RZCW90100FF blocked for session b91a2b42-1bb0-4732-9f2a-44073cc1ef17 [device-farm-main] Updating allocated device: "{"userBlocked":true,"offline":false,"adbPort":5037,"systemPort":59159,"sdk":"14","realDevice":true,"name":"dm3qxxx","busy":false,"state":"device","udid":"RZCW90100FF","platform":"android","deviceType":"real","host":"http://192.198.1.115:4723","totalUtilizationTimeMilliSec":5186853,"sessionStartTime":0,"width":"unknown","height":"unknown","liveStreaming":false,"tags":[],"nodeId":"3fd41c3e-b712-4dba-9ca1-3cf424e61670","meta":{"revision":1,"created":1719236329596,"version":0,"updated":1719236334623},"$loki":1}" [device-farm-main] Updated allocated device: "[{"userBlocked":true,"offline":false,"adbPort":5037,"systemPort":59159,"sdk":"14","realDevice":true,"name":"dm3qxxx","busy":true,"state":"device","udid":"RZCW90100FF","platform":"android","deviceType":"real","host":"http://192.198.1.115:4723","totalUtilizationTimeMilliSec":5186853,"sessionStartTime":1719236338152,"width":"unknown","height":"unknown","liveStreaming":false,"tags":[],"nodeId":"3fd41c3e-b712-4dba-9ca1-3cf424e61670","meta":{"revision":4,"created":1719236329596,"version":0,"updated":1719236338152},"$loki":1,"newCommandTimeout":120,"session_id":"b91a2b42-1bb0-4732-9f2a-44073cc1ef17","lastCmdExecutedAt":1719236338152}]" [device-farm-main] 92472e1d-f119-4f8e-b6fd-38f8d3c35e4f 📱 Updating Device RZCW90100FF with session ID b91a2b42-1bb0-4732-9f2a-44073cc1ef17 [AppiumDriver@39c0] Promoting 1 sessionless plugins to be attached to session ID b91a2b42-1bb0-4732-9f2a-44073cc1ef17 [AndroidUiautomator2Driver@04fd (b91a2b42)] Cached the protocol value 'W3C' for the new session b91a2b42-1bb0-4732-9f2a-44073cc1ef17 [AndroidUiautomator2Driver@04fd (b91a2b42)] Responding to client with driver.createSession() result: {"capabilities":{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211,"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211},"deviceName":"RZCW90100FF","deviceUDID":"RZCW90100FF","pixelRatio":"2.8125","statBarHeight":75,"viewportRect":{"left":0,"top":75,"width":1080,"height":2241},"deviceApiLevel":34,"platformVersion":"14","deviceManuf... [HTTP] <-- POST /wd/hub/session 200 3518 ms - 1184 [HTTP] [device-farm-main] Response from browser create session {"value":{"capabilities":{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211,"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","df:skipReport":true,"automationName":"UIAutomator2","newCommandTimeout":120,"waitForIdleTimeout":10,"adbExecTimeout":80000,"uiautomator2ServerLaunchTimeout":60000,"udid":"RZCW90100FF","systemPort":59209,"chromeDriverPort":59210,"adbPort":5037,"mjpegServerPort":59211},"deviceName":"RZCW90100FF","deviceUDID":"RZCW90100FF","pixelRatio":"2.8125","statBarHeight":75,"viewportRect":{"left":0,"top":75,"width":1080,"height":2241},"deviceApiLevel":34,"platformVersion":"14","deviceManufacturer":"samsung","deviceModel":"SM-S918B","deviceScreenSize":"1080x2316","deviceScreenDensity":450},"sessionId":"b91a2b42-1bb0-4732-9f2a-44073cc1ef17"}} [device-farm-main] Updated devices with filter: {"udid":{"$in":["RZCW90100FF"]}} [HTTP] <-- POST /device-farm/api/dashboard/appiumSession 200 3524 ms - 708 [HTTP] [HTTP] --> POST /device-farm/api/dashboard/installAndroidStreamingApp [HTTP] {"udid":"RZCW90100FF","systemPort":59159} [device-farm-main] Received non-webdriver request with url /device-farm/api/dashboard/installAndroidStreamingApp. So, not proxying it to downstream. [device-farm-main] Updated devices with filter: {"udid":{"$in":["RZCW90100FF"]}} [ADB] Using 'adb' from '/Users/USERID/Library/Android/sdk/platform-tools/adb' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 start-server' Current directory: /Users/USERID/.appium/node_modules/appium-device-farm/lib/stream.apk [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF install /Users/USERID/.appium/node_modules/appium-device-farm/lib/stream.apk' [HTTP] --> GET /device-farm/api/device [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/device. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/device 200 3 ms - 635 [HTTP] [HTTP] --> GET /device-farm/api/queue/length [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/queue/length. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/queue/length 304 1 ms - - [HTTP] [HTTP] --> GET /device-farm/api/device [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/device. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/device 304 2 ms - - [HTTP] [HTTP] --> GET /device-farm/api/queue/length [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/queue/length. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/queue/length 304 1 ms - - [HTTP] Installed /Users/USERID/.appium/node_modules/appium-device-farm/lib/stream.apk on device RZCW90100FF [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell pm list packages' Allowing recording permissions [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell appops set com.device.farm PROJECT_MEDIA allow' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell am start -W -n com.device.farm/com.device.farm.ScreenCaptureActivity' [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF forward tcp:59159 tcp:1991' Pressing home [ADB] Running '/Users/USERID/Library/Android/sdk/platform-tools/adb -P 5037 -s RZCW90100FF shell input keyevent KEYCODE_HOME' [device-farm-main] Found 0 device candidates to be released [device-farm-main] Cleaning pending sessions... [device-farm-main] No pending sessions to clean [HTTP] --> GET /device-farm/api/device [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/device. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/device 304 3 ms - - [HTTP] [HTTP] --> GET /device-farm/api/queue/length [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/api/queue/length. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/api/queue/length 304 1 ms - - [HTTP] [device-farm-main] Websocket event received, streaming app is running [HTTP] <-- POST /device-farm/api/dashboard/installAndroidStreamingApp 200 21969 ms - 703 [HTTP] [device-farm-main] New streaming request recieved with url: /android-stream/RZCW90100FF [device-farm-main] Device id RZCW90100FF matched for streaming url : /android-stream/RZCW90100FF [device-farm-main] Updated devices with filter: {"udid":{"$in":["RZCW90100FF"]}} [device-farm-main] Creating new proxy streaming session for device RZCW90100FF [HTTP] --> GET /device-farm/ui-assets/device-loading-BbhTw1Mo.gif [HTTP] {} [device-farm-main] Received non-webdriver request with url /device-farm/ui-assets/device-loading-BbhTw1Mo.gif. So, not proxying it to downstream. [HTTP] <-- GET /device-farm/ui-assets/device-loading-BbhTw1Mo.gif 304 1 ms - - [HTTP] [device-farm-main] Successfully created proxy streaming session for device RZCW90100FF WebSocket message received: { action: 'swipe', args: { actions: [ [Object] ] } } Performing action on the screen { actions: [ { type: 'pointer', id: 'finger1', parameters: [Object], actions: [Array] } ] } { userBlocked: true, offline: false, adbPort: 5037, systemPort: 59159, sdk: '14', realDevice: true, name: 'dm3qxxx', busy: true, state: 'device', udid: 'RZCW90100FF', platform: 'android', deviceType: 'real', host: 'http://192.198.1.115:4723', totalUtilizationTimeMilliSec: 5186853, sessionStartTime: 1719236338152, width: 'unknown', height: 'unknown', liveStreaming: false, tags: [], nodeId: '3fd41c3e-b712-4dba-9ca1-3cf424e61670', meta: { revision: 4, created: 1719236329596, version: 0, updated: 1719236338152 }, '$loki': 1, newCommandTimeout: 120, session_id: 'b91a2b42-1bb0-4732-9f2a-44073cc1ef17', lastCmdExecutedAt: 1719236338152 } [device-farm-main] Proxying request to appium {"method":"post","url":"http://127.0.0.1:4723/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions","timeout":60000,"headers":{"Content-Type":"application/json"},"data":{"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]}} [HTTP] --> POST /wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions [HTTP] {"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]} [device-farm-main] Updating lastCmdExecutedAt for device RZCW90100FF in session b91a2b42-1bb0-4732-9f2a-44073cc1ef17 [AndroidUiautomator2Driver@04fd (b91a2b42)] Calling AppiumDriver.performActions() with args: [[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}],"b91a2b42-1bb0-4732-9f2a-44073cc1ef17"] [AppiumDriver@39c0] Clearing new command timeout pre-emptively since plugin(s) will handle this command [AppiumDriver@39c0] Plugins which can handle cmd 'performActions': device-farm [AppiumDriver@39c0] Plugin device-farm is now handling cmd 'performActions' [AppiumDriver@39c0] Executing default handling behavior for command 'performActions' [AndroidUiautomator2Driver@04fd (b91a2b42)] Preprocessed actions: [ [AndroidUiautomator2Driver@04fd (b91a2b42)] { [AndroidUiautomator2Driver@04fd (b91a2b42)] "type": "pointer", [AndroidUiautomator2Driver@04fd (b91a2b42)] "id": "finger1", [AndroidUiautomator2Driver@04fd (b91a2b42)] "parameters": { [AndroidUiautomator2Driver@04fd (b91a2b42)] "pointerType": "touch" [AndroidUiautomator2Driver@04fd (b91a2b42)] }, [AndroidUiautomator2Driver@04fd (b91a2b42)] "actions": [ [AndroidUiautomator2Driver@04fd (b91a2b42)] { [AndroidUiautomator2Driver@04fd (b91a2b42)] "type": "pointerMove", [AndroidUiautomator2Driver@04fd (b91a2b42)] "duration": 0, [AndroidUiautomator2Driver@04fd (b91a2b42)] "x": null, [AndroidUiautomator2Driver@04fd (b91a2b42)] "y": null [AndroidUiautomator2Driver@04fd (b91a2b42)] }, [AndroidUiautomator2Driver@04fd (b91a2b42)] { [AndroidUiautomator2Driver@04fd (b91a2b42)] "type": "pointerDown", [AndroidUiautomator2Driver@04fd (b91a2b42)] "button": 0 [AndroidUiautomator2Driver@04fd (b91a2b42)] }, [AndroidUiautomator2Driver@04fd (b91a2b42)] { [AndroidUiautomator2Driver@04fd (b91a2b42)] "type": "pause", [AndroidUiautomator2Driver@04fd (b91a2b42)] "duration": 0 [AndroidUiautomator2Driver@04fd (b91a2b42)] }, [AndroidUiautomator2Driver@04fd (b91a2b42)] { [AndroidUiautomator2Driver@04fd (b91a2b42)] "type": "pointerMove", [AndroidUiautomator2Driver@04fd (b91a2b42)] "duration": 100, [AndroidUiautomator2Driver@04fd (b91a2b42)] "origin": "viewport", [AndroidUiautomator2Driver@04fd (b91a2b42)] "x": null, [AndroidUiautomator2Driver@04fd (b91a2b42)] "y": null [AndroidUiautomator2Driver@04fd (b91a2b42)] }, [AndroidUiautomator2Driver@04fd (b91a2b42)] { [AndroidUiautomator2Driver@04fd (b91a2b42)] "type": "pointerUp", [AndroidUiautomator2Driver@04fd (b91a2b42)] "button": 0 [AndroidUiautomator2Driver@04fd (b91a2b42)] } [AndroidUiautomator2Driver@04fd (b91a2b42)] ] [AndroidUiautomator2Driver@04fd (b91a2b42)] } [AndroidUiautomator2Driver@04fd (b91a2b42)] ] [AndroidUiautomator2Driver@04fd (b91a2b42)] Matched '/actions' to command name 'performActions' [AndroidUiautomator2Driver@04fd (b91a2b42)] Proxying [POST /actions] to [POST http://127.0.0.1:59209/session/6cbded05-7ddf-44f1-a27a-e08022dc906a/actions] with body: {"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]} [device-farm-main] Updating lastCmdExecutedAt for device RZCW90100FF in session b91a2b42-1bb0-4732-9f2a-44073cc1ef17 [AndroidUiautomator2Driver@04fd (b91a2b42)] Got response with status 400: {"sessionId":"6cbded05-7ddf-44f1-a27a-e08022dc906a","value":{"error":"invalid argument","message":"Both coordinates must be be set for action item 'pointerMove' #1 of action 'finger1'","stacktrace":"io.appium.uiautomator2.utils.w3c.ActionsParseException: Both coordinates must be be set for action item 'pointerMove' #1 of action 'finger1'\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:277)\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:260)\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.applyPointerActionToEventsMapping(ActionsTokenizer.java:452)\n\tat io.appium.uiautomator2.utils.w3c.ActionsTokenizer.tokenize(ActionsTokenizer.java:574)\n\tat io.appium.uiautomator2.handler.W3CActions.safeHandle(W3CActions.java:78)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:59)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:259)\n... [W3C] Matched W3C error code 'invalid argument' to InvalidArgumentError [AndroidUiautomator2Driver@04fd (b91a2b42)] Encountered internal error running command: io.appium.uiautomator2.utils.w3c.ActionsParseException: Both coordinates must be be set for action item 'pointerMove' #1 of action 'finger1' [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:277) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.extractCoordinates(ActionsTokenizer.java:260) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.applyPointerActionToEventsMapping(ActionsTokenizer.java:452) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.utils.w3c.ActionsTokenizer.tokenize(ActionsTokenizer.java:574) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.handler.W3CActions.safeHandle(W3CActions.java:78) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:59) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:259) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:253) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:77) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.handler.codec.MessageToMessageDecoder.channelRead(MessageToMessageDecoder.java:102) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.CombinedChannelDuplexHandler$DelegatingChannelHandlerContext.fireChannelRead(CombinedChannelDuplexHandler.java:435) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:293) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:267) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.CombinedChannelDuplexHandler.channelRead(CombinedChannelDuplexHandler.java:250) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:266) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:345) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1294) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:911) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:131) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:611) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:552) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:466) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:438) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:140) [AndroidUiautomator2Driver@04fd (b91a2b42)] at io.netty.util.concurrent.DefaultThreadFactory$DefaultRunnableDecorator.run(DefaultThreadFactory.java:144) [AndroidUiautomator2Driver@04fd (b91a2b42)] at java.lang.Thread.run(Thread.java:1012) [AndroidUiautomator2Driver@04fd (b91a2b42)] [HTTP] <-- POST /wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions 400 60 ms - 4192 [HTTP] [device-farm-main] ** UnhandledRejection ** [device-farm-main] Reason:
AxiosError: Request failed with status code 400 at settle (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/settle.js:19:12) at IncomingMessage.handleStreamEnd (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/adapters/http.js:589:11) at IncomingMessage.emit (node:events:532:35) at endReadableNT (node:internal/streams/readable:1696:12) at processTicksAndRejections (node:internal/process/task_queues:82:21) at Axios.request (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/Axios.js:45:41) at processTicksAndRejections (node:internal/process/task_queues:95:5) { code: 'ERR_BAD_REQUEST', config: { transitional: { silentJSONParsing: true, forcedJSONParsing: true, clarifyTimeoutError: false }, adapter: [ 'xhr', 'http', 'fetch' ], transformRequest: [ [Function: transformRequest] ], transformResponse: [ [Function: transformResponse] ], timeout: 60000, xsrfCookieName: 'XSRF-TOKEN', xsrfHeaderName: 'X-XSRF-TOKEN', maxContentLength: -1, maxBodyLength: -1, env: { FormData: [Function], Blob: [class Blob] }, validateStatus: [Function: validateStatus], headers: Object [AxiosHeaders] { Accept: 'application/json, text/plain, /', 'Content-Type': 'application/json', 'User-Agent': 'axios/1.7.2', 'Content-Length': '322', 'Accept-Encoding': 'gzip, compress, deflate, br' }, method: 'post', url: 'http://127.0.0.1:4723/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions', data: '{"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]}' }, request: <ref 1> ClientRequest { _events: [Object: null prototype] { abort: [Function (anonymous)], aborted: [Function (anonymous)], connect: [Function (anonymous)], error: [Function (anonymous)], socket: [Function (anonymous)], timeout: [Function (anonymous)], finish: [Function: requestOnFinish] }, _eventsCount: 7, _maxListeners: undefined, outputData: [], outputSize: 0, writable: true, destroyed: true, _last: false, chunkedEncoding: false, shouldKeepAlive: true, maxRequestsOnConnectionReached: false, _defaultKeepAlive: true, useChunkedEncodingByDefault: true, sendDate: false, _removedConnection: false, _removedContLen: false, _removedTE: false, strictContentLength: false, _contentLength: '322', _hasBody: true, _trailer: '', finished: true, _headerSent: true, _closed: true, _header: 'POST /wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions HTTP/1.1\r\n' + 'Accept: application/json, text/plain, /*\r\n' + 'Content-Type: application/json\r\n' + 'User-Agent: axios/1.7.2\r\n' + 'Content-Length: 322\r\n' + 'Accept-Encoding: gzip, compress, deflate, br\r\n' + 'Host: 127.0.0.1:4723\r\n' + 'Connection: keep-alive\r\n' + '\r\n', _keepAliveTimeout: 0, _onPendingData: [Function: nop], agent: Agent { _events: [Object: null prototype], _eventsCount: 2, _maxListeners: undefined, defaultPort: 80, protocol: 'http:', options: [Object: null prototype], requests: [Object: null prototype] {}, sockets: [Object: null prototype] {}, freeSockets: [Object: null prototype], keepAliveMsecs: 1000, keepAlive: true, maxSockets: Infinity, maxFreeSockets: 256, scheduling: 'lifo', maxTotalSockets: Infinity, totalSocketCount: 1,

  [Symbol(kCapture)]: false
},
socketPath: undefined,
method: 'POST',
maxHeaderSize: undefined,
insecureHTTPParser: undefined,
joinDuplicateHeaders: undefined,
path: '/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions',
_ended: true,
res: IncomingMessage {
  _events: [Object],
  _readableState: [ReadableState],
  _maxListeners: undefined,
  socket: null,
  httpVersionMajor: 1,
  httpVersionMinor: 1,
  httpVersion: '1.1',
  complete: true,
  rawHeaders: [Array],
  rawTrailers: [],
  joinDuplicateHeaders: undefined,
  aborted: false,
  upgrade: false,
  url: '',
  method: null,
  statusCode: 400,
  statusMessage: 'Bad Request',
  client: [Socket],
  _consuming: false,
  _dumped: false,
  req: [Circular *1],
  _eventsCount: 4,
  responseUrl: 'http://127.0.0.1:4723/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions',
  redirects: [],
  [Symbol(shapeMode)]: true,
  [Symbol(kCapture)]: false,
  [Symbol(kHeaders)]: [Object],
  [Symbol(kHeadersCount)]: 16,
  [Symbol(kTrailers)]: null,
  [Symbol(kTrailersCount)]: 0
},
aborted: false,
timeoutCb: null,
upgradeOrConnect: false,
parser: null,
maxHeadersCount: null,
reusedSocket: false,
host: '127.0.0.1',
protocol: 'http:',
_redirectable: Writable {
  _events: [Object],
  _writableState: [WritableState],
  _maxListeners: undefined,
  _options: [Object],
  _ended: true,
  _ending: true,
  _redirectCount: 0,
  _redirects: [],
  _requestBodyLength: 322,
  _requestBodyBuffers: [],
  _eventsCount: 3,
  _onNativeResponse: [Function (anonymous)],
  _currentRequest: [Circular *1],
  _currentUrl: 'http://127.0.0.1:4723/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions',
  _timeout: null,
  [Symbol(shapeMode)]: true,
  [Symbol(kCapture)]: false
},
[Symbol(shapeMode)]: false,
[Symbol(kCapture)]: false,
[Symbol(kBytesWritten)]: 0,
[Symbol(kNeedDrain)]: false,
[Symbol(corked)]: 0,
[Symbol(kChunkedBuffer)]: [],
[Symbol(kChunkedLength)]: 0,
[Symbol(kSocket)]: Socket {
  connecting: false,
  _hadError: false,
  _parent: null,
  _host: null,
  _closeAfterHandlingError: false,
  _events: [Object],
  _readableState: [ReadableState],
  _writableState: [WritableState],
  allowHalfOpen: false,
  _maxListeners: undefined,
  _eventsCount: 6,
  _sockname: null,
  _pendingData: null,
  _pendingEncoding: '',
  server: null,
  _server: null,
  timeout: 5000,
  parser: null,
  _httpMessage: null,
  [Symbol(async_id_symbol)]: -1,
  [Symbol(kHandle)]: [TCP],
  [Symbol(lastWriteQueueSize)]: 0,
  [Symbol(timeout)]: Timeout {
    _idleTimeout: 5000,
    _idlePrev: [TimersList],
    _idleNext: [TimersList],
    _idleStart: 43758,
    _onTimeout: [Function: bound ],
    _timerArgs: undefined,
    _repeat: null,
    _destroyed: false,
    [Symbol(refed)]: false,
    [Symbol(kHasPrimitive)]: false,
    [Symbol(asyncId)]: 52018,
    [Symbol(triggerId)]: 52016
  },
  [Symbol(kBuffer)]: null,
  [Symbol(kBufferCb)]: null,
  [Symbol(kBufferGen)]: null,
  [Symbol(shapeMode)]: true,
  [Symbol(kCapture)]: false,
  [Symbol(kSetNoDelay)]: true,
  [Symbol(kSetKeepAlive)]: true,
  [Symbol(kSetKeepAliveInitialDelay)]: 1,
  [Symbol(kBytesRead)]: 0,
  [Symbol(kBytesWritten)]: 0
},
[Symbol(kOutHeaders)]: [Object: null prototype] {
  accept: [Array],
  'content-type': [Array],
  'user-agent': [Array],
  'content-length': [Array],
  'accept-encoding': [Array],
  host: [Array]
},
[Symbol(errored)]: null,
[Symbol(kHighWaterMark)]: 65536,
[Symbol(kRejectNonStandardBodyWrites)]: false,
[Symbol(kUniqueHeaders)]: null

}, response: { status: 400, statusText: 'Bad Request', headers: Object [AxiosHeaders] { 'x-powered-by': 'Express', vary: 'X-HTTP-Method-Override', 'content-type': 'application/json; charset=utf-8', 'content-length': '4192', etag: 'W/"1060-EeZR77azKOr1IcX51obatRKAZBA"', date: 'Mon, 24 Jun 2024 13:39:28 GMT', connection: 'keep-alive', 'keep-alive': 'timeout=800' }, config: { transitional: [Object], adapter: [Array], transformRequest: [Array], transformResponse: [Array], timeout: 60000, xsrfCookieName: 'XSRF-TOKEN', xsrfHeaderName: 'X-XSRF-TOKEN', maxContentLength: -1, maxBodyLength: -1, env: [Object], validateStatus: [Function: validateStatus], headers: [Object [AxiosHeaders]], method: 'post', url: 'http://127.0.0.1:4723/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions', data: '{"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]}' }, request: <ref 1> ClientRequest { _events: [Object: null prototype], _eventsCount: 7, _maxListeners: undefined, outputData: [], outputSize: 0, writable: true, destroyed: true, _last: false, chunkedEncoding: false, shouldKeepAlive: true, maxRequestsOnConnectionReached: false, _defaultKeepAlive: true, useChunkedEncodingByDefault: true, sendDate: false, _removedConnection: false, _removedContLen: false, _removedTE: false, strictContentLength: false, _contentLength: '322', _hasBody: true, _trailer: '', finished: true, _headerSent: true, _closed: true, _header: 'POST /wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions HTTP/1.1\r\n' + 'Accept: application/json, text/plain, /*\r\n' + 'Content-Type: application/json\r\n' + 'User-Agent: axios/1.7.2\r\n' + 'Content-Length: 322\r\n' + 'Accept-Encoding: gzip, compress, deflate, br\r\n' + 'Host: 127.0.0.1:4723\r\n' + 'Connection: keep-alive\r\n' + '\r\n', _keepAliveTimeout: 0, _onPendingData: [Function: nop], agent: [Agent], socketPath: undefined, method: 'POST', maxHeaderSize: undefined, insecureHTTPParser: undefined, joinDuplicateHeaders: undefined, path: '/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions', _ended: true, res: [IncomingMessage], aborted: false, timeoutCb: null, upgradeOrConnect: false, parser: null, maxHeadersCount: null, reusedSocket: false, host: '127.0.0.1', protocol: 'http:', _redirectable: [Writable],

  [Symbol(kCapture)]: false,
  [Symbol(kBytesWritten)]: 0,
  [Symbol(kNeedDrain)]: false,
  [Symbol(corked)]: 0,
  [Symbol(kChunkedBuffer)]: [],
  [Symbol(kChunkedLength)]: 0,
  [Symbol(kSocket)]: [Socket],
  [Symbol(kOutHeaders)]: [Object: null prototype],
  [Symbol(errored)]: null,
  [Symbol(kHighWaterMark)]: 65536,
  [Symbol(kRejectNonStandardBodyWrites)]: false,
  [Symbol(kUniqueHeaders)]: null
},
data: { value: [Object] }

} } [device-farm-main] AxiosError: Request failed with status code 400 at settle (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/settle.js:19:12) at IncomingMessage.handleStreamEnd (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/adapters/http.js:589:11) at IncomingMessage.emit (node:events:532:35) at endReadableNT (node:internal/streams/readable:1696:12) at processTicksAndRejections (node:internal/process/task_queues:82:21) at Axios.request (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/Axios.js:45:41) at processTicksAndRejections (node:internal/process/task_queues:95:5) [device-farm-main] Promise: Promise {

AxiosError: Request failed with status code 400 at settle (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/settle.js:19:12) at IncomingMessage.handleStreamEnd (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/adapters/http.js:589:11) at IncomingMessage.emit (node:events:532:35) at endReadableNT (node:internal/streams/readable:1696:12) at processTicksAndRejections (node:internal/process/task_queues:82:21) at Axios.request (/Users/USERID/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/Axios.js:45:41) at processTicksAndRejections (node:internal/process/task_queues:95:5) { code: 'ERR_BAD_REQUEST', config: { transitional: [Object], adapter: [Array], transformRequest: [Array], transformResponse: [Array], timeout: 60000, xsrfCookieName: 'XSRF-TOKEN', xsrfHeaderName: 'X-XSRF-TOKEN', maxContentLength: -1, maxBodyLength: -1, env: [Object], validateStatus: [Function: validateStatus], headers: [Object [AxiosHeaders]], method: 'post', url: 'http://127.0.0.1:4723/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions', data: '{"actions":[{"type":"pointer","id":"finger1","parameters":{"pointerType":"touch"},"actions":[{"type":"pointerMove","duration":0,"x":null,"y":null},{"type":"pointerDown","button":0},{"type":"pause","duration":0},{"type":"pointerMove","duration":100,"origin":"viewport","x":null,"y":null},{"type":"pointerUp","button":0}]}]}' }, request: ClientRequest { _events: [Object: null prototype], _eventsCount: 7, _maxListeners: undefined, outputData: [], outputSize: 0, writable: true, destroyed: true, _last: false, chunkedEncoding: false, shouldKeepAlive: true, maxRequestsOnConnectionReached: false, _defaultKeepAlive: true, useChunkedEncodingByDefault: true, sendDate: false, _removedConnection: false, _removedContLen: false, _removedTE: false, strictContentLength: false, _contentLength: '322', _hasBody: true, _trailer: '', finished: true, _headerSent: true, _closed: true, _header: 'POST /wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions HTTP/1.1\r\n' + 'Accept: application/json, text/plain, */*\r\n' + 'Content-Type: application/json\r\n' + 'User-Agent: axios/1.7.2\r\n' + 'Content-Length: 322\r\n' + 'Accept-Encoding: gzip, compress, deflate, br\r\n' + 'Host: 127.0.0.1:4723\r\n' + 'Connection: keep-alive\r\n' + '\r\n', _keepAliveTimeout: 0, _onPendingData: [Function: nop], agent: [Agent], socketPath: undefined, method: 'POST', maxHeaderSize: undefined, insecureHTTPParser: undefined, joinDuplicateHeaders: undefined, path: '/wd/hub/session/b91a2b42-1bb0-4732-9f2a-44073cc1ef17/actions', _ended: true, res: [IncomingMessage], aborted: false, timeoutCb: null, upgradeOrConnect: false, parser: null, maxHeadersCount: null, reusedSocket: false, host: '127.0.0.1', protocol: 'http:', _redirectable: [Writable], [Symbol(shapeMode)]: false, [Symbol(kCapture)]: false, [Symbol(kBytesWritten)]: 0, [Symbol(kNeedDrain)]: false, [Symbol(corked)]: 0, [Symbol(kChunkedBuffer)]: [], [Symbol(kChunkedLength)]: 0, [Symbol(kSocket)]: [Socket], [Symbol(kOutHeaders)]: [Object: null prototype], [Symbol(errored)]: null, [Symbol(kHighWaterMark)]: 65536, [Symbol(kRejectNonStandardBodyWrites)]: false, [Symbol(kUniqueHeaders)]: null }, response: { status: 400, statusText: 'Bad Request', headers: [Object [AxiosHeaders]], config: [Object], request: [ClientRequest], data: [Object] } } }
sudharsan-selvaraj commented 1 week ago

@SubbuLomada I would like to understand more about the issue.

  1. Is this issue only happening of remote devices?
  2. Were you able to see the live screen on the browser?
  3. Have checked behaviour on ios simulator/real device?

Could you also share me a screenshot of the browser with device screen loaded?

SubbuLomada commented 1 week ago
  1. Is this issue only happening of remote devices -- As of now i tried on remote only for Android device and able to see this issue in that
  2. Were you able to see the live screen on the browser? -- Able to see the live screen.. If i perform anything directly on the mobile device it is reflecting
  3. Have checked behaviour on ios simulator/real device? -- Tried on IOS simulator... It is same behaviour for Simulator IPADs but for iphone simulators it is having more delay.
SubbuLomada commented 1 week ago

Hi @sudharsan-selvaraj please find the attached screenshots ![Uploading IMG_9023.jpeg…]()

SubbuLomada commented 1 week ago

@saikrishna321

please find the below details

adb -s RZCW901OPDG shell wm size Physical size: 1440x3088 Override size: 1080x2316

saikrishna321 commented 1 week ago

@SubbuLomada We found the issue. We will release a fix today.

sudharsan-selvaraj commented 1 week ago

@SubbuLomada Issue is now fixed. Kindly update the device farm to 8.4.7-rc.46 and give it a try.

erdncyz commented 1 week ago

Hi @sudharsan-selvaraj

the problem is persist. I uploaded lastest version 8.4.7-rc.46

image

My gist : https://gist.github.com/erdncyz/eafeade66c15ee966657758643f0a96c

saikrishna321 commented 1 week ago

@erdncyz What is your issue?

erdncyz commented 1 week ago

@saikrishna321 I am encountering Axios error

Also you can see my gist.

/wd/hub/session 500 717 ms - 1154 [device-farm-main] Received error from remote node: {"message":"Request failed with status code 500","name":"AxiosError","stack":"AxiosError: Request failed with status code 500\n at settle (/Users/techqaautomation2/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/settle.js:19:12)\n at IncomingMessage.handleStreamEnd (/Users/techqaautomation2/.appium/node_modules/appium-device-farm/node_modules/axios/lib/adapters/http.js:589:11)\n at IncomingMessage.emit (node:events:531:35)\n at endReadableNT (node:internal/streams/readable:1696:12)\n at processTicksAndRejections (node:internal/process/task_queues:82:21)\n at Axios.request (/Users/techqaautomation2/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/Axios.js:45:41)\n at processTicksAndRejections (node:internal/process/task_queues:95:5)","config":{"transitional":{"silentJSONParsing":true,"forcedJSONParsing":true,"clarifyTimeoutError":false},"adapter":["xhr","http","fetch"],"transformRequest":[null],"transformResponse":[null],"timeout":260000,"xsrfCookieName":"XSRF-TOKEN","xsrfHeaderName":"X-XSRF-TOKEN","maxContentLength":-1,"maxBodyLength":-1,"env":{},"headers":{"Accept":"application/json, text/plain, /","Content-Type":"application/json","User-Agent":"axios/1.7.2","Content-Length":"565","Accept-Encoding":"gzip, compress, deflate, br"},"method":"post","url":"http://127.0.0.1:4723/wd/hub/session","data":"{\"capabilities\":{\"alwaysMatch\":{\"platformName\":\"android\",\"appium:automationName\":\"UIAutomator2\",\"appium:newCommandTimeout\":120,\"appium:waitForIdleTimeout\":10,\"appium:udid\":\"241ae3789b1c7ece\",\"df:skipReport\":true,\"appium:systemPort\":65004,\"appium:adbExecTimeout\":80000,\"appium:uiautomator2ServerLaunchTimeout\":60000},\"firstMatch\":[{}]},\"desiredCapabilities\":{\"platformName\":\"android\",\"appium:automationName\":\"UIAutomator2\",\"appium:newCommandTimeout\":120,\"appium:waitForIdleTimeout\":10,\"appium:udid\":\"241ae3789b1c7ece\",\"df:skipReport\":true,\"appium:systemPort\":65004}}"},"code":"ERR_BAD_RESPONSE","status":500}

AxiosError: Request failed with status code 404 at settle (/Users/techqaautomation2/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/settle.js:19:12) at IncomingMessage.handleStreamEnd (/Users/techqaautomation2/.appium/node_modules/appium-device-farm/node_modules/axios/lib/adapters/http.js:589:11) at IncomingMessage.emit (node:events:531:35) at endReadableNT (node:internal/streams/readable:1696:12) at processTicksAndRejections (node:internal/process/task_queues:82:21) at Axios.request (/Users/techqaautomation2/.appium/node_modules/appium-device-farm/node_modules/axios/lib/core/Axios.js:45:41) at processTicksAndRejections (node:internal/process/task_queues:95:5) { code: 'ERR_BAD_REQUEST', config: { transitional: { silentJSONParsing: true, forcedJSONParsing: true, clarifyTimeoutError: false }, adapter: [ 'xhr', 'http', 'fetch' ], transformRequest: [ [Function: transformRequest] ], transformResponse: [ [Function: transformResponse] ], timeout: 0, xsrfCookieName: 'XSRF-TOKEN', xsrfHeaderName: 'X-XSRF-TOKEN', maxContentLength: -1, maxBodyLength: -1, env: { FormData: [Function], Blob: [class Blob] }, validateStatus: [Function: validateStatus], headers: Object [AxiosHeaders] { Accept: 'application/json, text/plain, /', 'Content-Type': 'application/json', 'User-Agent': 'axios/1.7.2', 'Content-Length': '2', 'Accept-Encoding': 'gzip, compress, deflate, br' },

saikrishna321 commented 1 week ago

@erdncyz

We will handle these errors gracefully. How is this impacting the user side?

[AndroidUiautomator2Driver@1989] Shutting down because we waited 60 seconds for a command
[AppiumDriver@38ca] Ending session, cause was 'New Command Timeout of 60 seconds expired. Try customizing the timeout using the 'newCommandTimeout' desired capability'
[AppiumDriver@38ca] Plugin device-farm defines an unexpected shutdown handler; calling it now
[AppiumDriver@38ca] Removing session 'bf8bcd01-2b70-417f-a1da-85257e97872a' from our master session list

Delete session is called by the appium server as the command timeout. 

[AndroidUiautomator2Driver@1989] Proxying [DELETE /] to [DELETE http://127.0.0.1:59707/session/914efb31-b99e-4103-a5fa-9fb70a292cfe] with no body
[device-farm-main] Unblocking device mapped with filter {"session_id":"bf8bcd01-2b70-417f-a1da-85257e97872a","udid":"241ae3789b1c7ece"} onUnexpectedShutdown from server
erdncyz commented 1 week ago

@saikrishna321 hi thanks for your answer.

I made my latest updates and started the run in the regression environment and the device suddenly stops. I saw that I was getting Axios errors when I started it again and again during the run, I thought it was related to that. When I saw an Axios error in this issue, I wrote it here instead of opening a new one.

Also Additionally, whatever data or testing you need, I can provide you with any support 24/7.

saikrishna321 commented 1 week ago

@erdncyz thanks a lot for coming forward for help.

In your code there is a some test which is not sending any commands to server for 60s.

SubbuLomada commented 1 week ago

@saikrishna321 if we are passing newcommand timeout with 120 seconds in the capability will it change the behaviour or by default it will be only 60 seconds ?

saikrishna321 commented 1 week ago

It will change the command time thats appium's behaviour

SubbuLomada commented 1 week ago

Thank you @saikrishna321