java-client
java-client copied to clipboard
appium
Did not get confirmation UiAutomator2 deleteSession worked; Error was: UnknownError: An unknown server-side error occurred while processing the command. Original error: 'DELETE /' cannot be proxied to UiAutomator2 server because the instrumentation process is not running (probably crashed)
The server is running [HTTP] Waiting until the server is closed [HTTP] Received server close event [Appium] Welcome to Appium v1.20.2 [Appium] Non-default server args: [Appium] relaxedSecurityEnabled: true [Appium] allowInsecure: { [Appium] } [Appium] denyInsecure: { [Appium] } [Appium] Appium REST http interface listener started on 0.0.0.0:4723 [HTTP] --> POST /wd/hub/session [HTTP] {"desiredCapabilities":{"VERSION":"10","appActivity":"com.pixelvide.fmsapp.activities.PreSplash","appPackage":"com.pixelvide.fmsapp","automationName ":"UiAutomator2","deviceName":"IFMIS","ensureWebviewsHavePages":true,"platformName":"Android","skipServerInstallation":"true","newCommandTimeout":0,"connectHardwareKeyboard":true}} [MJSONWP] Calling AppiumDriver.createSession() with args: [{"VERSION":"10","appActivity":"com.pixelvide.fmsapp.activities.PreSplash","appPackage":"com.pixelvide.fmsapp","automationName ":"UiAutomator2","deviceName":"IFMIS","ensureWebviewsHavePages":true,"platformName":"Android","skipServerInstallation":"true","newCommandTimeout":0,"connectHardwareKeyboard":true},null,null] [BaseDriver] Event 'newSessionRequested' logged at 1648550713430 (16:15:13 GMT+0530 (India Standard Time)) [Appium] [Appium] ====================================================================== [Appium] DEPRECATION WARNING: [Appium] [Appium] The 'automationName' capability was not provided in the desired [Appium] capabilities for this Android session [Appium] [Appium] Setting 'automationName=UiAutomator2' by default and using the [Appium] UiAutomator2 Driver [Appium] [Appium] The next major version of Appium (2.x) will require the [Appium] 'automationName' capability to be set for all sessions on all [Appium] platforms [Appium] [Appium] In previous versions (Appium <= 1.13.x), the default was [Appium] 'automationName=UiAutomator1' [Appium] [Appium] If you wish to use that automation instead of UiAutomator2, please [Appium] add 'automationName=UiAutomator1' to your desired capabilities [Appium] [Appium] For more information about drivers, please visit [Appium] http://appium.io/docs/en/about-appium/intro/ and explore the [Appium] 'Drivers' menu [Appium] [Appium] ====================================================================== [Appium] [Appium] Appium v1.20.2 creating new AndroidUiautomator2Driver (v1.61.2) session [Appium] Applying relaxed security to 'AndroidUiautomator2Driver' as per server command line argument. All insecure features will be enabled unless explicitly disabled by --deny-insecure [BaseDriver] Creating session with MJSONWP desired capabilities: { [BaseDriver] "VERSION": "10", [BaseDriver] "appActivity": "com.pixelvide.fmsapp.activities.PreSplash", [BaseDriver] "appPackage": "com.pixelvide.fmsapp", [BaseDriver] "automationName ": "UiAutomator2", [BaseDriver] "deviceName": "IFMIS", [BaseDriver] "ensureWebviewsHavePages": true, [BaseDriver] "platformName": "Android", [BaseDriver] "skipServerInstallation": "true", [BaseDriver] "newCommandTimeout": 0, [BaseDriver] "connectHardwareKeyboard": true [BaseDriver] } [BaseDriver] Capability 'skipServerInstallation' changed from string to boolean. This may cause unexpected behavior [BaseDriver] The following capabilities were provided, but are not recognized by Appium: [BaseDriver] VERSION [BaseDriver] automationName [BaseDriver] connectHardwareKeyboard [BaseDriver] Session created with session id: fb8b12a4-93be-4107-9e41-1917a3cd059a [UiAutomator2] Starting 'com.pixelvide.fmsapp' directly on the device [ADB] Using 'adb' from '/Users/karthik/Library/Android/sdk/platform-tools/adb' [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 start-server' [AndroidDriver] Retrieving device list [ADB] Trying to find a connected android device [ADB] Getting connected devices [ADB] Connected devices: [{"udid":"emulator-5554","state":"device"}] [AndroidDriver] Using device: emulator-5554 [ADB] Using 'adb' from '/Users/karthik/Library/Android/sdk/platform-tools/adb' [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 start-server' [ADB] Setting device id to emulator-5554 [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.sdk' [ADB] Current device property 'ro.build.version.sdk': 29 [ADB] Getting device platform version [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell getprop ro.build.version.release' [ADB] Current device property 'ro.build.version.release': 10 [ADB] Device API level: 29 [UiAutomator2] Relaxing hidden api policy [ADB] Running '/Users/karthik/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'' [AndroidDriver] No app sent in, not parsing package/activity [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 wait-for-device' [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell echo ping' [AndroidDriver] Pushing settings apk to device... [ADB] Getting install status for io.appium.settings [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings' [ADB] 'io.appium.settings' is installed [ADB] Getting package info for 'io.appium.settings' [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package io.appium.settings' [ADB] The version name of the installed 'io.appium.settings' is greater or equal to the application version name ('3.2.1' >= '3.2.1') [ADB] There is no need to install/upgrade '/Applications/Appium.app/Contents/Resources/app/node_modules/appium/node_modules/io.appium.settings/apks/settings_apk-debug.apk' [ADB] Getting IDs of all 'io.appium.settings' processes [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell 'pgrep --help; echo $?'' [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pgrep -f ([[:blank:]]|^)io.appium.settings([[:blank:]]|$)' [AndroidDriver] io.appium.settings is already running. There is no need to reset its permissions. [Logcat] Starting logs capture with command: /Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 logcat -v threadtime [UiAutomator2] Forwarding UiAutomator2 Server port 6790 to local port 8200 [ADB] Forwarding system: 8200 to device: 6790 [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 forward tcp:8200 tcp:6790' [UiAutomator2] 'skipServerInstallation' is set. Skipping UIAutomator2 server installation. [UiAutomator2] No app capability. Assuming it is already on the device [ADB] Getting install status for com.pixelvide.fmsapp [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell dumpsys package com.pixelvide.fmsapp' [ADB] 'com.pixelvide.fmsapp' is installed [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop com.pixelvide.fmsapp' [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pm clear com.pixelvide.fmsapp' [AndroidDriver] Performed fast reset on the installed 'com.pixelvide.fmsapp' application (stop and clear) [UiAutomator2] Performing shallow cleanup of automation leftovers [UiAutomator2] No obsolete sessions have been detected (socket hang up) [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test' [UiAutomator2] 'skipServerInstallation' is set. Attempting to use UIAutomator2 server from the device [UiAutomator2] Waiting up to 30000ms for UiAutomator2 to be online... [ADB] Creating ADB subprocess with args: ["-P",5037,"-s","emulator-5554","shell","am","instrument","-w","io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"] [WD Proxy] Matched '/status' to command name 'getStatus' [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8200/wd/hub/status] with no body [WD Proxy] socket hang up [Instrumentation] android.util.AndroidException: INSTRUMENTATION_FAILED: io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner [Instrumentation] at com.android.commands.am.Instrument.run(Instrument.java:514) [Instrumentation] at com.android.commands.am.Am.runInstrument(Am.java:196) [Instrumentation] at com.android.commands.am.Am.onRun(Am.java:80) [Instrumentation] at com.android.internal.os.BaseCommand.run(BaseCommand.java:56) [Instrumentation] at com.android.commands.am.Am.main(Am.java:50) [Instrumentation] at com.android.internal.os.RuntimeInit.nativeFinishInit(Native Method) [Instrumentation] at com.android.internal.os.RuntimeInit.main(RuntimeInit.java:338) [Instrumentation] FORTIFY: pthread_mutex_lock called on a destroyed mutex (0x97dfd000) [Instrumentation] The process has exited with code 1 [UiAutomator2] The instrumentation process has been unexpectedly terminated. Retrying UiAutomator2 startup (#1 of 1) [UiAutomator2] Performing strict cleanup of automation leftovers [UiAutomator2] No obsolete sessions have been detected (socket hang up) [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop io.appium.uiautomator2.server.test' [ADB] Attempting to kill all uiautomator processes [ADB] Getting IDs of all 'uiautomator' processes [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell pgrep -f ([[:blank:]]|^)uiautomator([[:blank:]]|$)' [ADB] No 'uiautomator' process has been found [UiAutomator2] Waiting up to 30000ms for UiAutomator2 to be online... [ADB] Creating ADB subprocess with args: ["-P",5037,"-s","emulator-5554","shell","am","instrument","-w","io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner"] [WD Proxy] Matched '/status' to command name 'getStatus' [WD Proxy] Proxying [GET /status] to [GET http://127.0.0.1:8200/wd/hub/status] with no body [WD Proxy] socket hang up [Instrumentation] android.util.AndroidException: INSTRUMENTATION_FAILED: io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner [Instrumentation] at com.android.commands.am.Instrument.run(Instrument.java:514) [Instrumentation] INSTRUMENTATION_STATUS: Error=Unable to find instrumentation info for: ComponentInfo{io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner} [Instrumentation] INSTRUMENTATION_STATUS: id=ActivityManagerService [Instrumentation] INSTRUMENTATION_STATUS_CODE: -1 [Instrumentation] at com.android.commands.am.Am.runInstrument(Am.java:196) [Instrumentation] at com.android.commands.am.Am.onRun(Am.java:80) [Instrumentation] at com.android.internal.os.BaseCommand.run(BaseCommand.java:56) [Instrumentation] at com.android.commands.am.Am.main(Am.java:50) [Instrumentation] at com.android.internal.os.RuntimeInit.nativeFinishInit(Native Method) [Instrumentation] at com.android.internal.os.RuntimeInit.main(RuntimeInit.java:338) [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. [UiAutomator2] Deleting UiAutomator2 session [UiAutomator2] Deleting UiAutomator2 server session [UiAutomator2] Did not get confirmation UiAutomator2 deleteSession worked; Error was: UnknownError: An unknown server-side error occurred while processing the command. Original error: 'DELETE /' cannot be proxied to UiAutomator2 server because the instrumentation process is not running (probably crashed). Check the server log and/or the logcat output for more details [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell am force-stop com.pixelvide.fmsapp' [Logcat] Stopping logcat capture [ADB] Removing forwarded port socket connection: 8200 [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 forward --remove tcp:8200' [UiAutomator2] Restoring hidden api policy to the device default configuration [ADB] Running '/Users/karthik/Library/Android/sdk/platform-tools/adb -P 5037 -s emulator-5554 shell 'settings delete global hidden_api_policy_pre_p_apps;settings delete global hidden_api_policy_p_apps;settings delete global hidden_api_policy'' [BaseDriver] Event 'newSessionStarted' logged at 1648550721359 (16:15:21 GMT+0530 (India Standard Time)) [MJSONWP] 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. [MJSONWP] at Object.errorAndThrow (/Applications/Appium.app/Contents/Resources/app/node_modules/appium/node_modules/appium-support/lib/logging.js:94:35) [MJSONWP] at UiAutomator2Server.startSession (/Applications/Appium.app/Contents/Resources/app/node_modules/appium/node_modules/appium-uiautomator2-driver/lib/uiautomator2.js:241:13) [MJSONWP] at AndroidUiautomator2Driver.startUiAutomator2Session (/Applications/Appium.app/Contents/Resources/app/node_modules/appium/node_modules/appium-uiautomator2-driver/lib/driver.js:407:5) [MJSONWP] at AndroidUiautomator2Driver.createSession (/Applications/Appium.app/Contents/Resources/app/node_modules/appium/node_modules/appium-uiautomator2-driver/lib/driver.js:224:7) [MJSONWP] at AppiumDriver.createSession (/Applications/Appium.app/Contents/Resources/app/node_modules/appium/lib/appium.js:371:35) [HTTP] <-- POST /wd/hub/session 500 7932 ms - 274 [HTTP] [HTTP] --> DELETE /wd/hub/session [HTTP] {} [HTTP] No route found for /wd/hub/session [HTTP] <-- DELETE /wd/hub/session 404 10 ms - 211 [HTTP]
Please provide the logcat output as requested in the actual error message
2022-03-29 17:37:30.313 11691-11691/? I/e.myapplicatio: Late-enabling -Xcheck:jni 2022-03-29 17:37:30.811 11691-11691/? E/e.myapplicatio: Unknown bits set in runtime_flags: 0x8000 2022-03-29 17:37:30.817 11691-11691/? W/e.myapplicatio: Unexpected CPU variant for X86 using defaults: x86 2022-03-29 17:37:32.681 11691-11723/com.example.myapplication D/libEGL: Emulator has host GPU support, qemu.gles is set to 1. 2022-03-29 17:37:32.705 11691-11723/com.example.myapplication W/libc: Unable to set property "qemu.gles" to "1": connection failed; errno=13 (Permission denied) 2022-03-29 17:37:32.820 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libEGL_emulation.so 2022-03-29 17:37:32.825 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libGLESv1_CM_emulation.so 2022-03-29 17:37:32.834 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libGLESv2_emulation.so 2022-03-29 17:37:32.665 11691-11691/com.example.myapplication W/RenderThread: type=1400 audit(0.0:151): avc: denied { write } for name="property_service" dev="tmpfs" ino=7423 scontext=u:r:untrusted_app:s0:c150,c256,c512,c768 tcontext=u:object_r:property_socket:s0 tclass=sock_file permissive=0 app=com.example.myapplication at com.google.android.chimera.config.ModuleManager.getCurrentModule(:com.google.android.gms@[email protected] (040700-319035315):2) 2022-03-29 15:51:29.263 1729-7221/? W/audio_hw_generic: Hardware backing HAL too slow, could only write 0 of 661 frames 2022-03-29 17:37:34.160 11691-11691/com.example.myapplication W/e.myapplicatio: Accessing hidden method Landroid/view/View;->computeFitSystemWindows(Landroid/graphics/Rect;Landroid/graphics/Rect;)Z (greylist, reflection, allowed) 2022-03-29 15:51:29.285 1991-2011/system_process D/AutofillManagerService: Close system dialogs 2022-03-29 17:37:34.160 11691-11691/com.example.myapplication W/e.myapplicatio: Accessing hidden method Landroid/view/ViewGroup;->makeOptionalFitsSystemWindows()V (greylist, reflection, allowed) 2022-03-29 17:37:34.406 11691-11691/com.example.myapplication W/e.myapplicatio: Verification of void androidx.appcompat.widget.AppCompatButton.onTextChanged(java.lang.CharSequence, int, int, int) took 152.474ms 2022-03-29 17:37:34.646 11691-11721/com.example.myapplication D/HostConnection: HostConnection::get() New Host Connection established 0x9643eff0, tid 11721 2022-03-29 17:37:34.662 11691-11721/com.example.myapplication D/HostConnection: HostComposition ext ANDROID_EMU_CHECKSUM_HELPER_v1 ANDROID_EMU_native_sync_v2 ANDROID_EMU_native_sync_v3 ANDROID_EMU_native_sync_v4 ANDROID_EMU_dma_v1 ANDROID_EMU_direct_mem ANDROID_EMU_host_composition_v1 ANDROID_EMU_host_composition_v2 ANDROID_EMU_YUV_Cache ANDROID_EMU_sync_buffer_data GL_OES_EGL_image_external_essl3 GL_OES_vertex_array_object GL_KHR_texture_compression_astc_ldr ANDROID_EMU_host_side_tracing ANDROID_EMU_gles_max_version_3_0 2022-03-29 17:37:34.688 11691-11721/com.example.myapplication W/OpenGLRenderer: Failed to choose config with EGL_SWAP_BEHAVIOR_PRESERVED, retrying without... 2022-03-29 15:51:29.368 1991-2012/system_process I/ActivityTaskManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10000100 cmp=com.google.android.apps.nexuslauncher/.NexusLauncherActivity (has extras)} from uid 0 2022-03-29 15:51:29.403 1729-7221/? W/audio_hw_generic: Hardware backing HAL too slow, could only write 0 of 661 frames 2022-03-29 17:37:34.699 11691-11721/com.example.myapplication D/EGL_emulation: eglMakeCurrent: 0xa27af9e0: ver 3 0 (tinfo 0xa284ee20) 2022-03-29 17:37:34.727 11691-11721/com.example.myapplication W/Gralloc3: mapper 3.x is not supported 2022-03-29 15:51:29.419 1729-7221/? W/audio_hw_generic: Hardware backing HAL too slow, could only write 0 of 661 frames 2022-03-29 17:37:34.735 11691-11721/com.example.myapplication D/HostConnection: createUnique: call 2022-03-29 15:51:29.446 1729-7221/? W/audio_hw_generic: Not supplying enough data to HAL, expected position 2881802 , only wrote 2881299 2022-03-29 17:37:34.736 11691-11721/com.example.myapplication D/HostConnection: HostConnection::get() New Host Connection established 0x964407b0, tid 11721 2022-03-29 17:37:34.737 11691-11721/com.example.myapplication D/HostConnection: HostComposition ext ANDROID_EMU_CHECKSUM_HELPER_v1 ANDROID_EMU_native_sync_v2 ANDROID_EMU_native_sync_v3 ANDROID_EMU_native_sync_v4 ANDROID_EMU_dma_v1 ANDROID_EMU_direct_mem ANDROID_EMU_host_composition_v1 ANDROID_EMU_host_composition_v2 ANDROID_EMU_YUV_Cache ANDROID_EMU_sync_buffer_data GL_OES_EGL_image_external_essl3 GL_OES_vertex_array_object GL_KHR_texture_compression_astc_ldr ANDROID_EMU_host_side_tracing ANDROID_EMU_gles_max_version_3_0 2022-03-29 17:37:34.740 11691-11721/com.example.myapplication D/eglCodecCommon: allocate: Ask for block of size 0x1000 2022-03-29 17:37:34.740 11691-11721/com.example.myapplication D/eglCodecCommon: allocate: ioctl allocate returned offset 0x3ff7ff000 size 0x2000 2022-03-29 17:37:34.837 11691-11721/com.example.myapplication D/EGL_emulation: eglMakeCurrent: 0xa27af9e0: ver 3 0 (tinfo 0xa284ee20) 2022-03-29 17:37:35.382 11691-11721/com.example.myapplication I/OpenGLRenderer: Davey! duration=855ms; Flags=1, IntendedVsync=5372326756593, Vsync=5372343423259, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=5372353000322, AnimationStart=5372353095322, PerformTraversalsStart=5372353176322, DrawStart=5372551965322, SyncQueued=5372638757322, SyncStart=5372646504322, IssueDrawCommandsStart=5372647331322, SwapBuffers=5373175252322, FrameCompleted=5373189781322, DequeueBufferDuration=833000, QueueBufferDuration=2603000, 2022-03-29 17:37:35.661 11691-11691/com.example.myapplication W/e.myapplicatio: Verification of void androidx.appcompat.view.menu.MenuItemImpl.setSubMenu(androidx.appcompat.view.menu.SubMenuBuilder) took 137.171ms 2022-03-29 17:37:35.723 11691-11721/com.example.myapplication I/OpenGLRenderer: Davey! duration=1170ms; Flags=0, IntendedVsync=5372360113812, Vsync=5373460113768, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=5373476466322, AnimationStart=5373476541322, PerformTraversalsStart=5373477221322, DrawStart=5373495996322, SyncQueued=5373520400322, SyncStart=5373521313322, IssueDrawCommandsStart=5373521420322, SwapBuffers=5373524149322, FrameCompleted=5373531557322, DequeueBufferDuration=1763000, QueueBufferDuration=1802000, 2022-03-29 17:37:30.313 11691-11691/? I/e.myapplicatio: Late-enabling -Xcheck:jni 2022-03-29 17:37:32.681 11691-11723/com.example.myapplication D/libEGL: Emulator has host GPU support, qemu.gles is set to 1. 2022-03-29 17:37:32.705 11691-11723/com.example.myapplication W/libc: Unable to set property "qemu.gles" to "1": connection failed; errno=13 (Permission denied) 2022-03-29 17:37:32.820 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libEGL_emulation.so 2022-03-29 17:37:32.825 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libGLESv1_CM_emulation.so 2022-03-29 17:37:32.834 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libGLESv2_emulation.so 2022-03-29 17:37:32.665 11691-11691/com.example.myapplication W/RenderThread: type=1400 audit(0.0:151): avc: denied { write } for name="property_service" dev="tmpfs" ino=7423 scontext=u:r:untrusted_app:s0:c150,c256,c512,c768 tcontext=u:object_r:property_socket:s0 tclass=sock_file permissive=0 app=com.example.myapplication 2022-03-29 17:37:34.160 11691-11691/com.example.myapplication W/e.myapplicatio: Accessing hidden method Landroid/view/View;->computeFitSystemWindows(Landroid/graphics/Rect;Landroid/graphics/Rect;)Z (greylist, reflection, allowed) 2022-03-29 17:37:34.160 11691-11691/com.example.myapplication W/e.myapplicatio: Accessing hidden method Landroid/view/ViewGroup;->makeOptionalFitsSystemWindows()V (greylist, reflection, allowed) 2022-03-29 17:37:34.406 11691-11691/com.example.myapplication W/e.myapplicatio: Verification of void androidx.appcompat.widget.AppCompatButton.onTextChanged(java.lang.CharSequence, int, int, int) took 152.474ms 2022-03-29 17:37:34.646 11691-11721/com.example.myapplication D/HostConnection: HostConnection::get() New Host Connection established 0x9643eff0, tid 11721 2022-03-29 17:37:34.688 11691-11721/com.example.myapplication W/OpenGLRenderer: Failed to choose config with EGL_SWAP_BEHAVIOR_PRESERVED, retrying without... 2022-03-29 17:37:34.692 11691-11721/com.example.myapplication D/EGL_emulation: eglCreateContext: 0xa27af9e0: maj 3 min 0 rcv 3 2022-03-29 17:37:34.699 11691-11721/com.example.myapplication D/EGL_emulation: eglMakeCurrent: 0xa27af9e0: ver 3 0 (tinfo 0xa284ee20) 2022-03-29 17:37:34.723 11691-11703/com.example.myapplication I/e.myapplicatio: Background concurrent copying GC freed 3246(256KB) AllocSpace objects, 0(0B) LOS objects, 49% free, 1746KB/3492KB, paused 746us total 164.273ms 2022-03-29 17:37:34.727 11691-11721/com.example.myapplication W/Gralloc3: mapper 3.x is not supported 2022-03-29 17:37:34.735 11691-11721/com.example.myapplication D/HostConnection: createUnique: call 2022-03-29 17:37:34.736 11691-11721/com.example.myapplication D/HostConnection: HostConnection::get() New Host Connection established 0x964407b0, tid 11721 2022-03-29 17:37:34.737 11691-11721/com.example.myapplication D/HostConnection: HostComposition ext ANDROID_EMU_CHECKSUM_HELPER_v1 ANDROID_EMU_native_sync_v2 ANDROID_EMU_native_sync_v3 ANDROID_EMU_native_sync_v4 ANDROID_EMU_dma_v1 ANDROID_EMU_direct_mem ANDROID_EMU_host_composition_v1 ANDROID_EMU_host_composition_v2 ANDROID_EMU_YUV_Cache ANDROID_EMU_sync_buffer_data GL_OES_EGL_image_external_essl3 GL_OES_vertex_array_object GL_KHR_texture_compression_astc_ldr ANDROID_EMU_host_side_tracing ANDROID_EMU_gles_max_version_3_0 2022-03-29 17:37:34.740 11691-11721/com.example.myapplication D/eglCodecCommon: allocate: Ask for block of size 0x1000 2022-03-29 17:37:34.740 11691-11721/com.example.myapplication D/eglCodecCommon: allocate: ioctl allocate returned offset 0x3ff7ff000 size 0x2000 2022-03-29 15:52:28.200 3151-3388/com.google.android.googlequicksearchbox W/ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 2022-03-29 17:37:34.837 11691-11721/com.example.myapplication D/EGL_emulation: eglMakeCurrent: 0xa27af9e0: ver 3 0 (tinfo 0xa284ee20) 2022-03-29 17:37:35.382 11691-11721/com.example.myapplication I/OpenGLRenderer: Davey! duration=855ms; Flags=1, IntendedVsync=5372326756593, Vsync=5372343423259, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=5372353000322, AnimationStart=5372353095322, PerformTraversalsStart=5372353176322, DrawStart=5372551965322, SyncQueued=5372638757322, SyncStart=5372646504322, IssueDrawCommandsStart=5372647331322, SwapBuffers=5373175252322, FrameCompleted=5373189781322, DequeueBufferDuration=833000, QueueBufferDuration=2603000, 2022-03-29 17:37:35.661 11691-11691/com.example.myapplication W/e.myapplicatio: Verification of void androidx.appcompat.view.menu.MenuItemImpl.setSubMenu(androidx.appcompat.view.menu.SubMenuBuilder) took 137.171ms 2022-03-29 17:37:35.668 11691-11691/com.example.myapplication I/Choreographer: Skipped 66 frames! The application may be doing too much work on its main thread. 2022-03-29 17:37:35.723 11691-11721/com.example.myapplication I/OpenGLRenderer: Davey! duration=1170ms; Flags=0, IntendedVsync=5372360113812, Vsync=5373460113768, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=5373476466322, AnimationStart=5373476541322, PerformTraversalsStart=5373477221322, DrawStart=5373495996322, SyncQueued=5373520400322, SyncStart=5373521313322, IssueDrawCommandsStart=5373521420322, SwapBuffers=5373524149322, FrameCompleted=5373531557322, DequeueBufferDuration=1763000, QueueBufferDuration=1802000, 2022-03-29 17:37:30.313 11691-11691/? I/e.myapplicatio: Late-enabling -Xcheck:jni 2022-03-29 17:37:30.811 11691-11691/? E/e.myapplicatio: Unknown bits set in runtime_flags: 0x8000 2022-03-29 17:37:30.817 11691-11691/? W/e.myapplicatio: Unexpected CPU variant for X86 using defaults: x86 2022-03-29 17:37:32.681 11691-11723/com.example.myapplication D/libEGL: Emulator has host GPU support, qemu.gles is set to 1. 2022-03-29 17:37:32.705 11691-11723/com.example.myapplication W/libc: Unable to set property "qemu.gles" to "1": connection failed; errno=13 (Permission denied) 2022-03-29 17:37:32.820 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libEGL_emulation.so 2022-03-29 17:37:32.825 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libGLESv1_CM_emulation.so 2022-03-29 17:37:32.834 11691-11723/com.example.myapplication D/libEGL: loaded /vendor/lib/egl/libGLESv2_emulation.so 2022-03-29 17:37:32.665 11691-11691/com.example.myapplication W/RenderThread: type=1400 audit(0.0:151): avc: denied { write } for name="property_service" dev="tmpfs" ino=7423 scontext=u:r:untrusted_app:s0:c150,c256,c512,c768 tcontext=u:object_r:property_socket:s0 tclass=sock_file permissive=0 app=com.example.myapplication 2022-03-29 17:37:34.160 11691-11691/com.example.myapplication W/e.myapplicatio: Accessing hidden method Landroid/view/View;->computeFitSystemWindows(Landroid/graphics/Rect;Landroid/graphics/Rect;)Z (greylist, reflection, allowed) 2022-03-29 17:37:34.160 11691-11691/com.example.myapplication W/e.myapplicatio: Accessing hidden method Landroid/view/ViewGroup;->makeOptionalFitsSystemWindows()V (greylist, reflection, allowed) 2022-03-29 17:37:34.406 11691-11691/com.example.myapplication W/e.myapplicatio: Verification of void androidx.appcompat.widget.AppCompatButton.onTextChanged(java.lang.CharSequence, int, int, int) took 152.474ms 2022-03-29 17:37:34.646 11691-11721/com.example.myapplication D/HostConnection: HostConnection::get() New Host Connection established 0x9643eff0, tid 11721 2022-03-29 17:37:34.662 11691-11721/com.example.myapplication D/HostConnection: HostComposition ext ANDROID_EMU_CHECKSUM_HELPER_v1 ANDROID_EMU_native_sync_v2 ANDROID_EMU_native_sync_v3 ANDROID_EMU_native_sync_v4 ANDROID_EMU_dma_v1 ANDROID_EMU_direct_mem ANDROID_EMU_host_composition_v1 ANDROID_EMU_host_composition_v2 ANDROID_EMU_YUV_Cache ANDROID_EMU_sync_buffer_data GL_OES_EGL_image_external_essl3 GL_OES_vertex_array_object GL_KHR_texture_compression_astc_ldr ANDROID_EMU_host_side_tracing ANDROID_EMU_gles_max_version_3_0 2022-03-29 17:37:34.688 11691-11721/com.example.myapplication W/OpenGLRenderer: Failed to choose config with EGL_SWAP_BEHAVIOR_PRESERVED, retrying without... 2022-03-29 17:37:34.692 11691-11721/com.example.myapplication D/EGL_emulation: eglCreateContext: 0xa27af9e0: maj 3 min 0 rcv 3 2022-03-29 17:37:34.699 11691-11721/com.example.myapplication D/EGL_emulation: eglMakeCurrent: 0xa27af9e0: ver 3 0 (tinfo 0xa284ee20) 2022-03-29 17:37:34.723 11691-11703/com.example.myapplication I/e.myapplicatio: Background concurrent copying GC freed 3246(256KB) AllocSpace objects, 0(0B) LOS objects, 49% free, 1746KB/3492KB, paused 746us total 164.273ms 2022-03-29 17:37:34.727 11691-11721/com.example.myapplication W/Gralloc3: mapper 3.x is not supported 2022-03-29 17:37:34.735 11691-11721/com.example.myapplication D/HostConnection: createUnique: call 2022-03-29 17:37:34.736 11691-11721/com.example.myapplication D/HostConnection: HostConnection::get() New Host Connection established 0x964407b0, tid 11721 2022-03-29 17:37:34.737 11691-11721/com.example.myapplication D/HostConnection: HostComposition ext ANDROID_EMU_CHECKSUM_HELPER_v1 ANDROID_EMU_native_sync_v2 ANDROID_EMU_native_sync_v3 ANDROID_EMU_native_sync_v4 ANDROID_EMU_dma_v1 ANDROID_EMU_direct_mem ANDROID_EMU_host_composition_v1 ANDROID_EMU_host_composition_v2 ANDROID_EMU_YUV_Cache ANDROID_EMU_sync_buffer_data GL_OES_EGL_image_external_essl3 GL_OES_vertex_array_object GL_KHR_texture_compression_astc_ldr ANDROID_EMU_host_side_tracing ANDROID_EMU_gles_max_version_3_0 2022-03-29 17:37:34.740 11691-11721/com.example.myapplication D/eglCodecCommon: allocate: Ask for block of size 0x1000 2022-03-29 17:37:34.740 11691-11721/com.example.myapplication D/eglCodecCommon: allocate: ioctl allocate returned offset 0x3ff7ff000 size 0x2000 2022-03-29 17:37:34.837 11691-11721/com.example.myapplication D/EGL_emulation: eglMakeCurrent: 0xa27af9e0: ver 3 0 (tinfo 0xa284ee20) 2022-03-29 17:37:35.382 11691-11721/com.example.myapplication I/OpenGLRenderer: Davey! duration=855ms; Flags=1, IntendedVsync=5372326756593, Vsync=5372343423259, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=5372353000322, AnimationStart=5372353095322, PerformTraversalsStart=5372353176322, DrawStart=5372551965322, SyncQueued=5372638757322, SyncStart=5372646504322, IssueDrawCommandsStart=5372647331322, SwapBuffers=5373175252322, FrameCompleted=5373189781322, DequeueBufferDuration=833000, QueueBufferDuration=2603000, 2022-03-29 17:37:35.661 11691-11691/com.example.myapplication W/e.myapplicatio: Verification of void androidx.appcompat.view.menu.MenuItemImpl.setSubMenu(androidx.appcompat.view.menu.SubMenuBuilder) took 137.171ms 2022-03-29 17:37:35.668 11691-11691/com.example.myapplication I/Choreographer: Skipped 66 frames! The application may be doing too much work on its main thread. 2022-03-29 17:37:35.723 11691-11721/com.example.myapplication I/OpenGLRenderer: Davey! duration=1170ms; Flags=0, IntendedVsync=5372360113812, Vsync=5373460113768, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=5373476466322, AnimationStart=5373476541322, PerformTraversalsStart=5373477221322, DrawStart=5373495996322, SyncQueued=5373520400322, SyncStart=5373521313322, IssueDrawCommandsStart=5373521420322, SwapBuffers=5373524149322, FrameCompleted=5373531557322, DequeueBufferDuration=1763000, QueueBufferDuration=1802000,
Are you sure it's the correct log snippet taken within the same time range the automation session has been starting?
Then probably something is missing from there. I'd expect some exception stack traces to be present in the log
@mykola-mokhnach will this help you with something
--------- beginning of main 03-29 20:18:04.023 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:04.025 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:04.025 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:04.025 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:08.457 15544 15916 E memtrack: Couldn't load memtrack module 03-29 20:18:08.457 15544 15916 W android.os.Debug: failed to get memory consumption info: -1 03-29 20:18:09.030 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:09.031 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:09.033 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:09.034 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:14.038 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:14.041 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:14.041 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:14.041 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:19.046 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:19.049 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:19.049 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:19.049 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:24.054 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:24.059 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:24.060 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:24.060 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:24.291 1828 1828 E netmgr : Failed to open QEMU pipe 'qemud:network': Invalid argument 03-29 20:18:25.555 1834 1834 E wifi_forwarder: RemoteConnection failed to initialize: RemoteConnection failed to open pipe 03-29 20:18:29.066 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:29.068 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:29.069 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:29.069 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:34.074 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:34.077 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:34.078 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:34.078 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:39.082 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:39.084 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:39.085 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:39.085 3151 3388 I MicroDetectionWorker: #onError(false) --------- beginning of system 03-29 20:18:40.163 1991 1991 V SettingsProvider: Notifying for 0: content://settings/global/hidden_api_policy_pre_p_apps 03-29 20:18:40.195 1991 1991 V SettingsProvider: Notifying for 0: content://settings/global/hidden_api_policy_p_apps 03-29 20:18:40.216 1991 1991 V SettingsProvider: Notifying for 0: content://settings/global/hidden_api_policy 03-29 20:18:40.732 1991 3318 I ActivityManager: Force stopping com.pixelvide.fmsapp appid=10148 user=0: from pid 15967 03-29 20:18:40.756 2438 2438 D CarrierSvcBindHelper: No carrier app for: 0 03-29 20:18:40.798 1991 2008 I ActivityManager: Force stopping com.pixelvide.fmsapp appid=10148 user=0: clear data 03-29 20:18:40.801 1991 2020 I ActivityManager: Force stopping com.pixelvide.fmsapp appid=10148 user=-1: clearApplicationUserData 03-29 20:18:40.805 1798 1798 I keystore: clear_uid 10148 03-29 20:18:40.813 1991 2008 I ConditionProviders: Disallowing condition provider com.pixelvide.fmsapp 03-29 20:18:40.816 1766 2204 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.823 1766 2590 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:40.823 1766 1959 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.828 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.831 1766 2204 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.834 1766 2590 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:40.841 1766 2204 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.841 1766 1959 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.849 2438 2438 D CarrierSvcBindHelper: No carrier app for: 0 03-29 20:18:40.849 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.851 1766 1959 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.852 1766 2590 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:40.857 1766 2204 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.860 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.860 2168 2168 I GeofencerStateMachine: removeGeofences: removeRequest=RemoveGeofencingRequest[REMOVE_ALL packageName=com.pixelvide.fmsapp] 03-29 20:18:40.862 1766 1959 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.863 4726 4726 I CarrierServices: [2] RcsAutoStartReceiver.a: enableRcs changed from true to true 03-29 20:18:40.868 1766 2204 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.869 1766 2590 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:40.871 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.881 1766 1959 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.883 1766 2590 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:40.887 1766 2204 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.895 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.900 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.904 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.906 1766 2590 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:40.906 1766 1958 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.913 1766 1958 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.914 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.935 1766 1958 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:40.941 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.946 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:40.952 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.952 1780 1780 E adbd : failed to connect to socket 'tcp:6790': Connection refused 03-29 20:18:40.966 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:40.972 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:40.979 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:41.000 1766 1958 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:41.003 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.012 1766 8817 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:41.022 8606 15976 I MediaProvider: Begin Intent { act=android.intent.action.PACKAGE_DATA_CLEARED dat=package:com.pixelvide.fmsapp flg=0x1000010 cmp=com.android.providers.media/.MediaService (has extras) } 03-29 20:18:41.028 1766 8817 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:41.031 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.033 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:41.050 1766 1766 I chatty : uid=1041(audioserver) /system/bin/audioserver identical 1 line 03-29 20:18:41.053 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:41.056 1766 8817 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:41.060 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:41.062 1766 8817 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:41.066 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:41.073 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:41.077 8606 15976 I MediaProvider: End Intent { act=android.intent.action.PACKAGE_DATA_CLEARED dat=package:com.pixelvide.fmsapp flg=0x1000010 cmp=com.android.providers.media/.MediaService (has extras) } 03-29 20:18:41.080 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.082 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:41.085 1766 1958 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:41.090 1766 1958 D AF::TrackHandle: OpPlayAudio: track:58 usage:13 not muted 03-29 20:18:41.102 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:41.114 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.117 1766 1766 D AF::TrackHandle: OpPlayAudio: track:56 usage:13 not muted 03-29 20:18:41.136 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:41.147 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.151 1766 1959 I chatty : uid=1041(audioserver) Binder:1766_2 identical 1 line 03-29 20:18:41.154 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.165 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:41.175 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:41.185 1766 1959 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.187 1766 2590 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:41.209 1766 1766 D AF::TrackHandle: OpPlayAudio: track:57 usage:13 not muted 03-29 20:18:41.209 1766 8817 D AF::TrackHandle: OpPlayAudio: track:55 usage:13 not muted 03-29 20:18:41.217 2168 15989 I Fitness : FitCleanupIntentOperation received Intent android.intent.action.PACKAGE_DATA_CLEARED [CONTEXT service_id=17 ] 03-29 20:18:41.235 1991 2405 W ActivityManager: Invalid packageName: io.appium.uiautomator2.server.test 03-29 20:18:41.258 2528 9837 I Icing : doRemovePackageData com.pixelvide.fmsapp 03-29 20:18:41.264 1780 1780 E adbd : failed to connect to socket 'tcp:6790': Connection refused 03-29 20:18:41.272 8579 15819 I ProvidersCache: Provider returned no roots. Possibly naughty: com.google.android.apps.docs.storage 03-29 20:18:41.557 15995 15995 D AndroidRuntime: >>>>>> START com.android.internal.os.RuntimeInit uid 2000 <<<<<< 03-29 20:18:41.549 15995 15995 W app_process: type=1400 audit(0.0:224): avc: denied { read } for name="u:object_r:device_config_runtime_native_boot_prop:s0" dev="tmpfs" ino=7329 scontext=u:r:shell:s0 tcontext=u:object_r:device_config_runtime_native_boot_prop:s0 tclass=file permissive=0 03-29 20:18:41.564 15995 15995 E libc : Access denied finding property "persist.device_config.runtime_native_boot.enable_apex_image" 03-29 20:18:41.564 15995 15995 I AndroidRuntime: Using default boot image 03-29 20:18:41.564 15995 15995 E libc : Access denied finding property "persist.device_config.runtime_native_boot.disable_lock_profiling" 03-29 20:18:41.564 15995 15995 I AndroidRuntime: Leaving lock profiling enabled 03-29 20:18:41.564 15995 15995 E libc : Access denied finding property "persist.device_config.runtime_native_boot.enable_generational_cc" 03-29 20:18:41.549 15995 15995 W app_process: type=1400 audit(0.0:225): avc: denied { read } for name="u:object_r:device_config_runtime_native_boot_prop:s0" dev="tmpfs" ino=7329 scontext=u:r:shell:s0 tcontext=u:object_r:device_config_runtime_native_boot_prop:s0 tclass=file permissive=0 03-29 20:18:41.549 15995 15995 W app_process: type=1400 audit(0.0:226): avc: denied { read } for name="u:object_r:device_config_runtime_native_boot_prop:s0" dev="tmpfs" ino=7329 scontext=u:r:shell:s0 tcontext=u:object_r:device_config_runtime_native_boot_prop:s0 tclass=file permissive=0 03-29 20:18:41.568 15995 15995 I app_process: Core platform API reporting enabled, enforcing=false 03-29 20:18:41.665 15995 15995 D ICU : Time zone APEX file found: /apex/com.android.tzdata/etc/icu/icu_tzdata.dat 03-29 20:18:41.672 15995 15995 W app_process: Unexpected CPU variant for X86 using defaults: x86 03-29 20:18:41.680 15995 15995 I app_process: The ClassLoaderContext is a special shared library. 03-29 20:18:41.697 15995 15995 W app_process: JNI RegisterNativeMethods: attempt to register 0 native methods for android.media.AudioAttributes 03-29 20:18:41.703 15995 15995 D AndroidRuntime: Calling main entry com.android.commands.am.Am 03-29 20:18:41.712 1991 2945 W ActivityManager: Unable to find instrumentation info for: ComponentInfo{io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner} 03-29 20:18:41.715 1991 16007 W Binder : Outgoing transactions from this process must be FLAG_ONEWAY 03-29 20:18:41.715 1991 16007 W Binder : java.lang.Throwable 03-29 20:18:41.715 1991 16007 W Binder : at android.os.BinderProxy.transact(BinderProxy.java:480) 03-29 20:18:41.715 1991 16007 W Binder : at android.app.IInstrumentationWatcher$Stub$Proxy.instrumentationStatus(IInstrumentationWatcher.java:172) 03-29 20:18:41.715 1991 16007 W Binder : at com.android.server.am.InstrumentationReporter$MyThread.run(InstrumentationReporter.java:80) 03-29 20:18:41.718 15995 15995 I app_process: System.exit called, status: 1 03-29 20:18:41.718 15995 15995 I AndroidRuntime: VM exiting with result code 1. 03-29 20:18:42.275 1780 1780 E adbd : failed to connect to socket 'tcp:6790': Connection refused 03-29 20:18:42.337 1991 2405 W ActivityManager: Invalid packageName: io.appium.uiautomator2.server.test 03-29 20:18:44.091 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:44.098 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:44.099 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:44.099 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:45.435 1780 1780 E adbd : failed to connect to socket 'tcp:6790': Connection refused 03-29 20:18:45.559 16018 16018 W app_process: type=1400 audit(0.0:227): avc: denied { read } for name="u:object_r:device_config_runtime_native_boot_prop:s0" dev="tmpfs" ino=7329 scontext=u:r:shell:s0 tcontext=u:object_r:device_config_runtime_native_boot_prop:s0 tclass=file permissive=0 03-29 20:18:45.559 16018 16018 W app_process: type=1400 audit(0.0:228): avc: denied { read } for name="u:object_r:device_config_runtime_native_boot_prop:s0" dev="tmpfs" ino=7329 scontext=u:r:shell:s0 tcontext=u:object_r:device_config_runtime_native_boot_prop:s0 tclass=file permissive=0 03-29 20:18:45.569 16018 16018 D AndroidRuntime: >>>>>> START com.android.internal.os.RuntimeInit uid 2000 <<<<<< 03-29 20:18:45.572 16018 16018 E libc : Access denied finding property "persist.device_config.runtime_native_boot.enable_apex_image" 03-29 20:18:45.572 16018 16018 I AndroidRuntime: Using default boot image 03-29 20:18:45.572 16018 16018 E libc : Access denied finding property "persist.device_config.runtime_native_boot.disable_lock_profiling" 03-29 20:18:45.559 16018 16018 W app_process: type=1400 audit(0.0:229): avc: denied { read } for name="u:object_r:device_config_runtime_native_boot_prop:s0" dev="tmpfs" ino=7329 scontext=u:r:shell:s0 tcontext=u:object_r:device_config_runtime_native_boot_prop:s0 tclass=file permissive=0 03-29 20:18:45.572 16018 16018 I AndroidRuntime: Leaving lock profiling enabled 03-29 20:18:45.572 16018 16018 E libc : Access denied finding property "persist.device_config.runtime_native_boot.enable_generational_cc" 03-29 20:18:45.579 16018 16018 I app_process: Core platform API reporting enabled, enforcing=false 03-29 20:18:45.642 16018 16018 D ICU : Time zone APEX file found: /apex/com.android.tzdata/etc/icu/icu_tzdata.dat 03-29 20:18:45.649 16018 16018 W app_process: Unexpected CPU variant for X86 using defaults: x86 03-29 20:18:45.650 16018 16018 I app_process: The ClassLoaderContext is a special shared library. 03-29 20:18:45.664 16018 16018 W app_process: JNI RegisterNativeMethods: attempt to register 0 native methods for android.media.AudioAttributes 03-29 20:18:45.668 16018 16018 D AndroidRuntime: Calling main entry com.android.commands.am.Am 03-29 20:18:45.676 1991 2945 W ActivityManager: Unable to find instrumentation info for: ComponentInfo{io.appium.uiautomator2.server.test/androidx.test.runner.AndroidJUnitRunner} 03-29 20:18:45.677 1991 16007 W Binder : Outgoing transactions from this process must be FLAG_ONEWAY 03-29 20:18:45.677 1991 16007 W Binder : java.lang.Throwable 03-29 20:18:45.677 1991 16007 W Binder : at android.os.BinderProxy.transact(BinderProxy.java:480) 03-29 20:18:45.677 1991 16007 W Binder : at android.app.IInstrumentationWatcher$Stub$Proxy.instrumentationStatus(IInstrumentationWatcher.java:172) 03-29 20:18:45.677 1991 16007 W Binder : at com.android.server.am.InstrumentationReporter$MyThread.run(InstrumentationReporter.java:80) 03-29 20:18:45.689 16018 16018 I app_process: System.exit called, status: 1 03-29 20:18:45.689 16018 16018 I AndroidRuntime: VM exiting with result code 1. 03-29 20:18:46.491 1991 2945 I ActivityManager: Force stopping com.pixelvide.fmsapp appid=10148 user=0: from pid 16033 03-29 20:18:46.505 2438 2438 D CarrierSvcBindHelper: No carrier app for: 0 03-29 20:18:46.590 1991 1991 V SettingsProvider: Notifying for 0: content://settings/global/hidden_api_policy_pre_p_apps 03-29 20:18:46.611 1991 1991 V SettingsProvider: Notifying for 0: content://settings/global/hidden_api_policy_p_apps 03-29 20:18:46.637 1991 1991 V SettingsProvider: Notifying for 0: content://settings/global/hidden_api_policy 03-29 20:18:49.110 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:49.114 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:49.115 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:49.115 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:50.828 1991 2013 I DropBoxManagerService: add tag=system_server_strictmode isTagEnabled=true flags=0x2 03-29 20:18:51.891 2168 15284 E WakeLock: GCM_HB_ALARM release without a matched acquire! 03-29 20:18:50.846 1991 2013 I chatty : uid=1000(system) android.io identical 6 lines 03-29 20:18:50.849 1991 2013 I DropBoxManagerService: add tag=system_server_strictmode isTagEnabled=true flags=0x2 03-29 20:18:52.839 1991 2020 W BroadcastQueue: Background execution not allowed: receiving Intent { act=android.intent.action.DROPBOX_ENTRY_ADDED flg=0x10 (has extras) } to com.google.android.gms/.stats.service.DropBoxEntryAddedReceiver 03-29 20:18:52.840 1991 2020 W BroadcastQueue: Background execution not allowed: receiving Intent { act=android.intent.action.DROPBOX_ENTRY_ADDED flg=0x10 (has extras) } to com.google.android.gms/.chimera.GmsIntentOperationService$PersistentTrustedReceiver 03-29 20:18:54.120 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:54.121 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:54.121 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:54.121 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:59.128 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:18:59.130 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:18:59.133 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:18:59.133 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:18:59.934 1991 2019 E memtrack: Couldn't load memtrack module 03-29 20:18:59.934 1991 2019 W android.os.Debug: failed to get memory consumption info: -1 03-29 20:19:00.010 2186 2186 D KeyguardClockSwitch: Updating clock: 819 03-29 20:19:04.139 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:19:04.141 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:19:04.146 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:19:04.146 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:19:09.152 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:19:09.154 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:19:09.159 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:19:09.160 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:19:14.164 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:19:14.165 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:19:14.167 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:19:14.167 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:19:19.172 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:19:19.173 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:19:19.174 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:19:19.174 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:19:24.177 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:19:24.178 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:19:24.180 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:19:24.180 3151 3388 I MicroDetectionWorker: #onError(false) 03-29 20:19:24.354 1828 1828 E netmgr : Failed to open QEMU pipe 'qemud:network': Invalid argument 03-29 20:19:25.617 1834 1834 E wifi_forwarder: RemoteConnection failed to initialize: RemoteConnection failed to open pipe 03-29 20:19:29.183 3151 3388 I MicroDetectionWorker: #startMicroDetector [speakerMode: 0] 03-29 20:19:29.186 3151 3388 W ErrorReporter: reportError [type: 211, code: 393244, bug: 0]: errorCode: 393244, engine: 0 03-29 20:19:29.186 3151 3388 I MicroDetector: Keeping mic open: false 03-29 20:19:29.187 3151 3388 I MicroDetectionWorker: #onError(false)
can someone help in resolving the above issue, I have uninstalled everything and started installing from scratch but the same error reflecting again and again