Erro_Parallel

[device-farm] Fetching Android Devices
[debug] [ADB] Getting connected devices
[debug] [ADB] Connected devices: [{"udid":"emulator-5554","state":"device"}]
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.release'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.characteristics'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.product.name'
[device-farm] Android Devices found [{"busy":false,"state":"device","udid":"emulator-5554","platform":"android","sdk":"11","realDevice":false,"name":"sdk_phone_x86"}]
[device-farm] Fetching iOS Devices
[HTTP] --> POST /wd/hub/session
[HTTP] {"capabilities":{"alwaysMatch":{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"},"firstMatch":[{}]},"desiredCapabilities":{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"}}
[debug] [W3C] Calling AppiumDriver.createSession() with args: [{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"},null,{"alwaysMatch":{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"},"firstMatch":[{}]}]
[Appium] Plugins which can handle cmd 'createSession': device-farm (sessionless)
[Appium] Plugin device-farm (sessionless) is now handling cmd 'createSession'
CLI Args { Platform: 'Android' }
[device-farm] Finding Free Device for Platform android
[device-farm] Device UDID emulator-5554 is blocked for execution.
[Appium] Executing default handling behavior for command 'createSession'
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1635248614244 (17:13:34 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/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-driver
[Appium] Appium v2.0.0-beta.18 creating new AndroidUiautomator2Driver (v1.67.0) session
[Appium] Checking BaseDriver versions for Appium and AndroidUiautomator2Driver
[Appium] Appium's BaseDriver version is 8.1.1
[Appium] Could not determine AndroidUiautomator2Driver's BaseDriver version
[debug] [BaseDriver] W3C capabilities and MJSONWP desired capabilities were provided
[debug] [BaseDriver] Creating session with W3C capabilities: {
[debug] [BaseDriver]   "alwaysMatch": {
[debug] [BaseDriver]     "platformName": "Android",
[debug] [BaseDriver]     "appium:uiautomator2ServerInstallTimeout": "50000",
[debug] [BaseDriver]     "appium:automationName": "UIAutomator2",
[debug] [BaseDriver]     "appium:app": "/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk",
[debug] [BaseDriver]     "appium:udid": "emulator-5554",
[debug] [BaseDriver]     "appium:deviceName": "emulator-5554",
[debug] [BaseDriver]     "appium:systemPort": 61984,
[debug] [BaseDriver]     "appium:chromeDriverPort": 61985
[debug] [BaseDriver]   },
[debug] [BaseDriver]   "firstMatch": [
[debug] [BaseDriver]     {}
[debug] [BaseDriver]   ]
[debug] [BaseDriver] }
[BaseDriver] Number capability passed in as string. Functionality may be compromised.
[BaseDriver] Capability 'uiautomator2ServerInstallTimeout' changed from string ('50000') to integer (50000). This may cause unexpected behavior
[BaseDriver] Session created with session id: 32bd4b1e-cecd-4709-a12c-d57b0394d2e4
[HTTP] --> POST /wd/hub/session
[HTTP] {"capabilities":{"alwaysMatch":{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"},"firstMatch":[{}]},"desiredCapabilities":{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"}}
[debug] [W3C] Calling AppiumDriver.createSession() with args: [{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"},null,{"alwaysMatch":{"platformName":"Android","appium:uiautomator2ServerInstallTimeout":"50000","appium:automationName":"UIAutomator2","appium:app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk"},"firstMatch":[{}]}]
[Appium] Plugins which can handle cmd 'createSession': device-farm (sessionless)
[Appium] Plugin device-farm (sessionless) is now handling cmd 'createSession'
CLI Args { Platform: 'Android' }
[device-farm] Finding Free Device for Platform android
[device-farm] Waiting for free device
[device-farm] Finding Free Device for Platform android
[BaseDriver] Using local app '/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk'
[debug] [UiAutomator2] Checking whether app is actually present
[ADB] Using 'adb' from '/Users/saikrisv/Library/Android/sdk/platform-tools/adb'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 start-server'
[AndroidDriver] Retrieving device list
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices
[debug] [ADB] Connected devices: [{"udid":"emulator-5554","state":"device"}]
[AndroidDriver] Using device: emulator-5554
[ADB] Using 'adb' from '/Users/saikrisv/Library/Android/sdk/platform-tools/adb'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 start-server'
[debug] [ADB] Setting device id to emulator-5554
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.sdk'
[debug] [ADB] Current device property 'ro.build.version.sdk': 30
[ADB] Getting device platform version
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.release'
[debug] [ADB] Current device property 'ro.build.version.release': 11
[debug] [ADB] Device API level: 30
[UiAutomator2] Relaxing hidden api policy
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 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''
[debug] [AndroidDriver] Parsing package and activity from app manifest
[ADB] Package name: 'com.vodqareactnative'
[ADB] Main activity name: 'com.vodqareactnative.MainActivity'
[debug] [AndroidDriver] Parsed package and activity are: com.vodqareactnative/com.vodqareactnative.MainActivity
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 wait-for-device'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell echo ping'
[debug] [AndroidDriver] Pushing settings apk to device...
[debug] [ADB] Getting install status for io.appium.settings
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings'
[debug] [ADB] 'io.appium.settings' is installed
[debug] [ADB] Getting package info for 'io.appium.settings'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings'
[debug] [ADB] The version name of the installed 'io.appium.settings' is greater or equal to the application version name ('3.3.0' >= '3.3.0')
[debug] [ADB] There is no need to install/upgrade '/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/io.appium.settings/apks/settings_apk-debug.apk'
[debug] [ADB] Getting IDs of all 'io.appium.settings' processes
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell 'pgrep --help; echo $?''
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pgrep -f \(\[\[:blank:\]\]\|\^\)io\.appium\.settings\(\[\[:blank:\]\]\|\$\)'
[debug] [AndroidDriver] io.appium.settings is already running. There is no need to reset its permissions.
[debug] [Logcat] Starting logs capture with command: /Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 logcat -v threadtime
[debug] [UiAutomator2] Forwarding UiAutomator2 Server port 6790 to local port 61984
[debug] [ADB] Forwarding system: 61984 to device: 6790
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 forward tcp:61984 tcp:6790'
[debug] [ADB] Getting install status for io.appium.uiautomator2.server
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server'
[debug] [ADB] 'io.appium.uiautomator2.server' is installed
[debug] [ADB] Getting package info for 'io.appium.uiautomator2.server'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server'
[debug] [ADB] The version name of the installed 'io.appium.uiautomator2.server' is greater or equal to the application version name ('4.23.2' >= '4.23.2')
[debug] [UiAutomator2] io.appium.uiautomator2.server installation state: sameVersionInstalled
[debug] [ADB] Checking app cert for /Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.23.2.apk
[debug] [ADB] Using the previously cached signature entry for 'appium-uiautomator2-server-v4.23.2.apk'
[debug] [ADB] sha256 hash did match for 'appium-uiautomator2-server-v4.23.2.apk'
[debug] [ADB] Getting install status for io.appium.uiautomator2.server.test
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server.test'
[debug] [ADB] 'io.appium.uiautomator2.server.test' is installed
[debug] [ADB] Checking app cert for /Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk
[debug] [ADB] Using the previously cached signature entry for 'appium-uiautomator2-server-debug-androidTest.apk'
[debug] [ADB] sha256 hash did match for 'appium-uiautomator2-server-debug-androidTest.apk'
[UiAutomator2] Server packages are not going to be (re)installed
[debug] [UiAutomator2] Waiting up to 30000ms for services to be available
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pm list instrumentation'
[debug] [UiAutomator2] 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
[debug] [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",";"]]
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys deviceidle whitelist +io.appium.settings ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server.test ;'
[debug] [ADB] Checking app cert for /Users/saikrisv/Documents/git/AppiumSample/VodQA.apk
[debug] [ADB] Using the previously cached signature entry for 'VodQA.apk'
[debug] [ADB] Getting install status for com.vodqareactnative
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package com.vodqareactnative'
[debug] [ADB] 'com.vodqareactnative' is installed
[debug] [ADB] Getting package info for 'com.vodqareactnative'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package com.vodqareactnative'
[debug] [ADB] The version name of the installed 'com.vodqareactnative' is greater or equal to the application version name ('1.0.0' >= '1.0.0')
[debug] [ADB] There is no need to install/upgrade '/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk'
[AndroidDriver] Performing fast reset on 'com.vodqareactnative'
[debug] [ADB] Getting install status for com.vodqareactnative
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package com.vodqareactnative'
[debug] [ADB] 'com.vodqareactnative' is installed
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop com.vodqareactnative'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pm clear com.vodqareactnative'
[debug] [AndroidDriver] Performed fast reset on the installed 'com.vodqareactnative' application (stop and clear)
[debug] [UiAutomator2] Performing shallow cleanup of automation leftovers
[debug] [UiAutomator2] No obsolete sessions have been detected (socket hang up)
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test'
[UiAutomator2] Starting UIAutomator2 server 4.23.2
[UiAutomator2] Using UIAutomator2 server from '/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.23.2.apk' and test from '/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk'
[UiAutomator2] Waiting up to 30000ms for UiAutomator2 to be online...
[debug] [ADB] Creating ADB subprocess with args: ["-P",5037,"-s","emulator-5554","shell","am","instrument","-w","-e","disableAnalytics",true,"io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"]
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:61984/wd/hub/status] with no body
[WD Proxy] socket hang up
[debug] [Instrumentation] io.appium.uiautomator2.server.test.AppiumUiAutomator2Server:
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:61984/wd/hub/status] with no body
[WD Proxy] socket hang up
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:61984/wd/hub/status] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"None","value":{"message":"UiAutomator2 Server is ready to accept commands","ready":true}}
[debug] [UiAutomator2] The initialization of the instrumentation process took 2158ms
[debug] [WD Proxy] Matched '/session' to command name 'createSession'
[debug] [WD Proxy] Proxying [POST /session] to [POST http://127.0.0.1:61984/wd/hub/session] with body: {"capabilities":{"firstMatch":[{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":61984,"chromeDriverPort":61985},"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":61984,"chromeDriverPort":61985,"deviceUDID":"emulator-5554","appPackage":"com.vodqareactnative"}],"alwaysMatch":{}}}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":{"capabilities":{"firstMatch":[{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":61984,"chromeDriverPort":61985},"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":61984,"chromeDriverPort":61985,"deviceUDID":"emulator-5554","appPackage":"com.vodqareactnative"}],"alwaysMatch":{}},"sessionId":"352e7655-388a-45c2-b08b-da10de260c49"}}
[WD Proxy] Determined the downstream protocol as 'W3C'
[debug] [WD Proxy] Proxying [GET /appium/device/info] to [GET http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/appium/device/info] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":{"androidId":"85c74e10ab1e755c","apiVersion":"30","bluetooth":{"state":"ON"},"brand":"Android","carrierName":"Android","displayDensity":560,"locale":"en_US","manufacturer":"unknown","model":"Android SDK built for x86","networks":[{"capabilities":{"SSID":null,"linkDownBandwidthKbps":30000,"linkUpstreamBandwidthKbps":15000,"networkCapabilities":"NET_CAPABILITY_MMS,NET_CAPABILITY_SUPL,NET_CAPABILITY_DUN,NET_CAPABILITY_FOTA,NET_CAPABILITY_IMS,NET_CAPABILITY_CBS,NET_CAPABILITY_INTERNET,NET_CAPABILITY_NOT_RESTRICTED,NET_CAPABILITY_TRUSTED,NET_CAPABILITY_NOT_VPN,NET_CAPABILITY_VALIDATED,NET_CAPABILITY_NOT_ROAMING,NET_CAPABILITY_NOT_CONGESTED,NET_CAPABILITY_NOT_SUSPENDED","signalStrength":-2147483648,"transportTypes":"TRANSPORT_CELLULAR"},"detailedState":"CONNECTED","extraInfo":"epc.tmobile.com","isAvailable":true,"isConnected":true,"isFailover":false,"isRoaming":false,"state":"CONNECTED","subtype":13,"subtypeName":"LTE","type":0,"typeName":"MOBILE"},{"ca...
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys window'
[AndroidDriver] Screen already unlocked, doing nothing
[UiAutomator2] Starting 'com.vodqareactnative/com.vodqareactnative.MainActivity and waiting for 'com.vodqareactnative/com.vodqareactnative.MainActivity'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am start -W -n com.vodqareactnative/com.vodqareactnative.MainActivity -S'
[debug] [ADB] Waiting up to 20000ms for activity matching pkg: 'com.vodqareactnative' and activity: 'com.vodqareactnative.MainActivity' to be focused
[debug] [ADB] Possible activities, to be checked: 'com.vodqareactnative.MainActivity', 'com.vodqareactnative.com.vodqareactnative.MainActivity'
[debug] [ADB] Getting focused package and activity
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys window displays'
[debug] [ADB] Found package: 'com.vodqareactnative' and fully qualified activity name : 'com.vodqareactnative.MainActivity'
[debug] [WD Proxy] Proxying [GET /appium/device/pixel_ratio] to [GET http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/appium/device/pixel_ratio] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":3.5}
[debug] [WD Proxy] Matched '/appium/device/system_bars' to command name 'getSystemBars'
[debug] [WD Proxy] Proxying [GET /appium/device/system_bars] to [GET http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/appium/device/system_bars] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":{"statusBar":84}}
[debug] [WD Proxy] Matched '/window/current/size' to command name 'getWindowSize'
[debug] [WD Proxy] Proxying [GET /window/current/size] to [GET http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/window/current/size] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":{"height":2392,"width":1440}}
[Appium] New AndroidUiautomator2Driver session created successfully, session 32bd4b1e-cecd-4709-a12c-d57b0394d2e4 added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1635248618371 (17:13:38 GMT+0530 (India Standard Time))
[debug] [W3C (32bd4b1e)] Cached the protocol value 'W3C' for the new session 32bd4b1e-cecd-4709-a12c-d57b0394d2e4
[debug] [W3C (32bd4b1e)] Responding to client with driver.createSession() result: {"capabilities":{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":61984,"chromeDriverPort":61985},"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":61984,"chromeDriverPort":61985,"deviceUDID":"emulator-5554","appPackage":"com.vodqareactnative","deviceApiLevel":30,"platformVersion":"11","deviceScreenSize":"1440x2560","deviceScreenDensity":560,"deviceModel":"Android SDK built for x86","deviceManufacturer":"unknown","pixelRatio":3.5,"statBarHeight":84,"viewportRect"...
[HTTP] <-- POST /wd/hub/session 200 4136 ms - 1131
[HTTP]
[HTTP] --> POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/element
[HTTP] {"using":"accessibility id","value":"login1"}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.findElement() with args: ["accessibility id","login1","32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[debug] [Appium] Set CLI arguments on device-farm plugin instance: {"Platform":"Android"}
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/element' to command name 'findElement'
[debug] [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/element] with body: {"strategy":"accessibility id","selector":"login1","context":"","multiple":false}
[WD Proxy] Got response with status 404: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":{"error":"no such element","message":"An element could not be located on the page using the given search parameters","stacktrace":"io.appium.uiautomator2.common.exceptions.ElementNotFoundException: An element could not be located on the page using the given search parameters\n\tat io.appium.uiautomator2.handler.FindElement.safeHandle(FindElement.java:67)\n\tat io.appium.uiautomator2.handler.request.SafeRequestHandler.handle(SafeRequestHandler.java:59)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleRequest(AppiumServlet.java:264)\n\tat io.appium.uiautomator2.server.AppiumServlet.handleHttpRequest(AppiumServlet.java:258)\n\tat io.appium.uiautomator2.http.ServerHandler.channelRead(ServerHandler.java:68)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:366)\n\tat io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:352)\n\tat io.netty.chann...
[debug] [W3C] Matched W3C error code 'no such element' to NoSuchElementError
[debug] [W3C (32bd4b1e)] Encountered internal error running command: NoSuchElementError: An element could not be located on the page using the given search parameters.
[debug] [W3C (32bd4b1e)]     at AndroidUiautomator2Driver.findElOrEls (/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-android-driver/lib/commands/find.js:75:11)
[debug] [W3C (32bd4b1e)]     at runMicrotasks (<anonymous>)
[debug] [W3C (32bd4b1e)]     at processTicksAndRejections (node:internal/process/task_queues:96:5)
[debug] [W3C (32bd4b1e)]     at AndroidUiautomator2Driver.findElOrElsWithProcessing (/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-base-driver/lib/basedriver/commands/find.js:33:12)
[debug] [W3C (32bd4b1e)]     at AndroidUiautomator2Driver.findElement (/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-base-driver/lib/basedriver/commands/find.js:53:10)
[HTTP] <-- POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/element 404 884 ms - 866
[HTTP]
[HTTP] --> POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements
[HTTP] {"using":"accessibility id","value":"login1"}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.findElements() with args: ["accessibility id","login1","32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/elements' to command name 'findElements'
[debug] [WD Proxy] Proxying [POST /elements] to [POST http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/elements] with body: {"strategy":"accessibility id","selector":"login1","context":"","multiple":true}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":[]}
[debug] [W3C (32bd4b1e)] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements 200 493 ms - 12
[HTTP]
[HTTP] --> POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements
[HTTP] {"using":"accessibility id","value":"login1"}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.findElements() with args: ["accessibility id","login1","32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/elements' to command name 'findElements'
[debug] [WD Proxy] Proxying [POST /elements] to [POST http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/elements] with body: {"strategy":"accessibility id","selector":"login1","context":"","multiple":true}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":[]}
[debug] [W3C (32bd4b1e)] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements 200 32 ms - 12
[HTTP]
[device-farm] Fetching Android Devices
[debug] [ADB] Getting connected devices
[debug] [ADB] Connected devices: [{"udid":"emulator-5554","state":"device"}]
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.release'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.characteristics'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.product.name'
[device-farm] Android Devices found [{"busy":false,"state":"device","udid":"emulator-5554","platform":"android","sdk":"11","realDevice":false,"name":"sdk_phone_x86"}]
[device-farm] Fetching iOS Devices
[HTTP] --> POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements
[HTTP] {"using":"accessibility id","value":"login1"}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.findElements() with args: ["accessibility id","login1","32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/elements' to command name 'findElements'
[debug] [WD Proxy] Proxying [POST /elements] to [POST http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/elements] with body: {"strategy":"accessibility id","selector":"login1","context":"","multiple":true}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":[]}
[debug] [W3C (32bd4b1e)] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements 200 1104 ms - 12
[HTTP]
[HTTP] --> POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements
[HTTP] {"using":"accessibility id","value":"login1"}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.findElements() with args: ["accessibility id","login1","32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/elements' to command name 'findElements'
[debug] [WD Proxy] Proxying [POST /elements] to [POST http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/elements] with body: {"strategy":"accessibility id","selector":"login1","context":"","multiple":true}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":[]}
[debug] [W3C (32bd4b1e)] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements 200 41 ms - 12
[HTTP]
[HTTP] --> POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements
[HTTP] {"using":"accessibility id","value":"login1"}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.findElements() with args: ["accessibility id","login1","32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/elements' to command name 'findElements'
[debug] [WD Proxy] Proxying [POST /elements] to [POST http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/elements] with body: {"strategy":"accessibility id","selector":"login1","context":"","multiple":true}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":[]}
[debug] [W3C (32bd4b1e)] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements 200 38 ms - 12
[HTTP]
[HTTP] --> POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements
[HTTP] {"using":"accessibility id","value":"login1"}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.findElements() with args: ["accessibility id","login1","32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/elements' to command name 'findElements'
[debug] [WD Proxy] Proxying [POST /elements] to [POST http://127.0.0.1:61984/wd/hub/session/352e7655-388a-45c2-b08b-da10de260c49/elements] with body: {"strategy":"accessibility id","selector":"login1","context":"","multiple":true}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"352e7655-388a-45c2-b08b-da10de260c49","value":[]}
[debug] [W3C (32bd4b1e)] Responding to client with driver.findElements() result: []
[HTTP] <-- POST /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4/elements 200 48 ms - 12
[HTTP]
[HTTP] --> DELETE /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4
[HTTP] {}
[debug] [W3C (32bd4b1e)] Calling AppiumDriver.deleteSession() with args: ["32bd4b1e-cecd-4709-a12c-d57b0394d2e4"]
[Appium] Plugins which can handle cmd 'deleteSession': device-farm (sessionless)
[Appium] Plugin device-farm (sessionless) is now handling cmd 'deleteSession'
Delete Session 32bd4b1e-cecd-4709-a12c-d57b0394d2e4
[Appium] Command 'deleteSession' was not handled by the following beahviors or plugins, even though they were registered to handle it: ["default"]. The command *was* handled by these: ["device-farm (sessionless)"].
[debug] [W3C (32bd4b1e)] Encountered internal error running command: TypeError: Cannot read property 'udid' of undefined
[debug] [W3C (32bd4b1e)]     at DevicePlugin.<anonymous> (/Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:81:76)
[debug] [W3C (32bd4b1e)]     at Generator.next (<anonymous>)
[debug] [W3C (32bd4b1e)]     at /Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:8:71
[debug] [W3C (32bd4b1e)]     at new Promise (<anonymous>)
[debug] [W3C (32bd4b1e)]     at __awaiter (/Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:4:12)
[debug] [W3C (32bd4b1e)]     at DevicePlugin.deleteSession (/Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:78:16)
[debug] [W3C (32bd4b1e)]     at wrappedCmd (/usr/local/lib/node_modules/appium/lib/appium.js:539:24)
[debug] [W3C (32bd4b1e)]     at AppiumDriver.executeWrappedCommand (/usr/local/lib/node_modules/appium/lib/appium.js:571:22)
[debug] [W3C (32bd4b1e)]     at AppiumDriver.executeCommand (/usr/local/lib/node_modules/appium/lib/appium.js:515:28)
[debug] [W3C (32bd4b1e)]     at asyncHandler (/usr/local/lib/node_modules/appium/node_modules/@appium/base-driver/lib/protocol/protocol.js:287:34)
[debug] [W3C (32bd4b1e)]     at /usr/local/lib/node_modules/appium/node_modules/@appium/base-driver/lib/protocol/protocol.js:413:15
[debug] [W3C (32bd4b1e)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (32bd4b1e)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/route.js:137:13)
[debug] [W3C (32bd4b1e)]     at Route.dispatch (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/route.js:112:3)
[debug] [W3C (32bd4b1e)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (32bd4b1e)]     at /usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:281:22
[debug] [W3C (32bd4b1e)]     at param (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:354:14)
[debug] [W3C (32bd4b1e)]     at param (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:365:14)
[debug] [W3C (32bd4b1e)]     at Function.process_params (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:410:3)
[debug] [W3C (32bd4b1e)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:275:10)
[debug] [W3C (32bd4b1e)]     at logger (/usr/local/lib/node_modules/appium/node_modules/morgan/index.js:144:5)
[debug] [W3C (32bd4b1e)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (32bd4b1e)]     at trim_prefix (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:317:13)
[debug] [W3C (32bd4b1e)]     at /usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:284:7
[debug] [W3C (32bd4b1e)]     at Function.process_params (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:335:12)
[debug] [W3C (32bd4b1e)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:275:10)
[debug] [W3C (32bd4b1e)]     at jsonParser (/usr/local/lib/node_modules/appium/node_modules/body-parser/lib/types/json.js:110:7)
[debug] [W3C (32bd4b1e)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (32bd4b1e)]     at trim_prefix (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:317:13)
[debug] [W3C (32bd4b1e)]     at /usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:284:7
[debug] [W3C (32bd4b1e)]     at Function.process_params (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:335:12)
[debug] [W3C (32bd4b1e)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:275:10)
[debug] [W3C (32bd4b1e)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:91:12)
[debug] [W3C (32bd4b1e)]     at trim_prefix (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:317:13)
[HTTP] <-- DELETE /wd/hub/session/32bd4b1e-cecd-4709-a12c-d57b0394d2e4 500 63 ms - 690
[HTTP]
[device-farm] Waiting for free device
[device-farm] Finding Free Device for Platform android
[device-farm] Device UDID emulator-5554 is blocked for execution.
[Appium] Executing default handling behavior for command 'createSession'
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1635248624262 (17:13:44 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/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-driver
[Appium] Appium v2.0.0-beta.18 creating new AndroidUiautomator2Driver (v1.67.0) session
[Appium] Checking BaseDriver versions for Appium and AndroidUiautomator2Driver
[Appium] Appium's BaseDriver version is 8.1.1
[Appium] Could not determine AndroidUiautomator2Driver's BaseDriver version
[debug] [BaseDriver] W3C capabilities and MJSONWP desired capabilities were provided
[debug] [BaseDriver] Creating session with W3C capabilities: {
[debug] [BaseDriver]   "alwaysMatch": {
[debug] [BaseDriver]     "platformName": "Android",
[debug] [BaseDriver]     "appium:uiautomator2ServerInstallTimeout": "50000",
[debug] [BaseDriver]     "appium:automationName": "UIAutomator2",
[debug] [BaseDriver]     "appium:app": "/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk",
[debug] [BaseDriver]     "appium:udid": "emulator-5554",
[debug] [BaseDriver]     "appium:deviceName": "emulator-5554",
[debug] [BaseDriver]     "appium:systemPort": 62092,
[debug] [BaseDriver]     "appium:chromeDriverPort": 62093
[debug] [BaseDriver]   },
[debug] [BaseDriver]   "firstMatch": [
[debug] [BaseDriver]     {}
[debug] [BaseDriver]   ]
[debug] [BaseDriver] }
[BaseDriver] Number capability passed in as string. Functionality may be compromised.
[BaseDriver] Capability 'uiautomator2ServerInstallTimeout' changed from string ('50000') to integer (50000). This may cause unexpected behavior
[BaseDriver] Session created with session id: 7d4fcbb9-7277-4257-9fa3-4a047aed662f
[BaseDriver] Using local app '/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk'
[debug] [UiAutomator2] Checking whether app is actually present
[ADB] Using 'adb' from '/Users/saikrisv/Library/Android/sdk/platform-tools/adb'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 start-server'
[AndroidDriver] Retrieving device list
[debug] [ADB] Trying to find a connected android device
[debug] [ADB] Getting connected devices
[debug] [ADB] Connected devices: [{"udid":"emulator-5554","state":"device"}]
[AndroidDriver] Using device: emulator-5554
[ADB] Using 'adb' from '/Users/saikrisv/Library/Android/sdk/platform-tools/adb'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 start-server'
[debug] [ADB] Setting device id to emulator-5554
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.sdk'
[debug] [ADB] Current device property 'ro.build.version.sdk': 30
[ADB] Getting device platform version
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.release'
[debug] [ADB] Current device property 'ro.build.version.release': 11
[debug] [ADB] Device API level: 30
[UiAutomator2] Relaxing hidden api policy
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 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''
[debug] [AndroidDriver] Parsing package and activity from app manifest
[ADB] Package name: 'com.vodqareactnative'
[ADB] Main activity name: 'com.vodqareactnative.MainActivity'
[debug] [AndroidDriver] Parsed package and activity are: com.vodqareactnative/com.vodqareactnative.MainActivity
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 wait-for-device'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell echo ping'
[debug] [AndroidDriver] Pushing settings apk to device...
[debug] [ADB] Getting install status for io.appium.settings
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings'
[debug] [ADB] 'io.appium.settings' is installed
[debug] [ADB] Getting package info for 'io.appium.settings'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings'
[debug] [ADB] The version name of the installed 'io.appium.settings' is greater or equal to the application version name ('3.3.0' >= '3.3.0')
[debug] [ADB] There is no need to install/upgrade '/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/io.appium.settings/apks/settings_apk-debug.apk'
[debug] [ADB] Getting IDs of all 'io.appium.settings' processes
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell 'pgrep --help; echo $?''
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pgrep -f \(\[\[:blank:\]\]\|\^\)io\.appium\.settings\(\[\[:blank:\]\]\|\$\)'
[debug] [AndroidDriver] io.appium.settings is already running. There is no need to reset its permissions.
[debug] [Logcat] Starting logs capture with command: /Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 logcat -v threadtime
[debug] [UiAutomator2] Forwarding UiAutomator2 Server port 6790 to local port 62092
[debug] [ADB] Forwarding system: 62092 to device: 6790
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 forward tcp:62092 tcp:6790'
[debug] [ADB] Getting install status for io.appium.uiautomator2.server
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server'
[debug] [ADB] 'io.appium.uiautomator2.server' is installed
[debug] [ADB] Getting package info for 'io.appium.uiautomator2.server'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server'
[debug] [ADB] The version name of the installed 'io.appium.uiautomator2.server' is greater or equal to the application version name ('4.23.2' >= '4.23.2')
[debug] [UiAutomator2] io.appium.uiautomator2.server installation state: sameVersionInstalled
[debug] [ADB] Checking app cert for /Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.23.2.apk
[debug] [ADB] Using the previously cached signature entry for 'appium-uiautomator2-server-v4.23.2.apk'
[debug] [ADB] sha256 hash did match for 'appium-uiautomator2-server-v4.23.2.apk'
[debug] [ADB] Getting install status for io.appium.uiautomator2.server.test
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server.test'
[debug] [ADB] 'io.appium.uiautomator2.server.test' is installed
[debug] [ADB] Checking app cert for /Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk
[debug] [ADB] Using the previously cached signature entry for 'appium-uiautomator2-server-debug-androidTest.apk'
[debug] [ADB] sha256 hash did match for 'appium-uiautomator2-server-debug-androidTest.apk'
[UiAutomator2] Server packages are not going to be (re)installed
[debug] [UiAutomator2] Waiting up to 30000ms for services to be available
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pm list instrumentation'
[debug] [UiAutomator2] 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
[debug] [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",";"]]
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys deviceidle whitelist +io.appium.settings ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server ; dumpsys deviceidle whitelist +io.appium.uiautomator2.server.test ;'
[debug] [ADB] Checking app cert for /Users/saikrisv/Documents/git/AppiumSample/VodQA.apk
[debug] [ADB] Using the previously cached signature entry for 'VodQA.apk'
[debug] [ADB] Getting install status for com.vodqareactnative
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package com.vodqareactnative'
[debug] [ADB] 'com.vodqareactnative' is installed
[debug] [ADB] Getting package info for 'com.vodqareactnative'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package com.vodqareactnative'
[debug] [ADB] The version name of the installed 'com.vodqareactnative' is greater or equal to the application version name ('1.0.0' >= '1.0.0')
[debug] [ADB] There is no need to install/upgrade '/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk'
[AndroidDriver] Performing fast reset on 'com.vodqareactnative'
[debug] [ADB] Getting install status for com.vodqareactnative
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package com.vodqareactnative'
[debug] [ADB] 'com.vodqareactnative' is installed
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop com.vodqareactnative'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pm clear com.vodqareactnative'
[debug] [AndroidDriver] Performed fast reset on the installed 'com.vodqareactnative' application (stop and clear)
[debug] [UiAutomator2] Performing shallow cleanup of automation leftovers
[debug] [UiAutomator2] The following obsolete sessions are still running: ["352e7655-388a-45c2-b08b-da10de260c49"]
[debug] [UiAutomator2] Cleaning up 1 obsolete session
[debug] [Instrumentation] .
[debug] [Instrumentation] Time: 10.095
[debug] [Instrumentation]
[debug] [Instrumentation] OK (1 test)
[debug] [Instrumentation] The process has exited with code 0
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test'
[UiAutomator2] Starting UIAutomator2 server 4.23.2
[UiAutomator2] Using UIAutomator2 server from '/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-v4.23.2.apk' and test from '/Users/saikrisv/.appium/appium-uiautomator2-driver/node_modules/appium-uiautomator2-server/apks/appium-uiautomator2-server-debug-androidTest.apk'
[UiAutomator2] Waiting up to 30000ms for UiAutomator2 to be online...
[debug] [ADB] Creating ADB subprocess with args: ["-P",5037,"-s","emulator-5554","shell","am","instrument","-w","-e","disableAnalytics",true,"io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"]
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:62092/wd/hub/status] with no body
[WD Proxy] socket hang up
[debug] [Instrumentation] io.appium.uiautomator2.server.test.AppiumUiAutomator2Server:
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:62092/wd/hub/status] with no body
[WD Proxy] socket hang up
[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:62092/wd/hub/status] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"None","value":{"message":"UiAutomator2 Server is ready to accept commands","ready":true}}
[debug] [UiAutomator2] The initialization of the instrumentation process took 2148ms
[debug] [WD Proxy] Matched '/session' to command name 'createSession'
[debug] [WD Proxy] Proxying [POST /session] to [POST http://127.0.0.1:62092/wd/hub/session] with body: {"capabilities":{"firstMatch":[{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":62092,"chromeDriverPort":62093},"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":62092,"chromeDriverPort":62093,"deviceUDID":"emulator-5554","appPackage":"com.vodqareactnative"}],"alwaysMatch":{}}}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b","value":{"capabilities":{"firstMatch":[{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":62092,"chromeDriverPort":62093},"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":62092,"chromeDriverPort":62093,"deviceUDID":"emulator-5554","appPackage":"com.vodqareactnative"}],"alwaysMatch":{}},"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b"}}
[WD Proxy] Determined the downstream protocol as 'W3C'
[debug] [WD Proxy] Proxying [GET /appium/device/info] to [GET http://127.0.0.1:62092/wd/hub/session/688ed625-e088-42cf-8a37-7e877ec0a82b/appium/device/info] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b","value":{"androidId":"85c74e10ab1e755c","apiVersion":"30","bluetooth":{"state":"ON"},"brand":"Android","carrierName":"Android","displayDensity":560,"locale":"en_US","manufacturer":"unknown","model":"Android SDK built for x86","networks":[{"capabilities":{"SSID":null,"linkDownBandwidthKbps":30000,"linkUpstreamBandwidthKbps":15000,"networkCapabilities":"NET_CAPABILITY_MMS,NET_CAPABILITY_SUPL,NET_CAPABILITY_DUN,NET_CAPABILITY_FOTA,NET_CAPABILITY_IMS,NET_CAPABILITY_CBS,NET_CAPABILITY_INTERNET,NET_CAPABILITY_NOT_RESTRICTED,NET_CAPABILITY_TRUSTED,NET_CAPABILITY_NOT_VPN,NET_CAPABILITY_VALIDATED,NET_CAPABILITY_NOT_ROAMING,NET_CAPABILITY_NOT_CONGESTED,NET_CAPABILITY_NOT_SUSPENDED","signalStrength":-2147483648,"transportTypes":"TRANSPORT_CELLULAR"},"detailedState":"CONNECTED","extraInfo":"epc.tmobile.com","isAvailable":true,"isConnected":true,"isFailover":false,"isRoaming":false,"state":"CONNECTED","subtype":13,"subtypeName":"LTE","type":0,"typeName":"MOBILE"},{"ca...
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys window'
[AndroidDriver] Screen already unlocked, doing nothing
[UiAutomator2] Starting 'com.vodqareactnative/com.vodqareactnative.MainActivity and waiting for 'com.vodqareactnative/com.vodqareactnative.MainActivity'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am start -W -n com.vodqareactnative/com.vodqareactnative.MainActivity -S'
[debug] [ADB] Waiting up to 20000ms for activity matching pkg: 'com.vodqareactnative' and activity: 'com.vodqareactnative.MainActivity' to be focused
[debug] [ADB] Possible activities, to be checked: 'com.vodqareactnative.MainActivity', 'com.vodqareactnative.com.vodqareactnative.MainActivity'
[debug] [ADB] Getting focused package and activity
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys window displays'
[debug] [ADB] Found package: 'com.vodqareactnative' and fully qualified activity name : 'com.vodqareactnative.MainActivity'
[debug] [WD Proxy] Proxying [GET /appium/device/pixel_ratio] to [GET http://127.0.0.1:62092/wd/hub/session/688ed625-e088-42cf-8a37-7e877ec0a82b/appium/device/pixel_ratio] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b","value":3.5}
[debug] [WD Proxy] Matched '/appium/device/system_bars' to command name 'getSystemBars'
[debug] [WD Proxy] Proxying [GET /appium/device/system_bars] to [GET http://127.0.0.1:62092/wd/hub/session/688ed625-e088-42cf-8a37-7e877ec0a82b/appium/device/system_bars] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b","value":{"statusBar":84}}
[debug] [WD Proxy] Matched '/window/current/size' to command name 'getWindowSize'
[debug] [WD Proxy] Proxying [GET /window/current/size] to [GET http://127.0.0.1:62092/wd/hub/session/688ed625-e088-42cf-8a37-7e877ec0a82b/window/current/size] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b","value":{"height":2392,"width":1440}}
[Appium] New AndroidUiautomator2Driver session created successfully, session 7d4fcbb9-7277-4257-9fa3-4a047aed662f added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1635248629400 (17:13:49 GMT+0530 (India Standard Time))
[debug] [W3C (7d4fcbb9)] Cached the protocol value 'W3C' for the new session 7d4fcbb9-7277-4257-9fa3-4a047aed662f
[debug] [W3C (7d4fcbb9)] Responding to client with driver.createSession() result: {"capabilities":{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":62092,"chromeDriverPort":62093},"platformName":"Android","uiautomator2ServerInstallTimeout":50000,"automationName":"UIAutomator2","app":"/Users/saikrisv/Documents/git/AppiumSample/VodQA.apk","udid":"emulator-5554","deviceName":"emulator-5554","systemPort":62092,"chromeDriverPort":62093,"deviceUDID":"emulator-5554","appPackage":"com.vodqareactnative","deviceApiLevel":30,"platformVersion":"11","deviceScreenSize":"1440x2560","deviceScreenDensity":560,"deviceModel":"Android SDK built for x86","deviceManufacturer":"unknown","pixelRatio":3.5,"statBarHeight":84,"viewportRect"...
[HTTP] <-- POST /wd/hub/session 200 15144 ms - 1131
[HTTP]
[HTTP] --> POST /wd/hub/session/7d4fcbb9-7277-4257-9fa3-4a047aed662f/element
[HTTP] {"using":"accessibility id","value":"login"}
[debug] [W3C (7d4fcbb9)] Calling AppiumDriver.findElement() with args: ["accessibility id","login","7d4fcbb9-7277-4257-9fa3-4a047aed662f"]
[debug] [Appium] Set CLI arguments on device-farm plugin instance: {"Platform":"Android"}
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, css selector, -android uiautomator
[debug] [BaseDriver] Waiting up to 0 ms for condition
[debug] [WD Proxy] Matched '/element' to command name 'findElement'
[debug] [WD Proxy] Proxying [POST /element] to [POST http://127.0.0.1:62092/wd/hub/session/688ed625-e088-42cf-8a37-7e877ec0a82b/element] with body: {"strategy":"accessibility id","selector":"login","context":"","multiple":false}
[device-farm] Fetching Android Devices
[debug] [ADB] Getting connected devices
[debug] [ADB] Connected devices: [{"udid":"emulator-5554","state":"device"}]
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.release'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.characteristics'
[debug] [ADB] Running '/Users/saikrisv/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.product.name'
[device-farm] Android Devices found [{"busy":false,"state":"device","udid":"emulator-5554","platform":"android","sdk":"11","realDevice":false,"name":"sdk_phone_x86"}]
[device-farm] Fetching iOS Devices
[debug] [WD Proxy] Got response with status 200: {"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b","value":{"ELEMENT":"00000000-0000-00fb-ffff-ffff00000010","element-6066-11e4-a52e-4f735466cecf":"00000000-0000-00fb-ffff-ffff00000010"}}
[debug] [W3C (7d4fcbb9)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"00000000-0000-00fb-ffff-ffff00000010","ELEMENT":"00000000-0000-00fb-ffff-ffff00000010"}
[HTTP] <-- POST /wd/hub/session/7d4fcbb9-7277-4257-9fa3-4a047aed662f/element 200 917 ms - 137
[HTTP]
[HTTP] --> POST /wd/hub/session/7d4fcbb9-7277-4257-9fa3-4a047aed662f/element/00000000-0000-00fb-ffff-ffff00000010/click
[HTTP] {}
[debug] [W3C (7d4fcbb9)] Calling AppiumDriver.click() with args: ["00000000-0000-00fb-ffff-ffff00000010","7d4fcbb9-7277-4257-9fa3-4a047aed662f"]
[debug] [WD Proxy] Matched '/element/00000000-0000-00fb-ffff-ffff00000010/click' to command name 'click'
[debug] [WD Proxy] Proxying [POST /element/00000000-0000-00fb-ffff-ffff00000010/click] to [POST http://127.0.0.1:62092/wd/hub/session/688ed625-e088-42cf-8a37-7e877ec0a82b/element/00000000-0000-00fb-ffff-ffff00000010/click] with body: {"element":"00000000-0000-00fb-ffff-ffff00000010"}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"688ed625-e088-42cf-8a37-7e877ec0a82b","value":null}
[debug] [W3C (7d4fcbb9)] Responding to client with driver.click() result: null
[HTTP] <-- POST /wd/hub/session/7d4fcbb9-7277-4257-9fa3-4a047aed662f/element/00000000-0000-00fb-ffff-ffff00000010/click 200 617 ms - 14
[HTTP]
[HTTP] --> DELETE /wd/hub/session/7d4fcbb9-7277-4257-9fa3-4a047aed662f
[HTTP] {}
[debug] [W3C (7d4fcbb9)] Calling AppiumDriver.deleteSession() with args: ["7d4fcbb9-7277-4257-9fa3-4a047aed662f"]
[Appium] Plugins which can handle cmd 'deleteSession': device-farm (sessionless)
[Appium] Plugin device-farm (sessionless) is now handling cmd 'deleteSession'
Delete Session 7d4fcbb9-7277-4257-9fa3-4a047aed662f
[Appium] Command 'deleteSession' was not handled by the following beahviors or plugins, even though they were registered to handle it: ["default"]. The command *was* handled by these: ["device-farm (sessionless)"].
[debug] [W3C (7d4fcbb9)] Encountered internal error running command: TypeError: Cannot read property 'udid' of undefined
[debug] [W3C (7d4fcbb9)]     at DevicePlugin.<anonymous> (/Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:81:76)
[debug] [W3C (7d4fcbb9)]     at Generator.next (<anonymous>)
[debug] [W3C (7d4fcbb9)]     at /Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:8:71
[debug] [W3C (7d4fcbb9)]     at new Promise (<anonymous>)
[debug] [W3C (7d4fcbb9)]     at __awaiter (/Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:4:12)
[debug] [W3C (7d4fcbb9)]     at DevicePlugin.deleteSession (/Users/saikrisv/Documents/git/appium-device-farm/lib/plugin.js:78:16)
[debug] [W3C (7d4fcbb9)]     at wrappedCmd (/usr/local/lib/node_modules/appium/lib/appium.js:539:24)
[debug] [W3C (7d4fcbb9)]     at AppiumDriver.executeWrappedCommand (/usr/local/lib/node_modules/appium/lib/appium.js:571:22)
[debug] [W3C (7d4fcbb9)]     at AppiumDriver.executeCommand (/usr/local/lib/node_modules/appium/lib/appium.js:515:28)
[debug] [W3C (7d4fcbb9)]     at asyncHandler (/usr/local/lib/node_modules/appium/node_modules/@appium/base-driver/lib/protocol/protocol.js:287:34)
[debug] [W3C (7d4fcbb9)]     at /usr/local/lib/node_modules/appium/node_modules/@appium/base-driver/lib/protocol/protocol.js:413:15
[debug] [W3C (7d4fcbb9)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (7d4fcbb9)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/route.js:137:13)
[debug] [W3C (7d4fcbb9)]     at Route.dispatch (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/route.js:112:3)
[debug] [W3C (7d4fcbb9)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (7d4fcbb9)]     at /usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:281:22
[debug] [W3C (7d4fcbb9)]     at param (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:354:14)
[debug] [W3C (7d4fcbb9)]     at param (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:365:14)
[debug] [W3C (7d4fcbb9)]     at Function.process_params (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:410:3)
[debug] [W3C (7d4fcbb9)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:275:10)
[debug] [W3C (7d4fcbb9)]     at logger (/usr/local/lib/node_modules/appium/node_modules/morgan/index.js:144:5)
[debug] [W3C (7d4fcbb9)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (7d4fcbb9)]     at trim_prefix (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:317:13)
[debug] [W3C (7d4fcbb9)]     at /usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:284:7
[debug] [W3C (7d4fcbb9)]     at Function.process_params (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:335:12)
[debug] [W3C (7d4fcbb9)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:275:10)
[debug] [W3C (7d4fcbb9)]     at jsonParser (/usr/local/lib/node_modules/appium/node_modules/body-parser/lib/types/json.js:110:7)
[debug] [W3C (7d4fcbb9)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:95:5)
[debug] [W3C (7d4fcbb9)]     at trim_prefix (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:317:13)
[debug] [W3C (7d4fcbb9)]     at /usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:284:7
[debug] [W3C (7d4fcbb9)]     at Function.process_params (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:335:12)
[debug] [W3C (7d4fcbb9)]     at next (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:275:10)
[debug] [W3C (7d4fcbb9)]     at Layer.handle [as handle_request] (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/layer.js:91:12)
[debug] [W3C (7d4fcbb9)]     at trim_prefix (/usr/local/lib/node_modules/appium/node_modules/express/lib/router/index.js:317:13)
[HTTP] <-- DELETE /wd/hub/session/7d4fcbb9-7277-4257-9fa3-4a047aed662f 500 5 ms - 690
[HTTP]