I've been slowly working to isolate the source-code at the root of this
error. The biggest problem I faced was the sheer number of errors
reported at boot-time swamped the kernel's log buffer (128KB by default)
and therefore I had no information about what was happening in the lead-
up to this.

Yesterday I built a new kernel with the kernel log buffer size increased
from 128KB to 1MB.

This is with Edgy Eft versions 2.6.17-10-generic and 2.6.17.14.

Using make menuconfig I changed the Kernel Hacking Kernel Log Buffer
size. I altered the log-buffer-shift parameter from 17 to 20. This is a
bit-shift value, so the buffer size is 2^X.

The entry in the kernel configuration file .config is
CONFIG_LOG_BUF_SHIFT.

Now finally I have the kernel messages leading up to bug:

[17179576.612000] AMD7441: IDE controller at PCI slot 0000:00:07.1
[17179576.612000] AMD7441: chipset revision 4
[17179576.612000] AMD7441: not 100% native mode: will probe irqs later
[17179576.612000] AMD7441: 0000:00:07.1 (rev 04) UDMA100 controller
[17179576.612000]     ide0: BM-DMA at 0xd800-0xd807, BIOS settings: hda:DMA, 
hdb:DMA
[17179576.612000]     ide1: BM-DMA at 0xd808-0xd80f, BIOS settings: hdc:DMA, 
hdd:DMA
[17179576.612000] Probing IDE interface ide0...
[17179576.900000] hda: Maxtor 6Y120L0, ATA DISK drive
[17179577.180000] hdb: Maxtor 6Y060L0, ATA DISK drive
[17179577.236000] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
[17179577.236000] Probing IDE interface ide1...
[17179577.972000] hdc: PIONEER DVD-RW DVR-109, ATAPI CD/DVD-ROM drive
[17179578.756000] hdd: PIONEER DVD-RW DVR-103, ATAPI CD/DVD-ROM drive
[17179578.812000] ide1 at 0x170-0x177,0x376 on irq 15
[17179578.824000] hda: max request size: 128KiB
[17179578.832000] hda: 240121728 sectors (122942 MB) w/2048KiB Cache, 
CHS=65535/16/63, UDMA(100)
[17179578.836000] hda: cache flushes supported
[17179578.836000]  hda: hda1 hda2 hda3 < hda5 hda6 hda7 hda8 >
[17179578.884000] hdb: max request size: 128KiB
[17179578.884000] hdb: 120103200 sectors (61492 MB) w/2048KiB Cache, 
CHS=65535/16/63, UDMA(100)
[17179578.884000] hdb: cache flushes supported
[17179578.884000]  hdb: hdb1
[17179578.888000] hdc: ATAPI 40X DVD-ROM DVD-R CD-R/RW drive, 2000kB Cache, 
UDMA(66)
[17179578.888000] Uniform CD-ROM driver Revision: 3.20
[17179578.912000] hdd: ATAPI 24X DVD-ROM DVD-R CD-R/RW drive, 2000kB Cache, DMA
[17179579.280000] PDC20271: IDE controller at PCI slot 0000:00:08.0
[17179579.280000] ACPI: PCI Interrupt 0000:00:08.0[A] -> GSI 20 (level, low) -> 
IRQ 169
[17179579.280000] PDC20271: chipset revision 2
[17179579.280000] PDC20271: ROM enabled at 0x88000000
[17179579.280000] PDC20271: 100% native mode on irq 169
[17179579.280000]     ide2: BM-DMA at 0xb000-0xb007, BIOS settings: hde:pio, 
hdf:pio
[17179579.280000]     ide3: BM-DMA at 0xb008-0xb00f, BIOS settings: hdg:pio, 
hdh:pio
[17179579.280000] Probing IDE interface ide2...
[17179579.572000] hde: Maxtor 6Y060L0, ATA DISK drive
[17179579.852000] hdf: Maxtor 6Y060L0, ATA DISK drive
[17179579.908000] ide2 at 0xd400-0xd407,0xd002 on irq 169
[17179579.908000] hde: max request size: 128KiB
[17179579.924000] hde: 120103200 sectors (61492 MB) w/2048KiB Cache, 
CHS=65535/16/63, UDMA(133)
[17179579.924000] hde: cache flushes supported
[17179579.924000]  hde: hde1 hde2 hde3 < >
[17179579.928000] hdf: max request size: 128KiB
[17179579.944000] hdf: 120103200 sectors (61492 MB) w/2048KiB Cache, 
CHS=65535/16/63, UDMA(133)
[17179579.944000] hdf: cache flushes supported
[17179579.944000]  hdf: unknown partition table
[17179579.952000] Probing IDE interface ide3...
[17179580.240000] hdg: Maxtor 6Y060L0, ATA DISK drive
[17179580.520000] hdh: Maxtor 6Y060L0, ATA DISK drive
[17179580.576000] ide3 at 0xb800-0xb807,0xb402 on irq 169
[17179580.576000] hdg: max request size: 128KiB
[17179580.592000] hdg: 120103200 sectors (61492 MB) w/2048KiB Cache, 
CHS=65535/16/63, UDMA(133)
[17179580.592000] hdg: cache flushes supported
[17179580.592000]  hdg: hdg1 hdg2 hdg3 < >
[17179580.616000] hdh: max request size: 128KiB
[17179580.632000] hdh: 120103200 sectors (61492 MB) w/2048KiB Cache, 
CHS=65535/16/63, UDMA(133)
[17179580.632000] hdh: cache flushes supported
[17179580.632000]  hdh: unknown partition table
[17179580.756000] hde: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.756000] hde: dma_intr: error=0x04 { DriveStatusError }
[17179580.756000] ide: failed opcode was: unknown
[17179580.756000] hde: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.756000] hde: dma_intr: error=0x04 { DriveStatusError }
[17179580.756000] ide: failed opcode was: unknown
[17179580.772000] hde: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.772000] hde: dma_intr: error=0x04 { DriveStatusError }
[17179580.772000] ide: failed opcode was: unknown
[17179580.772000] hde: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.772000] hde: dma_intr: error=0x04 { DriveStatusError }
[17179580.772000] ide: failed opcode was: unknown
[17179580.772000] hde: DMA disabled
[17179580.772000] hdf: DMA disabled
[17179580.772000] PDC202XX: Primary channel reset.
[17179580.820000] ide2: reset: success
[17179580.832000] hdg: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.832000] hdg: dma_intr: error=0x04 { DriveStatusError }
[17179580.832000] ide: failed opcode was: unknown
[17179580.832000] hdg: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.832000] hdg: dma_intr: error=0x04 { DriveStatusError }
[17179580.832000] ide: failed opcode was: unknown
[17179580.848000] hdg: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.848000] hdg: dma_intr: error=0x04 { DriveStatusError }
[17179580.848000] ide: failed opcode was: unknown
[17179580.848000] hdg: dma_intr: status=0x51 { DriveReady SeekComplete Error }
[17179580.848000] hdg: dma_intr: error=0x04 { DriveStatusError }
[17179580.848000] ide: failed opcode was: unknown
[17179580.848000] hdg: DMA disabled
[17179580.848000] hdh: DMA disabled
[17179580.848000] PDC202XX: Secondary channel reset.
[17179580.864000] hde: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179580.864000] hde: task_in_intr: error=0x04 { DriveStatusError }
[17179580.864000] ide: failed opcode was: unknown
[17179580.896000] ide3: reset: success
[17179580.896000] hde: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179580.896000] hde: task_in_intr: error=0x04 { DriveStatusError }
[17179580.896000] ide: failed opcode was: unknown
[17179580.932000] hdg: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179580.932000] hdg: task_in_intr: error=0x04 { DriveStatusError }
[17179580.932000] ide: failed opcode was: unknown
[17179580.956000] hde: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179580.956000] hde: task_in_intr: error=0x04 { DriveStatusError }
[17179580.956000] ide: failed opcode was: unknown
[17179580.964000] hdg: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179580.964000] hdg: task_in_intr: error=0x04 { DriveStatusError }
[17179580.964000] ide: failed opcode was: unknown
[17179580.988000] hde: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179580.988000] hde: task_in_intr: error=0x04 { DriveStatusError }
[17179580.988000] ide: failed opcode was: unknown
[17179580.988000] PDC202XX: Primary channel reset.
[17179581.008000] hdg: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179581.008000] hdg: task_in_intr: error=0x04 { DriveStatusError }
[17179581.008000] ide: failed opcode was: unknown
[17179581.036000] ide2: reset: success
[17179581.040000] hdg: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179581.040000] hdg: task_in_intr: error=0x04 { DriveStatusError }
[17179581.040000] ide: failed opcode was: unknown
[17179581.040000] PDC202XX: Secondary channel reset.
[17179581.088000] ide3: reset: success
[17179581.096000] hde: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179581.096000] hde: task_in_intr: error=0x04 { DriveStatusError }
[17179581.096000] ide: failed opcode was: unknown
[17179581.096000] end_request: I/O error, dev hde, sector 135202804
[17179581.096000] Buffer I/O error on device hde2, logical block 21510976
[17179581.124000] hdg: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179581.124000] hdg: task_in_intr: error=0x04 { DriveStatusError }
[17179581.124000] ide: failed opcode was: unknown
[17179581.124000] end_request: I/O error, dev hdg, sector 135202804
[17179581.124000] Buffer I/O error on device hdg2, logical block 21510976
[17179581.132000] hde: task_in_intr: status=0x59 { DriveReady SeekComplete 
DataRequest Error }
[17179581.132000] hde: task_in_intr: error=0x04 { DriveStatusError }
[17179581.132000] ide: failed opcode was: unknown[/code]

-- 
Disk Read Errors during boot-time probe of physical softRAID drives
https://launchpad.net/bugs/77734

-- 
ubuntu-bugs mailing list
ubuntu-bugs@lists.ubuntu.com
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs

Reply via email to