usb devices not working after last update

Wed Aug 30 13:01:07 UTC 2006

On Wed, 2006-08-30 at 05:35 -0700, Tod Merley wrote:
> On 8/30/06, Dieter Schicker <dieter.schicker at uni-graz.at> wrote:
> > Hi,
> >
> > On Wed, 2006-08-30 at 04:13 -0700, Tod Merley wrote:
> > > On 8/30/06, Dieter Schicker <dieter.schicker at uni-graz.at> wrote:
> > > > Hi,
> > > >
> > > > on our lab computers (~30) all usb devices don't get automounted
> > > > anymore.
> > > > Linux seems to "see" the devices but no mounting happens. Can anyone
> > > > help?
> > > >
> > > > Thanks in advance
> > > > Dieter
> > > >
> > > > PS: Here's the output of syslog:
> > > >
> > > > Aug 30 11:23:30 inig146 kernel: [17350654.776000] usb 5-7: new high
> > > > speed USB de
> > > > vice using ehci_hcd and address 3
> > > > Aug 30 11:23:30 inig146 kernel: [17350654.920000] scsi3 : SCSI emulation
> > > > for USB
> > > >  Mass Storage devices
> > > > Aug 30 11:23:30 inig146 kernel: [17350654.920000] usb-storage: device
> > > > found at 3
> > > > Aug 30 11:23:30 inig146 kernel: [17350654.920000] usb-storage: waiting
> > > > for devic
> > > > e to settle before scanning
> > > > Aug 30 11:23:35 inig146 kernel: [17350659.920000]   Vendor: Kingston
> > > > Model: Dat
> > > > aTraveler 2.0  Rev: 1.04
> > > > Aug 30 11:23:35 inig146 kernel: [17350659.920000]   Type:
> > > > Direct-Access
> > > >                ANSI SCSI revision: 00
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.196000] SCSI device sdc:
> > > > 499712 512-by
> > > > te hdwr sectors (256 MB)
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.196000] sdc: Write Protect is
> > > > off
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.196000] sdc: Mode Sense: 23 00
> > > > 00 00
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.196000] sdc: assuming drive
> > > > cache: wri
> > > > te through
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.200000] SCSI device sdc:
> > > > 499712 512-by
> > > > te hdwr sectors (256 MB)
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.200000] sdc: Write Protect is
> > > > off
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.200000] sdc: Mode Sense: 23 00
> > > > 00 00
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.200000] sdc: assuming drive
> > > > cache: wri
> > > > te through
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.200000]  sdc: sdc1
> > > > Aug 30 11:23:36 inig146 kernel: [17350660.200000] sd 3:0:0:0: Attached
> > > > scsi remo
> > > > vable disk sdc
> > > >
> > > >
> > > > --
> > > > ubuntu-users mailing list
> > > > ubuntu-users at lists.ubuntu.com
> > > > https://lists.ubuntu.com/mailman/listinfo/ubuntu-users
> > > >
> > >
> > > Hi Dieter!
> > >
> > > It is late for me so I can only help a little.
> >
> > output of lsusb is perfect:
> >
> > Bus 002 Device 001: ID 0000:0000
> > Bus 005 Device 001: ID 0000:0000
> > Bus 004 Device 001: ID 0000:0000
> > Bus 003 Device 001: ID 0000:0000
> > Bus 001 Device 010: ID 05ac:1209 Apple Computer, Inc.
> > Bus 001 Device 009: ID 0930:6532 Toshiba Corp.
> > Bus 001 Device 001: ID 0000:0000
> >
> > here's my syslog which (to me) seems correct, too.
> >
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_event_run: seq 2737 forked,
> > pid [8944], 'add' 'scsi', 0 seconds old
> > Aug 30 13:32:46 inig146 kernel: [17183214.944000]   Vendor: Apple
> > Model: iPod              Rev: 1.62
> > Aug 30 13:32:46 inig146 kernel: [17183214.944000]   Type:
> > Direct-Access                      ANSI SCSI revision: 00
> > Aug 30 13:32:46 inig146 udevd-event[8944]: wait_for_sysfs: wait for 20
> > mseconds
> > Aug 30 13:32:46 inig146 kernel: [17183214.944000] SCSI device sdc:
> > 117210240 512-byte hdwr sectors (60012 MB)
> > Aug 30 13:32:46 inig146 kernel: [17183214.944000] sdc: Write Protect is
> > off
> > Aug 30 13:32:46 inig146 kernel: [17183214.944000] sdc: Mode Sense: 6c 00
> > 00 08
> > Aug 30 13:32:46 inig146 kernel: [17183214.944000] sdc: assuming drive
> > cache: write through
> > Aug 30 13:32:46 inig146 kernel: [17183214.948000] SCSI device sdc:
> > 117210240 512-byte hdwr sectors (60012 MB)
> > Aug 30 13:32:46 inig146 kernel: [17183214.948000] sdc: Write Protect is
> > off
> > Aug 30 13:32:46 inig146 kernel: [17183214.948000] sdc: Mode Sense: 6c 00
> > 00 08
> > Aug 30 13:32:46 inig146 kernel: [17183214.948000] sdc: assuming drive
> > cache: write through
> > Aug 30 13:32:46 inig146 kernel: [17183214.948000]  sdc: sdc1 sdc2
> > Aug 30 13:32:46 inig146 kernel: [17183214.964000] sd 10:0:0:0: Attached
> > scsi removable disk sdc
> > Aug 30 13:32:46 inig146 kernel: [17183214.964000] sd 10:0:0:0: Attached
> > scsi generic sg2 type 0
> > Aug 30 13:32:46 inig146 kernel: [17183214.964000] usb-storage: device
> > scan complete
> > Aug 30 13:32:46 inig146 udevd-event[8944]: wait_for_sysfs: file appeared
> > after 1 loops
> > Aug 30 13:32:46 inig146 udevd-event[8944]: pass_env_to_socket: passed
> > 249 bytes to socket '/org/freedesktop/hal/udev_event',
> > Aug 30 13:32:46 inig146 udevd-event[8944]: pass_env_to_socket: passed -1
> > bytes to socket '/org/kernel/udev/monitor',
> > Aug 30 13:32:46 inig146 udevd-event[8944]: udev_event_run: seq 2737
> > finished
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_done: seq 2737, pid [8944]
> > exit with 0, 0 seconds old
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_event_run: seq 2738 forked,
> > pid [8945], 'add' 'block', 0 seconds old
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_event_run: seq 2741 forked,
> > pid [8946], 'add' 'scsi_device', 0 seconds old
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_event_run: seq 2742 forked,
> > pid [8947], 'add' 'scsi_generic', 0 seconds old
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program: 'usb_id -x'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/usb_id' (stdout) 'ID_VENDOR=Apple'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/usb_id' (stdout) 'ID_MODEL=iPod'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/usb_id' (stdout) 'ID_REVISION=1.62'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/usb_id' (stdout) 'ID_SERIAL=Apple_iPod_000A2700148E6AF1'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/usb_id' (stdout) 'ID_TYPE=disk'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/usb_id' (stdout) 'ID_BUS=usb'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/usb_id' returned with status 0
> > Aug 30 13:32:46 inig146 udevd-event[8945]: udev_rules_get_name: add
> > symlink 'disk/by-id/usb-Apple_iPod_000A2700148E6AF1'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > 'path_id /block/sdc'
> > Aug 30 13:32:46 inig146 udevd-event[8946]: pass_env_to_socket: passed
> > 262 bytes to socket '/org/freedesktop/hal/udev_event',
> > Aug 30 13:32:46 inig146 udevd-event[8946]: run_program: '/sbin/modprobe
> > -Qba sd_mod'
> > Aug 30 13:32:46 inig146 udevd-event[8946]: run_program: '/sbin/modprobe'
> > returned with status 0
> > Aug 30 13:32:46 inig146 udevd-event[8946]: run_program: '/sbin/modprobe
> > -Qba sg'
> > Aug 30 13:32:46 inig146 udevd-event[8946]: run_program: '/sbin/modprobe'
> > returned with status 0
> > Aug 30 13:32:46 inig146 udevd-event[8946]: pass_env_to_socket: passed -1
> > bytes to socket '/org/kernel/udev/monitor',
> > Aug 30 13:32:46 inig146 udevd-event[8946]: udev_event_run: seq 2741
> > finished
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_done: seq 2741, pid [8946]
> > exit with 0, 0 seconds old
> > Aug 30 13:32:46 inig146 udevd-event[8947]: udev_rules_get_name: no node
> > name set, will use kernel name 'sg2'
> > Aug 30 13:32:46 inig146 udevd-event[8947]: create_node: creating device
> > node '/dev/sg2'
> > Aug 30 13:32:46 inig146 udevd-event[8947]: pass_env_to_socket: passed
> > 289 bytes to socket '/org/freedesktop/hal/udev_event',
> > Aug 30 13:32:46 inig146 udevd-event[8947]: pass_env_to_socket: passed -1
> > bytes to socket '/org/kernel/udev/monitor',
> > Aug 30 13:32:46 inig146 udevd-event[8947]: udev_event_run: seq 2742
> > finished
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_done: seq 2742, pid [8947]
> > exit with 0, 0 seconds old
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/path_id' (stdout) 'ID_PATH=usb-000A2700148E6AF1:0:0:0'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: run_program:
> > '/lib/udev/path_id' returned with status 0
> > Aug 30 13:32:46 inig146 udevd-event[8945]: udev_rules_get_name: add
> > symlink 'disk/by-path/usb-000A2700148E6AF1:0:0:0'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: udev_rules_get_name: no node
> > name set, will use kernel name 'sdc'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: create_node: creating device
> > node '/dev/sdc'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: create_node: creating symlink
> > '/dev/disk/by-id/usb-Apple_iPod_000A2700148E6AF1' to '../../sdc'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: create_node: creating symlink
> > '/dev/disk/by-path/usb-000A2700148E6AF1:0:0:0' to '../../sdc'
> > Aug 30 13:32:46 inig146 udevd-event[8945]: pass_env_to_socket: passed
> > 502 bytes to socket '/org/freedesktop/hal/udev_event',
> > Aug 30 13:32:46 inig146 udevd-event[8945]: pass_env_to_socket: passed -1
> > bytes to socket '/org/kernel/udev/monitor',
> > Aug 30 13:32:46 inig146 udevd-event[8945]: udev_event_run: seq 2738
> > finished
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_done: seq 2738, pid [8945]
> > exit with 0, 0 seconds old
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_event_run: seq 2739 forked,
> > pid [8959], 'add' 'block', 0 seconds old
> > Aug 30 13:32:46 inig146 udevd[2233]: udev_event_run: seq 2740 forked,
> > pid [8960], 'add' 'block', 0 seconds old
> > Aug 30 13:32:46 inig146 udevd-event[8959]: udev_rules_get_name: add
> > symlink 'disk/by-id/usb-Apple_iPod_000A2700148E6AF1-part1'
> > Aug 30 13:32:46 inig146 udevd-event[8959]: udev_rules_get_name: add
> > symlink 'disk/by-path/usb-000A2700148E6AF1:0:0:0-part1'
> > Aug 30 13:32:46 inig146 udevd-event[8959]: run_program: 'vol_id
> > --export /dev/.tmp-8-33'
> > Aug 30 13:32:46 inig146 udevd-event[8960]: udev_rules_get_name: add
> > symlink 'disk/by-id/usb-Apple_iPod_000A2700148E6AF1-part2'
> > Aug 30 13:32:46 inig146 udevd-event[8960]: udev_rules_get_name: add
> > symlink 'disk/by-path/usb-000A2700148E6AF1:0:0:0-part2'
> > Aug 30 13:32:46 inig146 udevd-event[8960]: run_program: 'vol_id
> > --export /dev/.tmp-8-34'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: run_program:
> > '/lib/udev/vol_id' (stdout) 'ID_FS_USAGE=filesystem'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: run_program:
> > '/lib/udev/vol_id' (stdout) 'ID_FS_TYPE=vfat'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: run_program:
> > '/lib/udev/vol_id' (stdout) 'ID_FS_VERSION=FAT32'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: run_program:
> > '/lib/udev/vol_id' (stdout) 'ID_FS_UUID=FCCA-8A18'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: run_program:
> > '/lib/udev/vol_id' (stdout) 'ID_FS_LABEL=PKBACK# 001'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: run_program:
> > '/lib/udev/vol_id' (stdout) 'ID_FS_LABEL_SAFE=PKBACK#_001'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: run_program:
> > '/lib/udev/vol_id' returned with status 0
> > Aug 30 13:32:47 inig146 udevd-event[8960]: udev_rules_get_name: add
> > symlink 'disk/by-uuid/FCCA-8A18'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: udev_rules_get_name: add
> > symlink 'disk/by-label/PKBACK#_001'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: udev_rules_get_name: no node
> > name set, will use kernel name 'sdc2'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: create_node: creating device
> > node '/dev/sdc2'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: create_node: creating symlink
> > '/dev/disk/by-id/usb-Apple_iPod_000A2700148E6AF1-part2' to '../../sdc2'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: create_node: creating symlink
> > '/dev/disk/by-path/usb-000A2700148E6AF1:0:0:0-part2' to '../../sdc2'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: create_node: creating symlink
> > '/dev/disk/by-uuid/FCCA-8A18' to '../../sdc2'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: create_node: creating symlink
> > '/dev/disk/by-label/PKBACK#_001' to '../../sdc2'
> > Aug 30 13:32:47 inig146 udevd-event[8960]: pass_env_to_socket: passed
> > 713 bytes to socket '/org/freedesktop/hal/udev_event',
> > Aug 30 13:32:47 inig146 udevd-event[8960]: pass_env_to_socket: passed -1
> > bytes to socket '/org/kernel/udev/monitor',
> > Aug 30 13:32:47 inig146 udevd-event[8960]: udev_event_run: seq 2740
> > finished
> > Aug 30 13:32:47 inig146 udevd[2233]: udev_done: seq 2740, pid [8960]
> > exit with 0, 1 seconds old
> > Aug 30 13:32:47 inig146 udevd-event[8959]: run_program:
> > '/lib/udev/vol_id' returned with status 3
> > Aug 30 13:32:47 inig146 udevd-event[8959]: udev_rules_get_name: no node
> > name set, will use kernel name 'sdc1'
> > Aug 30 13:32:47 inig146 udevd-event[8959]: create_node: creating device
> > node '/dev/sdc1'
> > Aug 30 13:32:47 inig146 udevd-event[8959]: create_node: creating symlink
> > '/dev/disk/by-id/usb-Apple_iPod_000A2700148E6AF1-part1' to '../../sdc1'
> > Aug 30 13:32:47 inig146 udevd-event[8959]: create_node: creating symlink
> > '/dev/disk/by-path/usb-000A2700148E6AF1:0:0:0-part1' to '../../sdc1'
> > Aug 30 13:32:47 inig146 udevd-event[8959]: pass_env_to_socket: passed
> > 525 bytes to socket '/org/freedesktop/hal/udev_event',
> > Aug 30 13:32:47 inig146 udevd-event[8959]: pass_env_to_socket: passed -1
> > bytes to socket '/org/kernel/udev/monitor',
> > Aug 30 13:32:47 inig146 udevd-event[8959]: udev_event_run: seq 2739
> > finished
> > Aug 30 13:32:47 inig146 udevd[2233]: udev_done: seq 2739, pid [8959]
> > exit with 0, 1 seconds old
> >
> > So, my question is: What should happen after udev is done??
> >
> > > Do you use hubs?  Which hubs?
> >
> > No.
> >
> > >
> > > Do you use long USB extension cords?
> >
> > No. USB devices are connected directly to the computer.
> >
> > > What USB devices are you trying to attach?
> >
> > A Kingston USB stick (256MB) and an Apple iPod (it's not mine, so please
> > don't blame me on that ;-))
> >
> > >
> > > What did they used to do, and under which OS (as specific as you can be).
> >
> > I only have a silly answer: They did work that means they were
> > automatically mounted under /media. I'm running Dapper 6.06 with kernel
> > didi at inig146:~$ uname -a
> > Linux inig146 2.6.15-26-386 #1 PREEMPT Thu Aug 3 02:52:00 UTC 2006 i686
> > GNU/Linux
> >
> > Thanks
> > Dieter
> >
> >
> > --
> > ubuntu-users mailing list
> > ubuntu-users at lists.ubuntu.com
> > https://lists.ubuntu.com/mailman/listinfo/ubuntu-users
> >
> 

Hi Tod,

> Hi Again Dieter,
> 
> 5:30a and no sleep for me (just dropped my daughter off to the Airport
> - hope she has a great trip!).
> 

Man, get yourself some sleep!! I really now have a bad conscience!

> What if we started at the wrong place (deep in the HW SW).  What do
> you find under System > Preferences > Removable Drives and Media?
> There under the "Storage" tab I find "Mount Removable Drives when
> hotplugged" and "Mount Removable Media when inserted" and "Browse
> Removable Media when inserted" checked.  The settings under the
> "Multimedia" tab would also interest you I think.

They are all selected ... In the meantime I tried to reinstall hal,
hal-device-manager, gnome-volume manager, but with no success. Thanks
for your help though!

Good night!!!
Dieter