[info] [Appium] Welcome to Appium v1.15.1
[info] [Appium] Non-default server args:
[info] [Appium]   address: 127.0.0.1
[info] [Appium]   allowInsecure: {
[info] [Appium]   }
[info] [Appium]   denyInsecure: {
[info] [Appium]   }
[info] [Appium] Appium REST http interface listener started on 127.0.0.1:4723[info] [HTTP] --> POST /wd/hub/session
[info] [HTTP] {"desiredCapabilities":{"appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","platformVersion":"9","automationName":"UiAutomator2","platformName":"Android","deviceName":"emulator-5554"},"capabilities":{"firstMatch":[{"appium:appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appium:appPackage":"ca.slava.tv.google.dev","appium:automationName":"UiAutomator2","appium:deviceName":"emulator-5554","platformName":"android","appium:platformVersion":"9"}]}}
[debug] [W3C] Calling AppiumDriver.createSession() with args: [{"appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","platformVersion":"9","automationName":"UiAutomator2","platformName":"Android","deviceName":"emulator-5554"},null,{"firstMatch":[{"appium:appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appium:appPackage":"ca.slava.tv.google.dev","appium:automationName":"UiAutomator2","appium:deviceName":"emulator-5554","platformName":"android","appium:platformVersion":"9"}]}]
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1581941640181 (15:14:00 GMT+0300 (Russia TZ 2 Standard Time))
[info] [Appium] Appium v1.15.1 creating new AndroidUiautomator2Driver (v1.37.2) session
[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:appActivity": "com.slava.box.rich.com.slava.tv.activities.SplashScreen",
[debug] [BaseDriver]     "appium:appPackage": "ca.slava.tv.google.dev",
[debug] [BaseDriver]     "appium:automationName": "UiAutomator2",
[debug] [BaseDriver]     "appium:deviceName": "emulator-5554",
[debug] [BaseDriver]     "appium:platformVersion": "9"
[debug] [BaseDriver]   },
[debug] [BaseDriver]   "firstMatch": [
[debug] [BaseDriver]     {}
[debug] [BaseDriver]   ]
[debug] [BaseDriver] }
[info] [BaseDriver] Session created with session id: 59f83235-ef88-4fc1-8a30-439100bb1e92
[info] [UiAutomator2] Starting 'ca.slava.tv.google.dev' directly on the device[info] [ADB] Using 'adb.exe' from 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe'
[info] [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"}]
[info] [AndroidDriver] Looking for a device with Android '9'
[debug] [ADB] Setting device id to emulator-5554
[info] [ADB] Getting device platform version
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell getprop ro.build.version.release'[debug] [ADB] Current device property 'ro.build.version.release': 9
[info] [AndroidDriver] Using device: emulator-5554
[info] [ADB] Using 'adb.exe' from 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe'
[debug] [ADB] Setting device id to emulator-5554
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell getprop ro.build.version.sdk'
[debug] [ADB] Current device property 'ro.build.version.sdk': 28
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell getprop ro.build.version.release'
[debug] [ADB] Current device property 'ro.build.version.release': 9
[debug] [ADB] Device API level: 28
[warn] [UiAutomator2] Relaxing hidden api policy
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings put global hidden_api_policy_pre_p_apps 1'[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings put global hidden_api_policy_p_apps 1'
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings put global hidden_api_policy 1'
[warn] [AndroidDriver] No app sent in, not parsing package/activity
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 wait-for-device'[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -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 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -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 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings'[info] [ADB] Cannot extract apk info using apkanalyzer. Falling back to aapt. Original error: Could not find 'apkanalyzer.bat' in ["C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\platform-tools\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\emulator\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\tools\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\tools\\bin\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\29.0.3\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\29.0.2\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\28.0.3\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\27.0.3\\apkanalyzer.bat"]. Do you have Android Build Tools installed at 'C:\Users\slavan\AppData\Local\Android\Sdk'?
[info] [ADB] Using 'aapt.exe' from 'C:\Users\slavan\AppData\Local\Android\Sdk\build-tools\29.0.3\aapt.exe'
[debug] [ADB] The version name of the installed 'io.appium.settings' is greater or equal to the application version name ('2.14.2' >= '2.14.2')
[debug] [ADB] There is no need to install/upgrade 'C:\Users\slavan\AppData\Local\Programs\Appium\resources\app\node_modules\appium\node_modules\io.appium.settings\apks\settings_apk-debug.apk'
[debug] [ADB] Getting IDs of all 'io.appium.settings' processes
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell 'pgrep --help; echo $?''
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pgrep -f io\\.appium\\.settings'[debug] [AndroidDriver] io.appium.settings is already running. There is no need to reset its permissions.
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell appops set io.appium.settings android\:mock_location allow'
[debug] [Logcat] Starting logcat capture
[debug] [ADB] Getting install status for io.appium.uiautomator2.server
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -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 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell dumpsys package io.appium.uiautomator2.server'
[info] [ADB] Cannot extract apk info using apkanalyzer. Falling back to aapt. Original error: Could not find 'apkanalyzer.bat' in ["C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\platform-tools\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\emulator\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\tools\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\tools\\bin\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\29.0.3\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\29.0.2\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\28.0.3\\apkanalyzer.bat","C:\\Users\\slavan\\AppData\\Local\\Android\\Sdk\\build-tools\\27.0.3\\apkanalyzer.bat"]. Do you have Android Build Tools installed at 'C:\Users\slavan\AppData\Local\Android\Sdk'?[debug] [ADB] The version name of the installed 'io.appium.uiautomator2.server' is greater or equal to the application version name ('4.3.0' >= '4.3.0')
[debug] [UiAutomator2] io.appium.uiautomator2.server installation state: sameVersionInstalled
[debug] [ADB] Checking app cert for C:\Users\slavan\AppData\Local\Programs\Appium\resources\app\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.3.0.apk
[info] [ADB] Using 'apksigner.bat' from 'C:\Users\slavan\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat'
[debug] [ADB] Starting 'C:\Users\slavan\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["verify","--print-certs","C:\\Users\\slavan\\AppData\\Local\\Programs\\Appium\\resources\\app\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-v4.3.0.apk"]'[debug] [ADB] apksigner stdout: Signer #1 certificate DN: EMAILADDRESS=android@android.com, CN=Android, OU=Android, O=Android, L=Mountain View, ST=California, C=US
[debug] [ADB] Signer #1 certificate SHA-256 digest: a40da80a59d170caa950cf15c18c454d47a39b26989d8b640ecd745ba71bf5dc
[debug] [ADB] Signer #1 certificate SHA-1 digest: 61ed377e85d386a8dfee6b864bd85b0bfaa5af81
[debug] [ADB] Signer #1 certificate MD5 digest: e89b158e4bcf988ebd09eb83f5378e87
[debug] [ADB] 
[debug] [ADB] 'C:\Users\slavan\AppData\Local\Programs\Appium\resources\app\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.3.0.apk' is already signed.
[debug] [ADB] Getting install status for io.appium.uiautomator2.server.test
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -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 C:\Users\slavan\AppData\Local\Programs\Appium\resources\app\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk
[debug] [ADB] Starting 'C:\Users\slavan\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["verify","--print-certs","C:\\Users\\slavan\\AppData\\Local\\Programs\\Appium\\resources\\app\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-debug-androidTest.apk"]'[debug] [ADB] apksigner stdout: Signer #1 certificate DN: EMAILADDRESS=android@android.com, CN=Android, OU=Android, O=Android, L=Mountain View, ST=California, C=US
[debug] [ADB] Signer #1 certificate SHA-256 digest: a40da80a59d170caa950cf15c18c454d47a39b26989d8b640ecd745ba71bf5dc
[debug] [ADB] Signer #1 certificate SHA-1 digest: 61ed377e85d386a8dfee6b864bd85b0bfaa5af81
[debug] [ADB] Signer #1 certificate MD5 digest: e89b158e4bcf988ebd09eb83f5378e87
[debug] [ADB] 
[debug] [ADB] 'C:\Users\slavan\AppData\Local\Programs\Appium\resources\app\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk' is already signed.
[info] [UiAutomator2] Server packages are not going to be (re)installed
[debug] [UiAutomator2] Waiting up to 30000ms for services to be available
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pm list instrumentation'[debug] [UiAutomator2] No app capability. Assuming it is already on the device
[debug] [ADB] Getting install status for ca.slava.tv.google.dev
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell dumpsys package ca.slava.tv.google.dev'
[debug] [ADB] 'ca.slava.tv.google.dev' is installed
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am force-stop ca.slava.tv.google.dev'[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pm clear ca.slava.tv.google.dev'
[debug] [AndroidDriver] Performed fast reset on the installed 'ca.slava.tv.google.dev' application (stop and clear)
[debug] [UiAutomator2] Performing shallow cleanup of automation leftovers
[debug] [UiAutomator2] The following obsolete sessions are still running: ["ad7252d7-dd1c-4c07-a259-9d44a634b82b"]
[debug] [UiAutomator2] Cleaning up the obsolete sessions[debug] [Instrumentation] .[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test'[info] [UiAutomator2] Starting UIAutomator2 server 4.3.0
[info] [UiAutomator2] Using UIAutomator2 server from 'C:\Users\slavan\AppData\Local\Programs\Appium\resources\app\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.3.0.apk' and test from 'C:\Users\slavan\AppData\Local\Programs\Appium\resources\app\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk'
[info] [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","io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"]
[debug] [Instrumentation] INSTRUMENTATION_RESULT: shortMsg=Process crashed.
[debug] [Instrumentation] INSTRUMENTATION_CODE: 0
[debug] [Instrumentation] The process has exited with code 0[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://localhost:8202/wd/hub/status] with no body
[info] [WD Proxy] Got an unexpected response with status undefined: {"code":"ECONNRESET"}[debug] [WD Proxy] Matched '/status' to command name 'getStatus'
[debug] [WD Proxy] Proxying [GET /status] to [GET http://localhost:8202/wd/hub/status] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"None","value":{"ready":true,"message":"UiAutomator2 Server is ready to accept commands"}}
[debug] [UiAutomator2] The initialization of the instrumentation process took 2095ms
[debug] [WD Proxy] Matched '/session' to command name 'createSession'
[debug] [WD Proxy] Proxying [POST /session] to [POST http://localhost:8202/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","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9"},"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9","deviceUDID":"emulator-5554"}],"alwaysMatch":{}}}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":{"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","capabilities":{"firstMatch":[{"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9"},"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9","deviceUDID":"emulator-5554"}],"alwaysMatch":{}}}}
[info] [WD Proxy] Determined the downstream protocol as 'W3C'
[debug] [WD Proxy] Proxying [GET /appium/device/info] to [GET http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30/appium/device/info] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":{"androidId":"fba969b3f9232a19","manufacturer":"unknown","model":"sdk_google_atv_x86","brand":"google","apiVersion":"28","platformVersion":"9","carrierName":"","realDisplaySize":"1280x720","displayDensity":213,"networks":[{"type":1,"typeName":"WIFI","subtype":0,"subtypeName":"","isConnected":true,"detailedState":"CONNECTED","state":"CONNECTED","extraInfo":null,"isAvailable":true,"isFailover":false,"isRoaming":false,"capabilities":{"transportTypes":"NET_CAPABILITY_SUPL","networkCapabilities":"","linkUpstreamBandwidthKbps":1048576,"linkDownBandwidthKbps":1048576,"signalStrength":-50,"networkSpecifier":null,"SSID":null}}],"locale":"en_US","timeZone":"GMT"}}
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell dumpsys window'
[info] [AndroidDriver] Screen already unlocked, doing nothing
[info] [UiAutomator2] Starting 'ca.slava.tv.google.dev/com.slava.box.rich.com.slava.tv.activities.SplashScreen and waiting for 'ca.slava.tv.google.dev/com.slava.box.rich.com.slava.tv.activities.SplashScreen'
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am start -W -n ca.slava.tv.google.dev/com.slava.box.rich.com.slava.tv.activities.SplashScreen -S'[debug] [WD Proxy] Proxying [GET /appium/device/pixel_ratio] to [GET http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30/appium/device/pixel_ratio] with body: {}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":1.3312501}
[debug] [WD Proxy] Matched '/appium/device/system_bars' to command name 'getSystemBars'
[debug] [WD Proxy] Proxying [GET /appium/device/system_bars] to [GET http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30/appium/device/system_bars] with body: {}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":{"statusBar":0}}
[debug] [WD Proxy] Matched '/window/current/size' to command name 'getWindowSize'
[debug] [WD Proxy] Proxying [GET /window/current/size] to [GET http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30/window/current/size] with body: {}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":{"height":720,"width":1280}}
[info] [Appium] New AndroidUiautomator2Driver session created successfully, session 59f83235-ef88-4fc1-8a30-439100bb1e92 added to master session list
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1581941649366 (15:14:09 GMT+0300 (Russia TZ 2 Standard Time))
[debug] [W3C (59f83235)] Cached the protocol value 'W3C' for the new session 59f83235-ef88-4fc1-8a30-439100bb1e92
[debug] [W3C (59f83235)] 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","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9"},"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9","deviceUDID":"emulator-5554","deviceApiLevel":28,"deviceScreenSize":"1280x720","deviceScreenDensity":213,"deviceModel":"sdk_google_atv_x86","deviceManufacturer":"unknown","pixelRatio":1.3312501,"statBarHeight":0,"viewportRect":{"left":0,"top":0,"width":1280,"height":720}}}
[info] [HTTP] <-- POST /wd/hub/session 200 9186 ms - 999
[info] [HTTP] 
[info] [HTTP] --> GET /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92
[info] [HTTP] {}
[debug] [W3C (59f83235)] Calling AppiumDriver.getSession() with args: ["59f83235-ef88-4fc1-8a30-439100bb1e92"]
[debug] [UiAutomator2] Getting session details from server to mix in
[debug] [WD Proxy] Matched '/' to command name 'getSession'
[debug] [WD Proxy] Proxying [GET /] to [GET http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30] with body: {}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":{}}
[debug] [W3C (59f83235)] Responding to client with driver.getSession() result: {"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9"},"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9","deviceUDID":"emulator-5554","deviceApiLevel":28,"deviceScreenSize":"1280x720","deviceScreenDensity":213,"deviceModel":"sdk_google_atv_x86","deviceManufacturer":"unknown","pixelRatio":1.3312501,"statBarHeight":0,"viewportRect":{"left":0,"top":0,"width":1280,"height":720}}
[info] [HTTP] <-- GET /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92 200 12 ms - 931
[info] [HTTP] 
[info] [HTTP] --> GET /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92
[info] [HTTP] {}
[debug] [W3C (59f83235)] Calling AppiumDriver.getSession() with args: ["59f83235-ef88-4fc1-8a30-439100bb1e92"]
[debug] [UiAutomator2] Getting session details from server to mix in
[debug] [WD Proxy] Matched '/' to command name 'getSession'
[debug] [WD Proxy] Proxying [GET /] to [GET http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30] with body: {}
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":{}}
[debug] [W3C (59f83235)] Responding to client with driver.getSession() result: {"platform":"LINUX","webStorageEnabled":false,"takesScreenshot":true,"javascriptEnabled":true,"databaseEnabled":false,"networkConnectionEnabled":true,"locationContextEnabled":false,"warnings":{},"desired":{"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9"},"platformName":"android","appActivity":"com.slava.box.rich.com.slava.tv.activities.SplashScreen","appPackage":"ca.slava.tv.google.dev","automationName":"UiAutomator2","deviceName":"emulator-5554","platformVersion":"9","deviceUDID":"emulator-5554","deviceApiLevel":28,"deviceScreenSize":"1280x720","deviceScreenDensity":213,"deviceModel":"sdk_google_atv_x86","deviceManufacturer":"unknown","pixelRatio":1.3312501,"statBarHeight":0,"viewportRect":{"left":0,"top":0,"width":1280,"height":720}}
[info] [HTTP] <-- GET /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92 200 10 ms - 931
[info] [HTTP] 
[info] [HTTP] --> POST /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92/timeouts
[info] [HTTP] {"implicit":5000}
[debug] [W3C (59f83235)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,5000,"59f83235-ef88-4fc1-8a30-439100bb1e92"]
[debug] [BaseDriver] W3C timeout argument: {"implicit":5000}}
[debug] [BaseDriver] Set implicit wait to 5000ms
[debug] [W3C (59f83235)] Responding to client with driver.timeouts() result: null
[info] [HTTP] <-- POST /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92/timeouts 200 1 ms - 14
[info] [HTTP] 
[info] [HTTP] --> POST /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92/element
[info] [HTTP] {"using":"-android uiautomator","value":"new UiSelector().resourceIdMatches(\".*guidedactions_item_title\").text(\"Next\")"}
[debug] [W3C (59f83235)] Calling AppiumDriver.findElement() with args: ["-android uiautomator","new UiSelector().resourceIdMatches(\".*guidedactions_item_title\").text(\"Next\")","59f83235-ef88-4fc1-8a30-439100bb1e92"]
[debug] [BaseDriver] Valid locator strategies for this request: xpath, id, class name, accessibility id, -android uiautomator
[debug] [BaseDriver] Waiting up to 5000 ms for condition
[debug] [WD Proxy] Matched '/element' to command name 'findElement'
[debug] [WD Proxy] Proxying [POST /element] to [POST http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30/element] with body: {"strategy":"-android uiautomator","selector":"new UiSelector().resourceIdMatches(\".*guidedactions_item_title\").text(\"Next\")","context":"","multiple":false}[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":{"ELEMENT":"608f6760-81f6-45f2-8a0c-b8686303a45e","element-6066-11e4-a52e-4f735466cecf":"608f6760-81f6-45f2-8a0c-b8686303a45e"}}
[debug] [W3C (59f83235)] Responding to client with driver.findElement() result: {"element-6066-11e4-a52e-4f735466cecf":"608f6760-81f6-45f2-8a0c-b8686303a45e","ELEMENT":"608f6760-81f6-45f2-8a0c-b8686303a45e"}
[info] [HTTP] <-- POST /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92/element 200 413 ms - 137
[info] [HTTP] 
[info] [HTTP] --> POST /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92/timeouts
[info] [HTTP] {"implicit":5000}
[debug] [W3C (59f83235)] Calling AppiumDriver.timeouts() with args: [null,null,null,null,5000,"59f83235-ef88-4fc1-8a30-439100bb1e92"]
[debug] [BaseDriver] W3C timeout argument: {"implicit":5000}}
[debug] [BaseDriver] Set implicit wait to 5000ms
[debug] [W3C (59f83235)] Responding to client with driver.timeouts() result: null
[info] [HTTP] <-- POST /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92/timeouts 200 1 ms - 14
[info] [HTTP] 
[info] [HTTP] --> DELETE /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92
[info] [HTTP] {}
[debug] [W3C (59f83235)] Calling AppiumDriver.deleteSession() with args: ["59f83235-ef88-4fc1-8a30-439100bb1e92"]
[debug] [BaseDriver] Event 'quitSessionRequested' logged at 1581941649892 (15:14:09 GMT+0300 (Russia TZ 2 Standard Time))
[info] [Appium] Removing session 59f83235-ef88-4fc1-8a30-439100bb1e92 from our master session list
[debug] [UiAutomator2] Deleting UiAutomator2 session
[debug] [UiAutomator2] Deleting UiAutomator2 server session
[debug] [WD Proxy] Matched '/' to command name 'deleteSession'
[debug] [WD Proxy] Proxying [DELETE /] to [DELETE http://localhost:8202/wd/hub/session/ba5e5c7a-9293-4f80-a803-ef8e090e4a30] with no body
[debug] [WD Proxy] Got response with status 200: {"sessionId":"ba5e5c7a-9293-4f80-a803-ef8e090e4a30","value":null}
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am force-stop ca.slava.tv.google.dev'[debug] [Logcat] Stopping logcat capture
[debug] [ADB] Removing forwarded port socket connection: 8202 
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 forward --remove tcp\:8202'
[info] [UiAutomator2] Restoring hidden api policy to the device default configuration
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings delete global hidden_api_policy_pre_p_apps'
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings delete global hidden_api_policy_p_apps'[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings delete global hidden_api_policy'
[debug] [Instrumentation] .
[debug] [BaseDriver] Event 'quitSessionFinished' logged at 1581941650378 (15:14:10 GMT+0300 (Russia TZ 2 Standard Time))
[debug] [W3C (59f83235)] Received response: null
[debug] [W3C (59f83235)] But deleting session, so not returning
[debug] [W3C (59f83235)] Responding to client with driver.deleteSession() result: null
[info] [HTTP] <-- DELETE /wd/hub/session/59f83235-ef88-4fc1-8a30-439100bb1e92 200 486 ms - 14
[info] [HTTP] [debug] [Instrumentation] Time: 4.033
[debug] [Instrumentation] 
[debug] [Instrumentation] OK (1 test)
[debug] [Instrumentation] The process has exited with code 0[warn] [BaseDriver] Shutting down because we waited 60 seconds for a command
[debug] [UiAutomator2] Deleting UiAutomator2 session
[warn] [Appium] Closing session, cause was 'New Command Timeout of 60 seconds expired. Try customizing the timeout using the 'newCommandTimeout' desired capability'
[info] [Appium] Removing session bc8a60a9-5479-4c77-ac47-4c9f6ff98f13 from our master session list
[debug] [UiAutomator2] Deleting UiAutomator2 server session
[debug] [WD Proxy] Matched '/' to command name 'deleteSession'
[debug] [WD Proxy] Proxying [DELETE /] to [DELETE http://localhost:8200/wd/hub/session/ad7252d7-dd1c-4c07-a259-9d44a634b82b] with no body
[info] [WD Proxy] Got an unexpected response with status undefined: {"code":"ECONNRESET"}
[warn] [UiAutomator2] Did not get confirmation UiAutomator2 deleteSession worked; Error was: UnknownError: An unknown server-side error occurred while processing the command. Original error: Could not proxy command to remote server. Original error: Error: socket hang up
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am force-stop ca.slava.tv.google.dev'
[debug] [Logcat] Stopping logcat capture
[debug] [ADB] Removing forwarded port socket connection: 8200 
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 forward --remove tcp\:8200'
[info] [UiAutomator2] Restoring hidden api policy to the device default configuration
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings delete global hidden_api_policy_pre_p_apps'[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings delete global hidden_api_policy_p_apps'
[debug] [ADB] Running 'C:\Users\slavan\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings delete global hidden_api_policy'