long boot due to ata recognition problems [SOLVED]

gajo · 2008-04-13 09:06:18

As the message says my boot is taking about 10 minutes, of which 95% of the time is spent trying to recognize ata4 device.
I'm using the x86_64 version of arch, which works just fine on my laptop, and on my desktop - when it boots that is.
Another thing that puzzles me is how am I getting those errors, considering I don't really have 4 ata drives, yet only two - hard disk and dvd rom.
Anyway, this is my dmesg output :

Linux version 2.6.24-ARCH (root@artin) (gcc version 4.3.0 (GCC) ) #1 SMP PREEMPT Sun Mar 30 10:50:22 CEST 2008
Command line: root=/dev/sda1 ro vga=791
BIOS-provided physical RAM map:
 BIOS-e820: 0000000000000000 - 000000000009f000 (usable)
 BIOS-e820: 000000000009f000 - 00000000000a0000 (reserved)
 BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
 BIOS-e820: 0000000000100000 - 000000007fee0000 (usable)
 BIOS-e820: 000000007fee0000 - 000000007fee3000 (ACPI NVS)
 BIOS-e820: 000000007fee3000 - 000000007fef0000 (ACPI data)
 BIOS-e820: 000000007fef0000 - 000000007ff00000 (reserved)
 BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved)
 BIOS-e820: 00000000fec00000 - 0000000100000000 (reserved)
Entering add_active_range(0, 0, 159) 0 entries of 256 used
Entering add_active_range(0, 256, 524000) 1 entries of 256 used
end_pfn_map = 1048576
DMI 2.4 present.
ACPI: RSDP 000F9210, 0014 (r0 IntelR)
ACPI: RSDT 7FEE3040, 003C (r1 IntelR AWRDACPI 42302E31 AWRD        0)
ACPI: FACP 7FEE30C0, 0074 (r1 IntelR AWRDACPI 42302E31 AWRD        0)
ACPI: DSDT 7FEE3180, 4BB6 (r1 INTELR AWRDACPI     1000 MSFT  100000E)
ACPI: FACS 7FEE0000, 0040
ACPI: HPET 7FEE7E80, 0038 (r1 IntelR AWRDACPI 42302E31 AWRD       98)
ACPI: MCFG 7FEE7F00, 003C (r1 IntelR AWRDACPI 42302E31 AWRD        0)
ACPI: APIC 7FEE7D80, 0084 (r1 IntelR AWRDACPI 42302E31 AWRD        0)
ACPI: SSDT 7FEE7F80, 015C (r1  PmRef  Cpu0Ist     3000 INTL 20060912)
ACPI: SSDT 7FEE8410, 02F1 (r1  PmRef    CpuPm     3000 INTL 20040311)
Entering add_active_range(0, 0, 159) 0 entries of 256 used
Entering add_active_range(0, 256, 524000) 1 entries of 256 used
Zone PFN ranges:
  DMA             0 ->     4096
  DMA32        4096 ->  1048576
  Normal    1048576 ->  1048576
Movable zone start PFN for each node
early_node_map[2] active PFN ranges
    0:        0 ->      159
    0:      256 ->   524000
On node 0 totalpages: 523903
  DMA zone: 56 pages used for memmap
  DMA zone: 1354 pages reserved
  DMA zone: 2589 pages, LIFO batch:0
  DMA32 zone: 7108 pages used for memmap
  DMA32 zone: 512796 pages, LIFO batch:31
  Normal zone: 0 pages used for memmap
  Movable zone: 0 pages used for memmap
ACPI: PM-Timer IO Port: 0x408
ACPI: Local APIC address 0xfee00000
ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
Processor #0 (Bootup-CPU)
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
Processor #1
ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] disabled)
ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] disabled)
ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1])
ACPI: IOAPIC (id[0x04] address[0xfec00000] gsi_base[0])
IOAPIC[0]: apic_id 4, 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.
Setting APIC routing to flat
ACPI: HPET id: 0x10b9a201 base: 0xfed00000
Using ACPI (MADT) for SMP configuration information
swsusp: Registered nosave memory region: 000000000009f000 - 00000000000a0000
swsusp: Registered nosave memory region: 00000000000a0000 - 00000000000f0000
swsusp: Registered nosave memory region: 00000000000f0000 - 0000000000100000
Allocating PCI resources starting at 80000000 (gap: 7ff00000:60100000)
SMP: Allowing 4 CPUs, 2 hotplug CPUs
PERCPU: Allocating 33200 bytes of per cpu data
Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 515385
Kernel command line: root=/dev/sda1 ro vga=791
Initializing CPU#0
PID hash table entries: 4096 (order: 12, 32768 bytes)
hpet clockevent registered
TSC calibrated against HPET
time.c: Detected 2395.908 MHz processor.
Console: colour dummy device 80x25
console [tty0] enabled
Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
Checking aperture...
Calgary: detecting Calgary via BIOS EBDA area
Calgary: Unable to locate Rio Grande table in EBDA - bailing!
Memory: 2057296k/2096000k available (2958k kernel code, 38092k reserved, 1092k data, 248k init)
SLUB: Genslabs=11, HWalign=64, Order=0-1, MinObjects=4, CPUs=4, Nodes=1
Calibrating delay using timer specific routine.. 4796.31 BogoMIPS (lpj=7990897)
Security Framework initialized
Capability LSM initialized
Mount-cache hash table entries: 256
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 4096K
using mwait in idle threads.
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 0
CPU0: Thermal monitoring enabled (TM1)
SMP alternatives: switching to UP code
Early unpacking initramfs... done
ACPI: Core revision 20070126
ACPI: Looking for DSDT in initramfs... error, file /DSDT.aml not found.
Using local APIC timer interrupts.
APIC timer calibration result 16638250
Detected 16.638 MHz APIC timer.
SMP alternatives: switching to SMP code
Booting processor 1/2 APIC 0x1
Initializing CPU#1
Calibrating delay using timer specific routine.. 4793.45 BogoMIPS (lpj=7986329)
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 4096K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 1
CPU1: Thermal monitoring enabled (TM2)
Intel(R) Core(TM)2 CPU          6600  @ 2.40GHz stepping 06
checking TSC synchronization [CPU#0 -> CPU#1]: passed.
Brought up 2 CPUs
net_namespace: 120 bytes
NET: Registered protocol family 16
ACPI: bus type pci registered
PCI: Using MMCONFIG at e0000000 - efffffff
ACPI: EC: Look up EC in DSDT
ACPI: Interpreter enabled
ACPI: (supports S0 S1 S4 S5)
ACPI: Using IOAPIC for interrupt routing
ACPI: PCI Root Bridge [PCI0] (0000:00)
PCI quirk: region 0400-047f claimed by ICH6 ACPI/GPIO/TCO
PCI quirk: region 0480-04bf claimed by ICH6 GPIO
PCI: Transparent bridge - 0000:00:1e.0
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX0._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.HUB0._PRT]
ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 7 9 *10 11 14 15)
ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 7 9 *10 11 14 15)
ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 7 9 10 *11 14 15)
ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 7 9 10 *11 14 15)
ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 7 9 10 11 14 15) *0, disabled.
ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 *5 7 9 10 11 14 15)
ACPI: PCI Interrupt Link [LNK0] (IRQs 3 4 5 7 *9 10 11 14 15)
ACPI: PCI Interrupt Link [LNK1] (IRQs 3 4 5 7 9 10 11 14 15) *0, disabled.
Linux Plug and Play Support v0.97 (c) Adam Belay
pnp: PnP ACPI init
ACPI: bus type pnp registered
pnp: PnP ACPI: found 16 devices
ACPI: ACPI bus type pnp unregistered
SCSI subsystem initialized
PCI: Using ACPI for IRQ routing
PCI: If a device doesn't work, try "pci=routeirq".  If it helps, post a report
NetLabel: Initializing
NetLabel:  domain hash size = 128
NetLabel:  protocols = UNLABELED CIPSOv4
NetLabel:  unlabeled traffic allowed by default
PCI-GART: No AMD northbridge found.
ACPI: RTC can wake from S4
Time: tsc clocksource has been installed.
system 00:01: ioport range 0x4d0-0x4d1 has been reserved
system 00:01: ioport range 0xa00-0xa7f has been reserved
system 00:01: ioport range 0x880-0x88f has been reserved
system 00:0c: ioport range 0x400-0x4bf could not be reserved
system 00:0e: iomem range 0xe0000000-0xefffffff could not be reserved
system 00:0f: iomem range 0xf0000-0xfffff could not be reserved
system 00:0f: iomem range 0xfed00000-0xfed000ff has been reserved
system 00:0f: iomem range 0x7fee0000-0x7fefffff could not be reserved
system 00:0f: iomem range 0x0-0x9ffff could not be reserved
system 00:0f: iomem range 0x100000-0x7fedffff could not be reserved
system 00:0f: iomem range 0xfec00000-0xfec00fff has been reserved
system 00:0f: iomem range 0xfed14000-0xfed1dfff has been reserved
system 00:0f: iomem range 0xfed20000-0xfed9ffff has been reserved
system 00:0f: iomem range 0xfee00000-0xfee00fff could not be reserved
system 00:0f: iomem range 0xffb00000-0xffb7ffff has been reserved
system 00:0f: iomem range 0xfff00000-0xffffffff has been reserved
system 00:0f: iomem range 0xe0000-0xeffff has been reserved
PCI: Bridge: 0000:00:01.0
  IO window: d000-dfff
  MEM window: fa000000-fcffffff
  PREFETCH window: d0000000-dfffffff
PCI: Bridge: 0000:00:1c.0
  IO window: b000-bfff
  MEM window: fdb00000-fdbfffff
  PREFETCH window: fdc00000-fdcfffff
PCI: Bridge: 0000:00:1e.0
  IO window: c000-cfff
  MEM window: fde00000-fdefffff
  PREFETCH window: fdd00000-fddfffff
ACPI: PCI Interrupt 0000:00:01.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:01.0 to 64
ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:1c.0 to 64
PCI: Setting latency timer of device 0000:00:1e.0 to 64
NET: Registered protocol family 2
IP route cache hash table entries: 65536 (order: 7, 524288 bytes)
TCP established hash table entries: 262144 (order: 10, 4194304 bytes)
TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
TCP: Hash tables configured (established 262144 bind 65536)
TCP reno registered
checking if image is initramfs... it is
Freeing initrd memory: 690k freed
VFS: Disk quotas dquot_6.5.1
Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
io scheduler noop registered
io scheduler anticipatory registered
io scheduler deadline registered
io scheduler cfq registered (default)
Boot video device is 0000:01:00.0
PCI: Setting latency timer of device 0000:00:01.0 to 64
assign_interrupt_mode Found MSI capability
Allocate Port Service[0000:00:01.0:pcie00]
Allocate Port Service[0000:00:01.0:pcie03]
PCI: Setting latency timer of device 0000:00:1c.0 to 64
assign_interrupt_mode Found MSI capability
Allocate Port Service[0000:00:1c.0:pcie00]
Allocate Port Service[0000:00:1c.0:pcie02]
Allocate Port Service[0000:00:1c.0:pcie03]
vesafb: framebuffer at 0xd0000000, mapped to 0xffffc20010100000, using 3072k, total 262144k
vesafb: mode is 1024x768x16, linelength=2048, pages=1
vesafb: scrolling: redraw
vesafb: Truecolor: size=0:5:6:5, shift=0:11:5:0
Console: switching to colour frame buffer device 128x48
fb0: VESA VGA frame buffer device
Linux agpgart interface v0.102
Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled
serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
00:08: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
00:09: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
RAMDISK driver initialized: 16 RAM disks of 16384K size 1024 blocksize
loop: module loaded
input: Macintosh mouse button emulation as /devices/virtual/input/input0
PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1
PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
serio: i8042 KBD port at 0x60,0x64 irq 1
mice: PS/2 mouse device common for all mice
input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
cpuidle: using governor ladder
cpuidle: using governor menu
TCP cubic registered
NET: Registered protocol family 1
NET: Registered protocol family 17
RPC: Registered udp transport module.
RPC: Registered tcp transport module.
Freeing unused kernel memory: 248k freed
libata version 3.00 loaded.
PCI: Enabling device 0000:02:00.1 (0000 -> 0001)
ACPI: PCI Interrupt 0000:02:00.1[b] -> GSI 17 (level, low) -> IRQ 17
Switched to high resolution mode on CPU 1
PCI: Setting latency timer of device 0000:02:00.1 to 64
scsi0 : pata_jmicron
Switched to high resolution mode on CPU 0
scsi1 : pata_jmicron
ata1: PATA max UDMA/100 cmd 0xbf00 ctl 0xbe00 bmdma 0xbb00 irq 17
ata2: PATA max UDMA/100 cmd 0xbd00 ctl 0xbc00 bmdma 0xbb08 irq 17
ata1.00: ATA-7: ST3200826A, 3.06, max UDMA/100
ata1.00: 390721968 sectors, multi 0: LBA48 
ata1.01: ATAPI: HL-DT-ST DVDRAM GSA-4120B, A101, max UDMA/33
ata1.00: configured for UDMA/100
ata1.01: configured for UDMA/33
scsi 0:0:0:0: Direct-Access     ATA      ST3200826A       3.06 PQ: 0 ANSI: 5
scsi 0:0:1:0: CD-ROM            HL-DT-ST DVDRAM GSA-4120B A101 PQ: 0 ANSI: 5
ahci 0000:02:00.0: version 3.0
ACPI: PCI Interrupt 0000:02:00.0[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 
PCI: Setting latency timer of device 0000:02:00.0 to 64
scsi2 : ahci
scsi3 : ahci
ata3: SATA max UDMA/133 abar m8192@0xfdbfe000 port 0xfdbfe100 irq 16
ata4: SATA max UDMA/133 abar m8192@0xfdbfe000 port 0xfdbfe180 irq 16
ata3: SATA link down (SStatus 0 SControl 300)
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 8 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: limiting SATA link speed to 1.5 Gbps
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata4.00: qc timeout (cmd 0xec)
ata4.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata4: failed to recover some devices, retrying in 5 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata4.00: qc timeout (cmd 0xec)
ata4.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata4: failed to recover some devices, retrying in 5 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata4.00: qc timeout (cmd 0xec)
ata4.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata4: failed to recover some devices, retrying in 5 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata_piix 0000:00:1f.2: version 2.12
ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]
ACPI: PCI Interrupt 0000:00:1f.2[b] -> GSI 19 (level, low) -> IRQ 19
PCI: Setting latency timer of device 0000:00:1f.2 to 64
scsi4 : ata_piix
scsi5 : ata_piix
ata5: SATA max UDMA/133 cmd 0xfa00 ctl 0xf900 bmdma 0xf600 irq 19
ata6: SATA max UDMA/133 cmd 0xf800 ctl 0xf700 bmdma 0xf608 irq 19
ata_piix 0000:00:1f.5: MAP [ P0 -- P1 -- ]
ACPI: PCI Interrupt 0000:00:1f.5[b] -> GSI 19 (level, low) -> IRQ 19
PCI: Setting latency timer of device 0000:00:1f.5 to 64
scsi6 : ata_piix
scsi7 : ata_piix
ata7: SATA max UDMA/133 cmd 0xf300 ctl 0xf200 bmdma 0xef00 irq 19
ata8: SATA max UDMA/133 cmd 0xf100 ctl 0xf000 bmdma 0xef08 irq 19
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
USB Universal Host Controller Interface driver v3.0
ACPI: PCI Interrupt 0000:00:1a.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:1a.0 to 64
uhci_hcd 0000:00:1a.0: UHCI Host Controller
uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
uhci_hcd 0000:00:1a.0: irq 16, io base 0x0000ff00
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1a.1[b] -> GSI 21 (level, low) -> IRQ 21
PCI: Setting latency timer of device 0000:00:1a.1 to 64
uhci_hcd 0000:00:1a.1: UHCI Host Controller
uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 2
uhci_hcd 0000:00:1a.1: irq 21, io base 0x0000fe00
usb usb2: configuration #1 chosen from 1 choice
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 23
PCI: Setting latency timer of device 0000:00:1d.0 to 64
uhci_hcd 0000:00:1d.0: UHCI Host Controller
uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 3
uhci_hcd 0000:00:1d.0: irq 23, io base 0x0000fd00
usb usb3: configuration #1 chosen from 1 choice
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1d.1[b] -> GSI 19 (level, low) -> IRQ 19
PCI: Setting latency timer of device 0000:00:1d.1 to 64
uhci_hcd 0000:00:1d.1: UHCI Host Controller
uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 4
uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000fc00
usb usb4: configuration #1 chosen from 1 choice
hub 4-0:1.0: USB hub found
hub 4-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 18
PCI: Setting latency timer of device 0000:00:1d.2 to 64
uhci_hcd 0000:00:1d.2: UHCI Host Controller
uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 5
uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000fb00
usb usb5: configuration #1 chosen from 1 choice
hub 5-0:1.0: USB hub found
hub 5-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1a.7[C] -> GSI 18 (level, low) -> IRQ 18
PCI: Setting latency timer of device 0000:00:1a.7 to 64
ehci_hcd 0000:00:1a.7: EHCI Host Controller
ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 6
PCI: cache line size of 32 is not supported by device 0000:00:1a.7
ehci_hcd 0000:00:1a.7: irq 18, io mem 0xfdfff000
usb 4-1: new low speed USB device using uhci_hcd and address 2
ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
usb usb6: configuration #1 chosen from 1 choice
hub 6-0:1.0: USB hub found
hub 6-0:1.0: 4 ports detected
ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 23
PCI: Setting latency timer of device 0000:00:1d.7 to 64
ehci_hcd 0000:00:1d.7: EHCI Host Controller
ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 7
PCI: cache line size of 32 is not supported by device 0000:00:1d.7
ehci_hcd 0000:00:1d.7: irq 23, io mem 0xfdffe000
usb 4-1: string descriptor 0 read error: -71
ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
usb usb7: configuration #1 chosen from 1 choice
hub 7-0:1.0: USB hub found
hub 7-0:1.0: 6 ports detected
usb 4-1: string descriptor 0 read error: -71
usb 4-1: configuration #1 chosen from 1 choice
usb 4-1: can't set config #1, error -71
usb 4-1: USB disconnect, address 2
Driver 'sd' needs updating - please use bus_type methods
sd 0:0:0:0: [sda] 390721968 512-byte hardware sectors (200050 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
Driver 'sr' needs updating - please use bus_type methods
sd 0:0:0:0: [sda] 390721968 512-byte hardware sectors (200050 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 sda2 sda3
sd 0:0:0:0: [sda] Attached SCSI disk
sr0: scsi3-mmc drive: 40x/40x writer dvd-ram cd/rw xa/form2 cdda tray
Uniform CD-ROM driver Revision: 3.20
sr 0:0:1:0: Attached scsi CD-ROM sr0
kjournald starting.  Commit interval 5 seconds
EXT3-fs: mounted filesystem with ordered data mode.
usb 4-1: new low speed USB device using uhci_hcd and address 3
usb 4-1: configuration #1 chosen from 1 choice
rtc_cmos 00:04: rtc core: registered rtc_cmos as rtc0
rtc0: alarms up to one month
r8169 Gigabit Ethernet driver 2.2LK loaded
ACPI: PCI Interrupt 0000:03:06.0[A] -> GSI 21 (level, low) -> IRQ 21
eth0: RTL8169sc/8110sc at 0xffffc20000024000, 00:16:17:b2:2b:11, XID 18000000 IRQ 21
ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 22 (level, low) -> IRQ 22
PCI: Setting latency timer of device 0000:00:1b.0 to 64
hda_codec: Unknown model for ALC883, trying auto-probe from BIOS...
input: Power Button (FF) as /devices/virtual/input/input2
ACPI: Power Button (FF) [PWRF]
input: Power Button (CM) as /devices/virtual/input/input3
ACPI: Power Button (CM) [PWRB]
ACPI: Fan [FAN] (on)
ACPI: SSDT 7FEE8380, 0087 (r1  PmRef  Cpu1Ist     3000 INTL 20060912)
ACPI Exception (processor_core-0816): AE_NOT_FOUND, Processor Device is not present [20070126]
ACPI Exception (processor_core-0816): AE_NOT_FOUND, Processor Device is not present [20070126]
ACPI: Thermal Zone [THRM] (43 C)
sd 0:0:0:0: Attached scsi generic sg0 type 0
sr 0:0:1:0: Attached scsi generic sg1 type 5
ACPI: PCI Interrupt 0000:00:1f.3[b] -> GSI 19 (level, low) -> IRQ 19
nvidia: module license 'NVIDIA' taints kernel.
PPP generic driver version 2.4.2
usbcore: registered new interface driver hiddev
input: Logitech USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:1d.1/usb4/4-1/4-1:1.0/input/input4
lp: driver loaded but no devices found
input,hidraw0: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:1d.1-1
usbcore: registered new interface driver usbhid
drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver
ppdev: user-space parallel port driver
ACPI: PCI Interrupt 0000:01:00.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:01:00.0 to 64
NVRM: loading NVIDIA UNIX x86_64 Kernel Module  169.12  Thu Feb 14 17:51:09 PST 2008
parport_pc 00:0a: reported by Plug and Play ACPI
parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
lp0: using parport0 (interrupt-driven).
EXT3 FS on sda1, internal journal
kjournald starting.  Commit interval 5 seconds
EXT3 FS on sda2, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
Adding 29294516k swap on /dev/sda3.  Priority:-1 extents:1 across:29294516k
r8169: eth0: link up
NET: Registered protocol family 10
lo: Disabled Privacy Extensions
eth0: no IPv6 routers present

That's the entire code, the part on which it holds on is :

ata4: classification failed
ata4: reset failed (errno=-22), retrying in 8 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: limiting SATA link speed to 1.5 Gbps
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata4.00: qc timeout (cmd 0xec)
ata4.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata4: failed to recover some devices, retrying in 5 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata4.00: qc timeout (cmd 0xec)
ata4.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata4: failed to recover some devices, retrying in 5 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata4.00: qc timeout (cmd 0xec)
ata4.00: failed to IDENTIFY (I/O error, err_mask=0x4)
ata4: failed to recover some devices, retrying in 5 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 10 secs
ata4: classification failed
ata4: reset failed (errno=-22), retrying in 35 secs
ata4: classfication failed, assuming ATA
ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 310)
ata_piix 0000:00:1f.2: version 2.12
ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]

Also I might add that on my first boot it didn't go this slow - I can't remember if I got the error or not though since I didn't pay attention.
I don't think it's necessarily a hardware issue, even though this PC had it's issues with linux - had to flash my bios just so grub would detect hard drives, this doesn't seem like one of those.
At least, I think it isn't since Mandriva booted just fine, and I don't think it's using a different kernel or some such, is it? Altough it was 32bit, but still, I find this quite odd.
Now if this really is an error, not just buggy software, is there a way to ignore the error - I mean it boots up eventually anyway, just takes a hell of a lot of time.

Last edited by gajo (2008-06-20 10:12:52)

kefir · 2008-04-13 11:15:18

http://bbs.archlinux.org/viewtopic.php?id=47041

And i return back into the darkness to search again.

Last edited by kefir (2008-04-13 12:08:01)

gajo · 2008-04-13 13:23:51

Ok, I'm too dumb to understand how that has anything to do with my problem, so if you could clarify it I guess I could google it eventually.

gajo · 2008-04-14 12:26:17

I remember in your first post you mentioned some sort of a disk check program, can you recommend any?

gajo · 2008-04-15 14:10:06

I've bought a new PATA cable, even tried meddling with master/slave pins on the hard disk, tried booting it as only device, but alas to no avail. I've also put the LBA mark on it in bios, it did nothing.
I'm running out of ideas, can anyone please suggest something - obviously not buying a new HD, it's not worth it. Perhaps I should do a different install or boot linux with different parameters. I don't have a RAID I think, it's marked as IDE in my bios, but I do seem to be using the jmicron technology. I haven't selected anything while doing the installation, and I'm not sure if I should have?

Next, you will be asked if you need support for booting from USB devices, FireWire devices, PCMCIA devices, NFS shares, software RAID arrays, LVM2 volumes, encrypted volumes, and DSDT support.

I don't think I qualify for any of those, so there is probably something else I might've missed.

gajo · 2008-04-26 19:13:57

A little update in hope someone out there might help out:
I've been trying out other distros, notably slackware (x86 version), knoppix (didn't get it to boot properly, only one attempt though), gentoo (didn't get it to boot the installation cd, and since i couldn't get knoppix up i gave up on it temporarily).
And of those I could get slackware to boot up without causing too much frustration to myself (LILO sucks).
What I noted though was, it's still giving me an error something like "ata4 softreset failed, retrying in 5 seconds", which causes a delay of perhaps 5 seconds, and continues booting normally afterwards.
I didn't notice any hardware malfunctions with it, so I'd really prefer to have arch boot like that instead of wasting 5-10mins on nothing.
Also, I obviously came back to arch, reinstalled it, and this time I actually payed attention to the first boot, and what I noticed was it gave me the same 5 second delay message slackware did, which is something I can live with.
However, after doing a pacman -Syu and updating the kernel (I guess that's what's slowing the boot down), it got back to the old slow 5-10min boot.

So my question is, what should I do now, try and make a custom kernel perhaps, downgrade that specific thing that's making it slow down?

praka123 · 2008-04-26 19:30:29

not much idea,still...did u have all pata and sata controllers enabled in BIOS?

MoonSwan · 2008-04-26 19:33:32

I have a similar issue, and unfortunately the only solution I came up with is to boot with the acpi=off kernel parameter. Try variations using that + noapic, irqpoll=off and maybe look at the mkinitcpio file for hints on how to disable the chip if its not actually in use.

gajo · 2008-06-10 08:59:55

I'm going to bring up this issue again, still haven't fixed it and it remains unsolved with the newest kernel.
The following links seem to have the same issue:
http://www.ubuntu-forum.net/showthread.php?t=765486
http://www.slackwarehelp.org/post-6750. … 194ecb9f80
http://www.archlinux.it/forum/viewtopic.php?pid=11632
http://www.linuxquestions.org/questions … 26-644368/

Some of those threads link to this one as well, pretty much all seem to be unresolved or lack any given solution.

One thing I noticed though, it seems that in nearly all cases the users report to have an MSI motherboard, coincidence? Hope so.
Any clues on how one might fix this? Facts are, the kernel boots eventually, always, and it works like there is no problem; the issue is that it takes it's time, about 5-10 times the amount it would be normally (or before 2.6.x). Note that in the old kernel the delay was only about 5 seconds or less, with just one error message.
Also, it seems to boot just fine in Windows, bit sad that Windows seems more stable/reliable eh?

So where to next? I really want to fix this. It seems Google can't spit out the solution, should I report a bug to the kernel devs and pray that they look it up? Or perhaps it might be feasible to just change the source code of the kernel so it doesn't try 4 times for 10, 10, 30 seconds yet only once for 1 second? Surely it would be a matter of a simple for loop, just a matter of finding it!

Please, even if you ain't got a solution to the particular issue, at least give me(and the people who google for the problem since this thread seems to be topping the results) an advice on what approach to take next, I'm fairly sure that everything can be fixed with common sense and a bit of C knowledge, only thing that's needed is a bit of experience.

gajo · 2008-06-16 15:30:33

Okay, finally managed to fix this problem, and here's how I did it.
I made a bug report and someone responded with a patch quite fast.
bug: http://bugzilla.kernel.org/process_bug.cgi
patch: http://bugzilla.kernel.org/attachment.c … ction=view
So simply get the patch, save it as a text file and patch your src/drivers/ata/ahci.c with it. (yes obviously you need to compile a custom kernel, it's really easy with ABS).
That's it, just works for me now.
Ahh, I made a lot bigger post describing in simple steps how to do it, then I accidentally closed the page so you won't be seeing that unfortunately.
PS: Anyone who wants to link this to some of the threads I mentioned before, especially the Ubuntu one, I'd be grateful, a bit lazy to go and make accounts just for that.

Arch Linux

#1 2008-04-13 09:06:18

long boot due to ata recognition problems [SOLVED]

#2 2008-04-13 11:15:18

Re: long boot due to ata recognition problems [SOLVED]

#3 2008-04-13 13:23:51

Re: long boot due to ata recognition problems [SOLVED]

#4 2008-04-14 12:26:17

Re: long boot due to ata recognition problems [SOLVED]

#5 2008-04-15 14:10:06

Re: long boot due to ata recognition problems [SOLVED]

#6 2008-04-26 19:13:57

Re: long boot due to ata recognition problems [SOLVED]

#7 2008-04-26 19:30:29

Re: long boot due to ata recognition problems [SOLVED]

#8 2008-04-26 19:33:32

Re: long boot due to ata recognition problems [SOLVED]

#9 2008-06-10 08:59:55

Re: long boot due to ata recognition problems [SOLVED]

#10 2008-06-16 15:30:33

Re: long boot due to ata recognition problems [SOLVED]

Board footer