appium@beta log

[Appium] Welcome to Appium v1.17.0-beta.1
[Appium] Appium REST http interface listener started on 0.0.0.0:4723
[HTTP] --> POST /wd/hub/session
[HTTP] {"desiredCapabilities":{"platformName":"Android","platformVersion":"10","deviceName":"Pixel","app":"c:\\Users\\cskala\\Documents\\Playground\\CSharp\\AppiumNunit/apps/ApiDemos-debug.apk","automationName":"UIAutomator2"},"capabilities":{"firstMatch":[{"platformName":"Android"}]}}
[debug] [W3C] Calling AppiumDriver.createSession() with args: [{"platformName":"Android","platformVersion":"10","deviceName":"Pixel","app":"c:\\Users\\cskala\\Documents\\Playground\\CSharp\\AppiumNunit/apps/ApiDemos-debug.apk","automationName":"UIAutomator2"},null,{"firstMatch":[{"platformName":"Android"}]}]
[debug] [BaseDriver] Event 'newSessionRequested' logged at 1583422349752 (10:32:29 GMT-0500 (Eastern Standard Time))
[Appium] The following capabilities were provided in the JSONWP desired capabilities that are missing in W3C capabilities: ["platformVersion","deviceName","app","automationName"]
[Appium] Trying to fix W3C capabilities by merging them with JSONWP caps
[BaseDriver] The following capabilities are not standard capabilities and should have an extension prefix:
[BaseDriver]   platformVersion
[BaseDriver]   deviceName
[BaseDriver]   app
[BaseDriver]   automationName
[Appium] Appium v1.17.0-beta.1 creating new AndroidUiautomator2Driver (v1.44.2) session
[debug] [BaseDriver] W3C capabilities and MJSONWP desired capabilities were provided
[debug] [BaseDriver] Creating session with W3C capabilities: {
[debug] [BaseDriver]   "alwaysMatch": {
[debug] [BaseDriver]     "appium:platformVersion": "10",
[debug] [BaseDriver]     "appium:deviceName": "Pixel",
[debug] [BaseDriver]     "appium:app": "c:\\Users\\cskala\\Documents\\Playground\\CSharp\\AppiumNunit/apps/ApiDemos-debug.apk",
[debug] [BaseDriver]     "appium:automationName": "UIAutomator2",
[debug] [BaseDriver]     "platformName": "Android"
[debug] [BaseDriver]   },
[debug] [BaseDriver]   "firstMatch": [
[debug] [BaseDriver]     {}
[debug] [BaseDriver]   ]
[debug] [BaseDriver] }
[BaseDriver] Session created with session id: 13ac58b6-266a-4999-9110-156f2573aa60
[BaseDriver] Using local app 'c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk'
[debug] [UiAutomator2] Checking whether app is actually present
[ADB] Found 1 'build-tools' folders under 'C:\Users\cskala\AppData\Local\Android\Sdk' (newest first):
[ADB]     C:/Users/cskala/AppData/Local/Android/Sdk/build-tools/29.0.3
[ADB] Using 'adb.exe' from 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe'
[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] Looking for a device with Android '10.0.0'
[debug] [ADB] Setting device id to emulator-5554
[ADB] Getting device platform version
[debug] [ADB] Running 'C:\Users\cskala\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': 10
[AndroidDriver] Using device: emulator-5554
[ADB] Using 'adb.exe' from 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe'
[debug] [ADB] Setting device id to emulator-5554
[debug] [ADB] Running 'C:\Users\cskala\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': 29
[ADB] Getting device platform version
[debug] [ADB] Running 'C:\Users\cskala\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': 10
[debug] [ADB] Device API level: 29
[UiAutomator2] Relaxing hidden api policy
[debug] [ADB] Running 'C:\Users\cskala\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\cskala\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\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings put global hidden_api_policy 1'
[debug] [AndroidDriver] Parsing package and activity from app manifest
[ADB] Package name: 'io.appium.android.apis'
[ADB] Main activity name: 'io.appium.android.apis.ApiDemos'
[debug] [AndroidDriver] Parsed package and activity are: io.appium.android.apis/io.appium.android.apis.ApiDemos
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 wait-for-device'
[debug] [ADB] Running 'C:\Users\cskala\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\cskala\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 not installed
[debug] [ADB] App 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\io.appium.settings\apks\settings_apk-debug.apk' is not installed
[debug] [ADB] Installing 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\io.appium.settings\apks\settings_apk-debug.apk'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell 'ls -t -1 /data/local/tmp/appium_cache 2>&1 || echo _ERROR_''
[debug] [ADB] Got an error 'ls: /data/local/tmp/appium_cache: No such file or directory' while getting the list of files in the cache. Assuming the cache does not exist yet
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell mkdir -p /data/local/tmp/appium_cache'
[debug] [ADB] The count of applications in the cache: 0
[ADB] Caching the application at 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\io.appium.settings\apks\settings_apk-debug.apk' to '/data/local/tmp/appium_cache/80ec2879fe799604adab3aec0e2993e4eef38525.apk'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell mkdir -p /data/local/tmp/appium_cache'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 push C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\io.appium.settings\\apks\\settings_apk-debug.apk /data/local/tmp/appium_cache/80ec2879fe799604adab3aec0e2993e4eef38525.apk'
[ADB] The upload of 'settings_apk-debug.apk' (1.15 MB) took 121ms
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pm install -g /data/local/tmp/appium_cache/80ec2879fe799604adab3aec0e2993e4eef38525.apk'
[ADB] The installation of 'settings_apk-debug.apk' took 389ms
[debug] [ADB] Install command stdout: Success
[debug] [ADB] Getting IDs of all 'io.appium.settings' processes
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell 'pgrep --help; echo $?''
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pgrep -f io\\.appium\\.settings'
[debug] [ADB] Getting IDs of all 'io.appium.settings' processes
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pgrep -f io\\.appium\\.settings'
[debug] [ADB] Starting Appium Settings app
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am start -n io.appium.settings/.Settings -a android.intent.action.MAIN -c android.intent.category.LAUNCHER'
[debug] [ADB] Getting IDs of all 'io.appium.settings' processes
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pgrep -f io\\.appium\\.settings'
[debug] [ADB] Running 'C:\Users\cskala\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] [UiAutomator2] Forwarding UiAutomator2 Server port 6790 to 8200
[debug] [ADB] Forwarding system: 8200 to device: 6790
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 forward tcp\:8200 tcp\:6790'
[debug] [ADB] Getting install status for io.appium.uiautomator2.server
[debug] [ADB] Running 'C:\Users\cskala\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 not installed
[debug] [ADB] App 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.5.5.apk' is not installed
[debug] [UiAutomator2] io.appium.uiautomator2.server installation state: notInstalled
[debug] [ADB] Checking app cert for C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.5.5.apk
[ADB] Using 'apksigner.bat' from 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat'
[debug] [ADB] Starting 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["verify","--print-certs","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-v4.5.5.apk"]'
[debug] [ADB] 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.5.5.apk' is signed with non-default certificate
[ADB] Using 'zipalign.exe' from 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\zipalign.exe'
[debug] [ADB] C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.5.5.apk' is already zip-aligned. Doing nothing
[debug] [ADB] Signing 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.5.5.apk' with default cert
[debug] [ADB] Starting 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["sign","--key","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-adb\\keys\\testkey.pk8","--cert","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-adb\\keys\\testkey.x509.pem","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-v4.5.5.apk"]'
[debug] [ADB] Getting install status for io.appium.uiautomator2.server.test
[debug] [ADB] Running 'C:\Users\cskala\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 not installed
[debug] [ADB] Checking app cert for C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk
[debug] [ADB] Starting 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["verify","--print-certs","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-debug-androidTest.apk"]'
[debug] [ADB] 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk' is signed with non-default certificate
[debug] [ADB] C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk' is already zip-aligned. Doing nothing
[debug] [ADB] Signing 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk' with default cert
[debug] [ADB] Starting 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["sign","--key","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-adb\\keys\\testkey.pk8","--cert","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-adb\\keys\\testkey.x509.pem","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-debug-androidTest.apk"]'
[UiAutomator2] Server packages are going to be (re)installed
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell 'ls -t -1 /data/local/tmp/appium_cache 2>&1 || echo _ERROR_''
[debug] [ADB] The count of applications in the cache: 1
[ADB] Caching the application at 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.5.5.apk' to '/data/local/tmp/appium_cache/75e2638551246b73c8e1fef0017fc2163110ac3c.apk'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell mkdir -p /data/local/tmp/appium_cache'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 push C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-v4.5.5.apk /data/local/tmp/appium_cache/75e2638551246b73c8e1fef0017fc2163110ac3c.apk'
[ADB] The upload of 'appium-uiautomator2-server-v4.5.5.apk' (2.14 MB) took 170ms
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pm install -r /data/local/tmp/appium_cache/75e2638551246b73c8e1fef0017fc2163110ac3c.apk'
[ADB] The installation of 'appium-uiautomator2-server-v4.5.5.apk' took 440ms
[debug] [ADB] Install command stdout: Success
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell 'ls -t -1 /data/local/tmp/appium_cache 2>&1 || echo _ERROR_''
[debug] [ADB] The count of applications in the cache: 2
[ADB] Caching the application at 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-debug-androidTest.apk' to '/data/local/tmp/appium_cache/3851c1f6b7d1981c83120643c3a570110e860edf.apk'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell mkdir -p /data/local/tmp/appium_cache'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 push C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-uiautomator2-server\\apks\\appium-uiautomator2-server-debug-androidTest.apk /data/local/tmp/appium_cache/3851c1f6b7d1981c83120643c3a570110e860edf.apk'
[ADB] The upload of 'appium-uiautomator2-server-debug-androidTest.apk' (533.53 KB) took 162ms
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pm install -r /data/local/tmp/appium_cache/3851c1f6b7d1981c83120643c3a570110e860edf.apk'
[ADB] The installation of 'appium-uiautomator2-server-debug-androidTest.apk' took 353ms
[debug] [ADB] Install command stdout: Success
[debug] [UiAutomator2] Waiting up to 30000ms for services to be available
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pm list instrumentation'
[debug] [UiAutomator2] Instrumentation target 'io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner' is available
[debug] [ADB] Checking app cert for c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk
[debug] [ADB] Starting 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["verify","--print-certs","c:\\Users\\cskala\\Documents\\Playground\\CSharp\\AppiumNunit/apps/ApiDemos-debug.apk"]'
[debug] [ADB] 'c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk' is signed with non-default certificate
[debug] [ADB] c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk' is already zip-aligned. Doing nothing
[debug] [ADB] Signing 'c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk' with default cert
[debug] [ADB] Starting 'C:\Users\cskala\AppData\Local\Android\Sdk\build-tools\29.0.3\apksigner.bat' with args '["sign","--key","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-adb\\keys\\testkey.pk8","--cert","C:\\Users\\cskala\\AppData\\Roaming\\npm\\node_modules\\appium\\node_modules\\appium-adb\\keys\\testkey.x509.pem","c:\\Users\\cskala\\Documents\\Playground\\CSharp\\AppiumNunit/apps/ApiDemos-debug.apk"]'
[debug] [ADB] Getting install status for io.appium.android.apis
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell dumpsys package io.appium.android.apis'
[debug] [ADB] 'io.appium.android.apis' is not installed
[debug] [ADB] App 'c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk' is not installed
[debug] [ADB] Installing 'c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell 'ls -t -1 /data/local/tmp/appium_cache 2>&1 || echo _ERROR_''
[debug] [ADB] The count of applications in the cache: 3
[ADB] Caching the application at 'c:\Users\cskala\Documents\Playground\CSharp\AppiumNunit/apps/ApiDemos-debug.apk' to '/data/local/tmp/appium_cache/e9f0ac9a8579829d2ad58169d4eb272326c62061.apk'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell mkdir -p /data/local/tmp/appium_cache'
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 push c:\\Users\\cskala\\Documents\\Playground\\CSharp\\AppiumNunit/apps/ApiDemos-debug.apk /data/local/tmp/appium_cache/e9f0ac9a8579829d2ad58169d4eb272326c62061.apk'
[ADB] The upload of 'ApiDemos-debug.apk' (4.59 MB) took 115ms
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pm install /data/local/tmp/appium_cache/e9f0ac9a8579829d2ad58169d4eb272326c62061.apk'
[ADB] The installation of 'ApiDemos-debug.apk' took 253ms
[debug] [ADB] Install command stdout: Success
[debug] [UiAutomator2] Performing shallow cleanup of automation leftovers
[debug] [UiAutomator2] No obsolete sessions have been detected (Error: socket hang up)
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test'
[UiAutomator2] Starting UIAutomator2 server 4.5.5
[UiAutomator2] Using UIAutomator2 server from 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-server\apks\appium-uiautomator2-server-v4.5.5.apk' and test from 'C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\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","io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"]
[debug] [Instrumentation] java.lang.SecurityException: Permission Denial: starting instrumentation ComponentInfo{io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner} from pid=5513, uid=5513 not allowed because package io.appium.uiautomator2.server.test does not have a signature matching the target io.appium.uiautomator2.server
[debug] [Instrumentation]       at android.os.Parcel.createException(Parcel.java:2071)
[debug] [Instrumentation]       at android.os.Parcel.readException(Parcel.java:2039)
[debug] [Instrumentation] at android.os.Parcel.readException(Parcel.java:1987)
[debug] [Instrumentation]       at android.app.IActivityManager$Stub$Proxy.startInstrumentation(IActivityManager.java:5441)
[debug] [Instrumentation]       at com.android.commands.am.Instrument.run(Instrument.java:512)
[debug] [Instrumentation]       at com.android.commands.am.Am.runInstrument(Am.java:196)
[debug] [Instrumentation]       at com.android.commands.am.Am.onRun(Am.java:80)
[debug] [Instrumentation]       at com.android.internal.os.BaseCommand.run(BaseCommand.java:56)
[debug] [Instrumentation]       at com.android.commands.am.Am.main(Am.java:50)
[debug] [Instrumentation]       at com.android.internal.os.RuntimeInit.nativeFinishInit(Native Method)
[debug] [Instrumentation]       at com.android.internal.os.RuntimeInit.main(RuntimeInit.java:338)
[debug] [Instrumentation] Caused by: android.os.RemoteException: Remote stack trace:
[debug] [Instrumentation]       at com.android.server.am.ActivityManagerService.startInstrumentation(ActivityManagerService.java:15744)
[debug] [Instrumentation]       at android.app.IActivityManager$Stub.onTransact(IActivityManager.java:2350)
[debug] [Instrumentation]       at com.android.server.am.ActivityManagerService.onTransact(ActivityManagerService.java:2741)
[debug] [Instrumentation]       at android.os.Binder.execTransactInternal(Binder.java:1021)
[debug] [Instrumentation]       at android.os.Binder.execTransact(Binder.java:994)
[debug] [Instrumentation] The process has exited with code 1
[debug] [Instrumentation] FORTIFY: pthread_mutex_lock called on a destroyed mutex (0xded8c000)
[UiAutomator2] The instrumentation process has been unexpectedly terminated. Retrying UiAutomator2 startup (#1 of 1)
[debug] [UiAutomator2] Performing strict cleanup of automation leftovers
[debug] [UiAutomator2] No obsolete sessions have been detected (Error: socket hang up)
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test'
[debug] [ADB] Attempting to kill all uiautomator processes
[debug] [ADB] Getting IDs of all 'uiautomator' processes
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell pgrep -f uiautomator'
[ADB] No 'uiautomator' process has been found
[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_STATUS: Error=Permission Denial: starting instrumentation ComponentInfo{io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner} from pid=5545, uid=5545 not allowed because package io.appium.uiautomator2.server.test does not have a signature matching the target io.appium.uiautomator2.server
[debug] [Instrumentation] java.lang.SecurityException: Permission Denial: starting instrumentation ComponentInfo{io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner} from pid=5545, uid=5545 not allowed because package io.appium.uiautomator2.server.test does not have a signature matching the target io.appium.uiautomator2.server
[debug] [Instrumentation]       at android.os.Parcel.createException(Parcel.java:2071)
[debug] [Instrumentation]       at android.os.Parcel.readException(Parcel.java:2039)
[debug] [Instrumentation]       at android.os.Parcel.readException(Parcel.java:1987)
[debug] [Instrumentation]       at android.app.IActivityManager$Stub$Proxy.startInstrumentation(IActivityManager.java:5441)
[debug] [Instrumentation]       at com.android.commands.am.Instrument.run(Instrument.java:512)
[debug] [Instrumentation]       at com.android.commands.am.Am.runInstrument(Am.java:196)
[debug] [Instrumentation]       at com.android.commands.am.Am.onRun(Am.java:80)
[debug] [Instrumentation]       at com.android.internal.os.BaseCommand.run(BaseCommand.java:56)
[debug] [Instrumentation]       at com.android.commands.am.Am.main(Am.java:50)
[debug] [Instrumentation]       at com.android.internal.os.RuntimeInit.nativeFinishInit(Native Method)
[debug] [Instrumentation]       at com.android.internal.os.RuntimeInit.main(RuntimeInit.java:338)
[debug] [Instrumentation] Caused by: android.os.RemoteException: Remote stack trace:
[debug] [Instrumentation]       at com.android.server.am.ActivityManagerService.startInstrumentation(ActivityManagerService.java:15744)
[debug] [Instrumentation]       at android.app.IActivityManager$Stub.onTransact(IActivityManager.java:2350)
[debug] [Instrumentation]       at com.android.server.am.ActivityManagerService.onTransact(ActivityManagerService.java:2741)
[debug] [Instrumentation]       at android.os.Binder.execTransactInternal(Binder.java:1021)
[debug] [Instrumentation]       at android.os.Binder.execTransact(Binder.java:994)
[debug] [Instrumentation] INSTRUMENTATION_STATUS: id=ActivityManagerService
[debug] [Instrumentation] INSTRUMENTATION_STATUS_CODE: -1
[debug] [Instrumentation] The process has exited with code 1
[UiAutomator2] The instrumentation process cannot be initialized. Make sure the application under test does not crash and investigate the logcat output.
[debug] [UiAutomator2] Deleting UiAutomator2 session
[debug] [UiAutomator2] Deleting UiAutomator2 server session
[debug] [WD Proxy] Matched '/' to command name 'deleteSession'
[UiAutomator2] Did not get confirmation UiAutomator2 deleteSession worked; Error was: UnknownError: An unknown server-side error occurred while processing the command. Original error: Trying to proxy a session command without session id
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell am force-stop io.appium.android.apis'
[debug] [Logcat] Stopping logcat capture
[debug] [ADB] Removing forwarded port socket connection: 8200
[debug] [ADB] Running 'C:\Users\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 forward --remove tcp\:8200'
[UiAutomator2] Restoring hidden api policy to the device default configuration
[debug] [ADB] Running 'C:\Users\cskala\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\cskala\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\cskala\AppData\Local\Android\Sdk\platform-tools\adb.exe -P 5037 -s emulator-5554 shell settings delete global hidden_api_policy'
[debug] [BaseDriver] Event 'newSessionStarted' logged at 1583422361793 (10:32:41 GMT-0500 (Eastern Standard Time))
[debug] [W3C] Encountered internal error running command: Error: The instrumentation process cannot be initialized. Make sure the application under test does not crash and investigate the logcat output.
[debug] [W3C]     at Object.errorAndThrow (C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-support\lib\logging.js:87:35)
[debug] [W3C]     at UiAutomator2Server.startSession (C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-driver\lib\uiautomator2.js:231:13)
[debug] [W3C]     at AndroidUiautomator2Driver.startUiAutomator2Session (C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-driver\lib\driver.js:366:5)
[debug] [W3C]     at AndroidUiautomator2Driver.createSession (C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\node_modules\appium-uiautomator2-driver\lib\driver.js:212:7)
[debug] [W3C]     at AppiumDriver.createSession (C:\Users\cskala\AppData\Roaming\npm\node_modules\appium\lib\appium.js:358:35)
[debug] [W3C] Destroying socket connection
[HTTP] <-- POST /wd/hub/session 500 12168 ms - 837
[HTTP]