Re: MCP55 NCQ problem? — Linux Kernel

CCing Peer Chen and Kuan Luo from NVIDIA..

Looks like there were some unrecognized FIS errors from the controllerin there?


Zoltan Boszormenyi wrote:

Hi,

I just got this with 2.6.22-rc2 + cfs-v13 + swncq patch:

ata2.00: exception Emask 0x0 SAct 0x6 SErr 0x0 action 0x2 frozen
ata2.00: cmd 61/18:08:0f:b7:68/00:00:16:00:00/40 tag 1 cdb 0x0 data12288 out
        res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
ata2.00: cmd 61/18:10:7f:b7:68/00:00:16:00:00/40 tag 2 cdb 0x0 data12288 out
        res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
ata2: hard resetting port
ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
ata2.00: ata_hpa_resize 1: sectors = 625142448, hpa_sectors = 625142448
ata2.00: ata_hpa_resize 1: sectors = 625142448, hpa_sectors = 625142448
ata2.00: configured for UDMA/133
ata2: EH pending after completion, repeating EH (cnt=4)
ata2: EH complete
sd 1:0:0:0: [sdb] 625142448 512-byte hardware sectors (320073 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'tsupport DPO or FUA
At the time I was creating a DVD ISO image (reads and writes went to thediskthat was resetted), browsing mail in thunderbird which also exercisedthe same
disk and I was downloading another ISO with about 400-450 kB/sec to
another disk. Here are the disks in question:
scsi 0:0:0:0: Direct-Access ATA SAMSUNG HD160JJ WU10 PQ: 0ANSI: 5scsi 1:0:0:0: Direct-Access ATA ST3320620AS 3.AA PQ: 0ANSI: 5
I got almost the same yesterday with 2.6.22-rc2-mm1:
May 29 12:44:20 localhost kernel: ata2.00: exception Emask 0x0 SAct 0x6SErr 0x0 action 0x2 frozenMay 29 12:44:20 localhost kernel: ata2.00: cmd61/10:08:2f:41:e9/00:00:07:00:00/40 tag 1 cdb 0x0 data 8192 outMay 29 12:44:20 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:44:20 localhost kernel: ata2.00: status: {DRDY }
May 29 12:44:20 localhost kernel: ata2.00: cmd61/30:10:8f:42:e9/00:00:07:00:00/40 tag 2 cdb 0x0 data 24576 outMay 29 12:44:20 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:44:20 localhost kernel: ata2.00: status: {DRDY }
May 29 12:44:20 localhost kernel: ata2: hard resetting port
May 29 12:44:21 localhost kernel: ata2: SATA link up 1.5 Gbps (SStatus113 SControl 300)May 29 12:44:21 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448May 29 12:44:21 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448
May 29 12:44:21 localhost kernel: ata2.00: configured for UDMA/133
May 29 12:44:21 localhost kernel: ata2: EH pending after completion,repeating EH (cnt=4)
May 29 12:44:21 localhost kernel: ata2: EH complete
May 29 12:44:21 localhost kernel: sd 1:0:0:0: [sdb] 625142448 512-bytehardware sectors (320073 MB)
May 29 12:44:21 localhost kernel: sd 1:0:0:0: [sdb] Write Protect is off
May 29 12:44:21 localhost kernel: sd 1:0:0:0: [sdb] Write cache:enabled, read cache: enabled, doesn't support DPO or FUA
..
May 29 12:47:46 localhost kernel: ata2.00: exception Emask 0x0 SAct 0x7SErr 0x0 action 0x2 frozenMay 29 12:47:46 localhost kernel: ata2.00: cmd61/08:00:27:5a:eb/00:00:07:00:00/40 tag 0 cdb 0x0 data 4096 outMay 29 12:47:46 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:47:46 localhost kernel: ata2.00: status: {DRDY }
May 29 12:47:46 localhost kernel: ata2.00: cmd61/08:08:bf:61:9e/00:00:0f:00:00/40 tag 1 cdb 0x0 data 4096 outMay 29 12:47:46 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:47:46 localhost kernel: ata2.00: status: {DRDY }
May 29 12:47:46 localhost kernel: ata2.00: cmd61/20:10:97:5a:eb/00:00:07:00:00/40 tag 2 cdb 0x0 data 16384 outMay 29 12:47:46 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:47:46 localhost kernel: ata2.00: status: {DRDY }
May 29 12:47:46 localhost kernel: ata2: hard resetting port
May 29 12:47:46 localhost kernel: ata2: SATA link up 1.5 Gbps (SStatus113 SControl 300)May 29 12:47:46 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448May 29 12:47:46 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448
May 29 12:47:47 localhost kernel: ata2.00: configured for UDMA/133
May 29 12:47:47 localhost kernel: ata2: EH pending after completion,repeating EH (cnt=4)
May 29 12:47:47 localhost kernel: ata2: EH complete
May 29 12:47:47 localhost kernel: sd 1:0:0:0: [sdb] 625142448 512-bytehardware sectors (320073 MB)
May 29 12:47:47 localhost kernel: sd 1:0:0:0: [sdb] Write Protect is off
May 29 12:47:47 localhost kernel: sd 1:0:0:0: [sdb] Write cache:enabled, read cache: enabled, doesn't support DPO or FUAMay 29 12:49:23 localhost kernel: ata2.00: exception Emask 0x0 SAct 0x6SErr 0x2000000 action 0x2 frozen
May 29 12:49:23 localhost kernel: ata2: SError: {UnrecFIS }
May 29 12:49:23 localhost kernel: ata2.00: cmd61/40:08:3f:71:fa/00:00:07:00:00/40 tag 1 cdb 0x0 data 32768 outMay 29 12:49:23 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:49:23 localhost kernel: ata2.00: status: {DRDY }
May 29 12:49:23 localhost kernel: ata2.00: cmd61/10:10:7f:e7:fa/00:00:07:00:00/40 tag 2 cdb 0x0 data 8192 outMay 29 12:49:23 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:49:23 localhost kernel: ata2.00: status: {DRDY }
May 29 12:49:23 localhost kernel: ata2: hard resetting port
May 29 12:49:24 localhost kernel: ata2: SATA link up 1.5 Gbps (SStatus113 SControl 300)May 29 12:49:24 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448May 29 12:49:24 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448
May 29 12:49:24 localhost kernel: ata2.00: configured for UDMA/133
May 29 12:49:24 localhost kernel: ata2: EH pending after completion,repeating EH (cnt=4)
May 29 12:49:24 localhost kernel: ata2: EH complete
May 29 12:49:24 localhost kernel: sd 1:0:0:0: [sdb] 625142448 512-bytehardware sectors (320073 MB)
May 29 12:49:24 localhost kernel: sd 1:0:0:0: [sdb] Write Protect is off
May 29 12:49:24 localhost kernel: sd 1:0:0:0: [sdb] Write cache:enabled, read cache: enabled, doesn't support DPO or FUAMay 29 12:50:24 localhost kernel: ata2.00: NCQ disabled due to excessiveerrorsMay 29 12:50:24 localhost kernel: ata2.00: exception Emask 0x0 SAct 0x6SErr 0x0 action 0x2 frozenMay 29 12:50:24 localhost kernel: ata2.00: cmd61/10:08:c7:88:b8/00:00:0f:00:00/40 tag 1 cdb 0x0 data 8192 outMay 29 12:50:24 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:50:24 localhost kernel: ata2.00: status: {DRDY }
May 29 12:50:24 localhost kernel: ata2.00: cmd61/10:10:9f:8a:b8/00:00:0f:00:00/40 tag 2 cdb 0x0 data 8192 outMay 29 12:50:24 localhost kernel: res40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
May 29 12:50:24 localhost kernel: ata2.00: status: {DRDY }
May 29 12:50:24 localhost kernel: ata2: hard resetting port
May 29 12:50:25 localhost kernel: ata2: SATA link up 1.5 Gbps (SStatus113 SControl 300)May 29 12:50:25 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448May 29 12:50:25 localhost kernel: ata2.00: ata_hpa_resize: sectors =625142448, hpa_sectors = 625142448
May 29 12:50:25 localhost kernel: ata2.00: configured for UDMA/133
May 29 12:50:25 localhost kernel: ata2: EH pending after completion,repeating EH (cnt=4)
May 29 12:50:25 localhost kernel: ata2: EH complete
May 29 12:50:25 localhost kernel: sd 1:0:0:0: [sdb] 625142448 512-bytehardware sectors (320073 MB)
May 29 12:50:25 localhost kernel: sd 1:0:0:0: [sdb] Write Protect is off
May 29 12:50:25 localhost kernel: sd 1:0:0:0: [sdb] Write cache:enabled, read cache: enabled, doesn't support DPO or FUA
After the system disabled NCQ there weren't any more more ata resets
and the disks were working OK.

Strange thing is, when I have run PostgreSQL pgbench with 25 clients
on 2.6.22-rc2 + cfs-v13 + swncq (which clearly showed advanced transferrate)
I had no such problems. The PostgreSQL DB was also on ata2.00.

Best regards,
Zoltán Böszörményi

-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to [email protected]
More majordomo info at  http://vger.kernel.org/majordomo-info.html
Please read the FAQ at  http://www.tux.org/lkml/



--
Robert Hancock      Saskatoon, SK, Canada
To email, remove "nospam" from [email protected]
Home Page: http://www.roberthancock.com/

-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to [email protected]
More majordomo info at  http://vger.kernel.org/majordomo-info.html
Please read the FAQ at  http://www.tux.org/lkml/

Follow-Ups:
- RE: MCP55 NCQ problem?
  - From: "Peer Chen" <[email protected]>

Prev by Date: Re: [2.6.21.1] running powertop 1.5 for 10 seconds causes a kernel panic
Next by Date: Re: [PATCH] x86: Document the hotplug code is incompatible with x86 irq handling
Previous by thread: MCP55 NCQ problem?
Next by thread: RE: MCP55 NCQ problem?
Index(es):
- Date
- Thread

[Index of Archives] [Kernel Newbies] [Netfilter] [Bugtraq] [Photo] [Stuff] [Gimp] [Yosemite News] [MIPS Linux] [ARM Linux] [Linux Security] [Linux RAID] [Video 4 Linux] [Linux for the blind] [Linux Resources]