USB disk fails when accessed after idle for some hours
All,
I have a USB disk (a 320GB Western Digital My Passport) which is
exhibiting the following problem.
When first hooked up and mounted, it works fine. I've successfully
transferred 100's of GB onto the disk.
However, if left idle for some hours, it fails when accessed, with a
spontaneous USB disconnect and reconnect of the device (log excerpts below).
Some hours later, it still gives immediate I/O errors when accessed (e.g.
with ls), but unmounting and re-mounting the drive makes it work again.
(It might have also needed a physical unplug and re-plug once, but I don't
recall for sure.)
It is a 2.5" disk with no external power supply, just power from USB. This
happens in multiple port group and multiple cables. I have another USB
disk, this one a 3.5" IDE drive which I installed in a USB enclosure
myself, that does have external power, that works with no problems.
Now, the unmount/remount cycle suggests that I could perhaps work around
the problem with automount. But, if the disk is just plain defective, I
don't want to paper over the problem.
I wonder if the computer can't provide enough power to run the device (it
exceeds the 500mA/port limit, though that was NOT clear in the newegg
description). However, if that's true, why does it only fail after a long
idle?
Thoughts?
Many thanks in advance,
Reid
Log excerpt 1 (failure during stat()):
Jan 29 02:27:07 reidster kernel: [7125216.194039] usb 4-4: USB disconnect, address 12
Jan 29 02:27:07 reidster kernel: [7125216.198039] sd 23:0:0:0: [sdc] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK,SUGGEST_OK
Jan 29 02:27:07 reidster kernel: [7125216.198039] end_request: I/O error, dev sdc, sector 12313
Jan 29 02:27:07 reidster kernel: [7125216.214034] EXT3-fs error (device sdc1): ext3_find_entry: reading directory #2 offset 0
Jan 29 02:27:07 reidster kernel: [7125216.214034] Buffer I/O error on device sdc1, logical block 0
Jan 29 02:27:07 reidster kernel: [7125216.214034] lost page write due to I/O error on sdc1
Jan 29 02:27:14 reidster kernel: [7125224.462581] usb 4-4: new high speed USB device using ehci_hcd and address 13
Jan 29 02:27:14 reidster kernel: [7125224.627320] usb 4-4: configuration #1 chosen from 1 choice
Jan 29 02:27:14 reidster kernel: [7125224.630074] scsi24 : SCSI emulation for USB Mass Storage devices
Jan 29 02:27:14 reidster kernel: [7125224.630074] usb-storage: device found at 13
Jan 29 02:27:14 reidster kernel: [7125224.630074] usb-storage: waiting for device to settle before scanning
Jan 29 02:27:14 reidster kernel: [7125224.630074] usb 4-4: New USB device found, idVendor=1058, idProduct=0704
Jan 29 02:27:14 reidster kernel: [7125224.630074] usb 4-4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jan 29 02:27:14 reidster kernel: [7125224.630074] usb 4-4: Product: External HDD
Jan 29 02:27:14 reidster kernel: [7125224.630074] usb 4-4: Manufacturer: Western Digital
Jan 29 02:27:14 reidster kernel: [7125224.630074] usb 4-4: SerialNumber: 575845583038564630313531
Jan 29 02:27:19 reidster kernel: [7125230.124765] usb-storage: device scan complete
Jan 29 02:27:19 reidster kernel: [7125230.125182] scsi 24:0:0:0: Direct-Access WD 3200BMV External 1.05 PQ: 0 ANSI: 4
Jan 29 02:27:19 reidster kernel: [7125230.127728] sd 24:0:0:0: [sdd] 625142448 512-byte hardware sectors (320073 MB)
Jan 29 02:27:19 reidster kernel: [7125230.127728] sd 24:0:0:0: [sdd] Write Protect is off
Jan 29 02:27:19 reidster kernel: [7125230.127728] sd 24:0:0:0: [sdd] Mode Sense: 21 00 00 00
Jan 29 02:27:19 reidster kernel: [7125230.127728] sd 24:0:0:0: [sdd] Assuming drive cache: write through
Jan 29 02:27:19 reidster kernel: [7125230.127728] sd 24:0:0:0: [sdd] 625142448 512-byte hardware sectors (320073 MB)
Jan 29 02:27:19 reidster kernel: [7125230.131727] sd 24:0:0:0: [sdd] Write Protect is off
Jan 29 02:27:19 reidster kernel: [7125230.131727] sd 24:0:0:0: [sdd] Mode Sense: 21 00 00 00
Jan 29 02:27:19 reidster kernel: [7125230.131727] sd 24:0:0:0: [sdd] Assuming drive cache: write through
Jan 29 02:27:19 reidster kernel: [7125230.131727] sdd: sdd1
Jan 29 02:27:19 reidster kernel: [7125230.183728] sd 24:0:0:0: [sdd] Attached SCSI disk
Jan 29 02:27:19 reidster kernel: [7125230.183728] sd 24:0:0:0: Attached scsi generic sg3 type 0
Log excerpt 2 (failure while writing actual data, though later fsck
revealed no problems):
Jan 27 02:30:43 reidster kernel: [6908883.127050] usb 8-2: USB disconnect, address 12
Jan 27 02:30:43 reidster kernel: [6908883.127050] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127057] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127060] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127063] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127065] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127068] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127070] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127073] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127076] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127079] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127082] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127084] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127087] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127090] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127093] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127095] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127098] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127100] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.127103] ehci_hcd 0000:00:1d.7: dev 2 ep2out scatterlist error -108/-108
Jan 27 02:30:43 reidster kernel: [6908883.128238] sd 18:0:0:0: [sdc] Result: hostbyte=DID_ERROR driverbyte=DRIVER_OK,SUGGEST_OK
Jan 27 02:30:43 reidster kernel: [6908883.128242] end_request: I/O error, dev sdc, sector 238251433
Jan 27 02:30:43 reidster kernel: [6908883.128246] Buffer I/O error on device sdc1, logical block 29781429
Jan 27 02:30:43 reidster kernel: [6908883.128248] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128253] Buffer I/O error on device sdc1, logical block 29781430
Jan 27 02:30:43 reidster kernel: [6908883.128254] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128257] Buffer I/O error on device sdc1, logical block 29781431
Jan 27 02:30:43 reidster kernel: [6908883.128259] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128261] Buffer I/O error on device sdc1, logical block 29781432
Jan 27 02:30:43 reidster kernel: [6908883.128263] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128266] Buffer I/O error on device sdc1, logical block 29781433
Jan 27 02:30:43 reidster kernel: [6908883.128267] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128270] Buffer I/O error on device sdc1, logical block 29781434
Jan 27 02:30:43 reidster kernel: [6908883.128272] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128274] Buffer I/O error on device sdc1, logical block 29781435
Jan 27 02:30:43 reidster kernel: [6908883.128276] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128278] Buffer I/O error on device sdc1, logical block 29781436
Jan 27 02:30:43 reidster kernel: [6908883.128280] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128282] Buffer I/O error on device sdc1, logical block 29781437
Jan 27 02:30:43 reidster kernel: [6908883.128284] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128287] Buffer I/O error on device sdc1, logical block 29781438
Jan 27 02:30:43 reidster kernel: [6908883.128288] lost page write due to I/O error on sdc1
Jan 27 02:30:43 reidster kernel: [6908883.128318] sd 18:0:0:0: [sdc] Result: hostbyte=DID_NO_CONNECT driverbyte=DRIVER_OK,SUGGEST_OK
Jan 27 02:30:43 reidster kernel: [6908883.128321] end_request: I/O error, dev sdc, sector 238251673
Jan 27 02:30:43 reidster kernel: [6908883.128373] Aborting journal on device sdc1.
Jan 27 02:30:43 reidster kernel: [6908883.128389] journal commit I/O error
Jan 27 02:30:43 reidster kernel: [6908883.128522] ext3_abort called.
Jan 27 02:30:43 reidster kernel: [6908883.128522] EXT3-fs error (device sdc1): ext3_journal_start_sb: Detected aborted journal
Jan 27 02:30:43 reidster kernel: [6908883.128522] Remounting filesystem read-only
Jan 27 02:30:48 reidster kernel: [6908889.687113] usb 8-2: new high speed USB device using ehci_hcd and address 13
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb 8-2: configuration #1 chosen from 1 choice
Jan 27 02:30:48 reidster kernel: [6908889.849426] scsi19 : SCSI emulation for USB Mass Storage devices
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb-storage: device found at 13
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb-storage: waiting for device to settle before scanning
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb 8-2: New USB device found, idVendor=1058, idProduct=0704
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb 8-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb 8-2: Product: External HDD
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb 8-2: Manufacturer: Western Digital
Jan 27 02:30:48 reidster kernel: [6908889.849426] usb 8-2: SerialNumber: 575845583038564630313531
Jan 27 02:30:53 reidster kernel: [6908896.487891] usb-storage: device scan complete
Jan 27 02:30:53 reidster kernel: [6908896.487891] scsi 19:0:0:0: Direct-Access WD 3200BMV External 1.05 PQ: 0 ANSI: 4
Jan 27 02:30:53 reidster kernel: [6908896.487891] sd 19:0:0:0: [sdd] 625142448 512-byte hardware sectors (320073 MB)
Jan 27 02:30:53 reidster kernel: [6908896.487891] sd 19:0:0:0: [sdd] Write Protect is off
Jan 27 02:30:53 reidster kernel: [6908896.487891] sd 19:0:0:0: [sdd] Mode Sense: 21 00 00 00
Jan 27 02:30:53 reidster kernel: [6908896.487891] sd 19:0:0:0: [sdd] Assuming drive cache: write through
Jan 27 02:30:53 reidster kernel: [6908896.487891] sd 19:0:0:0: [sdd] 625142448 512-byte hardware sectors (320073 MB)
Jan 27 02:30:53 reidster kernel: [6908896.495789] sd 19:0:0:0: [sdd] Write Protect is off
Jan 27 02:30:53 reidster kernel: [6908896.495789] sd 19:0:0:0: [sdd] Mode Sense: 21 00 00 00
Jan 27 02:30:53 reidster kernel: [6908896.495789] sd 19:0:0:0: [sdd] Assuming drive cache: write through
Jan 27 02:30:53 reidster kernel: [6908896.495789] sdd: sdd1
Jan 27 02:30:53 reidster kernel: [6908896.548364] sd 19:0:0:0: [sdd] Attached SCSI disk
Jan 27 02:30:53 reidster kernel: [6908896.548364] sd 19:0:0:0: Attached scsi generic sg3 type 0
Reply to: