OWON Oscilloscope Problems

Hi Michael.

I'm having trouble getting my USB oscilloscope (OWON VDS10221, VID/PID: 5345/1234) working with VirtualHere. 

The server is a licensed copy of vhusbdarmpi3 v4.4.8 on a RasPi 3.

The config file is below. I added the "onReset" line after reading posts related to some similar problems, and it got me past the first hurdle, which was a client message, "Error "Operation not permitted" (-1) trying to use this device. (<ip address>). There was an error using this device," when attempting to use the device (which appears simply as "U").

ServerName=PiUSB
License=<license key>
It=1554241142
EasyFindId=XUjYDd4nHR6xRCQcKhrV5Z
EasyFindPin=4DPXPi
AutoAttachToKernel=1
#IgnoredDevices=0424/ec00,5e3/749
IgnoredDevices=424/ec00,424/7800,5e3/749,54c/ddf
onReset.5345.1234=

The client is version 5.4.2 on a Windows 10 VM under Hyper-V on Windows Server 2012.

Client system messages on startup are:

2023-02-02 12:46:04 INFO  :VirtualHere Client 5.4.2 starting (Compiled: Dec  8 2022 10:00:10)
2023-02-02 12:46:04 INFO  :Client OS is Windows 10 (build 19044), 64-bit edition
2023-02-02 12:46:04 INFO  :Using config at C:\Users\<username>\AppData\Roaming\vhui.ini
2023-02-02 12:46:04 INFO  :IPC available at \\.\pipe\vhclient
2023-02-02 12:46:04 INFO  :Auto-find (Bonjour) on
2023-02-02 12:46:04 INFO  :Auto-find (Bonjour SSL) on
2023-02-02 12:46:04 INFO  :Drivers are old, they will be upgraded
2023-02-02 12:46:09 INFO  :Connected to the VirtualHere Client Driver (Version 2)

When attempting to use the device, nothing additional appears in the client system messages window. The device reverts to "not used" after 4-5 seconds.

Below is the content added to /var/log/syslog on the server as a result of an attempt to use the device:

Feb  2 13:21:34 Pi3 vhusbdarmpi3_v4.4.8[16727]: Executed "" for onReset.5345.1234
Feb  2 13:21:34 Pi3 vhusbdarmpi3_v4.4.8[16727]: Device 1133 [5345:1234] BOUND to connection 1
Feb  2 13:21:35 Pi3 vhusbdarmpi3_v4.4.8[16727]: Executed "" for onReset.5345.1234
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3:1.0: Device (SEQNUM=5906, ACTION=unbind) is queued
Feb  2 13:21:39 Pi3 systemd-udevd[150]: Validate module index
Feb  2 13:21:39 Pi3 vhusbdarmpi3_v4.4.8[16727]: Device 1133 [5345:1234] SURPRISE UNBOUND from connection 1
Feb  2 13:21:39 Pi3 systemd-udevd[150]: Check if link configuration needs reloading.
Feb  2 13:21:39 Pi3 kernel: [4829884.806145] usb 1-1.3.3: USB disconnect, device number 81
Feb  2 13:21:39 Pi3 vhusbdarmpi3_v4.4.8[16727]: Unmanaging device 1133 [5345:1234]
Feb  2 13:21:39 Pi3 systemd-udevd[150]: Successfully forked off 'n/a' as PID 17206.
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3:1.0: Worker [17206] is forked for processing SEQNUM=5906.
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3:1.0: Device (SEQNUM=5907, ACTION=remove) is queued
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: Processing device (SEQNUM=5906, ACTION=unbind)
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: Device (SEQNUM=5908, ACTION=unbind) is queued
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: Device (SEQNUM=5909, ACTION=remove) is queued
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: Device (SEQNUM=5906, ACTION=unbind) processed
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: sd-device-monitor: Passed 262 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3:1.0: sd-device-monitor: Passed 321 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: Processing device (SEQNUM=5907, ACTION=remove)
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: Device (SEQNUM=5907, ACTION=remove) processed
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: sd-device-monitor: Passed 321 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: sd-device-monitor: Passed 300 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Processing device (SEQNUM=5908, ACTION=unbind)
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: IMPORT builtin 'usb_id' /lib/udev/rules.d/50-udev-default.rules:13
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Failed to open USB device 'descriptors' file: No such file or directory
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Failed to get idVendor attribute: No such file or directory
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: IMPORT builtin 'usb_id' fails: No such file or directory
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Handling device node '/dev/bus/usb/001/081', devnum=c189:80, mode=0600, uid=0, gid=0
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: cannot stat() node '/dev/bus/usb/001/081' (No such file or directory)
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: sd-device: Created empty file '/run/udev/data/c189:80' for '/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Device (SEQNUM=5908, ACTION=unbind) processed
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: sd-device-monitor: Passed 300 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: sd-device-monitor: Passed 300 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Processing device (SEQNUM=5909, ACTION=remove)
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Device (SEQNUM=5909, ACTION=remove) processed
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: sd-device-monitor: Passed 300 byte to netlink monitor
Feb  2 13:21:39 Pi3 kernel: [4829885.105999] usb 1-1.3.3: new full-speed USB device number 82 using dwc_otg
Feb  2 13:21:39 Pi3 kernel: [4829885.239627] usb 1-1.3.3: language id specifier not provided by device, defaulting to English
Feb  2 13:21:39 Pi3 kernel: [4829885.246631] usb 1-1.3.3: New USB device found, idVendor=5345, idProduct=1234, bcdDevice=10.01
Feb  2 13:21:39 Pi3 kernel: [4829885.246654] usb 1-1.3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Feb  2 13:21:39 Pi3 kernel: [4829885.246671] usb 1-1.3.3: Product: U
Feb  2 13:21:39 Pi3 kernel: [4829885.246696] usb 1-1.3.3: Manufacturer: S
Feb  2 13:21:39 Pi3 kernel: [4829885.246711] usb 1-1.3.3: SerialNumber: 0
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: Device (SEQNUM=5910, ACTION=add) is queued
Feb  2 13:21:39 Pi3 vhusbdarmpi3_v4.4.8[16727]: Error 22 discarding urb 0x1de5b60 for device /sys/bus/usb/devices/1-1.3.1.3, Invalid argument (abort endpoint)
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: sd-device-monitor: Passed 297 byte to netlink monitor
Feb  2 13:21:39 Pi3 vhusbdarmpi3_v4.4.8[16727]: Error 22 discarding urb 0x1df6820 for device /sys/bus/usb/devices/1-1.3.1.3, Invalid argument (abort endpoint)
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Processing device (SEQNUM=5910, ACTION=add)
Feb  2 13:21:39 Pi3 vhusbdarmpi3_v4.4.8[16727]: Found Full speed device [5345:1234] "S, U" at address 1133
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3:1.0: Device (SEQNUM=5911, ACTION=add) is queued
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: Device (SEQNUM=5912, ACTION=bind) is queued
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: IMPORT builtin 'usb_id' /lib/udev/rules.d/50-udev-default.rules:13
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: IMPORT builtin 'hwdb' /lib/udev/rules.d/50-udev-default.rules:13
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: MODE 0664 /lib/udev/rules.d/50-udev-default.rules:45
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: PROGRAM 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82' /lib/udev/rules.d/69-libmtp.rules:2541
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Starting 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Successfully forked off '(spawn)' as PID 17219.
Feb  2 13:21:39 Pi3 mtp-probe: checking bus 1, device 82: "/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3"
Feb  2 13:21:39 Pi3 mtp-probe: bus: 1, device: 82 was not an MTP device
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82'(out) '0'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Process 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82' succeeded.
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Handling device node '/dev/bus/usb/001/082', devnum=c189:81, mode=0664, uid=0, gid=0
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Setting permissions /dev/bus/usb/001/082, 020664, uid=0, gid=0
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Creating symlink '/dev/char/189:81' to '../bus/usb/001/082'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: sd-device: Created db file '/run/udev/data/c189:81' for '/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Device (SEQNUM=5910, ACTION=add) processed
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: sd-device-monitor: Passed 560 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3:1.0: sd-device-monitor: Passed 318 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: Processing device (SEQNUM=5911, ACTION=add)
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: IMPORT builtin 'hwdb' /lib/udev/rules.d/50-udev-default.rules:14
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: IMPORT builtin 'usb_id' /lib/udev/rules.d/60-libgphoto2-6.rules:9
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: Failed to access usb_interface: No such file or directory
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: IMPORT builtin 'usb_id' fails: No such file or directory
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: RUN 'kmod load $env{MODALIAS}' /lib/udev/rules.d/80-drivers.rules:5
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: sd-device: Created db file '/run/udev/data/+usb:1-1.3.3:1.0' for '/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3/1-1.3.3:1.0'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Loading module: usb:v5345p1234d1001dc02dsc00dp00ic05isc06ip50in00
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Failed to find module 'usb:v5345p1234d1001dc02dsc00dp00ic05isc06ip50in00'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: Device (SEQNUM=5911, ACTION=add) processed
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3:1.0: sd-device-monitor: Passed 434 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[150]: 1-1.3.3: sd-device-monitor: Passed 309 byte to netlink monitor
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Processing device (SEQNUM=5912, ACTION=bind)
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: IMPORT builtin 'usb_id' /lib/udev/rules.d/50-udev-default.rules:13
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: IMPORT builtin 'hwdb' /lib/udev/rules.d/50-udev-default.rules:13
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: PROGRAM 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82' /lib/udev/rules.d/69-libmtp.rules:2541
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Starting 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Successfully forked off '(spawn)' as PID 17231.
Feb  2 13:21:39 Pi3 mtp-probe: checking bus 1, device 82: "/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3"
Feb  2 13:21:39 Pi3 mtp-probe: bus: 1, device: 82 was not an MTP device
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82'(out) '0'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: Process 'mtp-probe /sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3 1 82' succeeded.
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Handling device node '/dev/bus/usb/001/082', devnum=c189:81, mode=0600, uid=0, gid=0
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Preserve already existing symlink '/dev/char/189:81' to '../bus/usb/001/082'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: sd-device: Created db file '/run/udev/data/c189:81' for '/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3.3'
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: Device (SEQNUM=5912, ACTION=bind) processed
Feb  2 13:21:39 Pi3 systemd-udevd[17206]: 1-1.3.3: sd-device-monitor: Passed 561 byte to netlink monitor
Feb  2 13:21:42 Pi3 systemd-udevd[150]: Cleanup idle workers
Feb  2 13:21:42 Pi3 systemd-udevd[17206]: Unload module index
Feb  2 13:21:42 Pi3 systemd-udevd[17206]: Unloaded link configuration context.
Feb  2 13:21:42 Pi3 systemd-udevd[150]: Worker [17206] exited

Any thoughts?

Thanks,

-Nick

#2

Can you stop the virtualhere server on the pi.

Edit the config.ini file and add the line

ClaimPorts=1

then save the config.ini and start the virtualhere server again.

Unplug/reply the Owon and then try to use the owon again via virtualhere.

Does that help?

#3

Yes, that did the trick. Thanks.

You do set the standard when it comes to technical support. :-)

-Nick

#4

Great thanks for letting me know.