You are not logged in.
Pages: 1
Ever since I switched from Ubuntu to Arch Linux I've been experiencing unstable behavior with USB devices. I first started noticing it with my EasyCap video capture devices; shortly after connecting them, the system would completely freeze (no keyboard/mouse response). I tried using a powered USB hub in case the devices were demanding too much current--same problem. Today I plugged my iPod in but it wouldn't mount. Less than a half hour later the whole system crashed. I don't think it's a hardware problem because I wasn't having this issue when Ubuntu was installed previously. Any ideas on how to troubleshoot it? Here is the relevant section of kernel.log:
Jan 1 12:36:00 localhost kernel: [1111476.098863] usb 2-4: new high speed USB device number 4 using ehci_hcd
Jan 1 12:36:01 localhost kernel: [1111476.941439] Initializing USB Mass Storage driver...
Jan 1 12:36:01 localhost kernel: [1111476.941576] scsi8 : usb-storage 2-4:1.0
Jan 1 12:36:01 localhost kernel: [1111476.941664] usbcore: registered new interface driver usb-storage
Jan 1 12:36:01 localhost kernel: [1111476.941666] USB Mass Storage support registered.
Jan 1 12:36:01 localhost kernel: [1111476.953280] usbcore: registered new interface driver uas
Jan 1 12:36:02 localhost kernel: [1111477.946691] scsi 8:0:0:0: Direct-Access Apple iPod 1.62 PQ: 0 ANSI: 0
Jan 1 12:36:05 localhost kernel: [1111477.950032] sd 8:0:0:0: [sdd] Spinning up disk...
Jan 1 12:36:05 localhost kernel: [1111480.472935] usb 2-4: USB disconnect, device number 4
Jan 1 12:36:06 localhost kernel: [1111481.512200] .ready
Jan 1 12:36:06 localhost kernel: [1111481.512298] sd 8:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:36:06 localhost kernel: [1111481.512300] sd 8:0:0:0: [sdd] Result: hostbyte=0x01 driverbyte=0x00
Jan 1 12:36:06 localhost kernel: [1111481.512304] sd 8:0:0:0: [sdd] Sense not available.
Jan 1 12:36:06 localhost kernel: [1111481.512323] sd 8:0:0:0: [sdd] Write Protect is off
Jan 1 12:36:06 localhost kernel: [1111481.512327] sd 8:0:0:0: [sdd] Mode Sense: 00 00 00 00
Jan 1 12:36:06 localhost kernel: [1111481.512341] sd 8:0:0:0: [sdd] Asking for cache data failed
Jan 1 12:36:06 localhost kernel: [1111481.512344] sd 8:0:0:0: [sdd] Assuming drive cache: write through
Jan 1 12:36:06 localhost kernel: [1111481.512558] sd 8:0:0:0: [sdd] Attached SCSI removable disk
Jan 1 12:36:28 localhost kernel: [1111503.802195] usb 1-4: new high speed USB device number 3 using ehci_hcd
Jan 1 12:36:28 localhost kernel: [1111503.934610] scsi9 : usb-storage 1-4:1.0
Jan 1 12:36:29 localhost kernel: [1111504.939543] scsi 9:0:0:0: Direct-Access Apple iPod 1.62 PQ: 0 ANSI: 0
Jan 1 12:36:53 localhost kernel: [1111504.942642] sd 9:0:0:0: [sdd] Spinning up disk..................
Jan 1 12:36:53 localhost kernel: [1111528.590033] usb 1-4: USB disconnect, device number 3
Jan 1 12:36:53 localhost kernel: [1111529.095539] .ready
Jan 1 12:36:53 localhost kernel: [1111529.095652] sd 9:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:36:53 localhost kernel: [1111529.095657] sd 9:0:0:0: [sdd] Result: hostbyte=0x01 driverbyte=0x00
Jan 1 12:36:53 localhost kernel: [1111529.095660] sd 9:0:0:0: [sdd] Sense not available.
Jan 1 12:36:53 localhost kernel: [1111529.095679] sd 9:0:0:0: [sdd] Write Protect is off
Jan 1 12:36:53 localhost kernel: [1111529.095683] sd 9:0:0:0: [sdd] Mode Sense: 00 00 00 00
Jan 1 12:36:53 localhost kernel: [1111529.095697] sd 9:0:0:0: [sdd] Asking for cache data failed
Jan 1 12:36:53 localhost kernel: [1111529.095700] sd 9:0:0:0: [sdd] Assuming drive cache: write through
Jan 1 12:36:53 localhost kernel: [1111529.095908] sd 9:0:0:0: [sdd] Attached SCSI removable disk
Jan 1 12:37:00 localhost kernel: [1111535.745534] usb 1-2: new high speed USB device number 4 using ehci_hcd
Jan 1 12:37:00 localhost kernel: [1111535.877415] scsi10 : usb-storage 1-2:1.0
Jan 1 12:37:01 localhost kernel: [1111536.883327] scsi 10:0:0:0: Direct-Access Apple iPod 1.62 PQ: 0 ANSI: 0
Jan 1 12:37:56 localhost kernel: [1111536.886177] sd 10:0:0:0: [sdd] Spinning up disk.................................................
Jan 1 12:37:56 localhost kernel: [1111591.399461] rhythmbox-metad[28030]: segfault at 9 ip 0000000000407ce1 sp 00007fffef391a20 error 4 in rhythmbox-metadata[400000+12000]
Jan 1 12:38:50 localhost kernel: [1111592.222194] ......................................................not responding...
Jan 1 12:39:14 localhost kernel: [1111669.735149] sd 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:39:14 localhost kernel: [1111669.735154] sd 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x08
Jan 1 12:39:14 localhost kernel: [1111669.735158] sd 10:0:0:0: [sdd] Sense Key : 0x2 [current]
Jan 1 12:39:14 localhost kernel: [1111669.735161] sd 10:0:0:0: [sdd] ASC=0x4 ASCQ=0x1
Jan 1 12:39:14 localhost kernel: [1111669.736132] sd 10:0:0:0: [sdd] Write Protect is off
Jan 1 12:39:14 localhost kernel: [1111669.736135] sd 10:0:0:0: [sdd] Mode Sense: 68 00 00 08
Jan 1 12:39:14 localhost kernel: [1111669.737132] sd 10:0:0:0: [sdd] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Jan 1 12:39:22 localhost kernel: [1111669.741138] sd 10:0:0:0: [sdd] Spinning up disk...
Jan 1 12:41:03 localhost kernel: [1111677.796130] sd 10:0:0:0: [sdd] Spinning up disk...........................................................................................................................................................................................not responding...
Jan 1 12:41:27 localhost kernel: [1111778.458834] .
Jan 1 12:41:27 localhost kernel: [1111802.619115] sd 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:41:27 localhost kernel: [1111802.619120] sd 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x08
Jan 1 12:41:27 localhost kernel: [1111802.619124] sd 10:0:0:0: [sdd] Sense Key : 0x2 [current]
Jan 1 12:41:27 localhost kernel: [1111802.619127] sd 10:0:0:0: [sdd] ASC=0x4 ASCQ=0x1
Jan 1 12:41:27 localhost kernel: [1111802.622089] sd 10:0:0:0: [sdd] Attached SCSI removable disk
Jan 1 12:41:28 localhost kernel: [1111803.622175] .not responding...
Jan 1 12:43:17 localhost kernel: [1111803.626090] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:45:05 localhost kernel: [1111912.349056] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:45:30 localhost kernel: [1112045.224039] sd 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:45:30 localhost kernel: [1112045.224043] sd 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x08
Jan 1 12:45:30 localhost kernel: [1112045.224047] sd 10:0:0:0: [sdd] Sense Key : 0x2 [current]
Jan 1 12:45:30 localhost kernel: [1112045.224050] sd 10:0:0:0: [sdd] ASC=0x4 ASCQ=0x1
Jan 1 12:47:18 localhost kernel: [1112045.229015] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:49:07 localhost kernel: [1112153.948984] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:49:25 localhost kernel: [1112280.652163] INFO: task blkid:28208 blocked for more than 120 seconds.
Jan 1 12:49:25 localhost kernel: [1112280.652167] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 1 12:49:25 localhost kernel: [1112280.652169] blkid D ffff88009fa67fd8 0 28208 27994 0x00000004
Jan 1 12:49:25 localhost kernel: [1112280.652174] ffff88009fa67ad8 0000000000000082 00007f4fc0e46fc0 ffff8801072d5db0
Jan 1 12:49:25 localhost kernel: [1112280.652178] ffff88012c3523f0 ffff88009fa67fd8 ffff88009fa67fd8 ffff88009fa67fd8
Jan 1 12:49:25 localhost kernel: [1112280.652181] ffff88006e140000 ffff88012c3523f0 ffff88009fa67af8 0000000000000246
Jan 1 12:49:25 localhost kernel: [1112280.652184] Call Trace:
Jan 1 12:49:25 localhost kernel: [1112280.652192] [<ffffffff8111b399>] ? zone_statistics+0x99/0xc0
Jan 1 12:49:25 localhost kernel: [1112280.652196] [<ffffffff8122719a>] ? kobject_get+0x1a/0x30
Jan 1 12:49:25 localhost kernel: [1112280.652217] [<ffffffff81215bea>] ? get_disk+0x9a/0x180
Jan 1 12:49:25 localhost kernel: [1112280.652221] [<ffffffff814072ef>] schedule+0x3f/0x60
Jan 1 12:49:25 localhost kernel: [1112280.652224] [<ffffffff81408939>] __mutex_lock_slowpath+0x139/0x330
Jan 1 12:49:25 localhost kernel: [1112280.652228] [<ffffffff81408b46>] mutex_lock+0x16/0x30
Jan 1 12:49:25 localhost kernel: [1112280.652232] [<ffffffff811943eb>] __blkdev_get+0x7b/0x430
Jan 1 12:49:25 localhost kernel: [1112280.652235] [<ffffffff811947f3>] blkdev_get+0x53/0x310
Jan 1 12:49:25 localhost kernel: [1112280.652238] [<ffffffff81194b0d>] blkdev_open+0x5d/0x80
Jan 1 12:49:25 localhost kernel: [1112280.652241] [<ffffffff8115b65c>] __dentry_open+0x21c/0x3f0
Jan 1 12:49:25 localhost kernel: [1112280.652244] [<ffffffff81194ab0>] ? blkdev_get+0x310/0x310
Jan 1 12:49:25 localhost kernel: [1112280.652248] [<ffffffff8115ca61>] nameidata_to_filp+0x71/0x80
Jan 1 12:49:25 localhost kernel: [1112280.652251] [<ffffffff8116ccfc>] do_last+0x32c/0x9d0
Jan 1 12:49:25 localhost kernel: [1112280.652254] [<ffffffff8116d4b2>] path_openat+0xd2/0x3c0
Jan 1 12:49:25 localhost kernel: [1112280.652257] [<ffffffff81124ea4>] ? handle_mm_fault+0x1b4/0x350
Jan 1 12:49:25 localhost kernel: [1112280.652261] [<ffffffff8122b330>] ? rb_insert_color+0x110/0x150
Jan 1 12:49:25 localhost kernel: [1112280.652264] [<ffffffff8116d8c2>] do_filp_open+0x42/0xa0
Jan 1 12:49:25 localhost kernel: [1112280.652268] [<ffffffff81179e6c>] ? alloc_fd+0xec/0x140
Jan 1 12:49:25 localhost kernel: [1112280.652270] [<ffffffff8115cb67>] do_sys_open+0xf7/0x1d0
Jan 1 12:49:25 localhost kernel: [1112280.652273] [<ffffffff8115cc60>] sys_open+0x20/0x30
Jan 1 12:49:25 localhost kernel: [1112280.652276] [<ffffffff8140aa42>] system_call_fastpath+0x16/0x1b
Jan 1 12:49:31 localhost kernel: [1112286.823965] sd 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:49:31 localhost kernel: [1112286.823970] sd 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x08
Jan 1 12:49:31 localhost kernel: [1112286.823973] sd 10:0:0:0: [sdd] Sense Key : 0x2 [current]
Jan 1 12:49:31 localhost kernel: [1112286.823977] sd 10:0:0:0: [sdd] ASC=0x4 ASCQ=0x1
Jan 1 12:51:20 localhost kernel: [1112286.828939] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:53:09 localhost kernel: [1112395.546896] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:53:33 localhost kernel: [1112528.421867] sd 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:53:33 localhost kernel: [1112528.421872] sd 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x08
Jan 1 12:53:33 localhost kernel: [1112528.421876] sd 10:0:0:0: [sdd] Sense Key : 0x2 [current]
Jan 1 12:53:33 localhost kernel: [1112528.421879] sd 10:0:0:0: [sdd] ASC=0x4 ASCQ=0x1
Jan 1 12:55:22 localhost kernel: [1112528.426841] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:57:10 localhost kernel: [1112637.170801] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 12:57:34 localhost kernel: [1112770.044774] sd 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 12:57:34 localhost kernel: [1112770.044779] sd 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x08
Jan 1 12:57:34 localhost kernel: [1112770.044783] sd 10:0:0:0: [sdd] Sense Key : 0x2 [current]
Jan 1 12:57:34 localhost kernel: [1112770.044786] sd 10:0:0:0: [sdd] ASC=0x4 ASCQ=0x1
Jan 1 12:59:23 localhost kernel: [1112770.049749] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 13:01:12 localhost kernel: [1112878.741710] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 13:01:25 localhost kernel: [1113000.652103] INFO: task blkid:28339 blocked for more than 120 seconds.
Jan 1 13:01:25 localhost kernel: [1113000.652107] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 1 13:01:25 localhost kernel: [1113000.652109] blkid D 0000000113e4f979 0 28339 27994 0x00000004
Jan 1 13:01:25 localhost kernel: [1113000.652114] ffff880100fa3ad8 0000000000000086 ffff880100000000 ffff8801072d5db0
Jan 1 13:01:25 localhost kernel: [1113000.652118] ffff88006e141590 ffff880100fa3fd8 ffff880100fa3fd8 ffff880100fa3fd8
Jan 1 13:01:25 localhost kernel: [1113000.652121] ffff880139ac7300 ffff88006e141590 ffff880100fa3af8 0000000000000246
Jan 1 13:01:25 localhost kernel: [1113000.652124] Call Trace:
Jan 1 13:01:25 localhost kernel: [1113000.652132] [<ffffffff8111b399>] ? zone_statistics+0x99/0xc0
Jan 1 13:01:25 localhost kernel: [1113000.652136] [<ffffffff8122719a>] ? kobject_get+0x1a/0x30
Jan 1 13:01:25 localhost kernel: [1113000.652158] [<ffffffff81215bea>] ? get_disk+0x9a/0x180
Jan 1 13:01:25 localhost kernel: [1113000.652162] [<ffffffff814072ef>] schedule+0x3f/0x60
Jan 1 13:01:25 localhost kernel: [1113000.652165] [<ffffffff81408939>] __mutex_lock_slowpath+0x139/0x330
Jan 1 13:01:25 localhost kernel: [1113000.652169] [<ffffffff81408b46>] mutex_lock+0x16/0x30
Jan 1 13:01:25 localhost kernel: [1113000.652173] [<ffffffff811943eb>] __blkdev_get+0x7b/0x430
Jan 1 13:01:25 localhost kernel: [1113000.652176] [<ffffffff811947f3>] blkdev_get+0x53/0x310
Jan 1 13:01:25 localhost kernel: [1113000.652179] [<ffffffff81194b0d>] blkdev_open+0x5d/0x80
Jan 1 13:01:25 localhost kernel: [1113000.652183] [<ffffffff8115b65c>] __dentry_open+0x21c/0x3f0
Jan 1 13:01:25 localhost kernel: [1113000.652185] [<ffffffff81194ab0>] ? blkdev_get+0x310/0x310
Jan 1 13:01:25 localhost kernel: [1113000.652189] [<ffffffff8115ca61>] nameidata_to_filp+0x71/0x80
Jan 1 13:01:25 localhost kernel: [1113000.652193] [<ffffffff8116ccfc>] do_last+0x32c/0x9d0
Jan 1 13:01:25 localhost kernel: [1113000.652195] [<ffffffff8116d4b2>] path_openat+0xd2/0x3c0
Jan 1 13:01:25 localhost kernel: [1113000.652199] [<ffffffff81124ea4>] ? handle_mm_fault+0x1b4/0x350
Jan 1 13:01:25 localhost kernel: [1113000.652202] [<ffffffff8122b330>] ? rb_insert_color+0x110/0x150
Jan 1 13:01:25 localhost kernel: [1113000.652205] [<ffffffff8116d8c2>] do_filp_open+0x42/0xa0
Jan 1 13:01:25 localhost kernel: [1113000.652209] [<ffffffff81179e6c>] ? alloc_fd+0xec/0x140
Jan 1 13:01:25 localhost kernel: [1113000.652212] [<ffffffff8115cb67>] do_sys_open+0xf7/0x1d0
Jan 1 13:01:25 localhost kernel: [1113000.652215] [<ffffffff8115cc60>] sys_open+0x20/0x30
Jan 1 13:01:25 localhost kernel: [1113000.652218] [<ffffffff8140aa42>] system_call_fastpath+0x16/0x1b
Jan 1 13:01:36 localhost kernel: [1113011.597639] sd 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 13:01:36 localhost kernel: [1113011.597644] sd 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x08
Jan 1 13:01:36 localhost kernel: [1113011.597648] sd 10:0:0:0: [sdd] Sense Key : 0x2 [current]
Jan 1 13:01:36 localhost kernel: [1113011.597651] sd 10:0:0:0: [sdd] ASC=0x4 ASCQ=0x1
Jan 1 13:03:25 localhost kernel: [1113011.602617] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................................................not responding...
Jan 1 13:04:42 localhost kernel: [1113120.320526] sd 10:0:0:0: [sdd] Spinning up disk.......................................................................
Jan 1 13:04:42 localhost kernel: [1113197.655251] usb 1-2: USB disconnect, device number 4
Jan 1 13:04:42 localhost kernel: [1113197.825373] .ready
Jan 1 13:04:42 localhost kernel: [1113197.825383] scsi 10:0:0:0: [sdd] READ CAPACITY failed
Jan 1 13:04:42 localhost kernel: [1113197.825386] scsi 10:0:0:0: [sdd] Result: hostbyte=0x00 driverbyte=0x04
Jan 1 13:04:42 localhost kernel: [1113197.825389] scsi 10:0:0:0: [sdd] Sense not available.
Jan 1 13:04:42 localhost kernel: [1113197.825394] scsi 10:0:0:0: [sdd] Asking for cache data failed
Jan 1 13:04:42 localhost kernel: [1113197.825396] scsi 10:0:0:0: [sdd] Assuming drive cache: write throughOffline
Pages: 1