Help with udev

["Mark Rivers" <rivers@cars.uchicago.edu>]

Folks,
 
I have written EPICS device support for a USB device (Saturn spectroscopy system from XIA).  It is working fine under both Windows and Linux.
 
However, on Linux I have been running the IOC application with root privilege, which I would like to avoid.  The problem arises because USB devices are created dynamically, so one cannot statically give them the desired mode (e.g. 666, 660, etc.).
 
My understanding is that one can use the Linux "udev" facility to handle this.  I've found some examples of how to do it on the Web, but I can't seem to get it to work.  I was hoping someone might be able to tell me what I'm doing wrong.
 
I've created a file, /etc/udev/rules.d/80-saturn.rules
 
[epics@baja rules.d]$ more /etc/udev/rules.d/80-saturn.rules 
SUBSYSTEM=="usb_device",ACTION=="add",ATTRS{idVendor}=="10E9",ATTRS{idProduct}=="0700",MODE="0666"
SUBSYSTEM=="usb_device",ACTION=="add",ATTRS{idVendor}=="10E9",ATTRS{idProduct}=="0701",MODE="0666"
This should set the permissions on the device to 666 when the USB device is added.  I have verified that these are the correct idVendor and idProduct with udevinfo:
 
[epics@baja udev]# /usr/bin/udevinfo --attribute-walk --name=/dev/bus/usb/005/008
Udevinfo starts with the device specified by the devpath and then
walks up the chain of parent devices. It prints for every device
found, all possible attributes in the udev rules key format.
A rule to match, can be composed by the attributes of the device
and the attributes from one single parent device.
  looking at device '/class/usb_device/usbdev5.8':
    KERNEL=="usbdev5.8"
    SUBSYSTEM=="usb_device"
    DRIVER==""
    ATTR{dev}=="189:519"
  looking at parent device '/devices/pci0000:00/0000:00:1d.7/usb5/5-1':
    KERNELS=="5-1"
    SUBSYSTEMS=="usb"
    DRIVERS=="usb"
    ATTRS{product}=="EZ-USB"
    ATTRS{manufacturer}=="Cypress"
    ATTRS{quirks}=="0x0"
    ATTRS{maxchild}=="0"
    ATTRS{version}==" 2.00"
    ATTRS{devnum}=="8"
    ATTRS{busnum}=="5"
    ATTRS{speed}=="480"
    ATTRS{bMaxPacketSize0}=="64"
    ATTRS{bNumConfigurations}=="1"
    ATTRS{bDeviceProtocol}=="00"
    ATTRS{bDeviceSubClass}=="00"
    ATTRS{bDeviceClass}=="00"
    ATTRS{bcdDevice}=="0000"
    ATTRS{idProduct}=="0701"
    ATTRS{idVendor}=="10e9"
    ATTRS{bMaxPower}=="100mA"
    ATTRS{bmAttributes}=="80"
    ATTRS{bConfigurationValue}=="1"
    ATTRS{bNumInterfaces}==" 1"
    ATTRS{configuration}==""
    ATTRS{dev}=="189:519"
 
I've increased the debugging level of udev, and restarted udevd.  I can see in the log file that it has read my rules file.
 
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/05-udev-early.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/06-udev-rh-early.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/10-libifp.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/40-multipath.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/50-udev.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-libmtp.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-libnjb.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-libsane.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-net.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-pcmcia.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-persistent-input.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-persistent-storage.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/60-wacom.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/80-saturn.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/85-pcscd_ccid.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/85-pcscd_egate.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/90-alsa.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/90-hal.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/95-pam-console.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/95-udev-late.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/99-fuse.rules' as rules file
Dec 20 18:21:37 baja udevd[3584]: parse_file: reading '/etc/udev/rules.d/bluetooth.rules' as rules file
Dec 20 18:21:37 baja udevd[3585]: main: initialize max_childs to 2114
Dec 20 18:21:37 baja udevd[3585]: main: initialize max_childs_running to 40
However, when powering the Saturn off and on (and thereby creating a new Linux USB device), the permissions are not what I want, they are still 644, not 666.  If I manually change the permissions on /proc/bus/usb/005/008 to 666 then non-privileged users can run the IOC application.  But the next time I power off and on the device, it will be device /proc/bus/usb/005/009, and again I would need to log in as root to change the permisions. 
 
 
Here is the output of the log file when the device is powered on and found by Linux.
 
Dec 20 18:21:56 baja kernel: usb 5-1: new high speed USB device using ehci_hcd and address 8
Dec 20 18:21:56 baja kernel: usb 5-1: configuration #1 chosen from 1 choice
Dec 20 18:21:56 baja udevd[3585]: udev_event_run: seq 1037 forked, pid [3600], 'add' 'usb', 0 seconds old
Dec 20 18:21:57 baja udevd-event[3600]: udev_rules_get_name: rule applied, '5-1' becomes 'bus/usb/005/008'
Dec 20 18:21:57 baja udevd-event[3600]: udev_db_get_device: no db file to read /dev/.udev/db/\x2fdevices\x2fpci0000:00\x2f0000:00:1d.7\x2fusb5\x2f5-1: No such file or directory
Dec 20 18:21:57 baja udevd-event[3600]: udev_node_add: creating device node '/dev/bus/usb/005/008', major=189, minor=519, mode=0644, uid=0, gid=0
Dec 20 18:21:57 baja udevd-event[3600]: name_index: creating index: '/dev/.udev/names/bus\x2fusb\x2f005\x2f008/\x2fdevices\x2fpci0000:00\x2f0000:00:1d.7\x2fusb5\x2f5-1'
Dec 20 18:21:57 baja udevd-event[3600]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:57 baja udevd-event[3600]: pass_env_to_socket: passed 322 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:57 baja udevd-event[3600]: run_program: '/sbin/pam_console_apply /dev/bus/usb/005/008 '
Dec 20 18:21:57 baja udevd-event[3600]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:57 baja udevd-event[3600]: udev_event_run: seq 1037 finished
Dec 20 18:21:57 baja udevd[3585]: udev_done: seq 1037, pid [3600] exit with 0, 1 seconds old
Dec 20 18:21:57 baja udevd[3585]: udev_event_run: seq 1038 forked, pid [3602], 'add' 'usb_endpoint', 1 seconds old
Dec 20 18:21:57 baja udevd[3585]: udev_event_run: seq 1039 forked, pid [3603], 'add' 'usb', 0 seconds old
Dec 20 18:21:57 baja udevd-event[3602]: udev_rules_get_name: add symlink 'usbdev5.8_ep00'
Dec 20 18:21:57 baja udevd-event[3602]: udev_rules_get_name: rule applied, 'usbdev5.8_ep00' becomes 'bus/usb/5/8_ep/00'
Dec 20 18:21:57 baja udevd-event[3603]: run_program: '/sbin/modprobe usb:v10E9p0701d0000dc00dsc00dp00icFFisc00ip00'
Dec 20 18:21:57 baja udevd-event[3603]: run_program: '/sbin/modprobe' (stderr) 'FATAL: Module usb:v10E9p0701d0000dc00dsc00dp00icFFisc00ip00 not found.'
Dec 20 18:21:57 baja udevd-event[3603]: run_program: '/sbin/modprobe' returned with status 1
Dec 20 18:21:57 baja udevd-event[3603]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:57 baja udevd-event[3603]: pass_env_to_socket: passed 343 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:57 baja udevd-event[3603]: run_program: '/sbin/pam_console_apply  '
Dec 20 18:21:57 baja udevd-event[3603]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:57 baja udevd-event[3603]: udev_event_run: seq 1039 finished
Dec 20 18:21:57 baja udevd[3585]: udev_done: seq 1039, pid [3603] exit with 1, 0 seconds old
Dec 20 18:21:57 baja udevd[3585]: udev_event_run: seq 1040 forked, pid [3606], 'add' 'usb_endpoint', 0 seconds old
Dec 20 18:21:57 baja udevd[3585]: udev_event_run: seq 1041 forked, pid [3607], 'add' 'usb_endpoint', 0 seconds old
Dec 20 18:21:57 baja udevd[3585]: udev_event_run: seq 1042 forked, pid [3608], 'add' 'usb_endpoint', 0 seconds old
Dec 20 18:21:57 baja udevd[3585]: udev_event_run: seq 1043 forked, pid [3609], 'add' 'usb_endpoint', 0 seconds old
Dec 20 18:21:57 baja udevd[3585]: udev_event_run: seq 1044 forked, pid [3610], 'add' 'usb_device', 0 seconds old
Dec 20 18:21:57 baja udevd-event[3610]: run_program: '/bin/sh -c 'K=usbdev5.8; K=${K#usbdev}; printf bus/usb/%03i/%03i ${K%%.*} ${K#*.}''
Dec 20 18:21:57 baja udevd-event[3610]: run_program: '/bin/sh' (stdout) 'bus/usb/005/008'
Dec 20 18:21:57 baja udevd-event[3610]: run_program: '/bin/sh' returned with status 0
Dec 20 18:21:57 baja udevd-event[3610]: udev_rules_get_name: rule applied, 'usbdev5.8' becomes 'bus/usb/005/008'
Dec 20 18:21:57 baja udevd-event[3608]: udev_rules_get_name: add symlink 'usbdev5.8_ep06'
Dec 20 18:21:57 baja udevd-event[3608]: udev_rules_get_name: rule applied, 'usbdev5.8_ep06' becomes 'bus/usb/5/8_ep/06'
Dec 20 18:21:57 baja udevd-event[3609]: udev_rules_get_name: add symlink 'usbdev5.8_ep88'
Dec 20 18:21:57 baja udevd-event[3606]: udev_rules_get_name: add symlink 'usbdev5.8_ep82'
Dec 20 18:21:57 baja udevd-event[3609]: udev_rules_get_name: rule applied, 'usbdev5.8_ep88' becomes 'bus/usb/5/8_ep/88'
Dec 20 18:21:57 baja udevd-event[3607]: udev_rules_get_name: add symlink 'usbdev5.8_ep01'
Dec 20 18:21:57 baja udevd-event[3606]: udev_rules_get_name: rule applied, 'usbdev5.8_ep82' becomes 'bus/usb/5/8_ep/82'
Dec 20 18:21:57 baja udevd-event[3607]: udev_rules_get_name: rule applied, 'usbdev5.8_ep01' becomes 'bus/usb/5/8_ep/01'
Dec 20 18:21:57 baja udevd-event[3602]: udev_db_get_device: no db file to read /dev/.udev/db/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep00: No such file or directory
Dec 20 18:21:57 baja udevd-event[3602]: udev_node_add: creating device node '/dev/bus/usb/5/8_ep/00', major=251, minor=10, mode=0644, uid=0, gid=0
Dec 20 18:21:58 baja udevd-event[3602]: name_index: creating index: '/dev/.udev/names/usbdev5.8_ep00/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep00'
Dec 20 18:21:58 baja udevd-event[3602]: name_index: creating index: '/dev/.udev/names/bus\x2fusb\x2f5\x2f8_ep\x2f00/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep00'
Dec 20 18:21:58 baja udevd-event[3602]: udev_node_update_symlinks: update symlink 'usbdev5.8_ep00' of '/class/usb_endpoint/usbdev5.8_ep00'
Dec 20 18:21:58 baja udevd-event[3602]: udev_db_get_devices_by_name: found index directory '/dev/.udev/names/usbdev5.8_ep00'
Dec 20 18:21:58 baja udevd-event[3602]: update_link: found 1 devices with name 'usbdev5.8_ep00'
Dec 20 18:21:58 baja udevd-event[3602]: update_link: found '/class/usb_endpoint/usbdev5.8_ep00' for 'usbdev5.8_ep00'
Dec 20 18:21:58 baja udevd-event[3602]: update_link: compare (our own) priority of '/class/usb_endpoint/usbdev5.8_ep00' 0 >= 0
Dec 20 18:21:58 baja udevd-event[3602]: update_link: 'usbdev5.8_ep00' with target 'bus/usb/5/8_ep/00' has the highest priority 0, create it
Dec 20 18:21:58 baja udevd-event[3602]: node_symlink: creating symlink '/dev/usbdev5.8_ep00' to 'bus/usb/5/8_ep/00'
Dec 20 18:21:58 baja udevd-event[3602]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:58 baja udevd-event[3602]: pass_env_to_socket: passed 319 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:58 baja udevd-event[3602]: run_program: '/sbin/pam_console_apply /dev/bus/usb/5/8_ep/00 /dev/usbdev5.8_ep00'
Dec 20 18:21:58 baja udevd-event[3602]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:58 baja udevd-event[3602]: udev_event_run: seq 1038 finished
Dec 20 18:21:58 baja udevd[3585]: udev_done: seq 1038, pid [3602] exit with 0, 2 seconds old
Dec 20 18:21:58 baja udevd-event[3608]: udev_db_get_device: no db file to read /dev/.udev/db/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep06: No such file or directory
Dec 20 18:21:58 baja udevd-event[3608]: udev_node_add: creating device node '/dev/bus/usb/5/8_ep/06', major=251, minor=13, mode=0644, uid=0, gid=0
Dec 20 18:21:58 baja udevd-event[3608]: name_index: creating index: '/dev/.udev/names/usbdev5.8_ep06/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep06'
Dec 20 18:21:58 baja udevd-event[3608]: name_index: creating index: '/dev/.udev/names/bus\x2fusb\x2f5\x2f8_ep\x2f06/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep06'
Dec 20 18:21:58 baja udevd-event[3608]: udev_node_update_symlinks: update symlink 'usbdev5.8_ep06' of '/class/usb_endpoint/usbdev5.8_ep06'
Dec 20 18:21:58 baja udevd-event[3608]: udev_db_get_devices_by_name: found index directory '/dev/.udev/names/usbdev5.8_ep06'
Dec 20 18:21:58 baja udevd-event[3608]: update_link: found 1 devices with name 'usbdev5.8_ep06'
Dec 20 18:21:58 baja udevd-event[3608]: update_link: found '/class/usb_endpoint/usbdev5.8_ep06' for 'usbdev5.8_ep06'
Dec 20 18:21:58 baja udevd-event[3608]: update_link: compare (our own) priority of '/class/usb_endpoint/usbdev5.8_ep06' 0 >= 0
Dec 20 18:21:58 baja udevd-event[3608]: update_link: 'usbdev5.8_ep06' with target 'bus/usb/5/8_ep/06' has the highest priority 0, create it
Dec 20 18:21:58 baja udevd-event[3608]: node_symlink: creating symlink '/dev/usbdev5.8_ep06' to 'bus/usb/5/8_ep/06'
Dec 20 18:21:58 baja udevd-event[3608]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:58 baja udevd-event[3608]: pass_env_to_socket: passed 309 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:58 baja udevd-event[3608]: run_program: '/sbin/pam_console_apply /dev/bus/usb/5/8_ep/06 /dev/usbdev5.8_ep06'
Dec 20 18:21:58 baja udevd-event[3609]: udev_db_get_device: no db file to read /dev/.udev/db/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep88: No such file or directory
Dec 20 18:21:58 baja udevd-event[3609]: udev_node_add: creating device node '/dev/bus/usb/5/8_ep/88', major=251, minor=14, mode=0644, uid=0, gid=0
Dec 20 18:21:58 baja udevd-event[3608]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:58 baja udevd-event[3608]: udev_event_run: seq 1042 finished
Dec 20 18:21:58 baja udevd[3585]: udev_done: seq 1042, pid [3608] exit with 0, 1 seconds old
Dec 20 18:21:58 baja udevd-event[3609]: name_index: creating index: '/dev/.udev/names/usbdev5.8_ep88/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep88'
Dec 20 18:21:58 baja udevd-event[3609]: name_index: creating index: '/dev/.udev/names/bus\x2fusb\x2f5\x2f8_ep\x2f88/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep88'
Dec 20 18:21:58 baja udevd-event[3609]: udev_node_update_symlinks: update symlink 'usbdev5.8_ep88' of '/class/usb_endpoint/usbdev5.8_ep88'
Dec 20 18:21:58 baja udevd-event[3609]: udev_db_get_devices_by_name: found index directory '/dev/.udev/names/usbdev5.8_ep88'
Dec 20 18:21:58 baja udevd-event[3609]: update_link: found 1 devices with name 'usbdev5.8_ep88'
Dec 20 18:21:58 baja udevd-event[3609]: update_link: found '/class/usb_endpoint/usbdev5.8_ep88' for 'usbdev5.8_ep88'
Dec 20 18:21:58 baja udevd-event[3609]: update_link: compare (our own) priority of '/class/usb_endpoint/usbdev5.8_ep88' 0 >= 0
Dec 20 18:21:58 baja udevd-event[3609]: update_link: 'usbdev5.8_ep88' with target 'bus/usb/5/8_ep/88' has the highest priority 0, create it
Dec 20 18:21:58 baja udevd-event[3609]: node_symlink: creating symlink '/dev/usbdev5.8_ep88' to 'bus/usb/5/8_ep/88'
Dec 20 18:21:58 baja udevd-event[3609]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:58 baja udevd-event[3609]: pass_env_to_socket: passed 309 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:58 baja udevd-event[3609]: run_program: '/sbin/pam_console_apply /dev/bus/usb/5/8_ep/88 /dev/usbdev5.8_ep88'
Dec 20 18:21:58 baja udevd-event[3606]: udev_db_get_device: no db file to read /dev/.udev/db/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep82: No such file or directory
Dec 20 18:21:58 baja udevd-event[3606]: udev_node_add: creating device node '/dev/bus/usb/5/8_ep/82', major=251, minor=11, mode=0644, uid=0, gid=0
Dec 20 18:21:58 baja udevd-event[3609]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:58 baja udevd-event[3609]: udev_event_run: seq 1043 finished
Dec 20 18:21:58 baja udevd[3585]: udev_done: seq 1043, pid [3609] exit with 0, 1 seconds old
Dec 20 18:21:58 baja udevd-event[3606]: name_index: creating index: '/dev/.udev/names/usbdev5.8_ep82/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep82'
Dec 20 18:21:58 baja udevd-event[3606]: name_index: creating index: '/dev/.udev/names/bus\x2fusb\x2f5\x2f8_ep\x2f82/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep82'
Dec 20 18:21:58 baja udevd-event[3606]: udev_node_update_symlinks: update symlink 'usbdev5.8_ep82' of '/class/usb_endpoint/usbdev5.8_ep82'
Dec 20 18:21:58 baja udevd-event[3606]: udev_db_get_devices_by_name: found index directory '/dev/.udev/names/usbdev5.8_ep82'
Dec 20 18:21:58 baja udevd-event[3606]: update_link: found 1 devices with name 'usbdev5.8_ep82'
Dec 20 18:21:58 baja udevd-event[3606]: update_link: found '/class/usb_endpoint/usbdev5.8_ep82' for 'usbdev5.8_ep82'
Dec 20 18:21:58 baja udevd-event[3607]: udev_db_get_device: no db file to read /dev/.udev/db/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep01: No such file or directory
Dec 20 18:21:58 baja udevd-event[3606]: update_link: compare (our own) priority of '/class/usb_endpoint/usbdev5.8_ep82' 0 >= 0
Dec 20 18:21:58 baja udevd-event[3606]: update_link: 'usbdev5.8_ep82' with target 'bus/usb/5/8_ep/82' has the highest priority 0, create it
Dec 20 18:21:58 baja udevd-event[3607]: udev_node_add: creating device node '/dev/bus/usb/5/8_ep/01', major=251, minor=12, mode=0644, uid=0, gid=0
Dec 20 18:21:58 baja udevd-event[3606]: node_symlink: creating symlink '/dev/usbdev5.8_ep82' to 'bus/usb/5/8_ep/82'
Dec 20 18:21:58 baja udevd-event[3606]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:58 baja udevd-event[3606]: pass_env_to_socket: passed 309 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:58 baja udevd-event[3607]: name_index: creating index: '/dev/.udev/names/usbdev5.8_ep01/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep01'
Dec 20 18:21:58 baja udevd-event[3607]: name_index: creating index: '/dev/.udev/names/bus\x2fusb\x2f5\x2f8_ep\x2f01/\x2fclass\x2fusb_endpoint\x2fusbdev5.8_ep01'
Dec 20 18:21:58 baja udevd-event[3606]: run_program: '/sbin/pam_console_apply /dev/bus/usb/5/8_ep/82 /dev/usbdev5.8_ep82'
Dec 20 18:21:58 baja udevd-event[3607]: udev_node_update_symlinks: update symlink 'usbdev5.8_ep01' of '/class/usb_endpoint/usbdev5.8_ep01'
Dec 20 18:21:58 baja udevd-event[3607]: udev_db_get_devices_by_name: found index directory '/dev/.udev/names/usbdev5.8_ep01'
Dec 20 18:21:58 baja udevd-event[3607]: update_link: found 1 devices with name 'usbdev5.8_ep01'
Dec 20 18:21:58 baja udevd-event[3607]: update_link: found '/class/usb_endpoint/usbdev5.8_ep01' for 'usbdev5.8_ep01'
Dec 20 18:21:58 baja udevd-event[3607]: update_link: compare (our own) priority of '/class/usb_endpoint/usbdev5.8_ep01' 0 >= 0
Dec 20 18:21:58 baja udevd-event[3607]: update_link: 'usbdev5.8_ep01' with target 'bus/usb/5/8_ep/01' has the highest priority 0, create it
Dec 20 18:21:58 baja udevd-event[3607]: node_symlink: creating symlink '/dev/usbdev5.8_ep01' to 'bus/usb/5/8_ep/01'
Dec 20 18:21:58 baja udevd-event[3606]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:58 baja udevd-event[3606]: udev_event_run: seq 1040 finished
Dec 20 18:21:58 baja udevd-event[3607]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:58 baja udevd[3585]: udev_done: seq 1040, pid [3606] exit with 0, 1 seconds old
Dec 20 18:21:58 baja udevd-event[3607]: pass_env_to_socket: passed 309 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:58 baja udevd-event[3607]: run_program: '/sbin/pam_console_apply /dev/bus/usb/5/8_ep/01 /dev/usbdev5.8_ep01'
Dec 20 18:21:58 baja udevd-event[3607]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:58 baja udevd-event[3607]: udev_event_run: seq 1041 finished
Dec 20 18:21:58 baja udevd[3585]: udev_done: seq 1041, pid [3607] exit with 0, 1 seconds old
Dec 20 18:21:59 baja udevd-event[3610]: udev_db_get_device: no db file to read /dev/.udev/db/\x2fclass\x2fusb_device\x2fusbdev5.8: No such file or directory
Dec 20 18:21:59 baja udevd-event[3610]: udev_node_add: creating device node '/dev/bus/usb/005/008', major=189, minor=519, mode=0644, uid=0, gid=0
Dec 20 18:21:59 baja udevd-event[3610]: udev_node_mknod: preserve file '/dev/bus/usb/005/008', because it has correct dev_t
Dec 20 18:21:59 baja udevd-event[3610]: name_index: creating index: '/dev/.udev/names/bus\x2fusb\x2f005\x2f008/\x2fclass\x2fusb_device\x2fusbdev5.8'
Dec 20 18:21:59 baja udevd-event[3610]: pass_env_to_socket: passed -1 bytes to socket '/org/kernel/udev/monitor',
Dec 20 18:21:59 baja udevd-event[3610]: pass_env_to_socket: passed 273 bytes to socket '/org/freedesktop/hal/udev_event',
Dec 20 18:21:59 baja udevd-event[3610]: run_program: '/sbin/pam_console_apply /dev/bus/usb/005/008 '
Dec 20 18:21:59 baja udevd-event[3610]: run_program: '/sbin/pam_console_apply' returned with status 0
Dec 20 18:21:59 baja udevd-event[3610]: udev_event_run: seq 1044 finished
Dec 20 18:21:59 baja udevd[3585]: udev_done: seq 1044, pid [3610] exit with 0, 2 seconds old

Any ideas?

Thanks,

Mark