Sony Bravia X95G - Android TV 9 - Unable to passthrough the damn xbox one pad adapter for windows!

Submitted by Benoire on #1

Hi Michael

This is probably the buggiest dongle ever in terms of what it does! I had to purchase a new tv due to a failed plasma panel so figured I'd drop the shield as to be honest I wasn't using it to its fullest and bought a Sony X9500G with Android TV built in. Its generally working fine and virtual here / Steam Link are working well with the USB Bluetooth dongle that is passed through to the windows client however the damn windows adapter for the xbox pads just won't passthrough... the server is not passing it through correctly as windows complains about a corrupt device once the client software attempts to use it.

I've looked through the server logs and there is a huge amount of errors occuring in the server which suggest the TV isn't interacting well with the server software... I can copy the log data but I'm unable to paste it anywhere... pasting in to emails causes the browsers to crash... I'll try and fix that as you'll need the logs to see if there is anything that you can do... in the meantime have you come across this before? It appears to be only the damn dongle again and if I use the pad wired it works fine.

I've tried the onreset command on the client and that doesn't do anything either.

Chris

Submitted by Benoire on Sat, 2020/02/08 - 16:43

#2

Here is the log from the initial load of the app and I think the attempt at passing through the device.

--------- beginning of main
02-08 18:44:00.067 7280 7317 I vhusbd : Sat Feb 8 18:44:00 2020 LOG_INFO 192.168.1.42 connected as connection 18
02-08 18:44:00.859 7280 7317 I vhusbd : Sat Feb 8 18:44:00 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 18:44:00.860 7280 7317 I vhusbd : Sat Feb 8 18:44:00 2020 LOG_INFO Device 6004 [045e:02fe] BOUND to connection 18
02-08 18:44:01.022 7280 7317 I vhusbd : Sat Feb 8 18:44:01 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 18:44:01.667 7280 7317 I vhusbd : Sat Feb 8 18:44:01 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 18:44:02.318 7280 7317 I vhusbd : Sat Feb 8 18:44:02 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 18:44:02.970 7280 7317 I vhusbd : Sat Feb 8 18:44:02 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 18:44:33.804 7280 7317 I vhusbd : Sat Feb 8 18:44:33 2020 LOG_INFO Device 6004 [045e:02fe] UNBOUND from connection 18
02-08 18:44:33.828 7280 7317 I vhusbd : Sat Feb 8 18:44:33 2020 LOG_INFO Connection 18 remotely disconnected gracefully (rx msg size)
02-08 18:44:43.737 7280 7317 I vhusbd : Sat Feb 8 18:44:43 2020 LOG_INFO Connection 18 successfully removed (reason:timeout)
02-08 18:44:50.688 7280 7280 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@1b2b0ec
02-08 18:44:50.802 7280 7280 F Looper : Could not write wake signal to fd 45: Bad file descriptor
--------- beginning of crash
02-08 18:44:50.802 7280 7280 F libc : Fatal signal 6 (SIGABRT), code -6 (SI_TKILL) in tid 7280 (e.androidserver), pid 7280 (e.androidserver)
02-08 18:44:50.877 14502 14502 I crash_dump32: obtaining output fd from tombstoned, type: kDebuggerdTombstone
02-08 18:44:50.884 14502 14502 I crash_dump32: performing dump of process 7280 (target tid = 7280)
02-08 18:44:50.899 14502 14502 F DEBUG : *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
02-08 18:44:50.899 14502 14502 F DEBUG : Build fingerprint: 'Sony/BRAVIA_UR2_4K_PA/BRAVIA_UR2_4K:9/PTT1.190515.001.S23/635901:user/release-keys'
02-08 18:44:50.899 14502 14502 F DEBUG : Revision: '0'
02-08 18:44:50.899 14502 14502 F DEBUG : ABI: 'arm'
02-08 18:44:50.899 14502 14502 F DEBUG : pid: 7280, tid: 7280, name: e.androidserver >>> com.virtualhere.androidserver <<<
02-08 18:44:50.899 14502 14502 F DEBUG : signal 6 (SIGABRT), code -6 (SI_TKILL), fault addr --------
02-08 18:44:50.899 14502 14502 F DEBUG : Abort message: 'Could not write wake signal to fd 45: Bad file descriptor'
02-08 18:44:50.899 14502 14502 F DEBUG : r0 00000000 r1 00001c70 r2 00000006 r3 f19e4768
02-08 18:44:50.900 14502 14502 F DEBUG : r4 00001c70 r5 00001c70 r6 ff92d63c r7 0000010c
02-08 18:44:50.900 14502 14502 F DEBUG : r8 e6d50b50 r9 ee51e2e0 r10 ff92daf8 r11 e6d50b00
02-08 18:44:50.900 14502 14502 F DEBUG : ip 00000041 sp ff92d628 lr f1970105 pc f1967e92
02-08 18:44:51.159 14502 14502 F DEBUG :
02-08 18:44:51.159 14502 14502 F DEBUG : backtrace:
02-08 18:44:51.160 14502 14502 F DEBUG : #00 pc 0001ce92 /system/lib/libc.so (abort+62)
02-08 18:44:51.160 14502 14502 F DEBUG : #01 pc 00006dd5 /system/lib/liblog.so (__android_log_assert+156)
02-08 18:44:51.160 14502 14502 F DEBUG : #02 pc 0000f047 /system/lib/libutils.so (android::Looper::wake()+114)
02-08 18:44:51.160 14502 14502 F DEBUG : #03 pc 003784a3 /system/lib/libhwui.so (android::uirenderer::renderthread::RenderProxy::RenderProxy(bool, android::uirenderer::RenderNode*, android::uirenderer::IContextFactory*)+394)
02-08 18:44:51.160 14502 14502 F DEBUG : #04 pc 000a6d4b /system/lib/libandroid_runtime.so (android::android_view_ThreadedRenderer_createProxy(_JNIEnv*, _jobject*, unsigned char, long long)+50)
02-08 18:44:51.160 14502 14502 F DEBUG : #05 pc 003b5849 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.graphics.pdf.PdfEditor.nativeOpen [DEDUPED]+120)
02-08 18:44:51.160 14502 14502 F DEBUG : #06 pc 009b9271 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.ThreadedRenderer.+488)
02-08 18:44:51.160 14502 14502 F DEBUG : #07 pc 00a98ecf /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.ViewRootImpl.enableHardwareAcceleration+662)
02-08 18:44:51.160 14502 14502 F DEBUG : #08 pc 00aa491b /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.ViewRootImpl.setView+1178)
02-08 18:44:51.160 14502 14502 F DEBUG : #09 pc 009c3607 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.WindowManagerGlobal.addView+1222)
02-08 18:44:51.160 14502 14502 F DEBUG : #10 pc 00b220cf /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.WindowManagerImpl.addView+134)
02-08 18:44:51.160 14502 14502 F DEBUG : #11 pc 0076715d /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.ActivityThread.handleResumeActivity+1028)
02-08 18:44:51.160 14502 14502 F DEBUG : #12 pc 008fb55f /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.servertransaction.ResumeActivityItem.execute+110)
02-08 18:44:51.160 14502 14502 F DEBUG : #13 pc 006937b5 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.servertransaction.TransactionExecutor.executeLifecycleState+308)
02-08 18:44:51.160 14502 14502 F DEBUG : #14 pc 00693d2d /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.servertransaction.TransactionExecutor.execute+236)
02-08 18:44:51.160 14502 14502 F DEBUG : #15 pc 007562c3 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.ActivityThread$H.handleMessage+578)
02-08 18:44:51.160 14502 14502 F DEBUG : #16 pc 0090fa81 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.os.Handler.dispatchMessage+136)
02-08 18:44:51.160 14502 14502 F DEBUG : #17 pc 00911a8b /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.os.Looper.loop+1162)
02-08 18:44:51.160 14502 14502 F DEBUG : #18 pc 00760b53 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.ActivityThread.main+674)
02-08 18:44:51.160 14502 14502 F DEBUG : #19 pc 00417d75 /system/lib/libart.so (art_quick_invoke_stub_internal+68)
02-08 18:44:51.160 14502 14502 F DEBUG : #20 pc 003f13f3 /system/lib/libart.so (art_quick_invoke_static_stub+222)
02-08 18:44:51.160 14502 14502 F DEBUG : #21 pc 000a1043 /system/lib/libart.so (art::ArtMethod::Invoke(art::Thread*, unsigned int*, unsigned int, art::JValue*, char const*)+154)
02-08 18:44:51.160 14502 14502 F DEBUG : #22 pc 00350a6d /system/lib/libart.so (art::(anonymous namespace)::InvokeWithArgArray(art::ScopedObjectAccessAlreadyRunnable const&, art::ArtMethod*, art::(anonymous namespace)::ArgArray*, art::JValue*, char const*)+52)
02-08 18:44:51.160 14502 14502 F DEBUG : #23 pc 00351eb5 /system/lib/libart.so (art::InvokeMethod(art::ScopedObjectAccessAlreadyRunnable const&, _jobject*, _jobject*, _jobject*, unsigned int)+960)
02-08 18:44:51.160 14502 14502 F DEBUG : #24 pc 00302bd9 /system/lib/libart.so (art::Method_invoke(_JNIEnv*, _jobject*, _jobject*, _jobjectArray*)+40)
02-08 18:44:51.160 14502 14502 F DEBUG : #25 pc 001131ff /system/framework/arm/boot-core-oj.oat (offset 0x10d000) (java.lang.Class.getDeclaredMethodInternal [DEDUPED]+110)
02-08 18:44:51.160 14502 14502 F DEBUG : #26 pc 00a0bb4b /system/framework/arm/boot-framework.oat (offset 0x3ac000) (com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run+114)
02-08 18:44:51.160 14502 14502 F DEBUG : #27 pc 00a11ad1 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (com.android.internal.os.ZygoteInit.main+2896)
02-08 18:44:51.160 14502 14502 F DEBUG : #28 pc 00417d75 /system/lib/libart.so (art_quick_invoke_stub_internal+68)
02-08 18:44:51.160 14502 14502 F DEBUG : #29 pc 003f13f3 /system/lib/libart.so (art_quick_invoke_static_stub+222)
02-08 18:44:51.160 14502 14502 F DEBUG : #30 pc 000a1043 /system/lib/libart.so (art::ArtMethod::Invoke(art::Thread*, unsigned int*, unsigned int, art::JValue*, char const*)+154)
02-08 18:44:51.160 14502 14502 F DEBUG : #31 pc 00350a6d /system/lib/libart.so (art::(anonymous namespace)::InvokeWithArgArray(art::ScopedObjectAccessAlreadyRunnable const&, art::ArtMethod*, art::(anonymous namespace)::ArgArray*, art::JValue*, char const*)+52)
02-08 18:44:51.160 14502 14502 F DEBUG : #32 pc 00350889 /system/lib/libart.so (art::InvokeWithVarArgs(art::ScopedObjectAccessAlreadyRunnable const&, _jobject*, _jmethodID*, std::__va_list)+304)
02-08 18:44:51.160 14502 14502 F DEBUG : #33 pc 002949cd /system/lib/libart.so (art::JNI::CallStaticVoidMethodV(_JNIEnv*, _jclass*, _jmethodID*, std::__va_list)+476)
02-08 18:44:51.160 14502 14502 F DEBUG : #34 pc 0006ce13 /system/lib/libandroid_runtime.so (_JNIEnv::CallStaticVoidMethod(_jclass*, _jmethodID*, ...)+38)
02-08 18:44:51.161 14502 14502 F DEBUG : #35 pc 0006f03b /system/lib/libandroid_runtime.so (android::AndroidRuntime::start(char const*, android::Vector const&, bool)+462)
02-08 18:44:51.161 14502 14502 F DEBUG : #36 pc 0000198d /system/bin/app_process32 (main+724)
02-08 18:44:51.161 14502 14502 F DEBUG : #37 pc 0008bd89 /system/lib/libc.so (__libc_init+48)
02-08 18:44:51.161 14502 14502 F DEBUG : #38 pc 00001677 /system/bin/app_process32 (_start_main+46)
02-08 18:44:51.161 14502 14502 F DEBUG : #39 pc 00017fa7 /system/bin/linker (__dl__ZN6soinfoD1Ev+14)
02-08 18:44:51.161 14502 14502 F DEBUG : #40 pc 007fe8a5 [stack:ff132000]
02-08 18:44:53.650 14517 14517 W e.androidserve: Using default instruction set features for ARM CPU variant (cortex-a9) using conservative defaults
02-08 18:44:53.652 14517 14517 E e.androidserve: Not starting debugger since process cannot load the jdwp agent.
02-08 18:44:53.777 14517 14544 I vhusbd : Sat Feb 8 18:44:53 2020 LOG_INFO >>> Starting VirtualHere USB Server v4.0.7 (Built: Nov 25 2019, 23:01:58)<<<
02-08 18:44:53.777 14517 14544 I vhusbd : Sat Feb 8 18:44:53 2020 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
02-08 18:44:53.831 14517 14544 I vhusbd : Sat Feb 8 18:44:53 2020 LOG_INFO Server licensed to=unlicensed max_devices=1
02-08 18:44:53.832 14517 14544 I vhusbd : Sat Feb 8 18:44:53 2020 LOG_INFO Using large URB's
02-08 18:44:53.832 14517 14544 I vhusbd : Sat Feb 8 18:44:53 2020 LOG_INFO Listening on all network interfaces at TCP port 7575 (IPv6 dual-stack)
02-08 18:44:53.833 14517 14544 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
02-08 18:44:54.888 14517 14544 I vhusbd : Sat Feb 8 18:44:54 2020 LOG_INFO Found Full speed device [045e:02fe] "Microsoft Inc., XBOX ACC" at address 6004
02-08 18:45:09.433 14517 14517 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@8260133
02-08 18:45:09.548 14517 14517 D OpenGLRenderer: Skia GL Pipeline
02-08 18:45:09.618 14517 14566 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0
02-08 18:45:09.619 14517 14566 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0
02-08 18:45:09.619 14517 14566 I OpenGLRenderer: Initialized EGL, version 1.4
02-08 18:45:09.619 14517 14566 D OpenGLRenderer: Swap behavior 2
02-08 18:45:09.631 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:09.866 14517 14566 D gralloc : MTK MALI GRALLOC Module v1.0
02-08 18:45:09.868 14517 14566 E ion : ioctl c0044901 failed with code -1: Invalid argument
02-08 18:45:12.349 14517 14525 W System : A resource failed to call close.
02-08 18:45:12.382 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:16.692 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:16.991 14517 14566 W libEGL : EGLNativeWindowType 0xd2ae2008 disconnect failed
02-08 18:45:19.900 14517 14566 W libEGL : EGLNativeWindowType 0xcd6c1808 disconnect failed
02-08 18:45:19.914 14517 14517 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.
02-08 18:45:21.002 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:24.826 14517 14566 W libEGL : EGLNativeWindowType 0xcd6c1808 disconnect failed
02-08 18:45:25.210 14517 14566 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 18:45:26.615 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:28.726 14517 14566 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 18:45:33.563 14517 14517 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@36c68b7
02-08 18:45:33.685 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:36.269 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:37.374 14689 14689 E libc : Access denied finding property "persist.svp.dbg.loglevel"
02-08 18:45:37.678 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:45:38.111 14517 14566 W libEGL : EGLNativeWindowType 0xcd6c1008 disconnect failed
02-08 18:46:01.649 14517 14566 W libEGL : EGLNativeWindowType 0xce30c808 disconnect failed
02-08 18:46:01.649 14517 14566 D OpenGLRenderer: endAllActiveAnimators on 0xce432f00 (RippleDrawable) with handle 0xe8583a40
02-08 18:46:01.669 14517 14517 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.
02-08 18:46:04.478 14517 14566 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 18:51:37.168 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:51:38.882 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:51:40.178 14892 14892 E libc : Access denied finding property "persist.svp.dbg.loglevel"
02-08 18:51:40.454 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 18:51:40.893 14517 14566 W libEGL : EGLNativeWindowType 0xcd64b808 disconnect failed
02-08 18:52:07.827 14517 14566 W libEGL : EGLNativeWindowType 0xce46f008 disconnect failed
02-08 18:52:07.843 14517 14566 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 19:05:28.642 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:05:28.712 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:05:33.615 14517 14566 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 19:05:33.615 14517 14566 D OpenGLRenderer: endAllActiveAnimators on 0xce408980 (RippleDrawable) with handle 0xe8583c40
02-08 19:05:33.634 14517 14517 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.
02-08 19:05:35.944 14517 14566 W libEGL : EGLNativeWindowType 0xd3138808 disconnect failed
02-08 19:05:52.332 16081 16081 W e.androidserve: Using default instruction set features for ARM CPU variant (cortex-a9) using conservative defaults
02-08 19:05:52.334 16081 16081 E e.androidserve: Not starting debugger since process cannot load the jdwp agent.
02-08 19:05:52.545 16081 16081 D OpenGLRenderer: Skia GL Pipeline
02-08 19:05:52.635 16081 16097 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0
02-08 19:05:52.635 16081 16097 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0
02-08 19:05:52.635 16081 16097 I OpenGLRenderer: Initialized EGL, version 1.4
02-08 19:05:52.635 16081 16097 D OpenGLRenderer: Swap behavior 2
02-08 19:05:52.651 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:05:52.673 16081 16097 D gralloc : MTK MALI GRALLOC Module v1.0
02-08 19:05:52.675 16081 16097 E ion : ioctl c0044901 failed with code -1: Invalid argument
02-08 19:05:52.703 16081 16081 E virtualhere-daemon: Opening local exception: Connection refused
02-08 19:05:52.703 16081 16081 E virtualhere-daemon: Opening local exception: Connection refused
02-08 19:05:52.751 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO >>> Starting VirtualHere USB Server v4.0.7 (Built: Nov 25 2019, 23:01:58)<<<
02-08 19:05:52.751 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
02-08 19:05:52.758 16081 16081 E virtualhere-daemon: Opening local exception: Connection refused
02-08 19:05:52.807 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Server licensed to=unlicensed max_devices=1
02-08 19:05:52.807 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Using large URB's
02-08 19:05:52.809 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Listening on all network interfaces at TCP port 7575 (IPv6 dual-stack)
02-08 19:05:52.809 16081 16119 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
02-08 19:05:53.914 16081 16119 I vhusbd : Sat Feb 8 19:05:53 2020 LOG_INFO Found Full speed device [045e:02fe] "Microsoft Inc., XBOX ACC" at address 6004
02-08 19:06:06.108 16081 16089 W System : A resource failed to call close.
02-08 19:07:32.299 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:07:33.592 16158 16158 E libc : Access denied finding property "persist.svp.dbg.loglevel"

Submitted by Benoire on Sat, 2020/02/08 - 16:53

#3

Another grab from the logs after plugging in the dongle and attempting to capture it:

--------- beginning of crash
02-08 18:44:50.802 7280 7280 F libc : Fatal signal 6 (SIGABRT), code -6 (SI_TKILL) in tid 7280 (e.androidserver), pid 7280 (e.androidserver)
02-08 18:44:50.899 14502 14502 F DEBUG : *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
02-08 18:44:50.899 14502 14502 F DEBUG : Build fingerprint: 'Sony/BRAVIA_UR2_4K_PA/BRAVIA_UR2_4K:9/PTT1.190515.001.S23/635901:user/release-keys'
02-08 18:44:50.899 14502 14502 F DEBUG : Revision: '0'
02-08 18:44:50.899 14502 14502 F DEBUG : ABI: 'arm'
02-08 18:44:50.899 14502 14502 F DEBUG : pid: 7280, tid: 7280, name: e.androidserver >>> com.virtualhere.androidserver <<<
02-08 18:44:50.899 14502 14502 F DEBUG : signal 6 (SIGABRT), code -6 (SI_TKILL), fault addr --------
02-08 18:44:50.899 14502 14502 F DEBUG : Abort message: 'Could not write wake signal to fd 45: Bad file descriptor'
02-08 18:44:50.899 14502 14502 F DEBUG : r0 00000000 r1 00001c70 r2 00000006 r3 f19e4768
02-08 18:44:50.900 14502 14502 F DEBUG : r4 00001c70 r5 00001c70 r6 ff92d63c r7 0000010c
02-08 18:44:50.900 14502 14502 F DEBUG : r8 e6d50b50 r9 ee51e2e0 r10 ff92daf8 r11 e6d50b00
02-08 18:44:50.900 14502 14502 F DEBUG : ip 00000041 sp ff92d628 lr f1970105 pc f1967e92
02-08 18:44:51.159 14502 14502 F DEBUG :
02-08 18:44:51.159 14502 14502 F DEBUG : backtrace:
02-08 18:44:51.160 14502 14502 F DEBUG : #00 pc 0001ce92 /system/lib/libc.so (abort+62)
02-08 18:44:51.160 14502 14502 F DEBUG : #01 pc 00006dd5 /system/lib/liblog.so (__android_log_assert+156)
02-08 18:44:51.160 14502 14502 F DEBUG : #02 pc 0000f047 /system/lib/libutils.so (android::Looper::wake()+114)
02-08 18:44:51.160 14502 14502 F DEBUG : #03 pc 003784a3 /system/lib/libhwui.so (android::uirenderer::renderthread::RenderProxy::RenderProxy(bool, android::uirenderer::RenderNode*, android::uirenderer::IContextFactory*)+394)
02-08 18:44:51.160 14502 14502 F DEBUG : #04 pc 000a6d4b /system/lib/libandroid_runtime.so (android::android_view_ThreadedRenderer_createProxy(_JNIEnv*, _jobject*, unsigned char, long long)+50)
02-08 18:44:51.160 14502 14502 F DEBUG : #05 pc 003b5849 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.graphics.pdf.PdfEditor.nativeOpen [DEDUPED]+120)
02-08 18:44:51.160 14502 14502 F DEBUG : #06 pc 009b9271 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.ThreadedRenderer.+488)
02-08 18:44:51.160 14502 14502 F DEBUG : #07 pc 00a98ecf /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.ViewRootImpl.enableHardwareAcceleration+662)
02-08 18:44:51.160 14502 14502 F DEBUG : #08 pc 00aa491b /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.ViewRootImpl.setView+1178)
02-08 18:44:51.160 14502 14502 F DEBUG : #09 pc 009c3607 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.WindowManagerGlobal.addView+1222)
02-08 18:44:51.160 14502 14502 F DEBUG : #10 pc 00b220cf /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.view.WindowManagerImpl.addView+134)
02-08 18:44:51.160 14502 14502 F DEBUG : #11 pc 0076715d /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.ActivityThread.handleResumeActivity+1028)
02-08 18:44:51.160 14502 14502 F DEBUG : #12 pc 008fb55f /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.servertransaction.ResumeActivityItem.execute+110)
02-08 18:44:51.160 14502 14502 F DEBUG : #13 pc 006937b5 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.servertransaction.TransactionExecutor.executeLifecycleState+308)
02-08 18:44:51.160 14502 14502 F DEBUG : #14 pc 00693d2d /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.servertransaction.TransactionExecutor.execute+236)
02-08 18:44:51.160 14502 14502 F DEBUG : #15 pc 007562c3 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.ActivityThread$H.handleMessage+578)
02-08 18:44:51.160 14502 14502 F DEBUG : #16 pc 0090fa81 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.os.Handler.dispatchMessage+136)
02-08 18:44:51.160 14502 14502 F DEBUG : #17 pc 00911a8b /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.os.Looper.loop+1162)
02-08 18:44:51.160 14502 14502 F DEBUG : #18 pc 00760b53 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (android.app.ActivityThread.main+674)
02-08 18:44:51.160 14502 14502 F DEBUG : #19 pc 00417d75 /system/lib/libart.so (art_quick_invoke_stub_internal+68)
02-08 18:44:51.160 14502 14502 F DEBUG : #20 pc 003f13f3 /system/lib/libart.so (art_quick_invoke_static_stub+222)
02-08 18:44:51.160 14502 14502 F DEBUG : #21 pc 000a1043 /system/lib/libart.so (art::ArtMethod::Invoke(art::Thread*, unsigned int*, unsigned int, art::JValue*, char const*)+154)
02-08 18:44:51.160 14502 14502 F DEBUG : #22 pc 00350a6d /system/lib/libart.so (art::(anonymous namespace)::InvokeWithArgArray(art::ScopedObjectAccessAlreadyRunnable const&, art::ArtMethod*, art::(anonymous namespace)::ArgArray*, art::JValue*, char const*)+52)
02-08 18:44:51.160 14502 14502 F DEBUG : #23 pc 00351eb5 /system/lib/libart.so (art::InvokeMethod(art::ScopedObjectAccessAlreadyRunnable const&, _jobject*, _jobject*, _jobject*, unsigned int)+960)
02-08 18:44:51.160 14502 14502 F DEBUG : #24 pc 00302bd9 /system/lib/libart.so (art::Method_invoke(_JNIEnv*, _jobject*, _jobject*, _jobjectArray*)+40)
02-08 18:44:51.160 14502 14502 F DEBUG : #25 pc 001131ff /system/framework/arm/boot-core-oj.oat (offset 0x10d000) (java.lang.Class.getDeclaredMethodInternal [DEDUPED]+110)
02-08 18:44:51.160 14502 14502 F DEBUG : #26 pc 00a0bb4b /system/framework/arm/boot-framework.oat (offset 0x3ac000) (com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run+114)
02-08 18:44:51.160 14502 14502 F DEBUG : #27 pc 00a11ad1 /system/framework/arm/boot-framework.oat (offset 0x3ac000) (com.android.internal.os.ZygoteInit.main+2896)
02-08 18:44:51.160 14502 14502 F DEBUG : #28 pc 00417d75 /system/lib/libart.so (art_quick_invoke_stub_internal+68)
02-08 18:44:51.160 14502 14502 F DEBUG : #29 pc 003f13f3 /system/lib/libart.so (art_quick_invoke_static_stub+222)
02-08 18:44:51.160 14502 14502 F DEBUG : #30 pc 000a1043 /system/lib/libart.so (art::ArtMethod::Invoke(art::Thread*, unsigned int*, unsigned int, art::JValue*, char const*)+154)
02-08 18:44:51.160 14502 14502 F DEBUG : #31 pc 00350a6d /system/lib/libart.so (art::(anonymous namespace)::InvokeWithArgArray(art::ScopedObjectAccessAlreadyRunnable const&, art::ArtMethod*, art::(anonymous namespace)::ArgArray*, art::JValue*, char const*)+52)
02-08 18:44:51.160 14502 14502 F DEBUG : #32 pc 00350889 /system/lib/libart.so (art::InvokeWithVarArgs(art::ScopedObjectAccessAlreadyRunnable const&, _jobject*, _jmethodID*, std::__va_list)+304)
02-08 18:44:51.160 14502 14502 F DEBUG : #33 pc 002949cd /system/lib/libart.so (art::JNI::CallStaticVoidMethodV(_JNIEnv*, _jclass*, _jmethodID*, std::__va_list)+476)
02-08 18:44:51.160 14502 14502 F DEBUG : #34 pc 0006ce13 /system/lib/libandroid_runtime.so (_JNIEnv::CallStaticVoidMethod(_jclass*, _jmethodID*, ...)+38)
02-08 18:44:51.161 14502 14502 F DEBUG : #35 pc 0006f03b /system/lib/libandroid_runtime.so (android::AndroidRuntime::start(char const*, android::Vector const&, bool)+462)
02-08 18:44:51.161 14502 14502 F DEBUG : #36 pc 0000198d /system/bin/app_process32 (main+724)
02-08 18:44:51.161 14502 14502 F DEBUG : #37 pc 0008bd89 /system/lib/libc.so (__libc_init+48)
02-08 18:44:51.161 14502 14502 F DEBUG : #38 pc 00001677 /system/bin/app_process32 (_start_main+46)
02-08 18:44:51.161 14502 14502 F DEBUG : #39 pc 00017fa7 /system/bin/linker (__dl__ZN6soinfoD1Ev+14)
02-08 18:44:51.161 14502 14502 F DEBUG : #40 pc 007fe8a5 [stack:ff132000]
--------- beginning of main
02-08 19:05:28.642 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:05:28.712 14517 14566 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:05:33.615 14517 14566 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 19:05:33.615 14517 14566 D OpenGLRenderer: endAllActiveAnimators on 0xce408980 (RippleDrawable) with handle 0xe8583c40
02-08 19:05:33.634 14517 14517 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.
02-08 19:05:35.944 14517 14566 W libEGL : EGLNativeWindowType 0xd3138808 disconnect failed
02-08 19:05:52.332 16081 16081 W e.androidserve: Using default instruction set features for ARM CPU variant (cortex-a9) using conservative defaults
02-08 19:05:52.334 16081 16081 E e.androidserve: Not starting debugger since process cannot load the jdwp agent.
02-08 19:05:52.545 16081 16081 D OpenGLRenderer: Skia GL Pipeline
02-08 19:05:52.635 16081 16097 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0
02-08 19:05:52.635 16081 16097 I ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0
02-08 19:05:52.635 16081 16097 I OpenGLRenderer: Initialized EGL, version 1.4
02-08 19:05:52.635 16081 16097 D OpenGLRenderer: Swap behavior 2
02-08 19:05:52.651 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:05:52.673 16081 16097 D gralloc : MTK MALI GRALLOC Module v1.0
02-08 19:05:52.675 16081 16097 E ion : ioctl c0044901 failed with code -1: Invalid argument
02-08 19:05:52.703 16081 16081 E virtualhere-daemon: Opening local exception: Connection refused
02-08 19:05:52.703 16081 16081 E virtualhere-daemon: Opening local exception: Connection refused
02-08 19:05:52.751 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO >>> Starting VirtualHere USB Server v4.0.7 (Built: Nov 25 2019, 23:01:58)<<<
02-08 19:05:52.751 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
02-08 19:05:52.758 16081 16081 E virtualhere-daemon: Opening local exception: Connection refused
02-08 19:05:52.807 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Server licensed to=unlicensed max_devices=1
02-08 19:05:52.807 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Using large URB's
02-08 19:05:52.809 16081 16119 I vhusbd : Sat Feb 8 19:05:52 2020 LOG_INFO Listening on all network interfaces at TCP port 7575 (IPv6 dual-stack)
02-08 19:05:52.809 16081 16119 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
02-08 19:05:53.914 16081 16119 I vhusbd : Sat Feb 8 19:05:53 2020 LOG_INFO Found Full speed device [045e:02fe] "Microsoft Inc., XBOX ACC" at address 6004
02-08 19:06:06.108 16081 16089 W System : A resource failed to call close.
02-08 19:07:32.299 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:07:33.592 16158 16158 E libc : Access denied finding property "persist.svp.dbg.loglevel"
02-08 19:07:33.946 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
--------- beginning of system
02-08 19:07:34.111 16081 16081 D ViewRootImpl[GUI]: updatePointerIcon called with position out of bounds
02-08 19:07:34.408 16081 16097 W libEGL : EGLNativeWindowType 0xce9dc008 disconnect failed
02-08 19:07:34.156 16081 16081 I chatty : uid=10159(com.virtualhere.androidserver) identical 4 lines
02-08 19:07:34.172 16081 16081 D ViewRootImpl[GUI]: updatePointerIcon called with position out of bounds
02-08 19:09:50.848 16081 16097 W libEGL : EGLNativeWindowType 0xcd11f008 disconnect failed
02-08 19:09:50.848 16081 16097 D OpenGLRenderer: endAllActiveAnimators on 0xcd2c9a00 (RippleDrawable) with handle 0xd22f8ba0
02-08 19:09:54.043 16081 16097 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 19:12:12.280 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:12:14.265 16081 16097 W libEGL : EGLNativeWindowType 0xedd45008 disconnect failed
02-08 19:13:28.417 16081 16119 I vhusbd : Sat Feb 8 19:13:28 2020 LOG_INFO 192.168.1.42 connected as connection 1
02-08 19:13:29.496 16081 16119 I vhusbd : Sat Feb 8 19:13:29 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:13:29.496 16081 16119 I vhusbd : Sat Feb 8 19:13:29 2020 LOG_INFO Device 6004 [045e:02fe] BOUND to connection 1
02-08 19:13:29.657 16081 16119 I vhusbd : Sat Feb 8 19:13:29 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:13:30.303 16081 16119 I vhusbd : Sat Feb 8 19:13:30 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:13:30.951 16081 16119 I vhusbd : Sat Feb 8 19:13:30 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:13:31.596 16081 16119 I vhusbd : Sat Feb 8 19:13:31 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:13:44.292 16081 16119 I vhusbd : Sat Feb 8 19:13:44 2020 LOG_INFO Device 6004 [045e:02fe] UNBOUND from connection 1
02-08 19:13:44.332 16081 16119 I vhusbd : Sat Feb 8 19:13:44 2020 LOG_INFO Connection 1 remotely disconnected gracefully (rx msg size)
02-08 19:13:52.332 16081 16119 I vhusbd : Sat Feb 8 19:13:52 2020 LOG_INFO Connection 1 successfully removed (reason:timeout)
02-08 19:15:51.237 16081 16119 I vhusbd : Sat Feb 8 19:15:51 2020 LOG_INFO Unmanaging device 6004 [045e:02fe]
02-08 19:15:51.822 16081 16544 D UsbDeviceConnectionJNI: close
02-08 19:44:20.718 16081 16081 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@351c699
02-08 19:44:20.733 16081 16119 I vhusbd : Sat Feb 8 19:44:20 2020 LOG_INFO Found Full speed device [045e:02fe] "Microsoft Inc., XBOX ACC" at address 6005
02-08 19:44:20.754 16081 16089 W System : A resource failed to call close.
02-08 19:44:29.108 16081 16081 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@356def8
02-08 19:44:29.243 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:44:31.946 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:44:34.702 16081 16097 W libEGL : EGLNativeWindowType 0xd22ac808 disconnect failed
02-08 19:44:34.725 16081 16097 W libEGL : EGLNativeWindowType 0xe85ff808 disconnect failed
02-08 19:45:03.140 16081 16119 I vhusbd : Sat Feb 8 19:45:03 2020 LOG_INFO 192.168.1.42 connected as connection 3
02-08 19:45:10.242 16081 16119 I vhusbd : Sat Feb 8 19:45:10 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:45:10.242 16081 16119 I vhusbd : Sat Feb 8 19:45:10 2020 LOG_INFO Device 6005 [045e:02fe] BOUND to connection 3
02-08 19:45:10.403 16081 16119 I vhusbd : Sat Feb 8 19:45:10 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:45:11.057 16081 16119 I vhusbd : Sat Feb 8 19:45:11 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:45:11.707 16081 16119 I vhusbd : Sat Feb 8 19:45:11 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:45:12.348 16081 16119 I vhusbd : Sat Feb 8 19:45:12 2020 LOG_INFO Executed "" for onReset.045e.02fe
02-08 19:48:46.009 16081 16119 I vhusbd : Sat Feb 8 19:48:46 2020 LOG_INFO Device 6005 [045e:02fe] UNBOUND from connection 3
02-08 19:48:51.733 16081 16119 I vhusbd : Sat Feb 8 19:48:51 2020 LOG_INFO Connection 3 remotely disconnected abruptly (rx msg size)
02-08 19:48:58.132 16081 16119 I vhusbd : Sat Feb 8 19:48:58 2020 LOG_INFO Connection 3 successfully removed (reason:timeout)
02-08 19:49:14.909 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:49:14.976 16081 16097 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
02-08 19:49:16.738 18879 18879 E libc : Access denied finding property "persist.svp.dbg.loglevel"

Submitted by Michael on Sat, 2020/02/08 - 17:09

#4

I don't think its going to work , unfortunately in android you cannot avoid a "RESET" being sent to the device even if you try to skip it in virtualhere by using the onReset... setting. Android will send a reset to the device regardless.

Could you turn back on the virtualhere reset anyway by right clicking XBox ACC in the virtualhere client and selecting Custom Event Handler... and pasting in

onReset.$VENDOR_ID$.$PRODUCT_ID$=REMOVE

Im not sure a RESET is the problem here, im thinking its just a bug in the sony USB implementation

Submitted by Benoire on Sat, 2020/02/08 - 17:24

#5

Nope, brings up the same error 'USB Devce Not Recognised' and in device manager is an error code 43. The bluetooth dongle I use for the BT enabled xbox one pad works fine and passes through well, its just this damned MS adapter!