Bug 14304 - ata exception & frozen
Summary: ata exception & frozen
Status: CLOSED UNREPRODUCIBLE
Alias: None
Product: IO/Storage
Classification: Unclassified
Component: Serial ATA (show other bugs)
Hardware: All Linux
: P1 blocking
Assignee: Jeff Garzik
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2009-10-02 04:08 UTC by Geo
Modified: 2012-06-13 18:59 UTC (History)
2 users (show)

See Also:
Kernel Version: 2.6.27.30-170.2.82
Subsystem:
Regression: No
Bisected commit-id:


Attachments

Description Geo 2009-10-02 04:08:10 UTC
# uname -a

Linux devpc 2.6.27.30-170.2.82.fc10.i686.PAE #1 SMP Mon Aug 17 08:24:23 EDT 2009 i686 i686 i386 GNU/Linux

# hdparm -i /dev/sda

Model=SAMSUNG HE103UJ, FwRev=1AA01112, SerialNo=S13VJ1NQxxxxxxx      
Config={ Fixed }
RawCHS=16383/16/63, TrkSize=34902, SectSize=554, ECCbytes=4
BuffType=DualPortCache, BuffSize=32767kB, MaxMultSect=16, MultSect=?0?
CurCHS=16383/16/63, CurSects=16514064, LBA=yes, LBAsects=1953525168
IORDY=on/off, tPIO={min:120,w/IORDY:120}, tDMA={min:120,rec:120}
PIO modes:  pio0 pio1 pio2 pio3 pio4 
DMA modes:  mdma0 mdma1 mdma2 
UDMA modes: udma0 udma1 udma2 udma3 udma4 udma5 *udma6 
AdvancedPM=yes: disabled (255) WriteCache=enabled
Drive conforms to: unknown:  ATA/ATAPI-3,4,5,6,7

# cat /var/log/messages

Sep 27 12:21:21 devpc kernel: ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
Sep 27 12:21:21 devpc kernel: ata2.00: cmd 35/00:00:cf:5d:9d/00:04:4e:00:00/e0 tag 0 dma 524288 out
Sep 27 12:21:21 devpc kernel:         res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
Sep 27 12:21:21 devpc kernel: ata2.00: status: { DRDY }
Sep 27 12:21:21 devpc kernel: ata2: hard resetting link
Sep 27 12:21:27 devpc kernel: ata2: link is slow to respond, please be patient (ready=0)
Sep 27 12:21:31 devpc kernel: ata2: COMRESET failed (errno=-16)
Sep 27 12:21:31 devpc kernel: ata2: hard resetting link
Sep 27 12:21:37 devpc kernel: ata2: link is slow to respond, please be patient (ready=0)
Sep 27 12:21:41 devpc kernel: ata2: COMRESET failed (errno=-16)
Sep 27 12:21:41 devpc kernel: ata2: hard resetting link
Sep 27 12:21:47 devpc kernel: ata2: link is slow to respond, please be patient (ready=0)
Sep 27 12:22:17 devpc kernel: ata2: COMRESET failed (errno=-16)
Sep 27 12:22:17 devpc kernel: ata2: limiting SATA link speed to 1.5 Gbps
Sep 27 12:22:17 devpc kernel: ata2: hard resetting link
Sep 27 12:22:22 devpc kernel: ata2: COMRESET failed (errno=-16)
Sep 27 12:22:22 devpc kernel: ata2: reset failed, giving up
Sep 27 12:22:22 devpc kernel: ata2.00: disabled
Sep 27 12:22:22 devpc kernel: ata2: EH complete
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1318936015
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1318937039
...
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1319402519
Sep 27 12:22:22 devpc kernel: I/O error in filesystem ("sdb1") meta-data dev sdb1 block 0x3a3a99db       ("xlog_iodone") error 5 buf count 10752
Sep 27 12:22:22 devpc kernel: xfs_force_shutdown(sdb1,0x2) called from line 1056 of file fs/xfs/xfs_log.c.  Return address = 0xf89ce6ff
Sep 27 12:22:22 devpc kernel: Filesystem "sdb1": Log I/O Error Detected.  Shutting down filesystem: sdb1
Sep 27 12:22:22 devpc kernel: Please umount the filesystem, and rectify the problem(s)
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1319402583
...
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1319380327
Sep 27 12:22:22 devpc kernel: Buffer I/O error on device sdb1, logical block 164866994
Sep 27 12:22:22 devpc kernel: lost page write due to I/O error on sdb1
Sep 27 12:22:22 devpc kernel: Buffer I/O error on device sdb1, logical block 164866995
Sep 27 12:22:22 devpc kernel: lost page write due to I/O error on sdb1
...
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1319380367
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1319380599
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1319380887
Sep 27 12:22:22 devpc kernel: sd 1:0:0:0: [sdb] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Sep 27 12:22:22 devpc kernel: end_request: I/O error, dev sdb, sector 1319378167
Sep 27 12:22:27 devpc kernel: Filesystem "sdb1": xfs_log_force: error 5 returned.
Sep 27 12:22:57 devpc kernel: Filesystem "sdb1": xfs_log_force: error 5 returned.
...

# hdparm -i /dev/sdb

/dev/sdb:
 HDIO_GET_IDENTITY failed: No message of desired type

# umount /dev/sdb1

umount: /mnt/sdb: device is busy.
        (In some cases useful info about processes that use
         the device is found by lsof(8) or fuser(1))

# cat /dev/sdb1
cat: /dev/sdb1: Input/output error

# lspci

00:00.0 Host bridge: Intel Corporation 82P965/G965 Memory Controller Hub (rev 02)
00:01.0 PCI bridge: Intel Corporation 82P965/G965 PCI Express Root Port (rev 02)
00:1a.0 USB Controller: Intel Corporation 82801H (ICH8 Family) USB UHCI Controller #4 (rev 02)
00:1a.1 USB Controller: Intel Corporation 82801H (ICH8 Family) USB UHCI Controller #5 (rev 02)
00:1a.7 USB Controller: Intel Corporation 82801H (ICH8 Family) USB2 EHCI Controller #2 (rev 02)
00:1b.0 Audio device: Intel Corporation 82801H (ICH8 Family) HD Audio Controller (rev 02)
00:1c.0 PCI bridge: Intel Corporation 82801H (ICH8 Family) PCI Express Port 1 (rev 02)
00:1c.1 PCI bridge: Intel Corporation 82801H (ICH8 Family) PCI Express Port 2 (rev 02)
00:1c.3 PCI bridge: Intel Corporation 82801H (ICH8 Family) PCI Express Port 4 (rev 02)
00:1c.4 PCI bridge: Intel Corporation 82801H (ICH8 Family) PCI Express Port 5 (rev 02)
00:1d.0 USB Controller: Intel Corporation 82801H (ICH8 Family) USB UHCI Controller #1 (rev 02)
00:1d.1 USB Controller: Intel Corporation 82801H (ICH8 Family) USB UHCI Controller #2 (rev 02)
00:1d.2 USB Controller: Intel Corporation 82801H (ICH8 Family) USB UHCI Controller #3 (rev 02)
00:1d.7 USB Controller: Intel Corporation 82801H (ICH8 Family) USB2 EHCI Controller #1 (rev 02)
00:1e.0 PCI bridge: Intel Corporation 82801 PCI Bridge (rev f2)
00:1f.0 ISA bridge: Intel Corporation 82801HB/HR (ICH8/R) LPC Interface Controller (rev 02)
00:1f.2 SATA controller: Intel Corporation 82801HB (ICH8) 4 port SATA AHCI Controller (rev 02)
00:1f.3 SMBus: Intel Corporation 82801H (ICH8 Family) SMBus Controller (rev 02)
01:00.0 VGA compatible controller: ATI Technologies Inc RV530LE [Radeon X1600]
01:00.1 Display controller: ATI Technologies Inc Device 71ee
02:00.0 SATA controller: JMicron Technologies, Inc. JMicron 20360/20363 AHCI Controller (rev 03)
02:00.1 IDE interface: JMicron Technologies, Inc. JMicron 20360/20363 AHCI Controller (rev 03)
03:00.0 Ethernet controller: Realtek Semiconductor Co., Ltd. RTL8111/8168B PCI Express Gigabit Ethernet controller (rev 01)
04:00.0 RAID bus controller: Silicon Image, Inc. SiI 3132 Serial ATA Raid II Controller (rev 01)
06:00.0 Mass storage controller: Promise Technology, Inc. PDC20268 (Ultra100 TX2) (rev 02)
06:01.0 Ethernet controller: Atheros Communications Inc. Atheros AR5001X+ Wireless Network Adapter (rev 01)
06:02.0 Ethernet controller: 3Com Corporation 3c905C-TX/TX-M [Tornado] (rev 78)

# lsmod | grep ata
ata_generic             8452  0 
pata_acpi               7680  0 
pata_jmicron            6912  0 
sata_sil24             16004  1 
pata_pdc2027x          11012  6
Comment 1 Geo 2009-10-02 04:12:33 UTC
# mount
/dev/md1 on / type xfs (rw)
proc on /proc type proc (rw)
sysfs on /sys type sysfs (rw)
devpts on /dev/pts type devpts (rw,gid=5,mode=620)
/dev/md0 on /boot type ext3 (rw)
tmpfs on /dev/shm type tmpfs (rw)
none on /proc/sys/fs/binfmt_misc type binfmt_misc (rw)
gvfs-fuse-daemon on /home/gt/.gvfs type fuse.gvfs-fuse-daemon (rw,nosuid,nodev,user=gt)
/dev/sda1 on /mnt/sda type xfs (rw)
/dev/sdc1 on /mnt/sdc type xfs (rw)
/dev/sdb1 on /mnt/sdb type xfs (rw)
/dev/sdg1 on /mnt/sdg type xfs (rw)
/dev/sdd1 on /mnt/sdd type ext3 (rw)

MB Asus P5B. PSU 530W. SATA cables length ~30-45cm.
Comment 2 Geo 2009-10-02 04:37:43 UTC
sda,sdc,sdb,sdd - attached to MB built-in SATA controller.
sdg - to SiI 3132 controller
md1,2 - 2 ATA HDD, attached to Promise IDE controller.

sda,sdc,sdb - SAMSUNG HE103UJ
sdg - Seagate ST3300831AS
sde,sdf (md1,2) - Seagate ST3320620A
Comment 3 Geo 2009-10-02 04:58:01 UTC
Last comment. 
sdb not damaged!
This error occurs also with sda and sdc drives periodically.
Comment 4 Tejun Heo 2009-10-02 09:39:57 UTC
Hmmm... the drive times out a WRITE_EXT and then just stops talking to the controller completely.  After such problem happened, does the device come back if you unplug and replug the SATA cable connected to the device?  If not, does unplugging and replugging the power cable make the kernel recognize the device again?  Please post full output of dmesg after experimenting with cables.  Also, what do you mean by "sdb not damaged"?

Thanks.
Comment 5 Geo 2009-10-02 12:05:39 UTC
> unplug and replug the SATA cable connected to the device
> unplugging and replugging the power cable

i am not sure, but plug/unplug cables online can break mb/hdd/data or not?

> Also, what do you mean by "sdb not damaged"?

i am run tests for 3 drives.
by ESTOOL (samsung test utility).
errors not found.
all 3 drives is OK.
Comment 6 Tejun Heo 2009-10-02 12:11:35 UTC
After the above problem has happened, the drive is already unavailable to the system so unplugging / replugging won't do much harm.  Removing power will cause emergency head unload in the disk but they are built to stand quite some number of them, so nothing to worry too much about.  And for the vendor testing tool, they surely are useful but it's not like they test all aspects of the device, so it would be nice to try the cable diddling so that we can isolate where the problem is.

Thanks.
Comment 7 Geo 2009-10-02 12:30:51 UTC
Error occur again...

1. plug/unplug data cable (power cable connected) - no any messages in log file about.
2. unplug data cable -> unplug power -> plug power again -> plug data cable - no any messages in log file.
3. plug/unplug power cable (with connected data cable in this time) - no any messages.

now, drive unvisible for any utility like hdparm.

only xfs adds to log file message like

...
... kernel: Filesystem "sdb1": xfs_log_force: error 5 returned.
...

thanks.
Comment 8 Geo 2009-10-02 17:21:44 UTC
> After such problem happened, does the device come back if you unplug and
> replug the SATA cable connected to the device?

no

> If not, does unplugging and replugging the power cable make the kernel
> recognize the device again?

no

> Please post full output of dmesg after experimenting with cables

see prev. my comment - no any log messages.
Comment 9 Tejun Heo 2009-10-03 10:06:46 UTC
Hmm... can you please try to "rmmod ahci" and then "modprobe ahci" after the problem happened?  Please note that this would only be possible after the raid array is unmounted and stopped.
Comment 10 Geo 2009-10-03 10:48:10 UTC
i cant unmount and stop array - root mount point mounted on /dev/md1

# mount

/dev/md0 on /boot type ext3 (rw)
/dev/md1 on / type xfs (rw)
proc on /proc type proc (rw)
sysfs on /sys type sysfs (rw)
devpts on /dev/pts type devpts (rw,gid=5,mode=620)
tmpfs on /dev/shm type tmpfs (rw)
Comment 11 Tejun Heo 2009-10-04 00:54:20 UTC
There have been a couple of similar reports involving similar hardware configuration.  It's strange that ahci fails to recover the port after such failure.  PHY reset is supposed to achieve that and ich ahcis have been pretty reliable on that front.

As for the root cause of the failure, the most likely is power related.  Can you please power up a separate PSU and connect half of the drives there and see whether the failure pattern changes?  Powering up an ATX PSU without mobo isn't difficult at all.

  http://modtown.co.uk/mt/article2.php?id=psumod
Comment 12 Geo 2009-10-16 20:12:32 UTC
i am install 2 PSUs. 
second PSU 550W.
530W + 550W = 1080W for 6 HDD, CDROM and C2D CPU...

3 HDD connected to 2nd PSU, 3 - to 1st (and motherboard).

i see same errors in log file.

next step?
Comment 13 Tejun Heo 2009-10-18 03:31:51 UTC
Does "pci=noacpi" or "irqpoll" kernel parameter make any difference?
Comment 14 Geo 2009-10-23 01:01:26 UTC
no any differences - same errors in logfile.
Comment 15 Tejun Heo 2009-10-26 14:49:44 UTC
Hmm.... When you connect the harddrives to two separate PSUs, is there any change in the failure pattern?  ie. problems confined to harddrives connected to a one PSU while drives on the other PSUs are fine kind of thing?

Also, after such failure, if you soft-reboot the machine, can the machine detect the drives?

Thanks.
Comment 16 Geo 2009-10-26 23:03:18 UTC
> When you connect the harddrives to two separate PSUs, is there any
> change in the failure pattern?

no any changes.

> ie. problems confined to harddrives connected
> to a one PSU while drives on the other PSUs are fine 
> kind of thing?

if anyone HDD is "frozen" after error, _all_ other HDDs works fine.

> Also, after such failure, if you soft-reboot the machine, can the machine
> detect the drives?

Sometimes detected ok after soft reboot, sometimes no.
If no, only computer power off/on make possible to kernel detect HDD while next boot process.
But, BIOS always detect all HDDs.

Thanks.


PS. sorry, my english not good.
Comment 17 Tejun Heo 2009-10-28 15:06:19 UTC
Your English is perfectly understandable so no need to worry about that.  :-)

That's very strange.  After soft reset the BIOS can detect the hard drive but libata can't?  It's the first time a symptom like that is reported and it means that controller wide reset wasn't enough to get it working again.  When the controller is put into ahci mode, the BIOS uses ahci mode too.  I wonder how BIOS can detect the device.  Can you please attach kernel boot log where the kernel fails to detect drives after soft reset?  And please double check that the BIOS actually detects the device.

Thanks.
Comment 18 Geo 2009-11-07 09:27:16 UTC
Again same error :(
Some records from /var/log/messages

Nov  7 11:46:50 devpc kernel: ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
Nov  7 11:46:50 devpc kernel: ata1.00: cmd 35/00:00:47:7b:83/00:04:26:00:00/e0 tag 0 dma 524288 out
Nov  7 11:46:50 devpc kernel:         res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
Nov  7 11:46:50 devpc kernel: ata1.00: status: { DRDY }
Nov  7 11:46:50 devpc kernel: ata1: hard resetting link
Nov  7 11:46:55 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Nov  7 11:47:00 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:47:00 devpc kernel: ata1: hard resetting link
Nov  7 11:47:05 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Nov  7 11:47:10 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:47:10 devpc kernel: ata1: hard resetting link
Nov  7 11:47:15 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Nov  7 11:47:45 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:47:45 devpc kernel: ata1: limiting SATA link speed to 1.5 Gbps
Nov  7 11:47:45 devpc kernel: ata1: hard resetting link
Nov  7 11:47:50 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:47:50 devpc kernel: ata1: reset failed, giving up
Nov  7 11:47:50 devpc kernel: ata1.00: disabled
Nov  7 11:47:50 devpc kernel: ata1.00: device reported invalid CHS sector 0
Nov  7 11:47:50 devpc kernel: ata1: EH complete
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646150983
...
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646158023
Nov  7 11:47:50 devpc kernel: Buffer I/O error on device sda1, logical block 80768609
Nov  7 11:47:50 devpc kernel: lost page write due to I/O error on sda1
Nov  7 11:47:50 devpc kernel: Buffer I/O error on device sda1, logical block 80768610
Nov  7 11:47:50 devpc kernel: lost page write due to I/O error on sda1
...
Nov  7 11:47:50 devpc kernel: Buffer I/O error on device sda1, logical block 80768617
Nov  7 11:47:50 devpc kernel: lost page write due to I/O error on sda1
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646158383
...
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646282551
Nov  7 11:47:50 devpc kernel: I/O error in filesystem ("sda1") meta-data dev sda1 block 0x3a3b2be3       ("xlog_iodone") error 5 buf count 8704
Nov  7 11:47:50 devpc kernel: xfs_force_shutdown(sda1,0x2) called from line 1056 of file fs/xfs/xfs_log.c.  Return address = 0xf89ce703
Nov  7 11:47:50 devpc kernel: Filesystem "sda1": Log I/O Error Detected.  Shutting down filesystem: sda1
Nov  7 11:47:50 devpc kernel: Please umount the filesystem, and rectify the problem(s)
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646282583
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646282615
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646282631
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 646283655
Nov  7 11:47:50 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Nov  7 11:47:50 devpc kernel: end_request: I/O error, dev sda, sector 63
Nov  7 11:48:06 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:17 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:17 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:17 devpc kernel: xfs_force_shutdown(sda1,0x1) called from line 420 of file fs/xfs/xfs_rw.c.  Return address = 0xf89e02b8
Nov  7 11:48:17 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:17 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:17 devpc kernel: xfs_force_shutdown(sda1,0x1) called from line 420 of file fs/xfs/xfs_rw.c.  Return address = 0xf89e02b8
Nov  7 11:48:18 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:18 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:18 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:18 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:18 devpc kernel: Filesystem "sda1": xfs_log_force: error 5 returned.
Nov  7 11:48:18 devpc kernel: end_request: I/O error, dev sda, sector 0
Nov  7 11:49:12 devpc console-kit-daemon[2802]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL


After that, i _restart_ computer (not shutdown or poweroff)
In boot time process kernel add records to /var/log/messages file about sda hard drive:

Nov  7 11:52:35 devpc kernel: ata1: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaff900 irq 19
Nov  7 11:52:35 devpc kernel: ata2: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaff980 irq 19
Nov  7 11:52:35 devpc kernel: ata3: DUMMY
Nov  7 11:52:35 devpc kernel: ata4: DUMMY
Nov  7 11:52:35 devpc kernel: ata5: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaffb00 irq 19
Nov  7 11:52:35 devpc kernel: ata6: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaffb80 irq 19
Nov  7 11:52:35 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Nov  7 11:52:35 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:52:35 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Nov  7 11:52:35 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:52:35 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Nov  7 11:52:35 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:52:35 devpc kernel: ata1: limiting SATA link speed to 1.5 Gbps
Nov  7 11:52:35 devpc kernel: ata1: COMRESET failed (errno=-16)
Nov  7 11:52:35 devpc kernel: ata1: reset failed, giving up
Nov  7 11:52:35 devpc kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Nov  7 11:52:35 devpc kernel: ata2.00: ATA-7: ST3300831AS, 3.06, max UDMA/133
Nov  7 11:52:35 devpc kernel: ata2.00: 586072368 sectors, multi 0: LBA48 NCQ (depth 31/32)
Nov  7 11:52:35 devpc kernel: ata2.00: configured for UDMA/133
Nov  7 11:52:35 devpc kernel: ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Nov  7 11:52:35 devpc kernel: ata5.00: ATA-7: SAMSUNG HE103UJ, 1AA01112, max UDMA7
Nov  7 11:52:35 devpc kernel: ata5.00: 1953525168 sectors, multi 0: LBA48 NCQ (depth 31/32)
Nov  7 11:52:35 devpc kernel: ata5.00: configured for UDMA/133
Nov  7 11:52:35 devpc kernel: ata6: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Nov  7 11:52:35 devpc kernel: ata6.00: ATA-7: SAMSUNG HE103UJ, 1AA01112, max UDMA7
Nov  7 11:52:35 devpc kernel: ata6.00: 1953525168 sectors, multi 0: LBA48 NCQ (depth 31/32)
Nov  7 11:52:35 devpc kernel: ata6.00: configured for UDMA/133
Nov  7 11:52:35 devpc kernel: scsi 1:0:0:0: Direct-Access     ATA      ST3300831AS      3.06 PQ: 0 ANSI: 5
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: [sda] 586072368 512-byte hardware sectors (300069 MB)
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: [sda] Write Protect is off
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: [sda] 586072368 512-byte hardware sectors (300069 MB)
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: [sda] Write Protect is off
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Nov  7 11:52:35 devpc kernel: sda: sda1
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: [sda] Attached SCSI disk
Nov  7 11:52:35 devpc kernel: sd 1:0:0:0: Attached scsi generic sg0 type 0
Nov  7 11:52:35 devpc kernel: scsi 4:0:0:0: Direct-Access     ATA      SAMSUNG HE103UJ  1AA0 PQ: 0 ANSI: 5
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: [sdb] 1953525168 512-byte hardware sectors (1000205 MB)
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: [sdb] Write Protect is off
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: [sdb] 1953525168 512-byte hardware sectors (1000205 MB)
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: [sdb] Write Protect is off
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Nov  7 11:52:35 devpc kernel: sdb: sdb1
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: [sdb] Attached SCSI disk
Nov  7 11:52:35 devpc kernel: sd 4:0:0:0: Attached scsi generic sg1 type 0
Nov  7 11:52:35 devpc kernel: scsi 5:0:0:0: Direct-Access     ATA      SAMSUNG HE103UJ  1AA0 PQ: 0 ANSI: 5
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: [sdc] 1953525168 512-byte hardware sectors (1000205 MB)
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: [sdc] Write Protect is off
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: [sdc] 1953525168 512-byte hardware sectors (1000205 MB)
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: [sdc] Write Protect is off
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Nov  7 11:52:35 devpc kernel: sdc: sdc1
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: [sdc] Attached SCSI disk
Nov  7 11:52:35 devpc kernel: sd 5:0:0:0: Attached scsi generic sg2 type 0
Nov  7 11:52:35 devpc kernel: ahci 0000:02:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
Nov  7 11:52:35 devpc kernel: ahci 0000:02:00.0: AHCI 0001.0000 32 slots 2 ports 3 Gbps 0x3 impl SATA mode
Nov  7 11:52:35 devpc kernel: ahci 0000:02:00.0: flags: 64bit ncq pm led clo pmp pio slum part 
Nov  7 11:52:35 devpc kernel: scsi6 : ahci
Nov  7 11:52:35 devpc kernel: scsi7 : ahci
Nov  7 11:52:35 devpc kernel: ata7: SATA max UDMA/133 abar m8192@0xff5fe000 port 0xff5fe100 irq 16
Nov  7 11:52:35 devpc kernel: ata8: SATA max UDMA/133 abar m8192@0xff5fe000 port 0xff5fe180 irq 16
Nov  7 11:52:35 devpc kernel: ata7: SATA link down (SStatus 0 SControl 300)
Nov  7 11:52:35 devpc kernel: ata8: SATA link down (SStatus 0 SControl 300)

Now, system loading OK, but sda not accessible for mounting file system on sda1 partition.

Thanks.

PS. all samsung drives works as SATA1. I am set this mode using ESTOOL utility.
Its was experiment only and not giving any results... SATA1 or SATA2 - same errors in log file and need executing poweroff command for enable access to hdd .
Comment 19 Tejun Heo 2009-11-09 04:27:39 UTC
From your log, it looks like the drive had completely shut down.  Can you please verify whether the drive is detected by the BIOS (or other operating system) after that happened?

Thanks.
Comment 20 Geo 2009-12-01 08:27:54 UTC
after that happened drive not detected by bios and linux.
bios detect hdd only after power off->power on.
if bios detect ok, then kernel detect ok too.

kernel messages log about that in my previous post.

this drives works fine with ms vista without any errors in all time (2 weeks).

my second computer (based on core i7) with linux (fc12) and one old SATA drive (seagate 80Gb) kernel reports same errors for this drive. i am shocked...
Comment 21 Tejun Heo 2009-12-01 08:42:24 UTC
Okay, yeap, that makes far more sense.  I think the problem is that the firmware is locking up.  Removing power to the drive, reapplying it and then requesting manual scan (echo "- - -" > /sys/class/scsi_host/host0/scan) should make the drive recognized again.  Early drive firmwares sometimes showed such behavior after certain failures but that was a long time ago so it's a bit surprising to see that with relatively new drive.  The difference between windows and linux can be anything - different maximum request lengths, use of certain commands (FLUSH, SMART) or simply accessing different sectors.

Can you please attach the outputs of "smartctl -a /dev/sda" and "dmesg"?

Thanks.
Comment 22 Geo 2009-12-01 08:54:09 UTC
uname -a

Linux devpc 2.6.27.38-170.2.113.fc10.i686.PAE #1 SMP Wed Nov 4 17:43:53 EST 2009 i686 i686 i386 GNU/Linux

[root@devpc /]# smartctl -s on -a /dev/sda
smartctl version 5.38 [i386-redhat-linux-gnu] Copyright (C) 2002-8 Bruce Allen
Home page is http://smartmontools.sourceforge.net/

=== START OF INFORMATION SECTION ===
Device Model:     SAMSUNG HE103UJ
Serial Number:    xxxxxxxxxxxxxx
Firmware Version: 1AA01112
User Capacity:    1,000,204,886,016 bytes
Device is:        In smartctl database [for details use: -P show]
ATA Version is:   8
ATA Standard is:  ATA-8-ACS revision 3b
Local Time is:    Tue Dec  1 11:47:16 2009 MSK

==> WARNING: May need -F samsung or -F samsung2 enabled; see manual for details.

SMART support is: Available - device has SMART capability.
SMART support is: Disabled

=== START OF ENABLE/DISABLE COMMANDS SECTION ===
SMART Enabled.

=== START OF READ SMART DATA SECTION ===
SMART overall-health self-assessment test result: PASSED

General SMART Values:
Offline data collection status:  (0x00)	Offline data collection activity
					was never started.
					Auto Offline Data Collection: Disabled.
Self-test execution status:      (   0)	The previous self-test routine completed
					without error or no self-test has ever 
					been run.
Total time to complete Offline 
data collection: 		 (12320) seconds.
Offline data collection
capabilities: 			 (0x7b) SMART execute Offline immediate.
					Auto Offline data collection on/off support.
					Suspend Offline collection upon new
					command.
					Offline surface scan supported.
					Self-test supported.
					Conveyance Self-test supported.
					Selective Self-test supported.
SMART capabilities:            (0x0003)	Saves SMART data before entering
					power-saving mode.
					Supports SMART auto save timer.
Error logging capability:        (0x01)	Error logging supported.
					General Purpose Logging supported.
Short self-test routine 
recommended polling time: 	 (   2) minutes.
Extended self-test routine
recommended polling time: 	 ( 206) minutes.
Conveyance self-test routine
recommended polling time: 	 (  22) minutes.
SCT capabilities: 	       (0x003f)	SCT Status supported.
					SCT Feature Control supported.
					SCT Data Table supported.

SMART Attributes Data Structure revision number: 16
Vendor Specific SMART Attributes with Thresholds:
ID# ATTRIBUTE_NAME          FLAG     VALUE WORST THRESH TYPE      UPDATED  WHEN_FAILED RAW_VALUE
  1 Raw_Read_Error_Rate     0x000f   100   100   051    Pre-fail  Always       -       0
  3 Spin_Up_Time            0x0007   084   084   011    Pre-fail  Always       -       5690
  4 Start_Stop_Count        0x0032   100   100   000    Old_age   Always       -       111
  5 Reallocated_Sector_Ct   0x0033   025   025   010    Pre-fail  Always       -       3285
  7 Seek_Error_Rate         0x000f   253   253   051    Pre-fail  Always       -       0
  8 Seek_Time_Performance   0x0025   100   100   015    Pre-fail  Offline      -       9951
  9 Power_On_Hours          0x0032   098   098   000    Old_age   Always       -       9091
 10 Spin_Retry_Count        0x0033   100   100   051    Pre-fail  Always       -       0
 11 Calibration_Retry_Count 0x0012   100   100   000    Old_age   Always       -       0
 12 Power_Cycle_Count       0x0032   100   100   000    Old_age   Always       -       111
 13 Read_Soft_Error_Rate    0x000e   100   100   000    Old_age   Always       -       0
183 Unknown_Attribute       0x0032   100   100   000    Old_age   Always       -       4
184 Unknown_Attribute       0x0033   100   100   099    Pre-fail  Always       -       0
187 Reported_Uncorrect      0x0032   100   100   000    Old_age   Always       -       0
188 Unknown_Attribute       0x0032   100   100   000    Old_age   Always       -       0
190 Airflow_Temperature_Cel 0x0022   065   065   000    Old_age   Always       -       35 (Lifetime Min/Max 35/36)
194 Temperature_Celsius     0x0022   065   065   000    Old_age   Always       -       35 (Lifetime Min/Max 35/36)
195 Hardware_ECC_Recovered  0x001a   100   100   000    Old_age   Always       -       2784
196 Reallocated_Event_Count 0x0032   100   100   000    Old_age   Always       -       0
197 Current_Pending_Sector  0x0012   100   100   000    Old_age   Always       -       0
198 Offline_Uncorrectable   0x0030   100   100   000    Old_age   Offline      -       0
199 UDMA_CRC_Error_Count    0x003e   100   100   000    Old_age   Always       -       2
200 Multi_Zone_Error_Rate   0x000a   099   099   000    Old_age   Always       -       5192
201 Soft_Read_Error_Rate    0x000a   253   253   000    Old_age   Always       -       0

SMART Error Log Version: 1
No Errors Logged

SMART Self-test log structure revision number 0
Warning: ATA Specification requires self-test log structure revision number = 1
Num  Test_Description    Status                  Remaining  LifeTime(hours)  LBA_of_first_error
# 1  Extended offline    Completed without error       00%        82         -

SMART Selective Self-Test Log Data Structure Revision Number (0) should be 1
SMART Selective self-test log data structure revision number 0
Warning: ATA Specification requires selective self-test log data structure revision number = 1
 SPAN  MIN_LBA  MAX_LBA  CURRENT_TEST_STATUS
    1        0        0  Not_testing
    2        0        0  Not_testing
    3        0        0  Not_testing
    4        0        0  Not_testing
    5        0        0  Not_testing
Selective self-test flags (0x0):
  After scanning selected spans, do NOT read-scan remainder of disk.
If Selective self-test is pending on power-up, resume after 0 minute delay.



relocated sectors count - i think that is fake value... this hdd work with vista without any problems.



dmesg

Initializing cgroup subsys cpuset
Initializing cgroup subsys cpu
Linux version 2.6.27.38-170.2.113.fc10.i686.PAE (mockbuild@x86-6.fedora.phx.redhat.com) (gcc version 4.3.2 20081105 (Red Hat 4.3.2-7) (GCC) ) #1 SMP Wed Nov 4 17:43:53 EST 2009
BIOS-provided physical RAM map:
 BIOS-e820: 0000000000000000 - 000000000009b800 (usable)
 BIOS-e820: 000000000009b800 - 00000000000a0000 (reserved)
 BIOS-e820: 00000000000e4000 - 0000000000100000 (reserved)
 BIOS-e820: 0000000000100000 - 000000007ff90000 (usable)
 BIOS-e820: 000000007ff90000 - 000000007ff9e000 (ACPI data)
 BIOS-e820: 000000007ff9e000 - 000000007ffe0000 (ACPI NVS)
 BIOS-e820: 000000007ffe0000 - 0000000080000000 (reserved)
 BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
 BIOS-e820: 00000000ffb00000 - 0000000100000000 (reserved)
 BIOS-e820: 0000000100000000 - 0000000180000000 (usable)
DMI 2.4 present.
AMI BIOS detected: BIOS may corrupt low RAM, working it around.
last_pfn = 0x180000 max_arch_pfn = 0x1000000
x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
kernel direct mapping tables up to 38000000 @ 10000-15000
NX (Execute Disable) protection: active
RAMDISK: 37c9c000 - 37fef461
ACPI: RSDP 000FA9B0, 0024 (r2 ACPIAM)
ACPI: XSDT 7FF90100, 004C (r1 MSTEST OEMXSDT   3000909 MSFT       97)
ACPI: FACP 7FF90290, 00F4 (r3 MSTEST OEMFACP   3000909 MSFT       97)
ACPI: DSDT 7FF905C0, 928C (r1  A0545 A0545000        0 INTL 20060113)
ACPI: FACS 7FF9E000, 0040
ACPI: APIC 7FF90390, 006C (r1 MSTEST OEMAPIC   3000909 MSFT       97)
ACPI: MCFG 7FF90400, 003C (r1 MSTEST OEMMCFG   3000909 MSFT       97)
ACPI: OEMB 7FF9E040, 007B (r1 MSTEST AMI_OEM   3000909 MSFT       97)
ACPI: HPET 7FF99850, 0038 (r1 MSTEST OEMHPET   3000909 MSFT       97)
5248MB HIGHMEM available.
896MB LOWMEM available.
  mapped low ram: 0 - 38000000
  low ram: 00000000 - 38000000
  bootmap 00012000 - 00019000
(9 early reservations) ==> bootmem [0000000000 - 0038000000]
  #0 [0000000000 - 0000001000]   BIOS data page ==> [0000000000 - 0000001000]
  #1 [0000001000 - 0000002000]    EX TRAMPOLINE ==> [0000001000 - 0000002000]
  #2 [0000006000 - 0000007000]       TRAMPOLINE ==> [0000006000 - 0000007000]
  #3 [0000400000 - 000099a72c]    TEXT DATA BSS ==> [0000400000 - 000099a72c]
  #4 [0037c9c000 - 0037fef461]          RAMDISK ==> [0037c9c000 - 0037fef461]
  #5 [000099b000 - 00009a4000]    INIT_PG_TABLE ==> [000099b000 - 00009a4000]
  #6 [000009b800 - 0000100000]    BIOS reserved ==> [000009b800 - 0000100000]
  #7 [0000010000 - 0000012000]          PGTABLE ==> [0000010000 - 0000012000]
  #8 [0000012000 - 0000019000]          BOOTMAP ==> [0000012000 - 0000019000]
found SMP MP-table at [c00ff780] 000ff780
Zone PFN ranges:
  DMA      0x00000010 -> 0x00001000
  Normal   0x00001000 -> 0x00038000
  HighMem  0x00038000 -> 0x00180000
Movable zone start PFN for each node
early_node_map[3] active PFN ranges
    0: 0x00000010 -> 0x0000009b
    0: 0x00000100 -> 0x0007ff90
    0: 0x00100000 -> 0x00180000
On node 0 totalpages: 1048347
free_area_init_node: node 0, pgdat c0809680, node_mem_map c1000200
  DMA zone: 3947 pages, LIFO batch:0
  Normal zone: 223520 pages, LIFO batch:31
  HighMem zone: 808592 pages, LIFO batch:31
Using APIC driver default
ACPI: PM-Timer IO Port: 0x808
ACPI: Local APIC address 0xfee00000
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
ACPI: LAPIC (acpi_id[0x03] lapic_id[0x82] disabled)
ACPI: LAPIC (acpi_id[0x04] lapic_id[0x83] disabled)
ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
ACPI: IRQ0 used by override.
ACPI: IRQ2 used by override.
ACPI: IRQ9 used by override.
Enabling APIC mode:  Flat.  Using 1 I/O APICs
ACPI: HPET id: 0x8086a202 base: 0xfed00000
Using ACPI (MADT) for SMP configuration information
SMP: Allowing 4 CPUs, 2 hotplug CPUs
mapped APIC to ffffb000 (fee00000)
mapped IOAPIC to ffffa000 (fec00000)
PM: Registered nosave memory: 000000000009b000 - 000000000009c000
PM: Registered nosave memory: 000000000009c000 - 00000000000a0000
PM: Registered nosave memory: 00000000000a0000 - 00000000000e4000
PM: Registered nosave memory: 00000000000e4000 - 0000000000100000
Allocating PCI resources starting at 88000000 (gap: 80000000:7ee00000)
PERCPU: Allocating 45596 bytes of per cpu data
NR_CPUS: 32, nr_cpu_ids: 4, nr_node_ids 1
Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 1036059
Kernel command line: ro root=/dev/md1 rhgb quiet nomodeset
Enabling fast FPU save and restore... done.
Enabling unmasked SIMD FPU exception support... done.
Initializing CPU#0
CPU 0 irqstacks, hard=c08c4000 soft=c08a4000
PID hash table entries: 4096 (order: 12, 16384 bytes)
Extended CMOS year: 2000
TSC: PIT calibration confirmed by PMTIMER.
TSC: using PMTIMER calibration value
Detected 2006.087 MHz processor.
Console: colour VGA+ 80x25
console [tty0] enabled
Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Memory: 4133048k/6291456k available (2799k kernel code, 59476k reserved, 1462k data, 424k init, 3276352k highmem)
virtual kernel memory layout:
    fixmap  : 0xffc57000 - 0xfffff000   (3744 kB)
    pkmap   : 0xff800000 - 0xffa00000   (2048 kB)
    vmalloc : 0xf8800000 - 0xff7fe000   ( 111 MB)
    lowmem  : 0xc0000000 - 0xf8000000   ( 896 MB)
      .init : 0xc082f000 - 0xc0899000   ( 424 kB)
      .data : 0xc06bbeb0 - 0xc0829778   (1462 kB)
      .text : 0xc0400000 - 0xc06bbeb0   (2799 kB)
Checking if this processor honours the WP bit even in supervisor mode...Ok.
CPA: page pool initialized 1 of 1 pages preallocated
SLUB: Genslabs=12, HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
hpet clockevent registered
Calibrating delay loop (skipped), value calculated using timer frequency.. 4012.17 BogoMIPS (lpj=2006087)
Security Framework initialized
SELinux:  Initializing.
SELinux:  Starting in permissive mode
Mount-cache hash table entries: 512
Initializing cgroup subsys ns
Initializing cgroup subsys cpuacct
Initializing cgroup subsys devices
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 2048K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 0
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#0.
using mwait in idle threads.
Checking 'hlt' instruction... OK.
ACPI: Core revision 20080609
ENABLING IO-APIC IRQs
..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1
CPU0: Intel(R) Core(TM)2 Duo CPU     E4400  @ 2.00GHz stepping 0d
APIC calibration not consistent with PM Timer: 119ms instead of 100ms
APIC delta adjusted to PM-Timer: 1253802 (1504550)
CPU 1 irqstacks, hard=c08c5000 soft=c08a5000
Booting processor 1/1 ip 6000
Initializing CPU#1
Calibrating delay using timer specific routine.. 4012.19 BogoMIPS (lpj=2006099)
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 2048K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 1
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#1.
x86 PAT enabled: cpu 1, old 0x7040600070406, new 0x7010600070106
CPU1: Intel(R) Core(TM)2 Duo CPU     E4400  @ 2.00GHz stepping 0d
checking TSC synchronization [CPU#0 -> CPU#1]: passed.
Brought up 2 CPUs
Total of 2 processors activated (8024.37 BogoMIPS).
sizeof(vma)=88 bytes
sizeof(page)=32 bytes
sizeof(inode)=340 bytes
sizeof(dentry)=132 bytes
sizeof(ext3inode)=492 bytes
sizeof(buffer_head)=56 bytes
sizeof(skbuff)=180 bytes
sizeof(task_struct)=3268 bytes
CPU0 attaching sched-domain:
 domain 0: span 0-1 level MC
  groups: 0 1
CPU1 attaching sched-domain:
 domain 0: span 0-1 level MC
  groups: 1 0
net_namespace: 840 bytes
Booting paravirtualized kernel on bare hardware
Time: 11:02:51  Date: 12/01/09
NET: Registered protocol family 16
No dock devices found.
ACPI: bus type pci registered
PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
PCI: Not using MMCONFIG.
PCI: PCI BIOS revision 3.00 entry at 0xf0031, last bus=6
PCI: Using configuration type 1 for base access
ACPI: EC: Look up EC in DSDT
ACPI: Interpreter enabled
ACPI: (supports S0 S1 S3 S4 S5)
ACPI: Using IOAPIC for interrupt routing
PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
PCI: MCFG area at e0000000 reserved in ACPI motherboard resources
PCI: Using MMCONFIG for extended config space
ACPI: PCI Root Bridge [PCI0] (0000:00)
pci 0000:00:01.0: PME# supported from D0 D3hot D3cold
pci 0000:00:01.0: PME# disabled
PCI: 0000:00:1a.0 reg 20 io port: [e000, e01f]
PCI: 0000:00:1a.1 reg 20 io port: [e080, e09f]
PCI: 0000:00:1a.7 reg 10 32bit mmio: [ffaff400, ffaff7ff]
pci 0000:00:1a.7: PME# supported from D0 D3hot D3cold
pci 0000:00:1a.7: PME# disabled
PCI: 0000:00:1b.0 reg 10 64bit mmio: [ffaf8000, ffafbfff]
pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
pci 0000:00:1b.0: PME# disabled
pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
pci 0000:00:1c.0: PME# disabled
pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
pci 0000:00:1c.1: PME# disabled
pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
pci 0000:00:1c.3: PME# disabled
pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold
pci 0000:00:1c.4: PME# disabled
PCI: 0000:00:1d.0 reg 20 io port: [d800, d81f]
PCI: 0000:00:1d.1 reg 20 io port: [d880, d89f]
PCI: 0000:00:1d.2 reg 20 io port: [dc00, dc1f]
PCI: 0000:00:1d.7 reg 10 32bit mmio: [ffaff000, ffaff3ff]
pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
pci 0000:00:1d.7: PME# disabled
pci 0000:00:1f.0: quirk: region 0800-087f claimed by ICH6 ACPI/GPIO/TCO
pci 0000:00:1f.0: quirk: region 0480-04bf claimed by ICH6 GPIO
PCI: 0000:00:1f.2 reg 10 io port: [ec00, ec07]
PCI: 0000:00:1f.2 reg 14 io port: [e880, e883]
PCI: 0000:00:1f.2 reg 18 io port: [e800, e807]
PCI: 0000:00:1f.2 reg 1c io port: [e480, e483]
PCI: 0000:00:1f.2 reg 20 io port: [e400, e41f]
PCI: 0000:00:1f.2 reg 24 32bit mmio: [ffaff800, ffafffff]
pci 0000:00:1f.2: PME# supported from D3hot
pci 0000:00:1f.2: PME# disabled
PCI: 0000:00:1f.3 reg 10 32bit mmio: [0, ff]
PCI: 0000:00:1f.3 reg 20 io port: [400, 41f]
PCI: 0000:01:00.0 reg 10 64bit mmio: [c0000000, cfffffff]
PCI: 0000:01:00.0 reg 18 64bit mmio: [ff4f0000, ff4fffff]
PCI: 0000:01:00.0 reg 20 io port: [8000, 80ff]
PCI: 0000:01:00.0 reg 30 32bit mmio: [ff4c0000, ff4dffff]
pci 0000:01:00.0: supports D1
pci 0000:01:00.0: supports D2
PCI: 0000:01:00.1 reg 10 64bit mmio: [ff4e0000, ff4effff]
pci 0000:01:00.1: supports D1
pci 0000:01:00.1: supports D2
Pre-1.1 PCIe device detected, disable ASPM for 0000:00:01.0. It can be enabled forcedly with 'pcie_aspm=force'
PCI: bridge 0000:00:01.0 io port: [6000, 8fff]
PCI: bridge 0000:00:01.0 32bit mmio: [ff400000, ff4fffff]
PCI: bridge 0000:00:01.0 64bit mmio pref: [bfe00000, dfdfffff]
PCI: bridge 0000:00:1c.0 64bit mmio pref: [dfe00000, dfefffff]
PCI: 0000:04:00.0 reg 10 64bit mmio: [ff8ffc00, ff8ffc7f]
PCI: 0000:04:00.0 reg 18 64bit mmio: [ff8f8000, ff8fbfff]
PCI: 0000:04:00.0 reg 20 io port: [bc00, bc7f]
PCI: 0000:04:00.0 reg 30 32bit mmio: [ff800000, ff87ffff]
pci 0000:04:00.0: supports D1
pci 0000:04:00.0: supports D2
Pre-1.1 PCIe device detected, disable ASPM for 0000:00:1c.1. It can be enabled forcedly with 'pcie_aspm=force'
PCI: bridge 0000:00:1c.1 io port: [b000, bfff]
PCI: bridge 0000:00:1c.1 32bit mmio: [ff700000, ff8fffff]
PCI: 0000:03:00.0 reg 10 io port: [a800, a8ff]
PCI: 0000:03:00.0 reg 18 64bit mmio: [ff6ff000, ff6fffff]
PCI: 0000:03:00.0 reg 30 32bit mmio: [ff6c0000, ff6dffff]
pci 0000:03:00.0: supports D1
pci 0000:03:00.0: supports D2
pci 0000:03:00.0: PME# supported from D1 D2 D3hot D3cold
pci 0000:03:00.0: PME# disabled
Pre-1.1 PCIe device detected, disable ASPM for 0000:00:1c.3. It can be enabled forcedly with 'pcie_aspm=force'
PCI: bridge 0000:00:1c.3 io port: [a000, afff]
PCI: bridge 0000:00:1c.3 32bit mmio: [ff600000, ff6fffff]
PCI: 0000:02:00.0 reg 24 32bit mmio: [ff5fe000, ff5fffff]
PCI: 0000:02:00.0 reg 30 32bit mmio: [ff5e0000, ff5effff]
pci 0000:02:00.0: PME# supported from D3hot
pci 0000:02:00.0: PME# disabled
PCI: 0000:02:00.1 reg 10 io port: [9c00, 9c07]
PCI: 0000:02:00.1 reg 14 io port: [9880, 9883]
PCI: 0000:02:00.1 reg 18 io port: [9800, 9807]
PCI: 0000:02:00.1 reg 1c io port: [9480, 9483]
PCI: 0000:02:00.1 reg 20 io port: [9400, 940f]
Pre-1.1 PCIe device detected, disable ASPM for 0000:00:1c.4. It can be enabled forcedly with 'pcie_aspm=force'
PCI: bridge 0000:00:1c.4 io port: [9000, 9fff]
PCI: bridge 0000:00:1c.4 32bit mmio: [ff500000, ff5fffff]
PCI: 0000:06:00.0 reg 10 io port: [cc00, cc07]
PCI: 0000:06:00.0 reg 14 io port: [c880, c883]
PCI: 0000:06:00.0 reg 18 io port: [c800, c807]
PCI: 0000:06:00.0 reg 1c io port: [c480, c483]
PCI: 0000:06:00.0 reg 20 io port: [c400, c40f]
PCI: 0000:06:00.0 reg 24 32bit mmio: [ff9fc000, ff9fffff]
PCI: 0000:06:00.0 reg 30 32bit mmio: [ff9e0000, ff9e3fff]
pci 0000:06:00.0: supports D1
PCI: 0000:06:02.0 reg 10 io port: [c080, c0ff]
PCI: 0000:06:02.0 reg 14 32bit mmio: [ff9fbc00, ff9fbc7f]
PCI: 0000:06:02.0 reg 30 32bit mmio: [ff9c0000, ff9dffff]
pci 0000:06:02.0: supports D1
pci 0000:06:02.0: supports D2
pci 0000:06:02.0: PME# supported from D0 D1 D2 D3hot D3cold
pci 0000:06:02.0: PME# disabled
pci 0000:00:1e.0: transparent bridge
PCI: bridge 0000:00:1e.0 io port: [c000, cfff]
PCI: bridge 0000:00:1e.0 32bit mmio: [ff900000, ff9fffff]
bus 00 -> node 0
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P2._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P1._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P4._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P5._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P7._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P8._PRT]
ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 10 *11 12 14 15)
ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 10 11 12 14 *15)
ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 7 10 11 12 14 15)
ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 *10 11 12 14 15)
ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 *11 12 14 15)
ACPI: PCI Interrupt Link [LNKG] (IRQs *3 4 5 6 7 10 11 12 14 15)
ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 10 11 12 *14 15)
ACPI Warning (tbutils-0217): Incorrect checksum in table [OEMB] - 07, should be 02 [20080609]
Linux Plug and Play Support v0.97 (c) Adam Belay
pnp: PnP ACPI init
ACPI: bus type pnp registered
pnp: PnP ACPI: found 14 devices
ACPI: ACPI bus type pnp unregistered
SCSI subsystem initialized
libata version 3.00 loaded.
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
PCI: Using ACPI for IRQ routing
NetLabel: Initializing
NetLabel:  domain hash size = 128
NetLabel:  protocols = UNLABELED CIPSOv4
NetLabel:  unlabeled traffic allowed by default
hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
hpet0: 3 64-bit timers, 14318180 Hz
tracer: 772 pages allocated for 65536 entries of 48 bytes
   actual entries 65620
ACPI: RTC can wake from S4
system 00:01: iomem range 0xfed14000-0xfed19fff has been reserved
system 00:07: ioport range 0x290-0x297 has been reserved
system 00:08: ioport range 0x4d0-0x4d1 has been reserved
system 00:08: ioport range 0x800-0x87f has been reserved
system 00:08: ioport range 0x480-0x4bf has been reserved
system 00:08: iomem range 0xffafe000-0xffb0cbff could not be reserved
system 00:08: iomem range 0xffb00000-0xffbfffff could not be reserved
system 00:08: iomem range 0xfed1c000-0xfed1ffff has been reserved
system 00:08: iomem range 0xfed20000-0xfed8ffff has been reserved
system 00:08: iomem range 0xfff00000-0xfffffffe could not be reserved
system 00:08: iomem range 0xfebfe000-0xfebfec00 has been reserved
system 00:0b: iomem range 0xfec00000-0xfec00fff has been reserved
system 00:0b: iomem range 0xfee00000-0xfee00fff could not be reserved
system 00:0c: iomem range 0xe0000000-0xefffffff has been reserved
system 00:0d: iomem range 0x0-0x9ffff could not be reserved
system 00:0d: iomem range 0xc0000-0xcffff could not be reserved
system 00:0d: iomem range 0xe0000-0xfffff could not be reserved
system 00:0d: iomem range 0x100000-0x7fffffff could not be reserved
pci 0000:00:01.0: PCI bridge, secondary bus 0000:01
pci 0000:00:01.0:   IO window: 0x6000-0x8fff
pci 0000:00:01.0:   MEM window: 0xff400000-0xff4fffff
pci 0000:00:01.0:   PREFETCH window: 0x000000bfe00000-0x000000dfdfffff
pci 0000:00:1c.0: PCI bridge, secondary bus 0000:05
pci 0000:00:1c.0:   IO window: disabled
pci 0000:00:1c.0:   MEM window: disabled
pci 0000:00:1c.0:   PREFETCH window: 0x000000dfe00000-0x000000dfefffff
pci 0000:00:1c.1: PCI bridge, secondary bus 0000:04
pci 0000:00:1c.1:   IO window: 0xb000-0xbfff
pci 0000:00:1c.1:   MEM window: 0xff700000-0xff8fffff
pci 0000:00:1c.1:   PREFETCH window: disabled
pci 0000:00:1c.3: PCI bridge, secondary bus 0000:03
pci 0000:00:1c.3:   IO window: 0xa000-0xafff
pci 0000:00:1c.3:   MEM window: 0xff600000-0xff6fffff
pci 0000:00:1c.3:   PREFETCH window: disabled
pci 0000:00:1c.4: PCI bridge, secondary bus 0000:02
pci 0000:00:1c.4:   IO window: 0x9000-0x9fff
pci 0000:00:1c.4:   MEM window: 0xff500000-0xff5fffff
pci 0000:00:1c.4:   PREFETCH window: disabled
pci 0000:00:1e.0: PCI bridge, secondary bus 0000:06
pci 0000:00:1e.0:   IO window: 0xc000-0xcfff
pci 0000:00:1e.0:   MEM window: 0xff900000-0xff9fffff
pci 0000:00:1e.0:   PREFETCH window: 0x00000088000000-0x000000880fffff
pci 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
pci 0000:00:01.0: setting latency timer to 64
pci 0000:00:1c.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
pci 0000:00:1c.0: setting latency timer to 64
pci 0000:00:1c.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
pci 0000:00:1c.1: setting latency timer to 64
pci 0000:00:1c.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19
pci 0000:00:1c.3: setting latency timer to 64
pci 0000:00:1c.4: PCI INT A -> GSI 16 (level, low) -> IRQ 16
pci 0000:00:1c.4: setting latency timer to 64
pci 0000:00:1e.0: setting latency timer to 64
bus: 00 index 0 io port: [0, ffff]
bus: 00 index 1 mmio: [0, ffffffffffffffff]
bus: 01 index 0 io port: [6000, 8fff]
bus: 01 index 1 mmio: [ff400000, ff4fffff]
bus: 01 index 2 mmio: [bfe00000, dfdfffff]
bus: 01 index 3 mmio: [0, 0]
bus: 05 index 0 mmio: [0, 0]
bus: 05 index 1 mmio: [0, 0]
bus: 05 index 2 mmio: [dfe00000, dfefffff]
bus: 05 index 3 mmio: [0, 0]
bus: 04 index 0 io port: [b000, bfff]
bus: 04 index 1 mmio: [ff700000, ff8fffff]
bus: 04 index 2 mmio: [0, 0]
bus: 04 index 3 mmio: [0, 0]
bus: 03 index 0 io port: [a000, afff]
bus: 03 index 1 mmio: [ff600000, ff6fffff]
bus: 03 index 2 mmio: [0, 0]
bus: 03 index 3 mmio: [0, 0]
bus: 02 index 0 io port: [9000, 9fff]
bus: 02 index 1 mmio: [ff500000, ff5fffff]
bus: 02 index 2 mmio: [0, 0]
bus: 02 index 3 mmio: [0, 0]
bus: 06 index 0 io port: [c000, cfff]
bus: 06 index 1 mmio: [ff900000, ff9fffff]
bus: 06 index 2 mmio: [88000000, 880fffff]
bus: 06 index 3 io port: [0, ffff]
bus: 06 index 4 mmio: [0, ffffffffffffffff]
NET: Registered protocol family 2
IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
TCP: Hash tables configured (established 131072 bind 65536)
TCP reno registered
NET: Registered protocol family 1
checking if image is initramfs... it is
Freeing initrd memory: 3405k freed
apm: BIOS version 1.2 Flags 0x03 (Driver version 1.16ac)
apm: disabled - APM is not SMP safe.
audit: initializing netlink socket (disabled)
type=2000 audit(1259665370.465:1): initialized
highmem bounce pool size: 64 pages
HugeTLB registered 2 MB page size, pre-allocated 0 pages
VFS: Disk quotas dquot_6.5.1
Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
msgmni has been set to 1681
SELinux:  Registering netfilter hooks
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
io scheduler noop registered
io scheduler anticipatory registered
io scheduler deadline registered
io scheduler cfq registered (default)
Switched to high resolution mode on CPU 1
Switched to high resolution mode on CPU 0
pci 0000:01:00.0: Boot video device
pcieport-driver 0000:00:01.0: setting latency timer to 64
pcieport-driver 0000:00:01.0: found MSI capability
pci_express 0000:00:01.0:pcie00: allocate port service
pci_express 0000:00:01.0:pcie03: allocate port service
pcieport-driver 0000:00:1c.0: setting latency timer to 64
pcieport-driver 0000:00:1c.0: found MSI capability
pci_express 0000:00:1c.0:pcie00: allocate port service
pci_express 0000:00:1c.0:pcie02: allocate port service
pci_express 0000:00:1c.0:pcie03: allocate port service
pcieport-driver 0000:00:1c.1: setting latency timer to 64
pcieport-driver 0000:00:1c.1: found MSI capability
pci_express 0000:00:1c.1:pcie00: allocate port service
pci_express 0000:00:1c.1:pcie02: allocate port service
pci_express 0000:00:1c.1:pcie03: allocate port service
pcieport-driver 0000:00:1c.3: setting latency timer to 64
pcieport-driver 0000:00:1c.3: found MSI capability
pci_express 0000:00:1c.3:pcie00: allocate port service
pci_express 0000:00:1c.3:pcie02: allocate port service
pci_express 0000:00:1c.3:pcie03: allocate port service
pcieport-driver 0000:00:1c.4: setting latency timer to 64
pcieport-driver 0000:00:1c.4: found MSI capability
pci_express 0000:00:1c.4:pcie00: allocate port service
pci_express 0000:00:1c.4:pcie02: allocate port service
pci_express 0000:00:1c.4:pcie03: allocate port service
pci_hotplug: PCI Hot Plug PCI Core version: 0.5
acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
input: Power Button (FF) as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
ACPI: Power Button (FF) [PWRF]
input: Power Button (CM) as /devices/LNXSYSTM:00/device:00/PNP0C0C:00/input/input1
ACPI: Power Button (CM) [PWRB]
ACPI: SSDT 7FF9E0C0, 0208 (r1    AMI   CPU1PM        1 INTL 20060113)
processor ACPI0007:00: registered as cooling_device0
ACPI: SSDT 7FF9E2D0, 013A (r1    AMI   CPU2PM        1 INTL 20060113)
processor ACPI0007:01: registered as cooling_device1
isapnp: Scanning for PnP cards...
isapnp: No Plug & Play device found
hpet_resources: 0xfed00000 is busy
Non-volatile memory driver v1.2
Linux agpgart interface v0.103
Serial: 8250/16550 driver4 ports, IRQ sharing enabled
serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
brd: module loaded
loop: module loaded
input: Macintosh mouse button emulation as /devices/virtual/input/input2
Driver 'sd' needs updating - please use bus_type methods
Driver 'sr' needs updating - please use bus_type methods
ahci 0000:00:1f.2: version 3.0
ahci 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 4 ports 3 Gbps 0x33 impl SATA mode
ahci 0000:00:1f.2: flags: 64bit ncq sntf stag pm led clo pio slum part ems 
ahci 0000:00:1f.2: setting latency timer to 64
scsi0 : ahci
scsi1 : ahci
scsi2 : ahci
scsi3 : ahci
scsi4 : ahci
scsi5 : ahci
ata1: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaff900 irq 19
ata2: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaff980 irq 19
ata3: DUMMY
ata4: DUMMY
ata5: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaffb00 irq 19
ata6: SATA max UDMA/133 abar m2048@0xffaff800 port 0xffaffb80 irq 19
ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
ata1.00: ATA-7: SAMSUNG HE103UJ, 1AA01112, max UDMA7
ata1.00: 1953525168 sectors, multi 0: LBA48 NCQ (depth 31/32)
ata1.00: configured for UDMA/133
ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
ata2.00: ATA-7: ST3300831AS, 3.06, max UDMA/133
ata2.00: 586072368 sectors, multi 0: LBA48 NCQ (depth 31/32)
ata2.00: configured for UDMA/133
ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
ata5.00: ATA-7: SAMSUNG HE103UJ, 1AA01112, max UDMA7
ata5.00: 1953525168 sectors, multi 0: LBA48 NCQ (depth 31/32)
ata5.00: configured for UDMA/133
ata6: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
ata6.00: ATA-7: SAMSUNG HE103UJ, 1AA01112, max UDMA7
ata6.00: 1953525168 sectors, multi 0: LBA48 NCQ (depth 31/32)
ata6.00: configured for UDMA/133
scsi 0:0:0:0: Direct-Access     ATA      SAMSUNG HE103UJ  1AA0 PQ: 0 ANSI: 5
sd 0:0:0:0: [sda] 1953525168 512-byte hardware sectors (1000205 MB)
sd 0:0:0:0: [sda] Write Protect is off
sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sd 0:0:0:0: [sda] 1953525168 512-byte hardware sectors (1000205 MB)
sd 0:0:0:0: [sda] Write Protect is off
sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
 sda: sda1
sd 0:0:0:0: [sda] Attached SCSI disk
sd 0:0:0:0: Attached scsi generic sg0 type 0
scsi 1:0:0:0: Direct-Access     ATA      ST3300831AS      3.06 PQ: 0 ANSI: 5
sd 1:0:0:0: [sdb] 586072368 512-byte hardware sectors (300069 MB)
sd 1:0:0:0: [sdb] Write Protect is off
sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00
sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sd 1:0:0:0: [sdb] 586072368 512-byte hardware sectors (300069 MB)
sd 1:0:0:0: [sdb] Write Protect is off
sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00
sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
 sdb: sdb1
sd 1:0:0:0: [sdb] Attached SCSI disk
sd 1:0:0:0: Attached scsi generic sg1 type 0
scsi 4:0:0:0: Direct-Access     ATA      SAMSUNG HE103UJ  1AA0 PQ: 0 ANSI: 5
sd 4:0:0:0: [sdc] 1953525168 512-byte hardware sectors (1000205 MB)
sd 4:0:0:0: [sdc] Write Protect is off
sd 4:0:0:0: [sdc] Mode Sense: 00 3a 00 00
sd 4:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sd 4:0:0:0: [sdc] 1953525168 512-byte hardware sectors (1000205 MB)
sd 4:0:0:0: [sdc] Write Protect is off
sd 4:0:0:0: [sdc] Mode Sense: 00 3a 00 00
sd 4:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
 sdc: sdc1
sd 4:0:0:0: [sdc] Attached SCSI disk
sd 4:0:0:0: Attached scsi generic sg2 type 0
scsi 5:0:0:0: Direct-Access     ATA      SAMSUNG HE103UJ  1AA0 PQ: 0 ANSI: 5
sd 5:0:0:0: [sdd] 1953525168 512-byte hardware sectors (1000205 MB)
sd 5:0:0:0: [sdd] Write Protect is off
sd 5:0:0:0: [sdd] Mode Sense: 00 3a 00 00
sd 5:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sd 5:0:0:0: [sdd] 1953525168 512-byte hardware sectors (1000205 MB)
sd 5:0:0:0: [sdd] Write Protect is off
sd 5:0:0:0: [sdd] Mode Sense: 00 3a 00 00
sd 5:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
 sdd: sdd1
sd 5:0:0:0: [sdd] Attached SCSI disk
sd 5:0:0:0: Attached scsi generic sg3 type 0
ahci 0000:02:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
ahci 0000:02:00.0: AHCI 0001.0000 32 slots 2 ports 3 Gbps 0x3 impl SATA mode
ahci 0000:02:00.0: flags: 64bit ncq pm led clo pmp pio slum part 
ahci 0000:02:00.0: setting latency timer to 64
scsi6 : ahci
scsi7 : ahci
ata7: SATA max UDMA/133 abar m8192@0xff5fe000 port 0xff5fe100 irq 16
ata8: SATA max UDMA/133 abar m8192@0xff5fe000 port 0xff5fe180 irq 16
ata7: SATA link down (SStatus 0 SControl 300)
ata8: SATA link down (SStatus 0 SControl 300)
ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 18 (level, low) -> IRQ 18
ehci_hcd 0000:00:1a.7: setting latency timer to 64
ehci_hcd 0000:00:1a.7: EHCI Host Controller
ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 1
ehci_hcd 0000:00:1a.7: debug port 1
ehci_hcd 0000:00:1a.7: cache line size of 32 is not supported
ehci_hcd 0000:00:1a.7: irq 18, io mem 0xffaff400
ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 4 ports detected
usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb1: Product: EHCI Host Controller
usb usb1: Manufacturer: Linux 2.6.27.38-170.2.113.fc10.i686.PAE ehci_hcd
usb usb1: SerialNumber: 0000:00:1a.7
ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
ehci_hcd 0000:00:1d.7: setting latency timer to 64
ehci_hcd 0000:00:1d.7: EHCI Host Controller
ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 2
ehci_hcd 0000:00:1d.7: debug port 1
ehci_hcd 0000:00:1d.7: cache line size of 32 is not supported
ehci_hcd 0000:00:1d.7: irq 23, io mem 0xffaff000
usb 1-4: new high speed USB device using ehci_hcd and address 2
ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
usb usb2: configuration #1 chosen from 1 choice
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 6 ports detected
usb 1-4: configuration #1 chosen from 1 choice
usb 1-4: New USB device found, idVendor=058f, idProduct=6362
usb 1-4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
usb 1-4: Product: Mass Storage Device
usb 1-4: Manufacturer: Generic
usb 1-4: SerialNumber: 058F312D81B1
usb usb2: New USB device found, idVendor=1d6b, idProduct=0002
usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb2: Product: EHCI Host Controller
usb usb2: Manufacturer: Linux 2.6.27.38-170.2.113.fc10.i686.PAE ehci_hcd
usb usb2: SerialNumber: 0000:00:1d.7
ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver
USB Universal Host Controller Interface driver v3.0
uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
uhci_hcd 0000:00:1a.0: setting latency timer to 64
uhci_hcd 0000:00:1a.0: UHCI Host Controller
uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 3
uhci_hcd 0000:00:1a.0: irq 16, io base 0x0000e000
usb usb3: configuration #1 chosen from 1 choice
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb3: Product: UHCI Host Controller
usb usb3: Manufacturer: Linux 2.6.27.38-170.2.113.fc10.i686.PAE uhci_hcd
usb usb3: SerialNumber: 0000:00:1a.0
uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
uhci_hcd 0000:00:1a.1: setting latency timer to 64
uhci_hcd 0000:00:1a.1: UHCI Host Controller
uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 4
uhci_hcd 0000:00:1a.1: irq 17, io base 0x0000e080
usb usb4: configuration #1 chosen from 1 choice
hub 4-0:1.0: USB hub found
hub 4-0:1.0: 2 ports detected
usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb4: Product: UHCI Host Controller
usb usb4: Manufacturer: Linux 2.6.27.38-170.2.113.fc10.i686.PAE uhci_hcd
usb usb4: SerialNumber: 0000:00:1a.1
uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
uhci_hcd 0000:00:1d.0: setting latency timer to 64
uhci_hcd 0000:00:1d.0: UHCI Host Controller
uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 5
uhci_hcd 0000:00:1d.0: irq 23, io base 0x0000d800
usb usb5: configuration #1 chosen from 1 choice
hub 5-0:1.0: USB hub found
hub 5-0:1.0: 2 ports detected
usb 2-6: new high speed USB device using ehci_hcd and address 6
usb 2-6: configuration #1 chosen from 1 choice
hub 2-6:1.0: USB hub found
hub 2-6:1.0: 4 ports detected
usb usb5: New USB device found, idVendor=1d6b, idProduct=0001
usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb5: Product: UHCI Host Controller
usb usb5: Manufacturer: Linux 2.6.27.38-170.2.113.fc10.i686.PAE uhci_hcd
usb usb5: SerialNumber: 0000:00:1d.0
uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
uhci_hcd 0000:00:1d.1: setting latency timer to 64
uhci_hcd 0000:00:1d.1: UHCI Host Controller
uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 6
uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000d880
usb usb6: configuration #1 chosen from 1 choice
hub 6-0:1.0: USB hub found
hub 6-0:1.0: 2 ports detected
usb 2-6: New USB device found, idVendor=04b4, idProduct=6560
usb 2-6: New USB device strings: Mfr=0, Product=0, SerialNumber=0
usb 5-1: new low speed USB device using uhci_hcd and address 2
usb usb6: New USB device found, idVendor=1d6b, idProduct=0001
usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb6: Product: UHCI Host Controller
usb usb6: Manufacturer: Linux 2.6.27.38-170.2.113.fc10.i686.PAE uhci_hcd
usb usb6: SerialNumber: 0000:00:1d.1
uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
uhci_hcd 0000:00:1d.2: setting latency timer to 64
uhci_hcd 0000:00:1d.2: UHCI Host Controller
uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 7
uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000dc00
usb usb7: configuration #1 chosen from 1 choice
hub 7-0:1.0: USB hub found
hub 7-0:1.0: 2 ports detected
usb 5-1: configuration #1 chosen from 1 choice
usb 5-1: New USB device found, idVendor=046d, idProduct=c00e
usb 5-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 5-1: Product: USB-PS/2 Optical Mouse
usb 5-1: Manufacturer: Logitech
usb usb7: New USB device found, idVendor=1d6b, idProduct=0001
usb usb7: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb7: Product: UHCI Host Controller
usb usb7: Manufacturer: Linux 2.6.27.38-170.2.113.fc10.i686.PAE uhci_hcd
usb usb7: SerialNumber: 0000:00:1d.2
PNP: No PS/2 controller found. Probing ports directly.
serio: i8042 KBD port at 0x60,0x64 irq 1
serio: i8042 AUX port at 0x60,0x64 irq 12
mice: PS/2 mouse device common for all mice
rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
rtc0: alarms up to one month, y3k, hpet irqs
device-mapper: uevent: version 1.0.3
device-mapper: ioctl: 4.14.0-ioctl (2008-04-23) initialised: dm-devel@redhat.com
cpuidle: using governor ladder
cpuidle: using governor menu
usb 5-2: new low speed USB device using uhci_hcd and address 3
usb 5-2: configuration #1 chosen from 1 choice
usb 5-2: New USB device found, idVendor=046d, idProduct=c30e
usb 5-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 5-2: Product: HID compliant keyboard
usb 5-2: Manufacturer: Logitech
usb 6-2: new low speed USB device using uhci_hcd and address 2
usb 6-2: configuration #1 chosen from 1 choice
usb 6-2: New USB device found, idVendor=051d, idProduct=0002
usb 6-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
usb 6-2: Product: Smart-UPS 1500 FW:653.13.I USB FW:7.3
usb 6-2: Manufacturer: American Power Conversion
usb 6-2: SerialNumber: AS0728112176
usb 7-1: new full speed USB device using uhci_hcd and address 2
usb 7-1: configuration #1 chosen from 1 choice
usb 7-1: New USB device found, idVendor=0a12, idProduct=0001
usb 7-1: New USB device strings: Mfr=0, Product=2, SerialNumber=0
usb 7-1: Product: EDRClassone
usbcore: registered new interface driver hiddev
input: Logitech USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/5-1:1.0/input/input3
input,hidraw0: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:1d.0-1
input: Logitech HID compliant keyboard as /devices/pci0000:00/0000:00:1d.0/usb5/5-2/5-2:1.0/input/input4
input,hidraw1: USB HID v1.10 Keyboard [Logitech HID compliant keyboard] on usb-0000:00:1d.0-2
input: Logitech HID compliant keyboard as /devices/pci0000:00/0000:00:1d.0/usb5/5-2/5-2:1.1/input/input5
input,hidraw2: USB HID v1.10 Device [Logitech HID compliant keyboard] on usb-0000:00:1d.0-2
hiddev96hidraw3: USB HID v1.10 Device [American Power Conversion Smart-UPS 1500 FW:653.13.I USB FW:7.3] on usb-0000:00:1d.1-2
usbcore: registered new interface driver usbhid
usbhid: v2.6:USB HID core driver
nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Plase use
nf_conntrack.acct=1 kernel paramater, acct=1 nf_conntrack module option or
sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
ip_tables: (C) 2000-2006 Netfilter Core Team
TCP cubic registered
Initializing XFRM netlink socket
NET: Registered protocol family 17
Using IPI No-Shortcut mode
registered taskstats version 1
  Magic number: 5:238:23
Freeing unused kernel memory: 424k freed
Write protecting the kernel text: 2800k
Write protecting the kernel read-only data: 1196k
[drm] Initialized drm 1.1.0 20060810
pci 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
pci 0000:01:00.0: setting latency timer to 64
[drm] Initialized radeon 1.29.0 20080528 on minor 0
SGI XFS with ACLs, security attributes, large block numbers, no debug enabled
SGI XFS Quota Management subsystem
md: raid1 personality registered for level 1
xor: automatically using best checksumming function: pIII_sse
   pIII_sse  :  7336.000 MB/sec
xor: using function: pIII_sse (7336.000 MB/sec)
async_tx: api initialized (sync-only)
raid6: int32x1    726 MB/s
raid6: int32x2    777 MB/s
raid6: int32x4    566 MB/s
raid6: int32x8    542 MB/s
raid6: mmxx1     2570 MB/s
raid6: mmxx2     2550 MB/s
raid6: sse1x1    1746 MB/s
raid6: sse1x2    2195 MB/s
raid6: sse2x1    3218 MB/s
raid6: sse2x2    3414 MB/s
raid6: using algorithm sse2x2 (3414 MB/s)
md: raid6 personality registered for level 6
md: raid5 personality registered for level 5
md: raid4 personality registered for level 4
pata_pdc2027x 0000:06:00.0: version 1.0
pata_pdc2027x 0000:06:00.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21
pata_pdc2027x 0000:06:00.0: PLL input clock 16651 kHz
scsi8 : pata_pdc2027x
scsi9 : pata_pdc2027x
ata9: PATA max UDMA/100 mmio m16384@0xff9fc000 cmd 0xff9fd7c0 irq 21
ata10: PATA max UDMA/100 mmio m16384@0xff9fc000 cmd 0xff9fd5c0 irq 21
ata9.00: ATA-7: ST3320620A, 3.AAD, max UDMA/100
ata9.00: 625142448 sectors, multi 16: LBA48 
ata9.00: configured for UDMA/100
ata10.00: ATA-7: ST3320620A, 3.AAD, max UDMA/100
ata10.00: 625142448 sectors, multi 16: LBA48 
ata10.00: configured for UDMA/100
scsi 8:0:0:0: Direct-Access     ATA      ST3320620A       3.AA PQ: 0 ANSI: 5
sd 8:0:0:0: [sde] 625142448 512-byte hardware sectors (320073 MB)
sd 8:0:0:0: [sde] Write Protect is off
sd 8:0:0:0: [sde] Mode Sense: 00 3a 00 00
sd 8:0:0:0: [sde] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sd 8:0:0:0: [sde] 625142448 512-byte hardware sectors (320073 MB)
sd 8:0:0:0: [sde] Write Protect is off
sd 8:0:0:0: [sde] Mode Sense: 00 3a 00 00
sd 8:0:0:0: [sde] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
 sde: sde1 sde2 sde3
sd 8:0:0:0: [sde] Attached SCSI disk
sd 8:0:0:0: Attached scsi generic sg4 type 0
scsi 9:0:0:0: Direct-Access     ATA      ST3320620A       3.AA PQ: 0 ANSI: 5
sd 9:0:0:0: [sdf] 625142448 512-byte hardware sectors (320073 MB)
sd 9:0:0:0: [sdf] Write Protect is off
sd 9:0:0:0: [sdf] Mode Sense: 00 3a 00 00
sd 9:0:0:0: [sdf] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sd 9:0:0:0: [sdf] 625142448 512-byte hardware sectors (320073 MB)
sd 9:0:0:0: [sdf] Write Protect is off
sd 9:0:0:0: [sdf] Mode Sense: 00 3a 00 00
sd 9:0:0:0: [sdf] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
 sdf: sdf1 sdf2 sdf3
sd 9:0:0:0: [sdf] Attached SCSI disk
sd 9:0:0:0: Attached scsi generic sg5 type 0
md: md1 stopped.
md: bind<sde2>
md: bind<sdf2>
raid1: raid set md1 active with 2 out of 2 mirrors
md: md2 stopped.
md: bind<sde3>
md: bind<sdf3>
raid1: raid set md2 active with 2 out of 2 mirrors
XFS mounting filesystem md1
Ending clean XFS mount for filesystem: md1
SELinux:  Disabled at runtime.
SELinux:  Unregistering netfilter hooks
type=1404 audit(1259665380.625:2): selinux=0 auid=4294967295 ses=4294967295
udevd version 127 started
Bluetooth: Core ver 2.13
NET: Registered protocol family 31
Bluetooth: HCI device and connection manager initialized
Bluetooth: HCI socket layer initialized
i801_smbus 0000:00:1f.3: enabling device (0001 -> 0003)
i801_smbus 0000:00:1f.3: PCI INT C -> GSI 18 (level, low) -> IRQ 18
ACPI: I/O resource 0000:00:1f.3 [0x400-0x41f] conflicts with ACPI region SMRG [0x400-0x40f]
ACPI: Device needs an ACPI driver
input: PC Speaker as /devices/platform/pcspkr/input/input6
3c59x 0000:06:02.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
3c59x: Donald Becker and others.
0000:06:02.0: 3Com PCI 3c905C Tornado at f88bac00.
udev: renamed network interface eth0 to eth1
pata_jmicron 0000:02:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
pata_jmicron 0000:02:00.1: setting latency timer to 64
scsi10 : pata_jmicron
scsi11 : pata_jmicron
ata11: PATA max UDMA/100 cmd 0x9c00 ctl 0x9880 bmdma 0x9400 irq 17
ata12: PATA max UDMA/100 cmd 0x9800 ctl 0x9480 bmdma 0x9408 irq 17
iTCO_vendor_support: vendor-support=0
iTCO_wdt: Intel TCO WatchDog Timer Driver v1.03 (30-Apr-2008)
iTCO_wdt: Found a ICH8 or ICH8R TCO device (Version=2, TCOBASE=0x0860)
iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
Initializing USB Mass Storage driver...
scsi12 : SCSI emulation for USB Mass Storage devices
usbcore: registered new interface driver usb-storage
USB Mass Storage support registered.
usb-storage: device found at 2
usb-storage: waiting for device to settle before scanning
parport_pc 00:0a: reported by Plug and Play ACPI
parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
ata11.01: ATAPI: Optiarc DVD RW AD-7173A, 1-03, max UDMA/66
ata11.01: limited to UDMA/33 due to 40-wire cable
ata11.01: configured for UDMA/33
ppdev: user-space parallel port driver
Bluetooth: Generic Bluetooth USB driver ver 0.3
usbcore: registered new interface driver btusb
scsi 10:0:1:0: CD-ROM            Optiarc  DVD RW AD-7173A  1-03 PQ: 0 ANSI: 5
sr0: scsi3-mmc drive: 48x/48x writer dvd-ram cd/rw xa/form2 cdda tray
Uniform CD-ROM driver Revision: 3.20
sr 10:0:1:0: Attached scsi CD-ROM sr0
sr 10:0:1:0: Attached scsi generic sg6 type 5
sata_sil24 0000:04:00.0: version 1.1
sata_sil24 0000:04:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
sata_sil24 0000:04:00.0: setting latency timer to 64
scsi13 : sata_sil24
scsi14 : sata_sil24
ata13: SATA max UDMA/100 host m128@0xff8ffc00 port 0xff8f8000 irq 17
ata14: SATA max UDMA/100 host m128@0xff8ffc00 port 0xff8fa000 irq 17
HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
HDA Intel 0000:00:1b.0: setting latency timer to 64
ata13: SATA link up 3.0 Gbps (SStatus 123 SControl 0)
ata13.00: ATA-7: ST3400633AS, 3.AAD, max UDMA/133
ata13.00: 781422768 sectors, multi 16: LBA48 NCQ (depth 31/32)
ata13.00: configured for UDMA/100
ata14: SATA link down (SStatus 0 SControl 0)
scsi 13:0:0:0: Direct-Access     ATA      ST3400633AS      3.AA PQ: 0 ANSI: 5
sd 13:0:0:0: [sdg] 781422768 512-byte hardware sectors (400088 MB)
sd 13:0:0:0: [sdg] Write Protect is off
sd 13:0:0:0: [sdg] Mode Sense: 00 3a 00 00
sd 13:0:0:0: [sdg] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sd 13:0:0:0: [sdg] 781422768 512-byte hardware sectors (400088 MB)
sd 13:0:0:0: [sdg] Write Protect is off
sd 13:0:0:0: [sdg] Mode Sense: 00 3a 00 00
sd 13:0:0:0: [sdg] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
 sdg: sdg1
sd 13:0:0:0: [sdg] Attached SCSI disk
sd 13:0:0:0: Attached scsi generic sg7 type 0
r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded
r8169 0000:03:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
r8169 0000:03:00.0: setting latency timer to 64
r8169 0000:03:00.0: no MSI. Back to INTx.
eth0: RTL8168b/8111b at 0xf8a46000, 00:1b:fc:89:b9:04, XID 38000000 IRQ 19
md: md0 stopped.
md: bind<sde1>
md: bind<sdf1>
usb-storage: device scan complete
scsi 12:0:0:0: Direct-Access     Generic  USB SD Reader    1.00 PQ: 0 ANSI: 0
scsi 12:0:0:1: Direct-Access     Generic  USB CF Reader    1.01 PQ: 0 ANSI: 0
scsi 12:0:0:2: Direct-Access     Generic  USB SM Reader    1.02 PQ: 0 ANSI: 0
scsi 12:0:0:3: Direct-Access     Generic  USB MS Reader    1.03 PQ: 0 ANSI: 0
sd 12:0:0:0: [sdh] Attached SCSI removable disk
sd 12:0:0:0: Attached scsi generic sg8 type 0
sd 12:0:0:1: [sdi] Attached SCSI removable disk
sd 12:0:0:1: Attached scsi generic sg9 type 0
sd 12:0:0:2: [sdj] Attached SCSI removable disk
sd 12:0:0:2: Attached scsi generic sg10 type 0
sd 12:0:0:3: [sdk] Attached SCSI removable disk
sd 12:0:0:3: Attached scsi generic sg11 type 0
raid1: raid set md0 active with 2 out of 2 mirrors
device-mapper: multipath: version 1.0.5 loaded
kjournald starting.  Commit interval 5 seconds
EXT3 FS on md0, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
Adding 2096376k swap on /dev/md2.  Priority:-1 extents:1 across:2096376k
IA-32 Microcode Update Driver: v1.14a <tigran@aivazian.fsnet.co.uk>
firmware: requesting intel-ucode/06-0f-0d
firmware: requesting intel-ucode/06-0f-0d
microcode: CPU0 updated from revision 0xa1 to 0xa3, date = 08132007 
microcode: CPU1 updated from revision 0xa1 to 0xa3, date = 08132007 
NET: Registered protocol family 10
lo: Disabled Privacy Extensions
ip6_tables: (C) 2000-2006 Netfilter Core Team
r8169: eth0: link up
r8169: eth0: link up
eth1:  setting full-duplex.
eth0: no IPv6 routers present
w83627ehf: Found W83627DHG chip at 0x290
coretemp coretemp.0: Using relative temperature scale!
coretemp coretemp.1: Using relative temperature scale!
eth1: no IPv6 routers present
Bluetooth: L2CAP ver 2.11
Bluetooth: L2CAP socket layer initialized
Bluetooth: SCO (Voice Link) ver 0.6
Bluetooth: SCO socket layer initialized
Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Bluetooth: BNEP filters: protocol multicast
Bridge firewalling registered
Bluetooth: RFCOMM socket layer initialized
Bluetooth: RFCOMM TTY layer initialized
Bluetooth: RFCOMM ver 1.10
PPP generic driver version 2.4.2
NET: Registered protocol family 24
mtrr: type mismatch for c0000000,10000000 old: write-back new: write-combining
mtrr: base(0xc0000000) is not aligned on a size(0xfff8000) boundary
[drm] Setting GART location based on new memory map
[drm] Loading R500 Microcode
[drm] Num pipes: 1
[drm] writeback test succeeded in 1 usecs
fuse init (API version 7.9)
UDP: bad checksum. From 193.200.68.74:31682 to 78.107.252.206:6881 ulen 111
XFS mounting filesystem sdc1
Ending clean XFS mount for filesystem: sdc1
XFS mounting filesystem sdd1
Ending clean XFS mount for filesystem: sdd1
XFS mounting filesystem sda1
Starting XFS recovery on filesystem: sda1 (logdev: internal)
Ending XFS recovery on filesystem: sda1 (logdev: internal)
XFS mounting filesystem sdb1
Ending clean XFS mount for filesystem: sdb1
kjournald starting.  Commit interval 5 seconds
EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
EXT3 FS on sdg1, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
UDP: bad checksum. From 168.187.151.100:23784 to 78.107.252.206:6881 ulen 111
UDP: bad checksum. From 69.199.13.203:46792 to 78.107.252.206:6881 ulen 111
Comment 23 Geo 2009-12-01 09:57:10 UTC
after error next error, i am try:

[root@devpc /]# echo "- - -" > /sys/class/scsi_host/host0/scan

Dec  1 12:50:49 devpc kernel: end_request: I/O error, dev sda, sector 0
Dec  1 12:51:10 devpc kernel: ata1: hard resetting link
Dec  1 12:51:16 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Dec  1 12:51:20 devpc kernel: ata1: COMRESET failed (errno=-16)
Dec  1 12:51:20 devpc kernel: ata1: hard resetting link
Dec  1 12:51:26 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Dec  1 12:51:30 devpc kernel: ata1: COMRESET failed (errno=-16)
Dec  1 12:51:30 devpc kernel: ata1: hard resetting link
Dec  1 12:51:36 devpc kernel: ata1: link is slow to respond, please be patient (ready=0)
Dec  1 12:52:05 devpc kernel: ata1: COMRESET failed (errno=-16)
Dec  1 12:52:05 devpc kernel: ata1: limiting SATA link speed to 1.5 Gbps
Dec  1 12:52:05 devpc kernel: ata1: hard resetting link
Dec  1 12:52:10 devpc kernel: ata1: COMRESET failed (errno=-16)
Dec  1 12:52:10 devpc kernel: ata1: reset failed, giving up
Dec  1 12:52:10 devpc kernel: ata1: EH complete
Dec  1 12:52:10 devpc kernel: ata1.00: detaching (SCSI 0:0:0:0)
Dec  1 12:52:10 devpc kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Dec  1 12:52:10 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Dec  1 12:52:10 devpc kernel: sd 0:0:0:0: [sda] Stopping disk
Dec  1 12:52:10 devpc kernel: sd 0:0:0:0: [sda] START_STOP FAILED
Dec  1 12:52:10 devpc kernel: sd 0:0:0:0: [sda] Result: hostbyte=DID_BAD_TARGET driverbyte=DRIVER_OK,SUGGEST_OK
Comment 24 Tejun Heo 2009-12-01 10:02:11 UTC
The reallocated counter is 3285.  Disks usually don't report inflated reallocated counter.  I have no idea why vista didn't have any problem.  What's likely is those failed sectors are localized to certain region and vista just didn't really use the region.  Drive firmware wandering off to wonderland wouldn't be too surprising given the large amount of failed sectors.  Can you please run SMART extended test on it?  Maybe it will reveal something.  Anyways, for a drive hanging up on writes on a drive with high number of failed sectors, I'm afraid there's nothing much to do other than replacing the drive.

Thanks.
Comment 25 Tejun Heo 2009-12-01 10:02:38 UTC
Oh... and please "attach" long output files.  Don't paste them inline.
Comment 26 Geo 2009-12-01 10:41:53 UTC
> Can you please run SMART extended test on it?

smart tests no reports any errors.

> I'm afraid there's nothing much to do other than replacing the drive

i have 3 SATA drives on fist computer and 1 SATA on second (both computers based on different chipsets, diffenrent PSU etc..).

all 4 drives under linux reports absolutly same errors. 3 drives - samsung 1tb and 1 - seagate 80gb.
i need replace all 4 drives? all drives have same problem in one time olny under linux?

seagate not increment relocated sectors count value, but error occurs periodically with seagate drive. its not hdd or other hardware problem.
Comment 27 Tejun Heo 2009-12-01 11:04:40 UTC
I thought the error was localized to one drive.  Can you please attach output of smartctl -a on other drives too?  Also, you see the *same* failure on the seagate drive too?
Comment 28 Geo 2009-12-01 12:18:15 UTC
> Can you please attach output of smartctl -a on other drives too?

for other drives relocated sectors count > 0 and too many ECC recovery errors.

i can buy new harddrive... after copying big files to the new drive, i will see errors in log file and incremented values in smart table of this drive. it is checked up!

in the beginning i think that is hdd/mb or PSU problem.
i am check this problem on 4 motherboards with 5-7 samsung and seagate drives.
all motherboards based on Intel chipsets (965, P35, X58 etc) and manufacturing by Asus. results not good - same errors on all configurations.

> Also, you see the *same* failure on the seagate drive too?

yes.
Comment 29 Tejun Heo 2009-12-01 12:49:13 UTC
I'm sorry but I'm running out of ideas.  The thing is that intel ahci's are the most widely used driver, so your configuration isn't in any way special.  It's common configuration, so it's very unlikely that the problem you're reporting is a wide spread one.  If it were, I should have seen a lot of related reports by now from everywhere.  But, then again, if different drives from different vendors are failing in the same way, it's very unlikely to be a drive problem.  So, at this point, I really don't know what to think.

I'm afraid we would need more information and/or pattern to find out what's going on.  Please let me know if you notice something.

Thanks.

Note You need to log in before you can comment on or make changes to this bug.