Problem using VirtualHere via Ad-Hoc

Hardware/Software
VirtualHere USB Server v2.7.1 on Nexus 5 D820 stock
VirtualHere Windows Client 64-bit v3.3.0 and v3.3.6
Connected via Windows Ad-Hoc Network

Issue: VirtualHere client works correctly the first time it is setup. However any interference after would cause crashes to client and often times Nexus 5 would refuse connection with ad-hoc network.
Interference would refer to any non-manual disconnects of Nexus 5 to Ad-Hoc network, any disconnect from Nexus 5 to USB device, or even closing VirtualHere Client and restarting it up.
VirtualHere Client would then be unable to find and verify hubs the second time (or anytime thereafter) and Nexus 5 device would then disconnect itself from Ad-Hoc network and refuse to connect back unless the network is restarted from the laptop via netsh wlan stop hostednetwork and start back again.

I'm not too sure how to narrow the bug down to stay away from it or to make my setup viable, say for couple of days straight.

#2

What device are you sharing from the nexus? Are you running marshmellow or lollipop?

Its unusual for the virtualhere client to crash, im wondering if its receiving corrupted data from the nexus or the device you are sharing is very sensitive to the "plug being pulled" which is the case if the network drops.

#3

Thank you for getting back, the device that is connected to the nexus is a CPR manikin called smartman. Ambusmartman.com it requires usb 2.0 for power.

#5

OK if possible when it drops can you send me the system messages from the app menu.

#6

--------- beginning of crash
01-20 12:27:39.873 17634 17662 F libc : Fatal signal 6 (SIGABRT), code -6 in tid 17662 (RenderThread)
--------- beginning of main
01-25 13:11:58.199 26414 26414 W System : ClassLoader referenced unknown path: /data/app/com.virtualhere.androidserver-1/lib/arm
01-25 13:11:58.303 26414 26443 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: true
01-25 13:11:58.375 26414 26443 I Adreno-EGL: : QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
01-25 13:11:58.377 26414 26443 I OpenGLRenderer: Initialized EGL, version 1.4
01-25 13:11:58.451 26414 26454 I vhusbd : Mon Jan 25 21:11:58 2016 LOG_INFO >>> Starting VirtualHere USB Server v2.7.0 (Built: Jan 22 2016, 16:24:23)<<<
01-25 13:11:58.451 26414 26454 I vhusbd : Mon Jan 25 21:11:58 2016 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
01-25 13:11:58.514 26414 26454 I vhusbd : Mon Jan 25 21:11:58 2016 LOG_INFO Server licensed to=unlicensed max_devices=1
01-25 13:11:58.515 26414 26454 I vhusbd : Mon Jan 25 21:11:58 2016 LOG_INFO Using large URB's
01-25 13:11:58.515 26414 26454 I vhusbd : Mon Jan 25 21:11:58 2016 LOG_DEBUG TCPServer starting...
01-25 13:11:58.515 26414 26454 I vhusbd : Mon Jan 25 21:11:58 2016 LOG_INFO Listening on all network interfaces at port 7575
01-25 13:11:58.516 26414 26454 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
01-25 13:12:00.838 26460 26460 W vhusbdan: type=1400 audit(0.0:197018): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:12:00.838 26460 26460 W vhusbdan: type=1400 audit(0.0:197019): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:12:00.843 26414 26454 I vhusbd : Mon Jan 25 21:12:00 2016 LOG_DEBUG Not a device .
01-25 13:12:00.843 26414 26454 I vhusbd : Mon Jan 25 21:12:00 2016 LOG_DEBUG Not a device ..
01-25 13:12:00.844 26414 26454 I vhusbd : Mon Jan 25 21:12:00 2016 LOG_DEBUG Found /dev/bus/usb/001/002 in /sys/bus/usb/devices/1-1 (bus/usb/001/002)
01-25 13:12:00.845 26414 26454 I vhusbd : Mon Jan 25 21:12:00 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:12:00.845 26414 26454 I vhusbd : Mon Jan 25 21:12:00 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:12:00.846 26414 26454 I vhusbd : Mon Jan 25 21:12:00 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:12:00.846 26414 26454 I vhusbd : Mon Jan 25 21:12:00 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:12:02.153 26414 26454 I vhusbd : Mon Jan 25 21:12:02 2016 LOG_INFO Unmanaging device 11
01-25 13:12:02.747 26414 26598 D UsbDeviceConnectionJNI: close
01-25 13:12:58.832 26414 26454 I vhusbd : Mon Jan 25 21:12:58 2016 LOG_DEBUG 192.168.0.101 connected
01-25 13:13:15.068 26460 26460 W vhusbdan: type=1400 audit(0.0:197020): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:13:15.068 26460 26460 W vhusbdan: type=1400 audit(0.0:197021): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:13:15.070 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_DEBUG Not a device .
01-25 13:13:15.070 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_DEBUG Not a device ..
01-25 13:13:15.070 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_DEBUG Found /dev/bus/usb/001/009 in /sys/bus/usb/devices/1-1 (bus/usb/001/009)
01-25 13:13:15.071 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:13:15.072 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:13:15.072 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:13:15.072 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:13:15.161 26414 26454 I vhusbd : Mon Jan 25 21:13:15 2016 LOG_INFO Unmanaging device 11
01-25 13:13:15.751 26414 26530 D UsbDeviceConnectionJNI: close
01-25 13:13:17.908 26460 26460 W vhusbdan: type=1400 audit(0.0:197022): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:13:17.908 26460 26460 W vhusbdan: type=1400 audit(0.0:197023): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:13:17.916 26414 26454 I vhusbd : Mon Jan 25 21:13:17 2016 LOG_DEBUG Not a device .
01-25 13:13:17.916 26414 26454 I vhusbd : Mon Jan 25 21:13:17 2016 LOG_DEBUG Not a device ..
01-25 13:13:17.917 26414 26454 I vhusbd : Mon Jan 25 21:13:17 2016 LOG_DEBUG Found /dev/bus/usb/001/010 in /sys/bus/usb/devices/1-1 (bus/usb/001/010)
01-25 13:13:17.919 26414 26454 I vhusbd : Mon Jan 25 21:13:17 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:13:17.919 26414 26454 I vhusbd : Mon Jan 25 21:13:17 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:13:17.920 26414 26454 I vhusbd : Mon Jan 25 21:13:17 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:13:17.920 26414 26454 I vhusbd : Mon Jan 25 21:13:17 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:13:19.335 26414 26454 I vhusbd : Mon Jan 25 21:13:19 2016 LOG_INFO Unmanaging device 11
01-25 13:13:19.921 26414 26756 D UsbDeviceConnectionJNI: close
01-25 13:13:30.438 26460 26460 W vhusbdan: type=1400 audit(0.0:197024): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:13:30.438 26460 26460 W vhusbdan: type=1400 audit(0.0:197025): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:13:30.441 26414 26454 I vhusbd : Mon Jan 25 21:13:30 2016 LOG_DEBUG Not a device .
01-25 13:13:30.441 26414 26454 I vhusbd : Mon Jan 25 21:13:30 2016 LOG_DEBUG Not a device ..
01-25 13:13:30.442 26414 26454 I vhusbd : Mon Jan 25 21:13:30 2016 LOG_DEBUG Found /dev/bus/usb/001/011 in /sys/bus/usb/devices/1-1 (bus/usb/001/011)
01-25 13:13:30.444 26414 26454 I vhusbd : Mon Jan 25 21:13:30 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:13:30.445 26414 26454 I vhusbd : Mon Jan 25 21:13:30 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:13:30.445 26414 26454 I vhusbd : Mon Jan 25 21:13:30 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:13:30.446 26414 26454 I vhusbd : Mon Jan 25 21:13:30 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:13:43.319 26414 26454 I vhusbd : Mon Jan 25 21:13:43 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 13:16:26.500 26414 26414 W IInputConnectionWrapper: getExtractedText on inactive InputConnection
01-25 13:16:26.501 26414 26414 W IInputConnectionWrapper: getTextBeforeCursor on inactive InputConnection
01-25 13:16:26.501 26414 26414 W IInputConnectionWrapper: getSelectedText on inactive InputConnection
01-25 13:16:26.502 26414 26414 W IInputConnectionWrapper: getTextAfterCursor on inactive InputConnection
01-25 13:22:37.376 26414 26454 I vhusbd : Mon Jan 25 21:22:37 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 13:22:37.377 26414 26454 I vhusbd : Mon Jan 25 21:22:37 2016 LOG_INFO Unmanaging device 11
01-25 13:22:37.962 26414 26484 D UsbDeviceConnectionJNI: close
01-25 13:22:59.258 26460 26460 W vhusbdan: type=1400 audit(0.0:197026): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:22:59.258 26460 26460 W vhusbdan: type=1400 audit(0.0:197027): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:22:59.267 26414 26454 I vhusbd : Mon Jan 25 21:22:59 2016 LOG_DEBUG Not a device .
01-25 13:22:59.268 26414 26454 I vhusbd : Mon Jan 25 21:22:59 2016 LOG_DEBUG Not a device ..
01-25 13:22:59.268 26414 26454 I vhusbd : Mon Jan 25 21:22:59 2016 LOG_DEBUG Found /dev/bus/usb/001/012 in /sys/bus/usb/devices/1-1 (bus/usb/001/012)
01-25 13:22:59.269 26414 26454 I vhusbd : Mon Jan 25 21:22:59 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:22:59.269 26414 26454 I vhusbd : Mon Jan 25 21:22:59 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:22:59.270 26414 26454 I vhusbd : Mon Jan 25 21:22:59 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:22:59.270 26414 26454 I vhusbd : Mon Jan 25 21:22:59 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:23:00.949 26414 26414 W IInputConnectionWrapper: getExtractedText on inactive InputConnection
01-25 13:23:00.949 26414 26414 W IInputConnectionWrapper: getTextBeforeCursor on inactive InputConnection
01-25 13:23:00.950 26414 26414 W IInputConnectionWrapper: getSelectedText on inactive InputConnection
01-25 13:23:00.950 26414 26414 W IInputConnectionWrapper: getTextAfterCursor on inactive InputConnection
01-25 13:23:04.508 26414 26454 I vhusbd : Mon Jan 25 21:23:04 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 13:23:49.274 26414 26454 I vhusbd : Mon Jan 25 21:23:49 2016 LOG_INFO Device 11 UNBOUND from connection 1
01-25 13:23:53.076 26414 26454 I vhusbd : Mon Jan 25 21:23:53 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 13:24:00.468 26414 26454 I vhusbd : Mon Jan 25 21:24:00 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 13:24:00.469 26414 26454 I vhusbd : Mon Jan 25 21:24:00 2016 LOG_INFO Unmanaging device 11
01-25 13:24:01.042 26414 26598 D UsbDeviceConnectionJNI: close
01-25 13:24:20.148 26460 26460 W vhusbdan: type=1400 audit(0.0:197028): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:24:20.148 26460 26460 W vhusbdan: type=1400 audit(0.0:197029): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:24:20.158 26414 26454 I vhusbd : Mon Jan 25 21:24:20 2016 LOG_DEBUG Not a device .
01-25 13:24:20.158 26414 26454 I vhusbd : Mon Jan 25 21:24:20 2016 LOG_DEBUG Not a device ..
01-25 13:24:20.159 26414 26454 I vhusbd : Mon Jan 25 21:24:20 2016 LOG_DEBUG Found /dev/bus/usb/001/016 in /sys/bus/usb/devices/1-1 (bus/usb/001/016)
01-25 13:24:20.160 26414 26454 I vhusbd : Mon Jan 25 21:24:20 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:24:20.160 26414 26454 I vhusbd : Mon Jan 25 21:24:20 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:24:20.161 26414 26454 I vhusbd : Mon Jan 25 21:24:20 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:24:20.161 26414 26454 I vhusbd : Mon Jan 25 21:24:20 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:24:27.283 26414 26454 I vhusbd : Mon Jan 25 21:24:27 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 13:25:10.101 26414 26414 W IInputConnectionWrapper: getExtractedText on inactive InputConnection
01-25 13:25:10.106 26414 26414 W IInputConnectionWrapper: getTextBeforeCursor on inactive InputConnection
01-25 13:25:10.107 26414 26414 W IInputConnectionWrapper: getSelectedText on inactive InputConnection
01-25 13:25:10.107 26414 26414 W IInputConnectionWrapper: getTextAfterCursor on inactive InputConnection
01-25 13:26:20.045 26414 26454 I vhusbd : Mon Jan 25 21:26:20 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 13:26:20.046 26414 26454 I vhusbd : Mon Jan 25 21:26:20 2016 LOG_INFO Unmanaging device 11
01-25 13:26:20.052 26414 26454 I vhusbd : Mon Jan 25 21:26:20 2016 LOG_WARNING Warning, unbinding device at /sys/bus/usb/devices/1-1 with 2 outstanding in-flight URBs
01-25 13:26:20.601 26414 26530 D UsbDeviceConnectionJNI: close
01-25 13:27:02.118 26460 26460 W vhusbdan: type=1400 audit(0.0:197030): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:27:02.118 26460 26460 W vhusbdan: type=1400 audit(0.0:197031): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:27:02.126 26414 26454 I vhusbd : Mon Jan 25 21:27:02 2016 LOG_DEBUG Not a device .
01-25 13:27:02.126 26414 26454 I vhusbd : Mon Jan 25 21:27:02 2016 LOG_DEBUG Not a device ..
01-25 13:27:02.127 26414 26454 I vhusbd : Mon Jan 25 21:27:02 2016 LOG_DEBUG Found /dev/bus/usb/001/018 in /sys/bus/usb/devices/1-1 (bus/usb/001/018)
01-25 13:27:02.129 26414 26454 I vhusbd : Mon Jan 25 21:27:02 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:27:02.129 26414 26454 I vhusbd : Mon Jan 25 21:27:02 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:27:02.129 26414 26454 I vhusbd : Mon Jan 25 21:27:02 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:27:02.130 26414 26454 I vhusbd : Mon Jan 25 21:27:02 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:27:09.233 26414 26454 I vhusbd : Mon Jan 25 21:27:09 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 13:27:13.515 26414 26414 W IInputConnectionWrapper: getExtractedText on inactive InputConnection
01-25 13:27:13.515 26414 26414 W IInputConnectionWrapper: getTextBeforeCursor on inactive InputConnection
01-25 13:27:13.516 26414 26414 W IInputConnectionWrapper: getSelectedText on inactive InputConnection
01-25 13:27:13.516 26414 26414 W IInputConnectionWrapper: getTextAfterCursor on inactive InputConnection
01-25 13:52:38.355 26414 26454 I vhusbd : Mon Jan 25 21:52:38 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 13:52:38.357 26414 26454 I vhusbd : Mon Jan 25 21:52:38 2016 LOG_INFO Unmanaging device 11
01-25 13:52:38.359 26414 26454 I vhusbd : Mon Jan 25 21:52:38 2016 LOG_WARNING Warning, unbinding device at /sys/bus/usb/devices/1-1 with 1 outstanding in-flight URBs
01-25 13:52:38.925 26414 26756 D UsbDeviceConnectionJNI: close
01-25 13:52:45.093 26414 26454 I vhusbd : Stopping...
01-25 13:52:45.409 26414 26443 D OpenGLRenderer: endAllStagingAnimators on 0xaec74b80 (co) with handle 0xb3f65e40
01-25 13:55:07.507 30473 30473 W System : ClassLoader referenced unknown path: /data/app/com.virtualhere.androidserver-1/lib/arm
01-25 13:55:07.560 30473 30503 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: true
01-25 13:55:07.612 30473 30503 I Adreno-EGL: : QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
01-25 13:55:07.616 30473 30503 I OpenGLRenderer: Initialized EGL, version 1.4
01-25 13:55:07.657 30473 30512 I vhusbd : Mon Jan 25 21:55:07 2016 LOG_INFO >>> Starting VirtualHere USB Server v2.7.0 (Built: Jan 22 2016, 16:24:23)<<<
01-25 13:55:07.657 30473 30512 I vhusbd : Mon Jan 25 21:55:07 2016 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
01-25 13:55:07.673 30473 30512 I vhusbd : Mon Jan 25 21:55:07 2016 LOG_INFO Server licensed to=unlicensed max_devices=1
01-25 13:55:07.673 30473 30512 I vhusbd : Mon Jan 25 21:55:07 2016 LOG_INFO Using large URB's
01-25 13:55:07.673 30473 30512 I vhusbd : Mon Jan 25 21:55:07 2016 LOG_DEBUG TCPServer starting...
01-25 13:55:07.674 30473 30512 I vhusbd : Mon Jan 25 21:55:07 2016 LOG_INFO Listening on all network interfaces at port 7575
01-25 13:55:07.675 30473 30512 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
01-25 13:55:13.158 30518 30518 W vhusbdan: type=1400 audit(0.0:197032): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:55:13.168 30518 30518 W vhusbdan: type=1400 audit(0.0:197033): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:55:13.170 30473 30512 I vhusbd : Mon Jan 25 21:55:13 2016 LOG_DEBUG Not a device .
01-25 13:55:13.170 30473 30512 I vhusbd : Mon Jan 25 21:55:13 2016 LOG_DEBUG Not a device ..
01-25 13:55:13.170 30473 30512 I vhusbd : Mon Jan 25 21:55:13 2016 LOG_DEBUG Found /dev/bus/usb/001/002 in /sys/bus/usb/devices/1-1 (bus/usb/001/002)
01-25 13:55:13.172 30473 30512 I vhusbd : Mon Jan 25 21:55:13 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:55:13.172 30473 30512 I vhusbd : Mon Jan 25 21:55:13 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:55:13.172 30473 30512 I vhusbd : Mon Jan 25 21:55:13 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:55:13.173 30473 30512 I vhusbd : Mon Jan 25 21:55:13 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:55:15.734 30473 30503 D OpenGLRenderer: endAllStagingAnimators on 0xb3f6bd80 (co) with handle 0xb3f654e0
01-25 13:55:28.568 30473 30512 I vhusbd : Mon Jan 25 21:55:28 2016 LOG_DEBUG 192.168.173.1 connected
01-25 13:55:37.899 30473 30512 I vhusbd : Mon Jan 25 21:55:37 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 13:56:28.540 30473 30512 I vhusbd : Mon Jan 25 21:56:28 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 13:56:28.540 30473 30512 I vhusbd : Mon Jan 25 21:56:28 2016 LOG_INFO Unmanaging device 11
01-25 13:56:29.131 30473 30684 D UsbDeviceConnectionJNI: close
01-25 13:56:34.689 30473 30570 E UsbManager: exception in UsbManager.openDevice
01-25 13:56:34.689 30473 30570 E UsbManager: java.lang.IllegalArgumentException: device /dev/bus/usb/001/004 does not exist or is restricted
01-25 13:56:34.689 30473 30570 E UsbManager: at android.os.Parcel.readException(Parcel.java:1624)
01-25 13:56:34.689 30473 30570 E UsbManager: at android.os.Parcel.readException(Parcel.java:1573)
01-25 13:56:34.689 30473 30570 E UsbManager: at android.hardware.usb.IUsbManager$Stub$Proxy.openDevice(IUsbManager.java:418)
01-25 13:56:34.689 30473 30570 E UsbManager: at android.hardware.usb.UsbManager.openDevice(UsbManager.java:317)
01-25 13:56:34.689 30473 30570 E UsbManager: at com.virtualhere.androidserver.h.a(Unknown Source)
01-25 13:56:34.689 30473 30570 E UsbManager: at com.virtualhere.androidserver.h.doInBackground(Unknown Source)
01-25 13:56:34.689 30473 30570 E UsbManager: at android.os.AsyncTask$2.call(AsyncTask.java:295)
01-25 13:56:34.689 30473 30570 E UsbManager: at java.util.concurrent.FutureTask.run(FutureTask.java:237)
01-25 13:56:34.689 30473 30570 E UsbManager: at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:234)
01-25 13:56:34.689 30473 30570 E UsbManager: at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1113)
01-25 13:56:34.689 30473 30570 E UsbManager: at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:588)
01-25 13:56:34.689 30473 30570 E UsbManager: at java.lang.Thread.run(Thread.java:818)
01-25 13:56:34.711 30473 30570 E vhusbd-server: Could not open device connection == null!
01-25 13:56:35.789 30473 30684 E UsbManager: exception in UsbManager.openDevice
01-25 13:56:35.789 30473 30684 E UsbManager: java.lang.IllegalArgumentException: device /dev/bus/usb/001/007 does not exist or is restricted
01-25 13:56:35.789 30473 30684 E UsbManager: at android.os.Parcel.readException(Parcel.java:1624)
01-25 13:56:35.789 30473 30684 E UsbManager: at android.os.Parcel.readException(Parcel.java:1573)
01-25 13:56:35.789 30473 30684 E UsbManager: at android.hardware.usb.IUsbManager$Stub$Proxy.openDevice(IUsbManager.java:418)
01-25 13:56:35.789 30473 30684 E UsbManager: at android.hardware.usb.UsbManager.openDevice(UsbManager.java:317)
01-25 13:56:35.789 30473 30684 E UsbManager: at com.virtualhere.androidserver.h.a(Unknown Source)
01-25 13:56:35.789 30473 30684 E UsbManager: at com.virtualhere.androidserver.h.doInBackground(Unknown Source)
01-25 13:56:35.789 30473 30684 E UsbManager: at android.os.AsyncTask$2.call(AsyncTask.java:295)
01-25 13:56:35.789 30473 30684 E UsbManager: at java.util.concurrent.FutureTask.run(FutureTask.java:237)
01-25 13:56:35.789 30473 30684 E UsbManager: at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:234)
01-25 13:56:35.789 30473 30684 E UsbManager: at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1113)
01-25 13:56:35.789 30473 30684 E UsbManager: at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:588)
01-25 13:56:35.789 30473 30684 E UsbManager: at java.lang.Thread.run(Thread.java:818)
01-25 13:56:35.789 30473 30684 E vhusbd-server: Could not open device connection == null!
01-25 13:57:15.474 30473 30512 I vhusbd : Mon Jan 25 21:57:15 2016 LOG_INFO Connection 1 remotely disconnected gracefully (rx msg size)
01-25 13:57:24.160 30473 30512 I vhusbd : Mon Jan 25 21:57:24 2016 LOG_INFO Connection 1 successfully removed (reason:timeout)
01-25 13:57:26.124 30473 30512 I vhusbd : Mon Jan 25 21:57:26 2016 LOG_DEBUG 192.168.173.1 connected
01-25 13:57:51.609 30473 30503 D OpenGLRenderer: endAllStagingAnimators on 0xaed2ea00 (co) with handle 0xb3fa7aa0
01-25 13:57:56.754 30473 30503 D OpenGLRenderer: endAllStagingAnimators on 0x9d645e00 (co) with handle 0xb3fa74d0
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Not a device .
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Not a device ..
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/011 in bus/usb/001/012
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/011 in bus/usb/001/001
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/011 in bus/usb/002/001
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Not a device 1-0:1.0
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Not a device 1-1:1.0
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_DEBUG Not a device 2-0:1.0
01-25 13:58:15.875 30473 30512 I vhusbd : Mon Jan 25 21:58:15 2016 LOG_ERR Android local server failed to find devPath match
01-25 13:58:15.903 30473 30473 I Choreographer: Skipped 581 frames! The application may be doing too much work on its main thread.
01-25 13:58:15.911 30473 30712 W System.err: java.io.IOException: Bad file descriptor
01-25 13:58:15.914 30473 30712 W System.err: at android.net.LocalSocketImpl.pending_native(Native Method)
01-25 13:58:15.914 30473 30712 W System.err: at android.net.LocalSocketImpl.-wrap1(LocalSocketImpl.java)
01-25 13:58:15.914 30473 30712 W System.err: at android.net.LocalSocketImpl$SocketOutputStream.flush(LocalSocketImpl.java:159)
01-25 13:58:15.914 30473 30712 W System.err: at com.virtualhere.androidserver.h.a(Unknown Source)
01-25 13:58:15.914 30473 30712 W System.err: at com.virtualhere.androidserver.h.doInBackground(Unknown Source)
01-25 13:58:15.914 30473 30712 W System.err: at android.os.AsyncTask$2.call(AsyncTask.java:295)
01-25 13:58:15.914 30473 30712 W System.err: at java.util.concurrent.FutureTask.run(FutureTask.java:237)
01-25 13:58:15.914 30473 30712 W System.err: at android.os.AsyncTask$SerialExecutor$1.run(AsyncTask.java:234)
01-25 13:58:15.914 30473 30712 W System.err: at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1113)
01-25 13:58:15.914 30473 30712 W System.err: at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:588)
01-25 13:58:15.914 30473 30712 W System.err: at java.lang.Thread.run(Thread.java:818)
01-25 13:58:16.498 30518 30518 W vhusbdan: type=1400 audit(0.0:197034): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:58:16.498 30518 30518 W vhusbdan: type=1400 audit(0.0:197035): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:58:16.500 30473 30712 D UsbDeviceConnectionJNI: close
01-25 13:58:16.501 30473 30512 I vhusbd : Mon Jan 25 21:58:16 2016 LOG_DEBUG Not a device .
01-25 13:58:16.502 30473 30512 I vhusbd : Mon Jan 25 21:58:16 2016 LOG_DEBUG Not a device ..
01-25 13:58:16.502 30473 30512 I vhusbd : Mon Jan 25 21:58:16 2016 LOG_DEBUG Found /dev/bus/usb/001/012 in /sys/bus/usb/devices/1-1 (bus/usb/001/012)
01-25 13:58:16.502 30473 30512 I vhusbd : Mon Jan 25 21:58:16 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:58:16.502 30473 30512 I vhusbd : Mon Jan 25 21:58:16 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:58:16.503 30473 30512 I vhusbd : Mon Jan 25 21:58:16 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:58:16.503 30473 30512 I vhusbd : Mon Jan 25 21:58:16 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:58:16.548 30473 30512 I vhusbd : Stopping...
01-25 13:58:22.137 31261 31261 W System : ClassLoader referenced unknown path: /data/app/com.virtualhere.androidserver-1/lib/arm
01-25 13:58:22.205 31261 31287 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: true
01-25 13:58:22.251 31261 31287 I Adreno-EGL: : QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
01-25 13:58:22.254 31261 31287 I OpenGLRenderer: Initialized EGL, version 1.4
01-25 13:58:22.287 31261 31296 I vhusbd : Mon Jan 25 21:58:22 2016 LOG_INFO >>> Starting VirtualHere USB Server v2.7.0 (Built: Jan 22 2016, 16:24:23)<<<
01-25 13:58:22.287 31261 31296 I vhusbd : Mon Jan 25 21:58:22 2016 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
01-25 13:58:22.308 31261 31296 I vhusbd : Mon Jan 25 21:58:22 2016 LOG_INFO Server licensed to=unlicensed max_devices=1
01-25 13:58:22.308 31261 31296 I vhusbd : Mon Jan 25 21:58:22 2016 LOG_INFO Using large URB's
01-25 13:58:22.308 31261 31296 I vhusbd : Mon Jan 25 21:58:22 2016 LOG_DEBUG TCPServer starting...
01-25 13:58:22.309 31261 31296 I vhusbd : Mon Jan 25 21:58:22 2016 LOG_INFO Listening on all network interfaces at port 7575
01-25 13:58:22.309 31261 31296 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
01-25 13:58:23.518 31301 31301 W vhusbdan: type=1400 audit(0.0:197036): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:58:23.518 31301 31301 W vhusbdan: type=1400 audit(0.0:197037): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 13:58:23.526 31261 31296 I vhusbd : Mon Jan 25 21:58:23 2016 LOG_DEBUG Not a device .
01-25 13:58:23.526 31261 31296 I vhusbd : Mon Jan 25 21:58:23 2016 LOG_DEBUG Not a device ..
01-25 13:58:23.526 31261 31296 I vhusbd : Mon Jan 25 21:58:23 2016 LOG_DEBUG Found /dev/bus/usb/001/012 in /sys/bus/usb/devices/1-1 (bus/usb/001/012)
01-25 13:58:23.526 31261 31296 I vhusbd : Mon Jan 25 21:58:23 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 13:58:23.526 31261 31296 I vhusbd : Mon Jan 25 21:58:23 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 13:58:23.537 31261 31296 I vhusbd : Mon Jan 25 21:58:23 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 13:58:23.537 31261 31296 I vhusbd : Mon Jan 25 21:58:23 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 13:58:59.582 31261 31296 I vhusbd : Mon Jan 25 21:58:59 2016 LOG_DEBUG 192.168.173.1 connected
01-25 13:59:04.107 31261 31296 I vhusbd : Mon Jan 25 21:59:04 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 13:59:39.328 31261 31261 W IInputConnectionWrapper: getExtractedText on inactive InputConnection
01-25 13:59:39.328 31261 31261 W IInputConnectionWrapper: getTextBeforeCursor on inactive InputConnection
01-25 13:59:39.328 31261 31261 W IInputConnectionWrapper: getSelectedText on inactive InputConnection
01-25 13:59:39.329 31261 31261 W IInputConnectionWrapper: getTextAfterCursor on inactive InputConnection
01-25 14:01:11.216 31261 31296 I vhusbd : Mon Jan 25 22:01:11 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 14:01:11.216 31261 31296 I vhusbd : Mon Jan 25 22:01:11 2016 LOG_INFO Unmanaging device 11
01-25 14:01:11.791 31261 32012 D UsbDeviceConnectionJNI: close
01-25 14:01:14.278 31301 31301 W vhusbdan: type=1400 audit(0.0:197038): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 14:01:14.278 31301 31301 W vhusbdan: type=1400 audit(0.0:197039): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 14:01:14.284 31261 31296 I vhusbd : Mon Jan 25 22:01:14 2016 LOG_DEBUG Not a device .
01-25 14:01:14.284 31261 31296 I vhusbd : Mon Jan 25 22:01:14 2016 LOG_DEBUG Not a device ..
01-25 14:01:14.285 31261 31296 I vhusbd : Mon Jan 25 22:01:14 2016 LOG_DEBUG Found /dev/bus/usb/001/013 in /sys/bus/usb/devices/1-1 (bus/usb/001/013)
01-25 14:01:14.286 31261 31296 I vhusbd : Mon Jan 25 22:01:14 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 14:01:14.286 31261 31296 I vhusbd : Mon Jan 25 22:01:14 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 14:01:14.286 31261 31296 I vhusbd : Mon Jan 25 22:01:14 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 14:01:14.287 31261 31296 I vhusbd : Mon Jan 25 22:01:14 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 14:01:22.071 31261 31296 I vhusbd : Mon Jan 25 22:01:22 2016 LOG_INFO Device 11 BOUND to connection 1
01-25 14:01:26.299 31261 31296 I vhusbd : Mon Jan 25 22:01:26 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 14:01:26.300 31261 31296 I vhusbd : Mon Jan 25 22:01:26 2016 LOG_INFO Unmanaging device 11
01-25 14:01:26.883 31261 31289 D UsbDeviceConnectionJNI: close
01-25 14:01:28.928 31301 31301 W vhusbdan: type=1400 audit(0.0:197040): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 14:01:28.928 31301 31301 W vhusbdan: type=1400 audit(0.0:197041): avc: denied { search } for name="usb" dev="tmpfs" ino=4296928 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 14:01:28.932 31261 31296 I vhusbd : Mon Jan 25 22:01:28 2016 LOG_DEBUG Not a device .
01-25 14:01:28.932 31261 31296 I vhusbd : Mon Jan 25 22:01:28 2016 LOG_DEBUG Not a device ..
01-25 14:01:28.932 31261 31296 I vhusbd : Mon Jan 25 22:01:28 2016 LOG_DEBUG Found /dev/bus/usb/001/014 in /sys/bus/usb/devices/1-1 (bus/usb/001/014)
01-25 14:01:28.934 31261 31296 I vhusbd : Mon Jan 25 22:01:28 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 14:01:28.934 31261 31296 I vhusbd : Mon Jan 25 22:01:28 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 14:01:28.935 31261 31296 I vhusbd : Mon Jan 25 22:01:28 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 14:01:28.935 31261 31296 I vhusbd : Mon Jan 25 22:01:28 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 14:01:34.137 31261 31287 D OpenGLRenderer: endAllStagingAnimators on 0xa0908f80 (co) with handle 0xb3fa4680
01-25 14:01:35.542 31261 31261 W InputEventReceiver: Attempted to finish an input event but the input event receiver has already been disposed.

Sorry for the long post, but I don't see a spoiler tag to shorten it.


--------- beginning of main
01-25 15:08:44.619 4320 4320 W IInputConnectionWrapper: getExtractedText on inactive InputConnection
01-25 15:08:44.620 4320 4320 W IInputConnectionWrapper: getTextBeforeCursor on inactive InputConnection
01-25 15:08:44.620 4320 4320 W IInputConnectionWrapper: getSelectedText on inactive InputConnection
01-25 15:08:44.621 4320 4320 W IInputConnectionWrapper: getTextAfterCursor on inactive InputConnection
01-25 15:09:09.710 4320 4410 I vhusbd : Mon Jan 25 23:09:09 2016 LOG_INFO Device 11 SURPRISE UNBOUND from connection 1
01-25 15:09:09.712 4320 4410 I vhusbd : Mon Jan 25 23:09:09 2016 LOG_INFO Unmanaging device 11
01-25 15:09:10.293 4320 6096 D UsbDeviceConnectionJNI: close
01-25 15:09:57.634 4417 4417 W vhusbdan: type=1400 audit(0.0:554): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:09:57.634 4417 4417 W vhusbdan: type=1400 audit(0.0:555): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:09:57.650 4320 4410 I vhusbd : Mon Jan 25 23:09:57 2016 LOG_DEBUG Not a device .
01-25 15:09:57.650 4320 4410 I vhusbd : Mon Jan 25 23:09:57 2016 LOG_DEBUG Not a device ..
01-25 15:09:57.650 4320 4410 I vhusbd : Mon Jan 25 23:09:57 2016 LOG_DEBUG Found /dev/bus/usb/001/003 in /sys/bus/usb/devices/1-1 (bus/usb/001/003)
01-25 15:09:57.651 4320 4410 I vhusbd : Mon Jan 25 23:09:57 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_001, Operation not permitted
01-25 15:09:57.651 4320 4410 I vhusbd : Mon Jan 25 23:09:57 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 15:09:57.651 4320 4410 I vhusbd : Mon Jan 25 23:09:57 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 15:09:57.651 4320 4410 I vhusbd : Mon Jan 25 23:09:57 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 11
01-25 15:10:19.040 4320 4410 I vhusbd : Mon Jan 25 23:10:19 2016 LOG_INFO Connection 1 remotely disconnected gracefully (rx msg size)
01-25 15:10:29.320 4320 4410 I vhusbd : Mon Jan 25 23:10:29 2016 LOG_INFO Connection 1 successfully removed (reason:timeout)
01-25 15:11:22.518 4320 4410 I vhusbd : Mon Jan 25 23:11:22 2016 LOG_INFO Unmanaging device 11
01-25 15:11:23.092 4320 4379 D UsbDeviceConnectionJNI: close
01-25 15:13:29.044 4320 4410 I vhusbd : Stopping...
01-25 15:13:29.397 4320 4359 D OpenGLRenderer: endAllStagingAnimators on 0xaa791d80 (co) with handle 0xa0d9b870
01-25 15:14:09.045 4320 4320 W System.err: java.io.IOException: Connection refused
01-25 15:14:09.045 4320 4320 W System.err: at android.net.LocalSocketImpl.connectLocal(Native Method)
01-25 15:14:09.045 4320 4320 W System.err: at android.net.LocalSocketImpl.connect(LocalSocketImpl.java:290)
01-25 15:14:09.045 4320 4320 W System.err: at android.net.LocalSocket.connect(LocalSocket.java:130)
01-25 15:14:09.045 4320 4320 W System.err: at com.virtualhere.androidserver.DaemonService.u(Unknown Source)
01-25 15:14:09.045 4320 4320 W System.err: at com.virtualhere.androidserver.DaemonService.a(Unknown Source)
01-25 15:14:09.045 4320 4320 W System.err: at com.virtualhere.androidserver.DaemonService.a(Unknown Source)
01-25 15:14:09.045 4320 4320 W System.err: at com.virtualhere.androidserver.j.handleMessage(Unknown Source)
01-25 15:14:09.045 4320 4320 W System.err: at android.os.Handler.dispatchMessage(Handler.java:102)
01-25 15:14:09.045 4320 4320 W System.err: at android.os.Looper.loop(Looper.java:148)
01-25 15:14:09.045 4320 4320 W System.err: at android.app.ActivityThread.main(ActivityThread.java:5417)
01-25 15:14:09.045 4320 4320 W System.err: at java.lang.reflect.Method.invoke(Native Method)
01-25 15:14:09.045 4320 4320 W System.err: at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:726)
01-25 15:14:09.045 4320 4320 W System.err: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:616)
01-25 15:14:09.079 4320 8422 I vhusbd : Mon Jan 25 23:14:09 2016 LOG_INFO >>> Starting VirtualHere USB Server v2.7.0 (Built: Jan 22 2016, 16:24:23)<<<
01-25 15:14:09.079 4320 8422 I vhusbd : Mon Jan 25 23:14:09 2016 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
01-25 15:14:09.096 4320 8422 I vhusbd : Mon Jan 25 23:14:09 2016 LOG_INFO Server licensed to=unlicensed max_devices=1
01-25 15:14:09.097 4320 8422 I vhusbd : Mon Jan 25 23:14:09 2016 LOG_INFO Using large URB's
01-25 15:14:09.097 4320 8422 I vhusbd : Mon Jan 25 23:14:09 2016 LOG_DEBUG TCPServer starting...
01-25 15:14:09.097 4320 8422 I vhusbd : Mon Jan 25 23:14:09 2016 LOG_INFO Listening on all network interfaces at port 7575
01-25 15:14:09.097 4320 8422 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
01-25 15:14:36.664 8427 8427 W vhusbdan: type=1400 audit(0.0:556): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:14:36.664 8427 8427 W vhusbdan: type=1400 audit(0.0:557): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:14:36.676 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_DEBUG Not a device .
01-25 15:14:36.677 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_DEBUG Not a device ..
01-25 15:14:36.677 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/002
01-25 15:14:36.677 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/001
01-25 15:14:36.677 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/002/001
01-25 15:14:36.678 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_DEBUG Not a device 1-1.2:1.0
01-25 15:14:36.678 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_DEBUG Found /dev/bus/usb/001/003 in /sys/bus/usb/devices/1-1.2 (bus/usb/001/003)
01-25 15:14:36.679 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_002, Operation not permitted
01-25 15:14:36.679 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 15:14:36.680 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 15:14:36.680 4320 8422 I vhusbd : Mon Jan 25 23:14:36 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 112
01-25 15:14:39.661 4320 8422 I vhusbd : Stopping...
01-25 15:14:39.991 4320 4359 D OpenGLRenderer: endAllStagingAnimators on 0xaa794400 (co) with handle 0xa0d9b3e0
01-25 15:15:14.109 4320 4320 W System.err: java.io.IOException: Connection refused
01-25 15:15:14.109 4320 4320 W System.err: at android.net.LocalSocketImpl.connectLocal(Native Method)
01-25 15:15:14.109 4320 4320 W System.err: at android.net.LocalSocketImpl.connect(LocalSocketImpl.java:290)
01-25 15:15:14.109 4320 4320 W System.err: at android.net.LocalSocket.connect(LocalSocket.java:130)
01-25 15:15:14.109 4320 4320 W System.err: at com.virtualhere.androidserver.DaemonService.u(Unknown Source)
01-25 15:15:14.109 4320 4320 W System.err: at com.virtualhere.androidserver.DaemonService.a(Unknown Source)
01-25 15:15:14.109 4320 4320 W System.err: at com.virtualhere.androidserver.DaemonService.a(Unknown Source)
01-25 15:15:14.110 4320 4320 W System.err: at com.virtualhere.androidserver.j.handleMessage(Unknown Source)
01-25 15:15:14.110 4320 4320 W System.err: at android.os.Handler.dispatchMessage(Handler.java:102)
01-25 15:15:14.110 4320 4320 W System.err: at android.os.Looper.loop(Looper.java:148)
01-25 15:15:14.110 4320 4320 W System.err: at android.app.ActivityThread.main(ActivityThread.java:5417)
01-25 15:15:14.110 4320 4320 W System.err: at java.lang.reflect.Method.invoke(Native Method)
01-25 15:15:14.110 4320 4320 W System.err: at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:726)
01-25 15:15:14.110 4320 4320 W System.err: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:616)
01-25 15:15:14.147 4320 8625 I vhusbd : Mon Jan 25 23:15:14 2016 LOG_INFO >>> Starting VirtualHere USB Server v2.7.0 (Built: Jan 22 2016, 16:24:23)<<<
01-25 15:15:14.147 4320 8625 I vhusbd : Mon Jan 25 23:15:14 2016 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
01-25 15:15:14.160 4320 8625 I vhusbd : Mon Jan 25 23:15:14 2016 LOG_INFO Server licensed to=unlicensed max_devices=1
01-25 15:15:14.161 4320 8625 I vhusbd : Mon Jan 25 23:15:14 2016 LOG_INFO Using large URB's
01-25 15:15:14.161 4320 8625 I vhusbd : Mon Jan 25 23:15:14 2016 LOG_DEBUG TCPServer starting...
01-25 15:15:14.161 4320 8625 I vhusbd : Mon Jan 25 23:15:14 2016 LOG_INFO Listening on all network interfaces at port 7575
01-25 15:15:14.161 4320 8625 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
01-25 15:15:23.030 4320 8625 I vhusbd : Stopping...
01-25 15:15:23.363 4320 4359 D OpenGLRenderer: endAllStagingAnimators on 0xa1407700 (co) with handle 0xaeeb1740
01-25 15:18:31.432 10476 10476 W System : ClassLoader referenced unknown path: /data/app/com.virtualhere.androidserver-1/lib/arm
01-25 15:18:31.489 10476 10505 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: true
01-25 15:18:31.547 10476 10505 I Adreno-EGL: : QUALCOMM Build: 10/21/15, 369a2ea, I96aee987eb
01-25 15:18:31.549 10476 10505 I OpenGLRenderer: Initialized EGL, version 1.4
01-25 15:18:31.605 10476 10513 I vhusbd : Mon Jan 25 23:18:31 2016 LOG_INFO >>> Starting VirtualHere USB Server v2.7.0 (Built: Jan 22 2016, 16:24:23)<<<
01-25 15:18:31.605 10476 10513 I vhusbd : Mon Jan 25 23:18:31 2016 LOG_INFO Using configuration /data/data/com.virtualhere.androidserver/config.ini
01-25 15:18:31.620 10476 10513 I vhusbd : Mon Jan 25 23:18:31 2016 LOG_INFO Server licensed to=unlicensed max_devices=1
01-25 15:18:31.620 10476 10513 I vhusbd : Mon Jan 25 23:18:31 2016 LOG_INFO Using large URB's
01-25 15:18:31.620 10476 10513 I vhusbd : Mon Jan 25 23:18:31 2016 LOG_DEBUG TCPServer starting...
01-25 15:18:31.620 10476 10513 I vhusbd : Mon Jan 25 23:18:31 2016 LOG_INFO Listening on all network interfaces at port 7575
01-25 15:18:31.620 10476 10513 I vhusbd : VirtualHere USB Server is running...press CTRL-C to stop
01-25 15:18:34.137 10519 10519 W vhusbdan: type=1400 audit(0.0:558): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:18:34.137 10519 10519 W vhusbdan: type=1400 audit(0.0:559): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:18:34.145 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_DEBUG Not a device .
01-25 15:18:34.146 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_DEBUG Not a device ..
01-25 15:18:34.146 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/002
01-25 15:18:34.146 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/001
01-25 15:18:34.146 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/002/001
01-25 15:18:34.146 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_DEBUG Not a device 1-1.2:1.0
01-25 15:18:34.147 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_DEBUG Found /dev/bus/usb/001/003 in /sys/bus/usb/devices/1-1.2 (bus/usb/001/003)
01-25 15:18:34.148 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_002, Operation not permitted
01-25 15:18:34.148 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 15:18:34.149 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 15:18:34.149 10476 10513 I vhusbd : Mon Jan 25 23:18:34 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 112
01-25 15:18:49.654 10476 10513 I vhusbd : Mon Jan 25 23:18:49 2016 LOG_INFO Unmanaging device 112
01-25 15:18:50.243 10476 10674 D UsbDeviceConnectionJNI: close
01-25 15:18:59.717 10519 10519 W vhusbdan: type=1400 audit(0.0:560): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:18:59.717 10519 10519 W vhusbdan: type=1400 audit(0.0:561): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:18:59.719 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_DEBUG Not a device .
01-25 15:18:59.719 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_DEBUG Not a device ..
01-25 15:18:59.720 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/002
01-25 15:18:59.720 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/001
01-25 15:18:59.721 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/002/001
01-25 15:18:59.721 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_DEBUG Not a device 1-1.2:1.0
01-25 15:18:59.721 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_DEBUG Found /dev/bus/usb/001/003 in /sys/bus/usb/devices/1-1.2 (bus/usb/001/003)
01-25 15:18:59.723 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_002, Operation not permitted
01-25 15:18:59.724 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 15:18:59.724 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 15:18:59.725 10476 10513 I vhusbd : Mon Jan 25 23:18:59 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 112
01-25 15:19:16.843 10476 10513 I vhusbd : Mon Jan 25 23:19:16 2016 LOG_DEBUG 192.168.173.1 connected
01-25 15:19:20.568 10476 10513 I vhusbd : Mon Jan 25 23:19:20 2016 LOG_INFO Device 112 BOUND to connection 1
01-25 15:19:29.390 10476 10513 I vhusbd : Mon Jan 25 23:19:29 2016 LOG_INFO Connection 1 receiving msg size didnt complete due to error 110, Operation timed out
01-25 15:19:31.711 10476 10513 I vhusbd : Mon Jan 25 23:19:31 2016 LOG_INFO Device 112 SURPRISE UNBOUND from connection 1
01-25 15:19:31.711 10476 10513 I vhusbd : Mon Jan 25 23:19:31 2016 LOG_INFO Unmanaging device 112
01-25 15:19:31.712 10476 10513 I vhusbd : Mon Jan 25 23:19:31 2016 LOG_WARNING Warning, unbinding device at /sys/bus/usb/devices/1-1.2 with 2 outstanding in-flight URBs
01-25 15:19:32.291 10476 10507 D UsbDeviceConnectionJNI: close
01-25 15:19:33.474 10476 10513 I vhusbd : Mon Jan 25 23:19:33 2016 LOG_INFO Connection 1 successfully removed (reason:timeout)
01-25 15:19:37.027 10519 10519 W vhusbdan: type=1400 audit(0.0:562): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:19:37.027 10519 10519 W vhusbdan: type=1400 audit(0.0:563): avc: denied { search } for name="usb" dev="tmpfs" ino=11464 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:usb_device:s0 tclass=dir permissive=0
01-25 15:19:37.034 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_DEBUG Not a device .
01-25 15:19:37.034 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_DEBUG Not a device ..
01-25 15:19:37.034 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/002
01-25 15:19:37.034 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/001/001
01-25 15:19:37.034 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_DEBUG Didnt find /dev/bus/usb/001/003 in bus/usb/002/001
01-25 15:19:37.035 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_DEBUG Not a device 1-1.2:1.0
01-25 15:19:37.035 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_DEBUG Found /dev/bus/usb/001/003 in /sys/bus/usb/devices/1-1.2 (bus/usb/001/003)
01-25 15:19:37.036 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_ERR Error 1 creating device node at /data/data/com.virtualhere.androidserver/bus_usb_001_002, Operation not permitted
01-25 15:19:37.036 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_WARNING Warning, some features may not be available, error 22 making parent hub node at (null), Invalid argument
01-25 15:19:37.037 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_WARNING Warning, error 2 opening the hub ((null)) file descriptor some functionality may not be available, No such file or directory
01-25 15:19:37.037 10476 10513 I vhusbd : Mon Jan 25 23:19:37 2016 LOG_INFO Found Low speed device [04d8:004f] "Ambu, Smart Baby" at address 112

#8

Thanks, that log is quite useful. It shows a lot of "SUPRISE UNBOUND" this means either the cable has been pulled or the usb device itself has restarted itself and dropped from the bus. Can you tell me if you have been physically disconnecting the manikin from the phone, or has it been connected all the time?

In reply to by Michael

#9

The wire I was using wasn't quite secure, so near the end of the log I was trying to physically disconnect it to reproduce the crash I've have had. But this should only show up at the end.

#10

OK, i think i fixed that rare crash in the client when running avast. Can you download version 3.3.7 of the client from my website. I also found a race condition in the server that could be causing the problem with your CPR manakin. Ive pushed android server version 2.7.3 to the playstore, when you get the update try again

#11

Thanks Michael! Much appreciated, I haven't had any problem with a crash so far. I'll let you know if I did.

Also, do you happen to know a way to get around android automatically refuse connection to network without internet connect?
Such as this screenshot I took http://i.imgur.com/8t9OTZH.png
It says it won't automatically reconnect but I couldn't manually connect to it either.