2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Jeremy Fitzhardinge]

[-- Attachment #1: Type: text/plain, Size: 527 bytes --]

I have a ThinkPad X60 which uses the Intel 82801G HDA audio chip.  This 
used to work for me, but lately (sometime during 2.6.18-rcX series) it 
stopped working - programs trying to use it tend to just block forever 
waiting for /dev/dsp.

The only obvious symptom is:

    hda_intel: azx_get_response timeout, switching to single_cmd mode...

appearing in the kernel log when booting.

Details attached.  The dmesg output is for the FC6 distro kernel 
2.6.18-1.2689.fc6PAE, but I see the same symptoms with 2.6.18-mm1.

    J

[-- Attachment #2: asound-cards.txt --]
[-- Type: text/plain, Size: 97 bytes --]

 0 [Intel          ]: HDA-Intel - HDA Intel
                      HDA Intel at 0xee240000 irq 58

[-- Attachment #3: asound-devices.txt --]
[-- Type: text/plain, Size: 176 bytes --]

  2:        : timer
  3:        : sequencer
  4: [ 0- 1]: digital audio playback
  5: [ 0- 0]: digital audio playback
  6: [ 0- 0]: digital audio capture
  7: [ 0]   : control

[-- Attachment #4: asound-modules.txt --]
[-- Type: text/plain, Size: 17 bytes --]

 0 snd_hda_intel

[-- Attachment #5: config.txt --]
[-- Type: text/plain, Size: 7648 bytes --]

CONFIG_X86_32=y
CONFIG_GENERIC_TIME=y
CONFIG_LOCKDEP_SUPPORT=y
CONFIG_STACKTRACE_SUPPORT=y
CONFIG_SEMAPHORE_SLEEPERS=y
CONFIG_X86=y
CONFIG_MMU=y
CONFIG_GENERIC_IOMAP=y
CONFIG_GENERIC_HWEIGHT=y
CONFIG_ARCH_MAY_HAVE_PC_FDC=y
CONFIG_DMI=y
CONFIG_DEFCONFIG_LIST="/lib/modules/$UNAME_RELEASE/.config"
CONFIG_EXPERIMENTAL=y
CONFIG_LOCK_KERNEL=y
CONFIG_INIT_ENV_ARG_LIMIT=32
CONFIG_LOCALVERSION=""
CONFIG_LOCALVERSION_AUTO=y
CONFIG_SWAP=y
CONFIG_SWAP_PREFETCH=y
CONFIG_SYSVIPC=y
CONFIG_BSD_PROCESS_ACCT=y
CONFIG_AUDIT=y
CONFIG_AUDITSYSCALL=y
CONFIG_IKCONFIG=y
CONFIG_INITRAMFS_SOURCE=""
CONFIG_EMBEDDED=y
CONFIG_UID16=y
CONFIG_SYSCTL=y
CONFIG_KALLSYMS=y
CONFIG_KALLSYMS_ALL=y
CONFIG_HOTPLUG=y
CONFIG_PRINTK=y
CONFIG_BUG=y
CONFIG_ELF_CORE=y
CONFIG_BASE_FULL=y
CONFIG_FUTEX=y
CONFIG_EPOLL=y
CONFIG_SHMEM=y
CONFIG_SLAB=y
CONFIG_VM_EVENT_COUNTERS=y
CONFIG_RT_MUTEXES=y
CONFIG_BASE_SMALL=0
CONFIG_MODULES=y
CONFIG_MODULE_UNLOAD=y
CONFIG_MODVERSIONS=y
CONFIG_KMOD=y
CONFIG_STOP_MACHINE=y
CONFIG_BLOCK=y
CONFIG_IOSCHED_NOOP=y
CONFIG_IOSCHED_AS=y
CONFIG_IOSCHED_DEADLINE=y
CONFIG_IOSCHED_CFQ=y
CONFIG_DEFAULT_AS=y
CONFIG_DEFAULT_IOSCHED="anticipatory"
CONFIG_SMP=y
CONFIG_X86_PC=y
CONFIG_MPENTIUMIII=y
CONFIG_X86_CMPXCHG=y
CONFIG_X86_XADD=y
CONFIG_X86_L1_CACHE_SHIFT=5
CONFIG_RWSEM_XCHGADD_ALGORITHM=y
CONFIG_GENERIC_CALIBRATE_DELAY=y
CONFIG_X86_WP_WORKS_OK=y
CONFIG_X86_INVLPG=y
CONFIG_X86_BSWAP=y
CONFIG_X86_POPAD_OK=y
CONFIG_X86_CMPXCHG64=y
CONFIG_X86_GOOD_APIC=y
CONFIG_X86_INTEL_USERCOPY=y
CONFIG_X86_USE_PPRO_CHECKSUM=y
CONFIG_X86_TSC=y
CONFIG_HPET_TIMER=y
CONFIG_HPET_EMULATE_RTC=y
CONFIG_NR_CPUS=8
CONFIG_SCHED_MC=y
CONFIG_PREEMPT_NONE=y
CONFIG_PREEMPT_BKL=y
CONFIG_X86_LOCAL_APIC=y
CONFIG_X86_IO_APIC=y
CONFIG_X86_MCE=y
CONFIG_VM86=y
CONFIG_GENERIC_ISA_DMA=y
CONFIG_X86_MSR=y
CONFIG_X86_CPUID=y
CONFIG_EDD=y
CONFIG_DCDBAS=m
CONFIG_HIGHMEM4G=y
CONFIG_VMSPLIT_3G=y
CONFIG_PAGE_OFFSET=0xC0000000
CONFIG_HIGHMEM=y
CONFIG_ARCH_FLATMEM_ENABLE=y
CONFIG_ARCH_SPARSEMEM_ENABLE=y
CONFIG_ARCH_SELECT_MEMORY_MODEL=y
CONFIG_ARCH_POPULATES_NODE_MAP=y
CONFIG_SELECT_MEMORY_MODEL=y
CONFIG_FLATMEM_MANUAL=y
CONFIG_FLATMEM=y
CONFIG_FLAT_NODE_MEM_MAP=y
CONFIG_SPARSEMEM_STATIC=y
CONFIG_SPLIT_PTLOCK_CPUS=4
CONFIG_ZONE_DMA=y
CONFIG_ADAPTIVE_READAHEAD=y
CONFIG_IRQBALANCE=y
CONFIG_SECCOMP=y
CONFIG_HZ_250=y
CONFIG_HZ=250
CONFIG_PHYSICAL_START=0x100000
CONFIG_HOTPLUG_CPU=y
CONFIG_COMPAT_VDSO=y
CONFIG_ARCH_ENABLE_MEMORY_HOTPLUG=y
CONFIG_PM=y
CONFIG_PM_LEGACY=y
CONFIG_SOFTWARE_SUSPEND=y
CONFIG_PM_STD_PARTITION=""
CONFIG_SUSPEND_SMP=y
CONFIG_CPU_FREQ=y
CONFIG_CPU_FREQ_TABLE=y
CONFIG_CPU_FREQ_STAT=y
CONFIG_CPU_FREQ_DEFAULT_GOV_PERFORMANCE=y
CONFIG_CPU_FREQ_GOV_PERFORMANCE=y
CONFIG_X86_P4_CLOCKMOD=m
CONFIG_X86_SPEEDSTEP_LIB=m
CONFIG_PCI=y
CONFIG_PCI_GOANY=y
CONFIG_PCI_BIOS=y
CONFIG_PCI_DIRECT=y
CONFIG_ISA_DMA_API=y
CONFIG_ISA=y
CONFIG_EISA=y
CONFIG_EISA_PCI_EISA=y
CONFIG_EISA_VIRTUAL_ROOT=y
CONFIG_EISA_NAMES=y
CONFIG_HOTPLUG_PCI=y
CONFIG_BINFMT_ELF=y
CONFIG_BINFMT_AOUT=y
CONFIG_BINFMT_MISC=y
CONFIG_NET=y
CONFIG_PACKET=y
CONFIG_PACKET_MMAP=y
CONFIG_UNIX=y
CONFIG_XFRM=y
CONFIG_NET_KEY=y
CONFIG_INET=y
CONFIG_IP_FIB_HASH=y
CONFIG_INET_XFRM_MODE_TRANSPORT=y
CONFIG_INET_XFRM_MODE_TUNNEL=y
CONFIG_INET_DIAG=y
CONFIG_INET_TCP_DIAG=y
CONFIG_TCP_CONG_BIC=y
CONFIG_BRIDGE=y
CONFIG_LLC=y
CONFIG_PREVENT_FIRMWARE_BUILD=y
CONFIG_FW_LOADER=y
CONFIG_CONNECTOR=y
CONFIG_PROC_EVENTS=y
CONFIG_PNP=y
CONFIG_PNP_DEBUG=y
CONFIG_ISAPNP=y
CONFIG_PNPBIOS=y
CONFIG_BLK_DEV_FD=y
CONFIG_BLK_DEV_LOOP=y
CONFIG_BLK_DEV_CRYPTOLOOP=y
CONFIG_BLK_DEV_RAM=y
CONFIG_BLK_DEV_RAM_COUNT=16
CONFIG_BLK_DEV_RAM_SIZE=4000
CONFIG_BLK_DEV_RAM_BLOCKSIZE=1024
CONFIG_BLK_DEV_INITRD=y
CONFIG_IDE=y
CONFIG_IDE_MAX_HWIFS=4
CONFIG_BLK_DEV_IDE=y
CONFIG_BLK_DEV_IDEDISK=y
CONFIG_IDEDISK_MULTI_MODE=y
CONFIG_BLK_DEV_IDECD=y
CONFIG_BLK_DEV_IDEPCI=y
CONFIG_IDEPCI_SHARE_IRQ=y
CONFIG_BLK_DEV_GENERIC=y
CONFIG_BLK_DEV_IDEDMA_PCI=y
CONFIG_IDEDMA_PCI_AUTO=y
CONFIG_BLK_DEV_PIIX=y
CONFIG_BLK_DEV_IDEDMA=y
CONFIG_IDEDMA_AUTO=y
CONFIG_SCSI=y
CONFIG_SCSI_NETLINK=y
CONFIG_SCSI_PROC_FS=y
CONFIG_BLK_DEV_SD=y
CONFIG_BLK_DEV_SR=y
CONFIG_CHR_DEV_SG=y
CONFIG_SCSI_SPI_ATTRS=y
CONFIG_SCSI_FC_ATTRS=y
CONFIG_ATA=y
CONFIG_SATA_AHCI=y
CONFIG_SATA_INTEL_COMBINED=y
CONFIG_NETDEVICES=y
CONFIG_DUMMY=y
CONFIG_NET_ETHERNET=y
CONFIG_MII=y
CONFIG_NET_VENDOR_3COM=y
CONFIG_EL3=m
CONFIG_VORTEX=m
CONFIG_NET_PCI=y
CONFIG_E100=y
CONFIG_R8169=y
CONFIG_NETCONSOLE=y
CONFIG_NETPOLL=y
CONFIG_NETPOLL_RX=y
CONFIG_NETPOLL_TRAP=y
CONFIG_NET_POLL_CONTROLLER=y
CONFIG_INPUT=y
CONFIG_INPUT_MOUSEDEV=y
CONFIG_INPUT_MOUSEDEV_PSAUX=y
CONFIG_INPUT_MOUSEDEV_SCREEN_X=1024
CONFIG_INPUT_MOUSEDEV_SCREEN_Y=768
CONFIG_INPUT_KEYBOARD=y
CONFIG_KEYBOARD_ATKBD=y
CONFIG_INPUT_MOUSE=y
CONFIG_MOUSE_PS2=y
CONFIG_SERIO=y
CONFIG_SERIO_I8042=y
CONFIG_SERIO_SERPORT=y
CONFIG_SERIO_LIBPS2=y
CONFIG_GAMEPORT=y
CONFIG_VT=y
CONFIG_VT_CONSOLE=y
CONFIG_HW_CONSOLE=y
CONFIG_SERIAL_8250=y
CONFIG_SERIAL_8250_PCI=y
CONFIG_SERIAL_8250_PNP=y
CONFIG_SERIAL_8250_NR_UARTS=4
CONFIG_SERIAL_8250_RUNTIME_UARTS=4
CONFIG_SERIAL_CORE=y
CONFIG_UNIX98_PTYS=y
CONFIG_LEGACY_PTYS=y
CONFIG_LEGACY_PTY_COUNT=256
CONFIG_RTC=y
CONFIG_AGP=y
CONFIG_AGP_INTEL=y
CONFIG_RAW_DRIVER=m
CONFIG_MAX_RAW_DEVS=256
CONFIG_VIDEO_V4L2=y
CONFIG_FIRMWARE_EDID=y
CONFIG_VGA_CONSOLE=y
CONFIG_VIDEO_SELECT=y
CONFIG_DUMMY_CONSOLE=y
CONFIG_USB_ARCH_HAS_HCD=y
CONFIG_USB_ARCH_HAS_OHCI=y
CONFIG_USB_ARCH_HAS_EHCI=y
CONFIG_EDAC=y
CONFIG_EDAC_DEBUG=y
CONFIG_EDAC_MM_EDAC=y
CONFIG_EDAC_AMD76X=y
CONFIG_EDAC_E7XXX=y
CONFIG_EDAC_E752X=y
CONFIG_EDAC_I82875P=y
CONFIG_EDAC_I82860=y
CONFIG_EDAC_R82600=y
CONFIG_EDAC_POLL=y
CONFIG_EXT2_FS=y
CONFIG_EXT3_FS=y
CONFIG_JBD=y
CONFIG_JBD_DEBUG=y
CONFIG_FS_POSIX_ACL=y
CONFIG_INOTIFY=y
CONFIG_INOTIFY_USER=y
CONFIG_DNOTIFY=y
CONFIG_AUTOFS4_FS=y
CONFIG_ISO9660_FS=y
CONFIG_JOLIET=y
CONFIG_ZISOFS=y
CONFIG_ZISOFS_FS=y
CONFIG_UDF_FS=y
CONFIG_UDF_NLS=y
CONFIG_FAT_FS=y
CONFIG_MSDOS_FS=y
CONFIG_VFAT_FS=y
CONFIG_FAT_DEFAULT_CODEPAGE=437
CONFIG_FAT_DEFAULT_IOCHARSET="iso8859-1"
CONFIG_NTFS_FS=m
CONFIG_NTFS_DEBUG=y
CONFIG_PROC_FS=y
CONFIG_PROC_KCORE=y
CONFIG_PROC_SYSCTL=y
CONFIG_SYSFS=y
CONFIG_TMPFS=y
CONFIG_HUGETLBFS=y
CONFIG_HUGETLB_PAGE=y
CONFIG_RAMFS=y
CONFIG_NFS_FS=y
CONFIG_NFS_V3=y
CONFIG_NFS_V4=y
CONFIG_NFSD=y
CONFIG_NFSD_V3=y
CONFIG_NFSD_V4=y
CONFIG_NFSD_TCP=y
CONFIG_LOCKD=y
CONFIG_LOCKD_V4=y
CONFIG_EXPORTFS=y
CONFIG_NFS_COMMON=y
CONFIG_SUNRPC=y
CONFIG_SUNRPC_GSS=y
CONFIG_RPCSEC_GSS_KRB5=y
CONFIG_RPCSEC_GSS_SPKM3=m
CONFIG_MSDOS_PARTITION=y
CONFIG_NLS=y
CONFIG_NLS_DEFAULT="iso8859-1"
CONFIG_NLS_ASCII=m
CONFIG_PROFILING=y
CONFIG_TRACE_IRQFLAGS_SUPPORT=y
CONFIG_ENABLE_MUST_CHECK=y
CONFIG_MAGIC_SYSRQ=y
CONFIG_UNUSED_SYMBOLS=y
CONFIG_DEBUG_KERNEL=y
CONFIG_LOG_BUF_SHIFT=17
CONFIG_DETECT_SOFTLOCKUP=y
CONFIG_DEBUG_SLAB=y
CONFIG_DEBUG_SLAB_LEAK=y
CONFIG_DEBUG_RT_MUTEXES=y
CONFIG_DEBUG_PI_LIST=y
CONFIG_DEBUG_SPINLOCK=y
CONFIG_DEBUG_MUTEXES=y
CONFIG_DEBUG_SPINLOCK_SLEEP=y
CONFIG_DEBUG_LOCKING_API_SELFTESTS=y
CONFIG_DEBUG_HIGHMEM=y
CONFIG_DEBUG_BUGVERBOSE=y
CONFIG_DEBUG_INFO=y
CONFIG_DEBUG_FS=y
CONFIG_DEBUG_VM=y
CONFIG_FRAME_POINTER=y
CONFIG_FORCED_INLINING=y
CONFIG_DEBUG_STACKOVERFLOW=y
CONFIG_DEBUG_STACK_USAGE=y
CONFIG_DEBUG_RODATA=y
CONFIG_X86_FIND_SMP_CONFIG=y
CONFIG_X86_MPPARSE=y
CONFIG_DOUBLEFAULT=y
CONFIG_CRYPTO=y
CONFIG_CRYPTO_ALGAPI=y
CONFIG_CRYPTO_BLKCIPHER=m
CONFIG_CRYPTO_MANAGER=m
CONFIG_CRYPTO_MD5=y
CONFIG_CRYPTO_ECB=m
CONFIG_CRYPTO_CBC=m
CONFIG_CRYPTO_DES=y
CONFIG_CRYPTO_CAST5=m
CONFIG_CRC_CCITT=m
CONFIG_CRC32=y
CONFIG_AUDIT_GENERIC=y
CONFIG_ZLIB_INFLATE=y
CONFIG_PLIST=y
CONFIG_GENERIC_HARDIRQS=y
CONFIG_GENERIC_IRQ_PROBE=y
CONFIG_GENERIC_PENDING_IRQ=y
CONFIG_X86_SMP=y
CONFIG_X86_HT=y
CONFIG_X86_BIOS_REBOOT=y
CONFIG_X86_TRAMPOLINE=y
CONFIG_KTIME_SCALAR=y

[-- Attachment #6: dmesg.txt --]
[-- Type: text/plain, Size: 37247 bytes --]

Linux version 2.6.18-1.2689.fc6PAE (brewbuilder@hs20-bc2-4.build.redhat.com) (gcc version 4.1.1 20060920 (Red Hat 4.1.1-24)) #1 SMP Thu Sep 21 21:21:43 EDT 2006
BIOS-provided physical RAM map:
 BIOS-e820: 0000000000000000 - 000000000009f000 (usable)
 BIOS-e820: 000000000009f000 - 00000000000a0000 (reserved)
 BIOS-e820: 00000000000d2000 - 00000000000d4000 (reserved)
 BIOS-e820: 00000000000dc000 - 0000000000100000 (reserved)
 BIOS-e820: 0000000000100000 - 000000007f6d0000 (usable)
 BIOS-e820: 000000007f6d0000 - 000000007f6e3000 (ACPI data)
 BIOS-e820: 000000007f6e3000 - 000000007f700000 (ACPI NVS)
 BIOS-e820: 000000007f700000 - 0000000080000000 (reserved)
 BIOS-e820: 00000000f0000000 - 00000000f4000000 (reserved)
 BIOS-e820: 00000000fec00000 - 00000000fec10000 (reserved)
 BIOS-e820: 00000000fed00000 - 00000000fed00400 (reserved)
 BIOS-e820: 00000000fed14000 - 00000000fed1a000 (reserved)
 BIOS-e820: 00000000fed1c000 - 00000000fed90000 (reserved)
 BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
 BIOS-e820: 00000000ff800000 - 0000000100000000 (reserved)
1142MB HIGHMEM available.
896MB LOWMEM available.
found SMP MP-table at 000f68b0
NX (Execute Disable) protection: active
On node 0 totalpages: 521936
  DMA zone: 4096 pages, LIFO batch:0
  Normal zone: 225280 pages, LIFO batch:31
  HighMem zone: 292560 pages, LIFO batch:31
DMI present.
Using APIC driver default
ACPI: RSDP (v002 LENOVO                                ) @ 0x000f6870
ACPI: XSDT (v001 LENOVO TP-7B    0x00001100  LTP 0x00000000) @ 0x7f6d6526
ACPI: FADT (v003 LENOVO TP-7B    0x00001100 LNVO 0x00000001) @ 0x7f6d6600
ACPI: SSDT (v001 LENOVO TP-7B    0x00001100 MSFT 0x0100000e) @ 0x7f6d67b4
ACPI: ECDT (v001 LENOVO TP-7B    0x00001100 LNVO 0x00000001) @ 0x7f6e2d45
ACPI: TCPA (v002 LENOVO TP-7B    0x00001100 LNVO 0x00000001) @ 0x7f6e2d97
ACPI: MADT (v001 LENOVO TP-7B    0x00001100 LNVO 0x00000001) @ 0x7f6e2dc9
ACPI: MCFG (v001 LENOVO TP-7B    0x00001100 LNVO 0x00000001) @ 0x7f6e2e31
ACPI: HPET (v001 LENOVO TP-7B    0x00001100 LNVO 0x00000001) @ 0x7f6e2e6f
ACPI: BOOT (v001 LENOVO TP-7B    0x00001100  LTP 0x00000001) @ 0x7f6e2fd8
ACPI: SSDT (v001 LENOVO TP-7B    0x00001100 INTL 0x20050513) @ 0x7f6d5ae1
ACPI: SSDT (v001 LENOVO TP-7B    0x00001100 INTL 0x20050513) @ 0x7f6d5909
ACPI: DSDT (v001 LENOVO TP-7B    0x00001100 MSFT 0x0100000e) @ 0x00000000
ACPI: PM-Timer IO Port: 0x1008
ACPI: Local APIC address 0xfee00000
ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
Processor #0 6:14 APIC version 20
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
Processor #1 6:14 APIC version 20
ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
ACPI: IOAPIC (id[0x01] address[0xfec00000] gsi_base[0])
IOAPIC[0]: apic_id 1, 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: 0x8086a201 base: 0xfed00000
Using ACPI (MADT) for SMP configuration information
Allocating PCI resources starting at 88000000 (gap: 80000000:70000000)
Detected 1828.805 MHz processor.
Built 1 zonelists.  Total pages: 521936
Kernel command line: ro root=LABEL=/ acpi_sleep=s3_bios
mapped APIC to ffffd000 (fee00000)
mapped IOAPIC to ffffc000 (fec00000)
Enabling fast FPU save and restore... done.
Enabling unmasked SIMD FPU exception support... done.
Initializing CPU#0
CPU 0 irqstacks, hard=c081c000 soft=c07fc000
PID hash table entries: 4096 (order: 12, 16384 bytes)
Console: colour VGA+ 80x25
Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
... MAX_LOCKDEP_SUBCLASSES:    8
... MAX_LOCK_DEPTH:          30
... MAX_LOCKDEP_KEYS:        2048
... CLASSHASH_SIZE:           1024
... MAX_LOCKDEP_ENTRIES:     8192
... MAX_LOCKDEP_CHAINS:      8192
... CHAINHASH_SIZE:          4096
 memory used by lock dependency info: 696 kB
 per task-struct memory footprint: 1200 bytes
Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Memory: 2061140k/2087744k available (2137k kernel code, 25324k reserved, 1117k data, 240k init, 1170240k highmem)
Checking if this processor honours the WP bit even in supervisor mode... Ok.
hpet0: at MMIO 0xfed00000 (virtual 0xf8800000), IRQs 2, 8, 0
hpet0: 3 64-bit timers, 14318180 Hz
Using HPET for base-timer
Calibrating delay using timer specific routine.. 3663.78 BogoMIPS (lpj=7327578)
Security Framework v1.0.0 initialized
SELinux:  Initializing.
SELinux:  Starting in permissive mode
selinux_register_security:  Registering secondary module capability
Capability LSM initialized as secondary
Mount-cache hash table entries: 512
CPU: After generic identify, caps: bfe9fbff 00100000 00000000 00000000 0000c1a9 00000000 00000000
CPU: After vendor identify, caps: bfe9fbff 00100000 00000000 00000000 0000c1a9 00000000 00000000
monitor/mwait feature present.
using mwait in idle threads.
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 2048K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 0
CPU: After all inits, caps: bfe9fbff 00100000 00000000 00000940 0000c1a9 00000000 00000000
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#0.
Checking 'hlt' instruction... OK.
lockdep: not fixing up alternatives.
ACPI: Core revision 20060707
CPU0: Intel Genuine Intel(R) CPU           T2400  @ 1.83GHz stepping 08
lockdep: not fixing up alternatives.
Booting processor 1/1 eip 3000
CPU 1 irqstacks, hard=c081d000 soft=c07fd000
Initializing CPU#1
Calibrating delay using timer specific routine.. 3657.65 BogoMIPS (lpj=7315308)
CPU: After generic identify, caps: bfe9fbff 00100000 00000000 00000000 0000c1a9 00000000 00000000
CPU: After vendor identify, caps: bfe9fbff 00100000 00000000 00000000 0000c1a9 00000000 00000000
monitor/mwait feature present.
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 2048K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 1
CPU: After all inits, caps: bfe9fbff 00100000 00000000 00000940 0000c1a9 00000000 00000000
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#1.
CPU1: Intel Genuine Intel(R) CPU           T2400  @ 1.83GHz stepping 08
Total of 2 processors activated (7321.44 BogoMIPS).
ENABLING IO-APIC IRQs
..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1
checking TSC synchronization across 2 CPUs: 
CPU#0 had -171 usecs TSC skew, fixed it up.
CPU#1 had 171 usecs TSC skew, fixed it up.
Brought up 2 CPUs
sizeof(vma)=88 bytes
sizeof(page)=32 bytes
sizeof(inode)=568 bytes
sizeof(dentry)=160 bytes
sizeof(ext3inode)=804 bytes
sizeof(buffer_head)=52 bytes
sizeof(skbuff)=172 bytes
migration_cost=78
checking if image is initramfs... it is
Freeing initrd memory: 1495k freed
PM: Adding info for No Bus:platform
NET: Registered protocol family 16
ACPI: bus type pci registered
PCI: Using MMCONFIG
Setting up standard PCI resources
ACPI: Found ECDT
ACPI: Interpreter enabled
ACPI: Using IOAPIC for interrupt routing
PM: Adding info for acpi:acpi
ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11)
ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 9 *10 11)
ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 7 9 10 11)
ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 10 *11)
ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 *10 11)
ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 *6 7 9 10 11)
ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 9 10 *11)
ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 9 *10 11)
ACPI: PCI Root Bridge [PCI0] (0000:00)
PCI: Probing PCI hardware (bus 00)
PM: Adding info for No Bus:pci0000:00
Boot video device is 0000:00:02.0
PCI: Ignoring BAR0-3 of IDE controller 0000:00:1f.1
PCI: Transparent bridge - 0000:00:1e.0
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
PM: Adding info for pci:0000:00:00.0
PM: Adding info for pci:0000:00:02.0
PM: Adding info for pci:0000:00:02.1
PM: Adding info for pci:0000:00:1b.0
PM: Adding info for pci:0000:00:1c.0
PM: Adding info for pci:0000:00:1c.1
PM: Adding info for pci:0000:00:1c.2
PM: Adding info for pci:0000:00:1c.3
PM: Adding info for pci:0000:00:1d.0
PM: Adding info for pci:0000:00:1d.1
PM: Adding info for pci:0000:00:1d.2
PM: Adding info for pci:0000:00:1d.3
PM: Adding info for pci:0000:00:1d.7
PM: Adding info for pci:0000:00:1e.0
PM: Adding info for pci:0000:00:1f.0
PM: Adding info for pci:0000:00:1f.1
PM: Adding info for pci:0000:00:1f.2
PM: Adding info for pci:0000:00:1f.3
PM: Adding info for pci:0000:02:00.0
PM: Adding info for pci:0000:03:00.0
PM: Adding info for pci:0000:15:00.0
PM: Adding info for pci:0000:15:00.1
PM: Adding info for pci:0000:15:00.2
ACPI: Embedded Controller [EC] (gpe 28) interrupt mode.
ACPI: Power Resource [PUBS] (on)
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP0._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP1._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP2._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP3._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCI1._PRT]
Linux Plug and Play Support v0.97 (c) Adam Belay
pnp: PnP ACPI init
PM: Adding info for No Bus:pnp0
PM: Adding info for pnp:00:00
PM: Adding info for pnp:00:01
PM: Adding info for pnp:00:02
PM: Adding info for pnp:00:03
PM: Adding info for pnp:00:04
PM: Adding info for pnp:00:05
PM: Adding info for pnp:00:06
PM: Adding info for pnp:00:07
PM: Adding info for pnp:00:08
PM: Adding info for pnp:00:09
PM: Adding info for pnp:00:0a
pnp: PnP ACPI: found 11 devices
usbcore: registered new driver usbfs
usbcore: registered new driver hub
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: Ignore bogus resource 6 [0:0] of 0000:00:02.0
PCI: Bridge: 0000:00:1c.0
  IO window: 2000-2fff
  MEM window: ee000000-ee0fffff
  PREFETCH window: disabled.
PCI: Bridge: 0000:00:1c.1
  IO window: 3000-4fff
  MEM window: ec000000-edffffff
  PREFETCH window: e4000000-e40fffff
PCI: Bridge: 0000:00:1c.2
  IO window: 5000-6fff
  MEM window: e8000000-e9ffffff
  PREFETCH window: e4100000-e41fffff
PCI: Bridge: 0000:00:1c.3
  IO window: 7000-8fff
  MEM window: ea000000-ebffffff
  PREFETCH window: e4200000-e42fffff
PCI: Bus 22, cardbus bridge: 0000:15:00.0
  IO window: 00009000-000090ff
  IO window: 00009400-000094ff
  PREFETCH window: e0000000-e1ffffff
  MEM window: e6000000-e7ffffff
PCI: Bridge: 0000:00:1e.0
  IO window: 9000-cfff
  MEM window: e4300000-e7ffffff
  PREFETCH window: e0000000-e3ffffff
ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 20 (level, low) -> IRQ 169
PCI: Setting latency timer of device 0000:00:1c.0 to 64
ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 21 (level, low) -> IRQ 177
PCI: Setting latency timer of device 0000:00:1c.1 to 64
ACPI: PCI Interrupt 0000:00:1c.2[C] -> GSI 22 (level, low) -> IRQ 185
PCI: Setting latency timer of device 0000:00:1c.2 to 64
ACPI: PCI Interrupt 0000:00:1c.3[D] -> GSI 23 (level, low) -> IRQ 193
PCI: Setting latency timer of device 0000:00:1c.3 to 64
PCI: Enabling device 0000:00:1e.0 (0005 -> 0007)
PCI: Setting latency timer of device 0000:00:1e.0 to 64
ACPI: PCI Interrupt 0000:15:00.0[A] -> GSI 16 (level, low) -> IRQ 201
PCI: Setting latency timer of device 0000:15:00.0 to 64
NET: Registered protocol family 2
IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
TCP established hash table entries: 131072 (order: 10, 4194304 bytes)
TCP bind hash table entries: 65536 (order: 9, 2097152 bytes)
TCP: Hash tables configured (established 131072 bind 65536)
TCP reno registered
PM: Adding info for platform:pcspkr
Simple Boot Flag at 0x35 set to 0x1
apm: BIOS not found.
audit: initializing netlink socket (disabled)
audit(1159185392.324:1): initialized
highmem bounce pool size: 64 pages
Total HugeTLB memory allocated, 0
VFS: Disk quotas dquot_6.5.1
Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
SELinux:  Registering netfilter hooks
Initializing Cryptographic API
ksign: Installing public key data
Loading keyring
- Added public key D1122D51C4AB4865
- User ID: Red Hat, Inc. (Kernel Module GPG key)
io scheduler noop registered
io scheduler anticipatory registered
io scheduler deadline registered
io scheduler cfq registered (default)
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]
PM: Adding info for pci_express:0000:00:1c.0:pcie00
Allocate Port Service[0000:00:1c.0:pcie02]
PM: Adding info for pci_express:0000:00:1c.0:pcie02
Allocate Port Service[0000:00:1c.0:pcie03]
PM: Adding info for pci_express:0000:00:1c.0:pcie03
PCI: Setting latency timer of device 0000:00:1c.1 to 64
assign_interrupt_mode Found MSI capability
Allocate Port Service[0000:00:1c.1:pcie00]
PM: Adding info for pci_express:0000:00:1c.1:pcie00
Allocate Port Service[0000:00:1c.1:pcie02]
PM: Adding info for pci_express:0000:00:1c.1:pcie02
Allocate Port Service[0000:00:1c.1:pcie03]
PM: Adding info for pci_express:0000:00:1c.1:pcie03
PCI: Setting latency timer of device 0000:00:1c.2 to 64
assign_interrupt_mode Found MSI capability
Allocate Port Service[0000:00:1c.2:pcie00]
PM: Adding info for pci_express:0000:00:1c.2:pcie00
Allocate Port Service[0000:00:1c.2:pcie02]
PM: Adding info for pci_express:0000:00:1c.2:pcie02
Allocate Port Service[0000:00:1c.2:pcie03]
PM: Adding info for pci_express:0000:00:1c.2:pcie03
PCI: Setting latency timer of device 0000:00:1c.3 to 64
assign_interrupt_mode Found MSI capability
Allocate Port Service[0000:00:1c.3:pcie00]
PM: Adding info for pci_express:0000:00:1c.3:pcie00
Allocate Port Service[0000:00:1c.3:pcie02]
PM: Adding info for pci_express:0000:00:1c.3:pcie02
Allocate Port Service[0000:00:1c.3:pcie03]
PM: Adding info for pci_express:0000:00:1c.3:pcie03
pci_hotplug: PCI Hot Plug PCI Core version: 0.5
PM: Adding info for platform:vesafb.0
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu0Ist] [20060707]
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu0Cst] [20060707]
ACPI: CPU0 (power states: C1[C1] C2[C2] C3[C3])
ACPI: Processor [CPU0] (supports 8 throttling states)
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu1Ist] [20060707]
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [ PmRef] OemTableId [ Cpu1Cst] [20060707]
ACPI: CPU1 (power states: C1[C1] C2[C2] C3[C3])
ACPI: Processor [CPU1] (supports 8 throttling states)
ACPI: Thermal Zone [THM0] (57 C)
ACPI: Thermal Zone [THM1] (56 C)
PM: Adding info for No Bus:pnp1
isapnp: Scanning for PnP cards...
isapnp: No Plug & Play device found
Real Time Clock Driver v1.12ac
hpet_resources: 0xfed00000 is busy
Non-volatile memory driver v1.2
Linux agpgart interface v0.101 (c) Dave Jones
agpgart: Detected an Intel 945GM Chipset.
agpgart: Detected 7932K stolen memory.
agpgart: AGP aperture is 256M @ 0xd0000000
Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
PM: Adding info for platform:serial8250
PM: Adding info for No Bus:isa
RAMDISK driver initialized: 16 RAM disks of 16384K size 4096 blocksize
Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
ICH7: IDE controller at PCI slot 0000:00:1f.1
ACPI: PCI Interrupt 0000:00:1f.1[C] -> GSI 16 (level, low) -> IRQ 201
ICH7: chipset revision 2
ICH7: not 100% native mode: will probe irqs later
    ide0: BM-DMA at 0x1810-0x1817, BIOS settings: hda:pio, hdb:pio
Probing IDE interface ide0...
Probing IDE interface ide0...
Probing IDE interface ide1...
ide-floppy driver 0.99.newide
Yenta: CardBus bridge found at 0000:15:00.0 [17aa:201c]
Yenta: ISA IRQ mask 0x0cb8, PCI irq 201
Socket status: 30000006
pcmcia: parent PCI bridge I/O window: 0x9000 - 0xcfff
cs: IO port probe 0x9000-0xcfff: clean.
pcmcia: parent PCI bridge Memory window: 0xe4300000 - 0xe7ffffff
pcmcia: parent PCI bridge Memory window: 0xe0000000 - 0xe3ffffff
usbcore: registered new driver libusual
usbcore: registered new driver hiddev
usbcore: registered new driver usbhid
drivers/usb/input/hid-core.c: v2.6:USB HID core driver
PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
PM: Adding info for platform:i8042
serio: i8042 AUX port at 0x60,0x64 irq 12
serio: i8042 KBD port at 0x60,0x64 irq 1
PM: Adding info for serio:serio0
mice: PS/2 mouse device common for all mice
PM: Adding info for serio:serio1
md: md driver 0.90.3 MAX_MD_DEVS=256, MD_SB_DISKS=27
md: bitmap version 4.39
TCP bic registered
Initializing IPsec netlink socket
NET: Registered protocol family 1
NET: Registered protocol family 17
Using IPI No-Shortcut mode
ACPI: (supports S0 S3 S4 S5)
Freeing unused kernel memory: 240k freed
Write protecting the kernel read-only data: 399k
Time: tsc clocksource has been installed.
Time: hpet clocksource has been installed.
input: AT Translated Set 2 keyboard as /class/input/input0
USB Universal Host Controller Interface driver v3.0
ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 16 (level, low) -> IRQ 201
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 1
uhci_hcd 0000:00:1d.0: irq 201, io base 0x00001820
PM: Adding info for usb:usb1
PM: Adding info for No Bus:usbdev1.1_ep00
usb usb1: configuration #1 chosen from 1 choice
PM: Adding info for usb:1-0:1.0
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 2 ports detected
PM: Adding info for No Bus:usbdev1.1_ep81
ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 17 (level, low) -> IRQ 58
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 2
uhci_hcd 0000:00:1d.1: irq 58, io base 0x00001840
PM: Adding info for usb:usb2
PM: Adding info for No Bus:usbdev2.1_ep00
usb usb2: configuration #1 chosen from 1 choice
PM: Adding info for usb:2-0:1.0
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 2 ports detected
IBM TrackPoint firmware: 0x0e, buttons: 3/3
input: TPPS/2 IBM TrackPoint as /class/input/input1
PM: Adding info for No Bus:usbdev2.1_ep81
ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 66
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 3
uhci_hcd 0000:00:1d.2: irq 66, io base 0x00001860
PM: Adding info for usb:usb3
PM: Adding info for No Bus:usbdev3.1_ep00
usb usb3: configuration #1 chosen from 1 choice
PM: Adding info for usb:3-0:1.0
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
PM: Adding info for No Bus:usbdev3.1_ep81
ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 19 (level, low) -> IRQ 74
PCI: Setting latency timer of device 0000:00:1d.3 to 64
uhci_hcd 0000:00:1d.3: UHCI Host Controller
uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 4
uhci_hcd 0000:00:1d.3: irq 74, io base 0x00001880
PM: Adding info for usb:usb4
PM: Adding info for No Bus:usbdev4.1_ep00
usb usb4: configuration #1 chosen from 1 choice
PM: Adding info for usb:4-0:1.0
hub 4-0:1.0: USB hub found
hub 4-0:1.0: 2 ports detected
PM: Adding info for No Bus:usbdev4.1_ep81
ohci_hcd: 2005 April 22 USB 1.1 'Open' Host Controller (OHCI) Driver (PCI)
ACPI: PCI Interrupt 0000:00:1d.7[D] -> GSI 19 (level, low) -> IRQ 74
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 5
ehci_hcd 0000:00:1d.7: debug port 1
PCI: cache line size of 32 is not supported by device 0000:00:1d.7
ehci_hcd 0000:00:1d.7: irq 74, io mem 0xee444000
ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
PM: Adding info for usb:usb5
PM: Adding info for No Bus:usbdev5.1_ep00
usb usb5: configuration #1 chosen from 1 choice
PM: Adding info for usb:5-0:1.0
hub 5-0:1.0: USB hub found
hub 5-0:1.0: 8 ports detected
PM: Adding info for No Bus:usbdev5.1_ep81
SCSI subsystem initialized
libata version 2.00 loaded.
ahci 0000:00:1f.2: version 2.0
ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 16 (level, low) -> IRQ 201
usb 4-2: new full speed USB device using uhci_hcd and address 2
PM: Adding info for usb:4-2
PM: Adding info for No Bus:usbdev4.2_ep00
usb 4-2: configuration #1 chosen from 1 choice
PM: Adding info for usb:4-2:1.0
PM: Adding info for No Bus:usbdev4.2_ep81
PM: Adding info for No Bus:usbdev4.2_ep02
PM: Adding info for No Bus:usbdev4.2_ep83
PCI: Setting latency timer of device 0000:00:1f.2 to 64
ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 4 ports 1.5 Gbps 0x1 impl SATA mode
ahci 0000:00:1f.2: flags: 64bit ncq pm led clo pio slum part 
ata1: SATA max UDMA/133 cmd 0xF884E500 ctl 0x0 bmdma 0x0 irq 82
ata2: SATA max UDMA/133 cmd 0xF884E580 ctl 0x0 bmdma 0x0 irq 82
ata3: SATA max UDMA/133 cmd 0xF884E600 ctl 0x0 bmdma 0x0 irq 82
ata4: SATA max UDMA/133 cmd 0xF884E680 ctl 0x0 bmdma 0x0 irq 82
scsi0 : ahci
PM: Adding info for No Bus:host0
ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
ata1.00: ATA-7, max UDMA/100, 195371568 sectors: LBA48 
ata1.00: ata1: dev 0 multi count 16
ata1.00: configured for UDMA/100
scsi1 : ahci
PM: Adding info for No Bus:host1
ata2: SATA link down (SStatus 0 SControl 0)
scsi2 : ahci
PM: Adding info for No Bus:host2
ata3: SATA link down (SStatus 0 SControl 0)
scsi3 : ahci
PM: Adding info for No Bus:host3
ata4: SATA link down (SStatus 0 SControl 0)
PM: Adding info for No Bus:target0:0:0
  Vendor: ATA       Model: HTS541010G9SA00   Rev: MBZI
  Type:   Direct-Access                      ANSI SCSI revision: 05
PM: Adding info for scsi:0:0:0:0
SCSI device sda: 195371568 512-byte hdwr sectors (100030 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
SCSI device sda: 195371568 512-byte hdwr sectors (100030 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
 sda: sda1 sda2 sda3 sda4 < sda5 sda6 sda7 >
sd 0:0:0:0: Attached scsi disk sda
kjournald starting.  Commit interval 5 seconds
EXT3-fs: mounted filesystem with ordered data mode.
SELinux:  Disabled at runtime.
SELinux:  Unregistering netfilter hooks
audit(1159185400.296:2): selinux=0 auid=4294967295
ath_hal: module license 'Proprietary' taints kernel.
ath_hal: 0.9.18.0 (AR5210, AR5211, AR5212, RF5111, RF5112, RF2413, RF5413)
Intel(R) PRO/1000 Network Driver - version 7.1.9-k4-NAPI
Copyright (c) 1999-2006 Intel Corporation.
ACPI: PCI Interrupt 0000:02:00.0[A] -> GSI 16 (level, low) -> IRQ 201
PCI: Setting latency timer of device 0000:02:00.0 to 64
e1000: 0000:02:00.0: e1000_probe: (PCI Express:2.5Gb/s:Width x1) 00:16:d3:20:d2:0b
e1000: eth0: e1000_probe: Intel(R) PRO/1000 Network Connection
input: PC Speaker as /class/input/input2
sdhci: Secure Digital Host Controller Interface driver, 0.12
sdhci: Copyright(c) Pierre Ossman
sdhci: SDHCI controller found at 0000:15:00.2 [1180:0822] (rev 18)
ACPI: PCI Interrupt 0000:15:00.2[C] -> GSI 18 (level, low) -> IRQ 66
PCI: Setting latency timer of device 0000:15:00.2 to 64
mmc0: SDHCI at 0xe4301800 irq 66 DMA
ieee1394: Initialized config rom entry `ip1394'
wlan: 0.8.4.2 (svn r1722)
ACPI: PCI Interrupt 0000:15:00.1[B] -> GSI 17 (level, low) -> IRQ 58
PCI: Setting latency timer of device 0000:15:00.1 to 64
PM: Adding info for ieee1394:fw-host0
ohci1394: fw-host0: OHCI-1394 1.0 (PCI): IRQ=[58]  MMIO=[e4301000-e43017ff]  Max Packet=[2048]  IR/IT contexts=[4/4]
ACPI: PCI Interrupt 0000:00:1f.3[A] -> GSI 23 (level, low) -> IRQ 193
PM: Adding info for No Bus:i2c-0
sd 0:0:0:0: Attached scsi generic sg0 type 0
ath_rate_sample: 1.2 (svn r1722)
cs: IO port probe 0x100-0x3af: excluding 0x1f0-0x1f7
cs: IO port probe 0x3e0-0x4ff: excluding 0x3f0-0x3f7 0x4d0-0x4d7
cs: IO port probe 0x820-0x8ff: clean.
cs: IO port probe 0xc00-0xcf7: clean.
cs: IO port probe 0xa00-0xaff: clean.
ath_pci: 0.9.4.5 (svn r1722)
ACPI: PCI Interrupt 0000:03:00.0[A] -> GSI 17 (level, low) -> IRQ 58
PCI: Setting latency timer of device 0000:03:00.0 to 64
wifi0: 11a rates: 6Mbps 9Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps
wifi0: 11b rates: 1Mbps 2Mbps 5.5Mbps 11Mbps
wifi0: 11g rates: 1Mbps 2Mbps 5.5Mbps 11Mbps 6Mbps 9Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps
wifi0: H/W encryption support: WEP AES AES_CCM TKIP
wifi0: mac 10.3 phy 6.1 radio 10.2
wifi0: Use hw queue 1 for WME_AC_BE traffic
wifi0: Use hw queue 0 for WME_AC_BK traffic
wifi0: Use hw queue 2 for WME_AC_VI traffic
wifi0: Use hw queue 3 for WME_AC_VO traffic
wifi0: Use hw queue 8 for CAB traffic
wifi0: Use hw queue 9 for beacons
wifi0: Atheros 5212: mem=0xedf00000, irq=58
PM: Adding info for ieee1394:000ae40600142001
ieee1394: Host added: ID:BUS[0-00:1023]  GUID[000ae40600142001]
PM: Adding info for ieee1394:000ae40600142001-0
Intel 82802 RNG detected
intel_rng: cannot enable RNG, aborting
intel_rng: RNG registering failed (-5)
ACPI: PCI Interrupt 0000:00:1b.0[B] -> GSI 17 (level, low) -> IRQ 58
PCI: Setting latency timer of device 0000:00:1b.0 to 64
hda_intel: azx_get_response timeout, switching to single_cmd mode...
Bluetooth: Core ver 2.10
PM: Adding info for platform:bluetooth
NET: Registered protocol family 31
Bluetooth: HCI device and connection manager initialized
Bluetooth: HCI socket layer initialized
Bluetooth: L2CAP ver 2.8
Bluetooth: L2CAP socket layer initialized
Bluetooth: RFCOMM socket layer initialized
Bluetooth: RFCOMM TTY layer initialized
Bluetooth: RFCOMM ver 1.8
Bluetooth: HIDP (Human Interface Emulation) ver 1.1
NET: Registered protocol family 10
lo: Disabled Privacy Extensions
IPv6 over IPv4 tunneling driver
ADDRCONF(NETDEV_UP): eth0: link is not ready
[drm] Initialized drm 1.0.1 20051102
ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level, low) -> IRQ 201
[drm] Initialized i915 1.5.0 20060119 on minor 0
ath0: no IPv6 routers present
netconsole: local port 6665
netconsole: interface eth0
netconsole: remote port 6666
netconsole: remote IP 192.168.0.6
netconsole: remote ethernet address 00:30:1b:b5:dd:8f
netconsole: no IP address for eth0, aborting
netconsole: local port 6665
netconsole: interface eth0
netconsole: remote port 6666
netconsole: remote IP 192.168.0.6
netconsole: remote ethernet address 00:30:1b:b5:dd:8f
netconsole: no IP address for eth0, aborting
PM: Preparing system for mem sleep
Disabling non-boot CPUs ...
CPU 1 is now offline
lockdep: not fixing up alternatives.
CPU1 is down
Stopping tasks: ===========================================================================================================================================================|
platform bluetooth: suspend
sd 0:0:0:0: suspend
 usbdev4.2_ep83: PM: suspend 0->2, parent 4-2:1.0 already 1
 usbdev4.2_ep02: PM: suspend 0->2, parent 4-2:1.0 already 1
 usbdev4.2_ep81: PM: suspend 0->2, parent 4-2:1.0 already 1
usb 4-2:1.0: PM: suspend 1-->2
usb 4-2: suspend, may wakeup
hub 5-0:1.0: suspend
usb usb5: suspend, may wakeup
hub 4-0:1.0: suspend
usb usb4: suspend, may wakeup
hub 3-0:1.0: suspend
usb usb3: suspend, may wakeup
hub 2-0:1.0: suspend
usb usb2: suspend, may wakeup
hub 1-0:1.0: suspend
usb usb1: suspend, may wakeup
i8042 i8042: suspend
serial8250 serial8250: suspend
platform vesafb.0: suspend
pci_express 0000:00:1c.3:pcie03: suspend
pci_express 0000:00:1c.3:pcie02: suspend
pci_express 0000:00:1c.3:pcie00: suspend
pci_express 0000:00:1c.2:pcie03: suspend
pci_express 0000:00:1c.2:pcie02: suspend
pci_express 0000:00:1c.2:pcie00: suspend
pci_express 0000:00:1c.1:pcie03: suspend
pci_express 0000:00:1c.1:pcie02: suspend
pci_express 0000:00:1c.1:pcie00: suspend
pci_express 0000:00:1c.0:pcie03: suspend
pci_express 0000:00:1c.0:pcie02: suspend
pci_express 0000:00:1c.0:pcie00: suspend
pcspkr pcspkr: suspend
pnp 00:0a: suspend
i8042 aux 00:09: suspend
i8042 kbd 00:08: suspend
pnp 00:07: suspend
pnp 00:06: suspend
pnp 00:05: suspend
pnp 00:04: suspend
pnp 00:03: suspend
system 00:02: suspend
pnp 00:01: suspend
system 00:00: suspend
sdhci 0000:15:00.2: suspend
ACPI: PCI interrupt for device 0000:15:00.2 disabled
ohci1394 0000:15:00.1: suspend
yenta_cardbus 0000:15:00.0: suspend
ACPI: PCI interrupt for device 0000:15:00.0 disabled
ath_pci 0000:03:00.0: suspend
ACPI: PCI interrupt for device 0000:03:00.0 disabled
e1000 0000:02:00.0: suspend
ACPI: PCI interrupt for device 0000:02:00.0 disabled
i801_smbus 0000:00:1f.3: suspend
ahci 0000:00:1f.2: suspend
ACPI: PCI interrupt for device 0000:00:1f.2 disabled
PIIX_IDE 0000:00:1f.1: suspend
pci 0000:00:1f.0: suspend
pci 0000:00:1e.0: suspend
ehci_hcd 0000:00:1d.7: suspend, may wakeup
ACPI: PCI interrupt for device 0000:00:1d.7 disabled
uhci_hcd 0000:00:1d.3: suspend
ACPI: PCI interrupt for device 0000:00:1d.3 disabled
uhci_hcd 0000:00:1d.2: suspend
ACPI: PCI interrupt for device 0000:00:1d.2 disabled
uhci_hcd 0000:00:1d.1: suspend
ACPI: PCI interrupt for device 0000:00:1d.1 disabled
uhci_hcd 0000:00:1d.0: suspend
ACPI: PCI interrupt for device 0000:00:1d.0 disabled
pcieport-driver 0000:00:1c.3: suspend
pcieport-driver 0000:00:1c.2: suspend
pcieport-driver 0000:00:1c.1: suspend
pcieport-driver 0000:00:1c.0: suspend
HDA Intel 0000:00:1b.0: suspend
ACPI: PCI interrupt for device 0000:00:1b.0 disabled
pci 0000:00:02.1: suspend
pci 0000:00:02.0: suspend
agpgart-intel 0000:00:00.0: suspend
acpi acpi: suspend
PM: Entering mem sleep
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#0.
Back to C!
PM: Finishing wakeup.
acpi acpi: resuming
agpgart-intel 0000:00:00.0: resuming
pci 0000:00:02.0: resuming
pci 0000:00:02.1: resuming
PM: Writing back config space on device 0000:00:02.1 at offset 1 (was 900000, writing 900003)
HDA Intel 0000:00:1b.0: resuming
PM: Writing back config space on device 0000:00:1b.0 at offset 1 (was 100106, writing 100100)
PCI: Enabling device 0000:00:1b.0 (0100 -> 0102)
ACPI: PCI Interrupt 0000:00:1b.0[B] -> GSI 17 (level, low) -> IRQ 58
PCI: Setting latency timer of device 0000:00:1b.0 to 64
pcieport-driver 0000:00:1c.0: resuming
PM: Writing back config space on device 0000:00:1c.0 at offset 1 (was 100107, writing 100507)
PCI: Setting latency timer of device 0000:00:1c.0 to 64
pcieport-driver 0000:00:1c.1: resuming
PM: Writing back config space on device 0000:00:1c.1 at offset 1 (was 100107, writing 100507)
PCI: Setting latency timer of device 0000:00:1c.1 to 64
pcieport-driver 0000:00:1c.2: resuming
PM: Writing back config space on device 0000:00:1c.2 at offset 7 (was 20006050, writing 6050)
PM: Writing back config space on device 0000:00:1c.2 at offset 1 (was 100107, writing 100507)
PCI: Setting latency timer of device 0000:00:1c.2 to 64
pcieport-driver 0000:00:1c.3: resuming
PM: Writing back config space on device 0000:00:1c.3 at offset f (was 40400, writing 4040a)
PM: Writing back config space on device 0000:00:1c.3 at offset 9 (was 10001, writing e421e421)
PM: Writing back config space on device 0000:00:1c.3 at offset 8 (was 0, writing ebf0ea00)
PM: Writing back config space on device 0000:00:1c.3 at offset 7 (was 20000000, writing 8070)
PM: Writing back config space on device 0000:00:1c.3 at offset 3 (was 810000, writing 810010)
PM: Writing back config space on device 0000:00:1c.3 at offset 1 (was 100000, writing 100507)
PCI: Setting latency timer of device 0000:00:1c.3 to 64
uhci_hcd 0000:00:1d.0: resuming
ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 16 (level, low) -> IRQ 201
PCI: Setting latency timer of device 0000:00:1d.0 to 64
usb usb1: root hub lost power or was reset
uhci_hcd 0000:00:1d.1: resuming
ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 17 (level, low) -> IRQ 58
PCI: Setting latency timer of device 0000:00:1d.1 to 64
usb usb2: root hub lost power or was reset
uhci_hcd 0000:00:1d.2: resuming
ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 66
PCI: Setting latency timer of device 0000:00:1d.2 to 64
usb usb3: root hub lost power or was reset
uhci_hcd 0000:00:1d.3: resuming
ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 19 (level, low) -> IRQ 74
PCI: Setting latency timer of device 0000:00:1d.3 to 64
usb usb4: root hub lost power or was reset
ehci_hcd 0000:00:1d.7: resuming
ACPI: PCI Interrupt 0000:00:1d.7[D] -> GSI 19 (level, low) -> IRQ 74
PCI: Setting latency timer of device 0000:00:1d.7 to 64
pci 0000:00:1e.0: resuming
PM: Writing back config space on device 0000:00:1e.0 at offset 1 (was 100005, writing 100007)
PCI: Setting latency timer of device 0000:00:1e.0 to 64
pci 0000:00:1f.0: resuming
PIIX_IDE 0000:00:1f.1: resuming
ahci 0000:00:1f.2: resuming
ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 16 (level, low) -> IRQ 201
PCI: Setting latency timer of device 0000:00:1f.2 to 64
i801_smbus 0000:00:1f.3: resuming
e1000 0000:02:00.0: resuming
ACPI: PCI Interrupt 0000:02:00.0[A] -> GSI 16 (level, low) -> IRQ 201
PCI: Setting latency timer of device 0000:02:00.0 to 64
ath_pci 0000:03:00.0: resuming
ACPI: PCI Interrupt 0000:03:00.0[A] -> GSI 17 (level, low) -> IRQ 58
PCI: Setting latency timer of device 0000:03:00.0 to 64
yenta_cardbus 0000:15:00.0: resuming
PM: Writing back config space on device 0000:15:00.0 at offset 1 (was 2100000, writing 2100007)
ACPI: PCI Interrupt 0000:15:00.0[A] -> GSI 16 (level, low) -> IRQ 201
ohci1394 0000:15:00.1: resuming
sdhci 0000:15:00.2: resuming
PM: Writing back config space on device 0000:15:00.2 at offset 4 (was 0, writing e4301800)
PM: Writing back config space on device 0000:15:00.2 at offset 3 (was 800000, writing 804000)
PM: Writing back config space on device 0000:15:00.2 at offset 1 (was 2100000, writing 2100006)
ACPI: PCI Interrupt 0000:15:00.2[C] -> GSI 18 (level, low) -> IRQ 66
system 00:00: resuming
pnp 00:01: resuming
system 00:02: resuming
pnp 00:03: resuming
pnp 00:04: resuming
pnp 00:05: resuming
pnp 00:06: resuming
pnp 00:07: resuming
i8042 kbd 00:08: resuming
pnp: Device 00:08 does not support activation.
i8042 aux 00:09: resuming
pnp: Device 00:09 does not support activation.
pnp 00:0a: resuming
pcspkr pcspkr: resuming
pci_express 0000:00:1c.0:pcie00: resuming
pci_express 0000:00:1c.0:pcie02: resuming
pci_express 0000:00:1c.0:pcie03: resuming
pci_express 0000:00:1c.1:pcie00: resuming
pci_express 0000:00:1c.1:pcie02: resuming
pci_express 0000:00:1c.1:pcie03: resuming
pci_express 0000:00:1c.2:pcie00: resuming
pci_express 0000:00:1c.2:pcie02: resuming
pci_express 0000:00:1c.2:pcie03: resuming
pci_express 0000:00:1c.3:pcie00: resuming
pci_express 0000:00:1c.3:pcie02: resuming
pci_express 0000:00:1c.3:pcie03: resuming
platform vesafb.0: resuming
serial8250 serial8250: resuming
i8042 i8042: resuming
psmouse serio0: resuming
ata2: SATA link down (SStatus 0 SControl 0)
ata3: SATA link down (SStatus 0 SControl 0)
ata4: SATA link down (SStatus 0 SControl 0)
atkbd serio1: resuming
usb usb1: resuming
hub 1-0:1.0: resuming
usb usb2: resuming
hub 2-0:1.0: resuming
usb usb3: resuming
hub 3-0:1.0: resuming
usb usb4: resuming
hub 4-0:1.0: resuming
usb usb5: resuming
hub 5-0:1.0: resuming
usb 4-2: resuming
 usbdev4.2_ep81: PM: resume from 0, parent 4-2:1.0 still 1
 usbdev4.2_ep02: PM: resume from 0, parent 4-2:1.0 still 1
 usbdev4.2_ep83: PM: resume from 0, parent 4-2:1.0 still 1
sd 0:0:0:0: resuming
platform bluetooth: resuming
Restarting tasks...<6>usb 4-2: USB disconnect, address 2
PM: Removing info for No Bus:usbdev4.2_ep81
PM: Removing info for No Bus:usbdev4.2_ep02
PM: Removing info for No Bus:usbdev4.2_ep83
PM: Removing info for usb:4-2:1.0
PM: Removing info for No Bus:usbdev4.2_ep00
PM: Removing info for usb:4-2
 done
Enabling non-boot CPUs ...
lockdep: not fixing up alternatives.
Booting processor 1/1 eip 3000
CPU 1 irqstacks, hard=c081d000 soft=c07fd000
Initializing CPU#1
Calibrating delay using timer specific routine.. 3656.68 BogoMIPS (lpj=7313375)
CPU: After generic identify, caps: bfe9fbff 00100000 00000000 00000000 0000c1a9 00000000 00000000
CPU: After vendor identify, caps: bfe9fbff 00100000 00000000 00000000 0000c1a9 00000000 00000000
monitor/mwait feature present.
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 2048K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 1
CPU: After all inits, caps: bfe9fbff 00100000 00000000 00000940 0000c1a9 00000000 00000000
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#1.
CPU1: Intel Genuine Intel(R) CPU           T2400  @ 1.83GHz stepping 08
usb 4-2: new full speed USB device using uhci_hcd and address 3
CPU1 is up
PM: Adding info for usb:4-2
PM: Adding info for No Bus:usbdev4.3_ep00
usb 4-2: configuration #1 chosen from 1 choice
PM: Adding info for usb:4-2:1.0
PM: Adding info for No Bus:usbdev4.3_ep81
PM: Adding info for No Bus:usbdev4.3_ep02
PM: Adding info for No Bus:usbdev4.3_ep83
ata1: waiting for device to spin up (8 secs)
ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
ADDRCONF(NETDEV_UP): ath0: link is not ready
ata1.00: configured for UDMA/100
SCSI device sda: 195371568 512-byte hdwr sectors (100030 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
ADDRCONF(NETDEV_CHANGE): ath0: link becomes ready
ath0: no IPv6 routers present

[-- Attachment #7: interrupts.txt --]
[-- Type: text/plain, Size: 787 bytes --]

           CPU0       CPU1       
  0:     713473          0    IO-APIC-edge  timer
  1:       6796          0    IO-APIC-edge  i8042
  8:         57          0    IO-APIC-edge  rtc
  9:       2899          0   IO-APIC-level  acpi
 12:      53094          0    IO-APIC-edge  i8042
 58:     536174          0   IO-APIC-level  uhci_hcd:usb2, ohci1394, wifi0, HDA Intel
 66:          0          0   IO-APIC-level  uhci_hcd:usb3, sdhci:slot0
 74:         51          0   IO-APIC-level  uhci_hcd:usb4, ehci_hcd:usb5
 82:      87933          0         PCI-MSI  libata
 90:       1358          0         PCI-MSI  eth0
201:     134742          0   IO-APIC-level  yenta, uhci_hcd:usb1, i915@pci:0000:00:02.0
NMI:          0          0 
LOC:     713408     710744 
ERR:          0
MIS:          0

[-- Attachment #8: lsmod.txt --]
[-- Type: text/plain, Size: 3048 bytes --]

Module                  Size  Used by
cpufreq_powersave       6209  0 
i915                   24129  2 
drm                    74741  3 i915
cpufreq_conservative    12105  2 
ipv6                  274593  26 
autofs4                26197  2 
hidp                   24521  2 
rfcomm                 47209  2 
l2cap                  32721  10 hidp,rfcomm
bluetooth              60485  5 hidp,rfcomm,l2cap
sunrpc                164125  1 
ipt_REJECT              9921  1 
xt_state                6464  2 
ip_conntrack           58657  1 xt_state
nfnetlink              11481  1 ip_conntrack
xt_tcpudp               7361  4 
iptable_filter          7361  1 
ip_tables              17925  1 iptable_filter
x_tables               18901  4 ipt_REJECT,xt_state,xt_tcpudp,ip_tables
vfat                   16961  1 
fat                    56693  1 vfat
dm_mirror              34449  0 
dm_mod                 63865  1 dm_mirror
video                  21701  0 
sbs                    20877  0 
ibm_acpi               32961  0 
i2c_ec                  9409  1 sbs
dock                   12677  0 
button                 11217  0 
battery                14789  0 
asus_acpi              21337  0 
ac                      9669  0 
parport_pc             32229  0 
lp                     17577  0 
parport                41769  2 parport_pc,lp
snd_hda_intel          23269  2 
snd_hda_codec         158065  1 snd_hda_intel
snd_seq_dummy           8133  0 
snd_seq_oss            38737  0 
snd_seq_midi_event     12105  1 snd_seq_oss
snd_seq                59161  5 snd_seq_dummy,snd_seq_oss,snd_seq_midi_event
wlan_scan_sta          18320  1 
snd_seq_device         13141  3 snd_seq_dummy,snd_seq_oss,snd_seq
snd_pcm_oss            47457  1 
ath_pci               100188  0 
snd_mixer_oss          21064  1 snd_pcm_oss
snd_pcm                82797  3 snd_hda_intel,snd_hda_codec,snd_pcm_oss
ath_rate_sample        18432  1 ath_pci
mmc_block              12753  0 
snd_timer              27741  2 snd_seq,snd_pcm
snd                    59269  11 snd_hda_intel,snd_hda_codec,snd_seq_oss,snd_seq,snd_seq_device,snd_pcm_oss,snd_mixer_oss,snd_pcm,snd_timer
sg                     39269  0 
ohci1394               39989  0 
i2c_i801               12237  0 
wlan                  199196  4 wlan_scan_sta,ath_pci,ath_rate_sample
ieee1394              304585  1 ohci1394
sdhci                  23393  0 
soundcore              14369  2 snd
pcspkr                  7489  0 
i2c_core               26321  2 i2c_ec,i2c_i801
snd_page_alloc         14665  2 snd_hda_intel,snd_pcm
serio_raw              11589  0 
e1000                 126185  0 
mmc_core               31305  2 mmc_block,sdhci
ath_hal               196304  3 ath_pci,ath_rate_sample
ahci                   23749  4 
libata                105953  1 ahci
sd_mod                 25537  5 
scsi_mod              142761  4 sg,ahci,libata,sd_mod
ext3                  138873  2 
jbd                    64545  1 ext3
ehci_hcd               36693  0 
ohci_hcd               25829  0 
uhci_hcd               28629  0 

[-- Attachment #9: lspci.txt --]
[-- Type: text/plain, Size: 9238 bytes --]

00:00.0 Host bridge: Intel Corporation Mobile 945GM/PM/GMS/940GML and 945GT Express Memory Controller Hub (rev 03)
	Subsystem: Lenovo Thinkpad R60e model 0657
	Flags: bus master, fast devsel, latency 0
	Capabilities: [e0] Vendor Specific Information

00:02.0 VGA compatible controller: Intel Corporation Mobile 945GM/GMS/940GML Express Integrated Graphics Controller (rev 03) (prog-if 00 [VGA])
	Subsystem: Lenovo Thinkpad R60e model 0657
	Flags: bus master, fast devsel, latency 0, IRQ 201
	Memory at ee100000 (32-bit, non-prefetchable) [size=512K]
	I/O ports at 1800 [size=8]
	Memory at d0000000 (32-bit, prefetchable) [size=256M]
	Memory at ee200000 (32-bit, non-prefetchable) [size=256K]
	Capabilities: [90] Message Signalled Interrupts: 64bit- Queue=0/0 Enable-
	Capabilities: [d0] Power Management version 2

00:02.1 Display controller: Intel Corporation Mobile 945GM/GMS/940GML Express Integrated Graphics Controller (rev 03)
	Subsystem: Lenovo Thinkpad R60e model 0657
	Flags: fast devsel
	Memory at ee180000 (32-bit, non-prefetchable) [size=512K]
	Capabilities: [d0] Power Management version 2

00:1b.0 Audio device: Intel Corporation 82801G (ICH7 Family) High Definition Audio Controller (rev 02)
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: bus master, fast devsel, latency 0, IRQ 58
	Memory at ee240000 (64-bit, non-prefetchable) [size=16K]
	Capabilities: [50] Power Management version 2
	Capabilities: [60] Message Signalled Interrupts: 64bit+ Queue=0/0 Enable-
	Capabilities: [70] Express Unknown type IRQ 0
	Capabilities: [100] Virtual Channel
	Capabilities: [130] Unknown (5)

00:1c.0 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 1 (rev 02) (prog-if 00 [Normal decode])
	Flags: bus master, fast devsel, latency 0
	Bus: primary=00, secondary=02, subordinate=02, sec-latency=0
	I/O behind bridge: 00002000-00002fff
	Memory behind bridge: ee000000-ee0fffff
	Capabilities: [40] Express Root Port (Slot+) IRQ 0
	Capabilities: [80] Message Signalled Interrupts: 64bit- Queue=0/0 Enable+
	Capabilities: [90] #0d [0000]
	Capabilities: [a0] Power Management version 2
	Capabilities: [100] Virtual Channel
	Capabilities: [180] Unknown (5)

00:1c.1 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 2 (rev 02) (prog-if 00 [Normal decode])
	Flags: bus master, fast devsel, latency 0
	Bus: primary=00, secondary=03, subordinate=03, sec-latency=0
	I/O behind bridge: 00003000-00004fff
	Memory behind bridge: ec000000-edffffff
	Prefetchable memory behind bridge: 00000000e4000000-00000000e4000000
	Capabilities: [40] Express Root Port (Slot+) IRQ 0
	Capabilities: [80] Message Signalled Interrupts: 64bit- Queue=0/0 Enable+
	Capabilities: [90] #0d [0000]
	Capabilities: [a0] Power Management version 2
	Capabilities: [100] Virtual Channel
	Capabilities: [180] Unknown (5)

00:1c.2 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 3 (rev 02) (prog-if 00 [Normal decode])
	Flags: bus master, fast devsel, latency 0
	Bus: primary=00, secondary=04, subordinate=0b, sec-latency=0
	I/O behind bridge: 00005000-00006fff
	Memory behind bridge: e8000000-e9ffffff
	Prefetchable memory behind bridge: 00000000e4100000-00000000e4100000
	Capabilities: [40] Express Root Port (Slot+) IRQ 0
	Capabilities: [80] Message Signalled Interrupts: 64bit- Queue=0/0 Enable+
	Capabilities: [90] #0d [0000]
	Capabilities: [a0] Power Management version 2
	Capabilities: [100] Virtual Channel
	Capabilities: [180] Unknown (5)

00:1c.3 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 4 (rev 02) (prog-if 00 [Normal decode])
	Flags: bus master, fast devsel, latency 0
	Bus: primary=00, secondary=0c, subordinate=13, sec-latency=0
	I/O behind bridge: 00007000-00008fff
	Memory behind bridge: ea000000-ebffffff
	Prefetchable memory behind bridge: 00000000e4200000-00000000e4200000
	Capabilities: [40] Express Root Port (Slot+) IRQ 0
	Capabilities: [80] Message Signalled Interrupts: 64bit- Queue=0/0 Enable+
	Capabilities: [90] #0d [0000]
	Capabilities: [a0] Power Management version 2
	Capabilities: [100] Virtual Channel
	Capabilities: [180] Unknown (5)

00:1d.0 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #1 (rev 02) (prog-if 00 [UHCI])
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: bus master, medium devsel, latency 0, IRQ 201
	I/O ports at 1820 [size=32]

00:1d.1 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #2 (rev 02) (prog-if 00 [UHCI])
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: bus master, medium devsel, latency 0, IRQ 58
	I/O ports at 1840 [size=32]

00:1d.2 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #3 (rev 02) (prog-if 00 [UHCI])
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: bus master, medium devsel, latency 0, IRQ 66
	I/O ports at 1860 [size=32]

00:1d.3 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #4 (rev 02) (prog-if 00 [UHCI])
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: bus master, medium devsel, latency 0, IRQ 74
	I/O ports at 1880 [size=32]

00:1d.7 USB Controller: Intel Corporation 82801G (ICH7 Family) USB2 EHCI Controller (rev 02) (prog-if 20 [EHCI])
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: bus master, medium devsel, latency 0, IRQ 74
	Memory at ee444000 (32-bit, non-prefetchable) [size=1K]
	Capabilities: [50] Power Management version 2
	Capabilities: [58] Debug port

00:1e.0 PCI bridge: Intel Corporation 82801 Mobile PCI Bridge (rev e2) (prog-if 01 [Subtractive decode])
	Flags: bus master, fast devsel, latency 0
	Bus: primary=00, secondary=15, subordinate=18, sec-latency=32
	I/O behind bridge: 00009000-0000cfff
	Memory behind bridge: e4300000-e7ffffff
	Prefetchable memory behind bridge: 00000000e0000000-00000000e3f00000
	Capabilities: [50] #0d [0000]

00:1f.0 ISA bridge: Intel Corporation 82801GBM (ICH7-M) LPC Interface Bridge (rev 02)
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: bus master, medium devsel, latency 0
	Capabilities: [e0] Vendor Specific Information

00:1f.1 IDE interface: Intel Corporation 82801G (ICH7 Family) IDE Controller (rev 02) (prog-if 8a [Master SecP PriP])
	Subsystem: Lenovo Thinkpad R60e model 0657
	Flags: bus master, medium devsel, latency 0, IRQ 201
	I/O ports at <unassigned>
	I/O ports at <unassigned>
	I/O ports at <unassigned>
	I/O ports at <unassigned>
	I/O ports at 1810 [size=16]

00:1f.2 SATA controller: Intel Corporation 82801GBM/GHM (ICH7 Family) Serial ATA Storage Controller AHCI (rev 02) (prog-if 01 [AHCI 1.0])
	Subsystem: Lenovo Thinkpad R60e model 0657
	Flags: bus master, 66MHz, medium devsel, latency 0, IRQ 201
	I/O ports at 18d0 [size=8]
	I/O ports at 18c4 [size=4]
	I/O ports at 18c8 [size=8]
	I/O ports at 18c0 [size=4]
	I/O ports at 18b0 [size=16]
	Memory at ee444400 (32-bit, non-prefetchable) [size=1K]
	Capabilities: [80] Message Signalled Interrupts: 64bit- Queue=0/0 Enable+
	Capabilities: [70] Power Management version 2

00:1f.3 SMBus: Intel Corporation 82801G (ICH7 Family) SMBus Controller (rev 02)
	Subsystem: Lenovo ThinkPad T60/R60 series
	Flags: medium devsel, IRQ 193
	I/O ports at 18e0 [size=32]

02:00.0 Ethernet controller: Intel Corporation 82573L Gigabit Ethernet Controller
	Subsystem: Lenovo Thinkpad X60s
	Flags: bus master, fast devsel, latency 0, IRQ 201
	Memory at ee000000 (32-bit, non-prefetchable) [size=128K]
	I/O ports at 2000 [size=32]
	Capabilities: [c8] Power Management version 2
	Capabilities: [d0] Message Signalled Interrupts: 64bit+ Queue=0/0 Enable+
	Capabilities: [e0] Express Endpoint IRQ 0
	Capabilities: [100] Advanced Error Reporting
	Capabilities: [140] Device Serial Number 0b-d2-20-ff-ff-d3-16-00

03:00.0 Ethernet controller: Atheros Communications, Inc. AR5212 802.11abg NIC (rev 01)
	Subsystem: IBM ThinkPad 11a/b/g Wireless LAN Mini Express Adapter (AR5BXB6)
	Flags: bus master, fast devsel, latency 0, IRQ 58
	Memory at edf00000 (64-bit, non-prefetchable) [size=64K]
	Capabilities: [40] Power Management version 2
	Capabilities: [50] Message Signalled Interrupts: 64bit- Queue=0/0 Enable-
	Capabilities: [60] Express Legacy Endpoint IRQ 0
	Capabilities: [90] MSI-X: Enable- Mask- TabSize=1
	Capabilities: [100] Advanced Error Reporting
	Capabilities: [140] Virtual Channel

15:00.0 CardBus bridge: Ricoh Co Ltd RL5c476 II (rev b4)
	Subsystem: Lenovo Thinkpad X60s
	Flags: bus master, medium devsel, latency 168, IRQ 201
	Memory at e4300000 (32-bit, non-prefetchable) [size=4K]
	Bus: primary=15, secondary=16, subordinate=17, sec-latency=176
	Memory window 0: e0000000-e1fff000 (prefetchable)
	Memory window 1: e6000000-e7fff000
	I/O window 0: 00009000-000090ff
	I/O window 1: 00009400-000094ff
	16-bit legacy interface ports at 0001

15:00.1 FireWire (IEEE 1394): Ricoh Co Ltd R5C552 IEEE 1394 Controller (rev 09) (prog-if 10 [OHCI])
	Subsystem: Lenovo Thinkpad X60s
	Flags: bus master, medium devsel, latency 64, IRQ 58
	Memory at e4301000 (32-bit, non-prefetchable) [size=2K]
	Capabilities: [dc] Power Management version 2

15:00.2 Class 0805: Ricoh Co Ltd R5C822 SD/SDIO/MMC/MS/MSPro Host Adapter (rev 18)
	Subsystem: Lenovo Thinkpad X60s
	Flags: bus master, medium devsel, latency 64, IRQ 66
	Memory at e4301800 (32-bit, non-prefetchable) [size=256]
	Capabilities: [80] Power Management version 2

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Pavel Machek]

Hi!

> I have a ThinkPad X60 which uses the Intel 82801G HDA 
> audio chip.  This used to work for me, but lately 
> (sometime during 2.6.18-rcX series) it stopped working - 
> programs trying to use it tend to just block forever 
> waiting for /dev/dsp.

I have x60 here,

> The only obvious symptom is:
> 
>    hda_intel: azx_get_response timeout, switching to 
>    single_cmd mode...
> 

sometimes see this message, too, and sound more or less works for me.
(Using alsa interface, mplayer works ok. mpg123 does not work).


-- 
Thanks for all the (sleeping) penguins.

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Michael Clark]

Pavel Machek wrote:
> Hi!
>
>   
>> I have a ThinkPad X60 which uses the Intel 82801G HDA 
>> audio chip.  This used to work for me, but lately 
>> (sometime during 2.6.18-rcX series) it stopped working - 
>> programs trying to use it tend to just block forever 
>> waiting for /dev/dsp.
>>     
>
> I have x60 here,
>
>   
>> The only obvious symptom is:
>>
>>    hda_intel: azx_get_response timeout, switching to 
>>    single_cmd mode...
>>
>>     

I got similar kernel message relating to an azx_get_response timeout
with an 82801G HDA audio running Debian kernel 2.6.16-2 (happened during
suspend to ram IIRC) - after replacing kernel alsa with alsa-source
1.0.12 (24 Aug release) the problem went away (in addition to making
sound come out when it didn't before).

Not sure if this info helps but trying the alsa-project release and
seeing if that works may help identify what needs fixing in mainline
hda_intel.

~mc

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Jeremy Fitzhardinge]

Pavel Machek wrote:
> sometimes see this message, too, and sound more or less works for me.
> (Using alsa interface, mplayer works ok. mpg123 does not work).
>   

That's how it used to be for me, but not any more.

    J

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Mon, 25 Sep 2006 12:58:08 -0700,
Jeremy Fitzhardinge wrote:
> 
> I have a ThinkPad X60 which uses the Intel 82801G HDA audio chip.  This 
> used to work for me, but lately (sometime during 2.6.18-rcX series) it 
> stopped working - programs trying to use it tend to just block forever 
> waiting for /dev/dsp.
> 
> The only obvious symptom is:
> 
>     hda_intel: azx_get_response timeout, switching to single_cmd mode...
> 
> appearing in the kernel log when booting.
> 

There is no big change relevant to TP X60 during 2.6.18rc, so I don't
think it's a regression in the hd-audio driver code.

> Details attached.  The dmesg output is for the FC6 distro kernel 
> 2.6.18-1.2689.fc6PAE, but I see the same symptoms with 2.6.18-mm1.

You must see difference with mm1 (suppose that mm1 already includes
the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
the driver first switches to poling mode, then single_cmd mode as
fallback.

Also, try disable_msi=1 option for mm1.  MSI seems broken on some
systems.


Takashi

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Randy Dunlap]

On Tue, 26 Sep 2006 12:16:33 +0200 Takashi Iwai wrote:

> At Mon, 25 Sep 2006 12:58:08 -0700,
> Jeremy Fitzhardinge wrote:
> > 
> > I have a ThinkPad X60 which uses the Intel 82801G HDA audio chip.  This 
> > used to work for me, but lately (sometime during 2.6.18-rcX series) it 
> > stopped working - programs trying to use it tend to just block forever 
> > waiting for /dev/dsp.
> > 
> > The only obvious symptom is:
> > 
> >     hda_intel: azx_get_response timeout, switching to single_cmd mode...
> > 
> > appearing in the kernel log when booting.
> > 
> 
> There is no big change relevant to TP X60 during 2.6.18rc, so I don't
> think it's a regression in the hd-audio driver code.
> 
> > Details attached.  The dmesg output is for the FC6 distro kernel 
> > 2.6.18-1.2689.fc6PAE, but I see the same symptoms with 2.6.18-mm1.
> 
> You must see difference with mm1 (suppose that mm1 already includes
> the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
> the driver first switches to poling mode, then single_cmd mode as
> fallback.
> 
> Also, try disable_msi=1 option for mm1.  MSI seems broken on some
> systems.

is that "pci=nomsi" ?

---
~Randy

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Tue, 26 Sep 2006 08:37:20 -0700,
Randy Dunlap wrote:
> 
> On Tue, 26 Sep 2006 12:16:33 +0200 Takashi Iwai wrote:
> 
> > At Mon, 25 Sep 2006 12:58:08 -0700,
> > Jeremy Fitzhardinge wrote:
> > > 
> > > I have a ThinkPad X60 which uses the Intel 82801G HDA audio chip.  This 
> > > used to work for me, but lately (sometime during 2.6.18-rcX series) it 
> > > stopped working - programs trying to use it tend to just block forever 
> > > waiting for /dev/dsp.
> > > 
> > > The only obvious symptom is:
> > > 
> > >     hda_intel: azx_get_response timeout, switching to single_cmd mode...
> > > 
> > > appearing in the kernel log when booting.
> > > 
> > 
> > There is no big change relevant to TP X60 during 2.6.18rc, so I don't
> > think it's a regression in the hd-audio driver code.
> > 
> > > Details attached.  The dmesg output is for the FC6 distro kernel 
> > > 2.6.18-1.2689.fc6PAE, but I see the same symptoms with 2.6.18-mm1.
> > 
> > You must see difference with mm1 (suppose that mm1 already includes
> > the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
> > the driver first switches to poling mode, then single_cmd mode as
> > fallback.
> > 
> > Also, try disable_msi=1 option for mm1.  MSI seems broken on some
> > systems.
> 
> is that "pci=nomsi" ?

No, snd-hda-intel driver has a new module option "disable_msi" to
disable MSI support on that driver.  As default, it's off, i.e. MSI is
enabled if available.  (Well, I feel it's better to rename it
enable_msi and set on as default...)

Sorry for unclear text.


Takashi

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Randy Dunlap]

On Tue, 26 Sep 2006 17:48:33 +0200 Takashi Iwai wrote:

> At Tue, 26 Sep 2006 08:37:20 -0700,
> Randy Dunlap wrote:
> > 
> > On Tue, 26 Sep 2006 12:16:33 +0200 Takashi Iwai wrote:
> > 
> > > At Mon, 25 Sep 2006 12:58:08 -0700,
> > > Jeremy Fitzhardinge wrote:
> > > > 
> > > > I have a ThinkPad X60 which uses the Intel 82801G HDA audio chip.  This 
> > > > used to work for me, but lately (sometime during 2.6.18-rcX series) it 
> > > > stopped working - programs trying to use it tend to just block forever 
> > > > waiting for /dev/dsp.
> > > > 
> > > > The only obvious symptom is:
> > > > 
> > > >     hda_intel: azx_get_response timeout, switching to single_cmd mode...
> > > > 
> > > > appearing in the kernel log when booting.
> > > > 
> > > 
> > > There is no big change relevant to TP X60 during 2.6.18rc, so I don't
> > > think it's a regression in the hd-audio driver code.
> > > 
> > > > Details attached.  The dmesg output is for the FC6 distro kernel 
> > > > 2.6.18-1.2689.fc6PAE, but I see the same symptoms with 2.6.18-mm1.
> > > 
> > > You must see difference with mm1 (suppose that mm1 already includes
> > > the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
> > > the driver first switches to poling mode, then single_cmd mode as
> > > fallback.
> > > 
> > > Also, try disable_msi=1 option for mm1.  MSI seems broken on some
> > > systems.
> > 
> > is that "pci=nomsi" ?
> 
> No, snd-hda-intel driver has a new module option "disable_msi" to
> disable MSI support on that driver.  As default, it's off, i.e. MSI is
> enabled if available.  (Well, I feel it's better to rename it
> enable_msi and set on as default...)
> 
> Sorry for unclear text.

ugh.  We shouldn't have drivers with such options IMO.
I have seen/used MSI for ethernet, SATA, and audio.
It either works for all of them or none of them AFAIK.

Why do you think that it should not just be a global system option/flag?

---
~Randy

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Tue, 26 Sep 2006 08:56:11 -0700,
Randy Dunlap wrote:
> 
> On Tue, 26 Sep 2006 17:48:33 +0200 Takashi Iwai wrote:
> 
> > At Tue, 26 Sep 2006 08:37:20 -0700,
> > Randy Dunlap wrote:
> > > 
> > > On Tue, 26 Sep 2006 12:16:33 +0200 Takashi Iwai wrote:
> > > 
> > > > At Mon, 25 Sep 2006 12:58:08 -0700,
> > > > Jeremy Fitzhardinge wrote:
> > > > > 
> > > > > I have a ThinkPad X60 which uses the Intel 82801G HDA audio chip.  This 
> > > > > used to work for me, but lately (sometime during 2.6.18-rcX series) it 
> > > > > stopped working - programs trying to use it tend to just block forever 
> > > > > waiting for /dev/dsp.
> > > > > 
> > > > > The only obvious symptom is:
> > > > > 
> > > > >     hda_intel: azx_get_response timeout, switching to single_cmd mode...
> > > > > 
> > > > > appearing in the kernel log when booting.
> > > > > 
> > > > 
> > > > There is no big change relevant to TP X60 during 2.6.18rc, so I don't
> > > > think it's a regression in the hd-audio driver code.
> > > > 
> > > > > Details attached.  The dmesg output is for the FC6 distro kernel 
> > > > > 2.6.18-1.2689.fc6PAE, but I see the same symptoms with 2.6.18-mm1.
> > > > 
> > > > You must see difference with mm1 (suppose that mm1 already includes
> > > > the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
> > > > the driver first switches to poling mode, then single_cmd mode as
> > > > fallback.
> > > > 
> > > > Also, try disable_msi=1 option for mm1.  MSI seems broken on some
> > > > systems.
> > > 
> > > is that "pci=nomsi" ?
> > 
> > No, snd-hda-intel driver has a new module option "disable_msi" to
> > disable MSI support on that driver.  As default, it's off, i.e. MSI is
> > enabled if available.  (Well, I feel it's better to rename it
> > enable_msi and set on as default...)
> > 
> > Sorry for unclear text.
> 
> ugh.  We shouldn't have drivers with such options IMO.
> I have seen/used MSI for ethernet, SATA, and audio.

Heh, you're a lucky guy :)

> It either works for all of them or none of them AFAIK.
> 
> Why do you think that it should not just be a global system option/flag?

In the ealier version, we didn't call pci_enable_msi() in the driver
while the newer version does unless you pass disable_msi=1 option.
Thus, this option means to behave like the old driver.  This makes
much easier to find out a regression than a global boot option
affecting all subsytems.


Takashi

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Andrew Morton]

On Tue, 26 Sep 2006 12:16:33 +0200
Takashi Iwai <tiwai@suse.de> wrote:

> You must see difference with mm1 (suppose that mm1 already includes
> the latest ALSA patches).

No, the alsa tree was accidentally omitted from 2.6.18-mm1, sorry.

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Tue, 26 Sep 2006 09:31:42 -0700,
Andrew Morton wrote:
> 
> On Tue, 26 Sep 2006 12:16:33 +0200
> Takashi Iwai <tiwai@suse.de> wrote:
> 
> > You must see difference with mm1 (suppose that mm1 already includes
> > the latest ALSA patches).
> 
> No, the alsa tree was accidentally omitted from 2.6.18-mm1, sorry.

Ah, that makes sense.  Thanks for notice.


Takashi

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Jeremy Fitzhardinge]

Takashi Iwai wrote:
> You must see difference with mm1 (suppose that mm1 already includes
> the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
> the driver first switches to poling mode, then single_cmd mode as
> fallback.
>   

I tried -mm2, and I'm seeing the same problem.

> Also, try disable_msi=1 option for mm1.  MSI seems broken on some
> systems.
>   

This made no difference.

    J

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Sat, 30 Sep 2006 23:03:08 -0700,
Jeremy Fitzhardinge wrote:
> 
> Takashi Iwai wrote:
> > You must see difference with mm1 (suppose that mm1 already includes
> > the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
> > the driver first switches to poling mode, then single_cmd mode as
> > fallback.
> >   
> 
> I tried -mm2, and I'm seeing the same problem.

At least, you have to see a different kernel message after the
patch...  Could you confirm it?


Takashi

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Jeremy Fitzhardinge]

Takashi Iwai wrote:
> At least, you have to see a different kernel message after the
> patch...  Could you confirm it?
>   

No, it looks like the same message as ever:

    hda_intel: azx_get_response timeout, switching to polling mode...
    hda_intel: azx_get_response timeout, switching to single_cmd mode...


This is with -mm3.

    J

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Wed, 04 Oct 2006 08:16:17 -0700,
Jeremy Fitzhardinge wrote:
> 
> Takashi Iwai wrote:
> > At least, you have to see a different kernel message after the
> > patch...  Could you confirm it?
> >   
> 
> No, it looks like the same message as ever:
> 
>     hda_intel: azx_get_response timeout, switching to polling mode...

This is a new message.  There was no poling mode on 2.6.18.

>     hda_intel: azx_get_response timeout, switching to single_cmd mode...

So, this looks like that the CORB/RIRB register mapping is actually
broken...


Takashi

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Wed, 04 Oct 2006 08:16:17 -0700,
Jeremy Fitzhardinge wrote:
> 
> Takashi Iwai wrote:
> > At least, you have to see a different kernel message after the
> > patch...  Could you confirm it?
> >   
> 
> No, it looks like the same message as ever:
> 
>     hda_intel: azx_get_response timeout, switching to polling mode...
>     hda_intel: azx_get_response timeout, switching to single_cmd mode...

A counter of RIRB pending commands could overflow the size of RIRB 
when a bunch of commands are sent but not synced.  This may lead to
the azx_get_response error, theoretically.

Could you apply the patch below and check what values are shown there?


thanks,

Takashi

diff -r 4963791e6192 sound/pci/hda/hda_intel.c
--- a/sound/pci/hda/hda_intel.c	Wed Oct 04 18:38:16 2006 +0200
+++ b/sound/pci/hda/hda_intel.c	Wed Oct 04 20:59:57 2006 +0200
@@ -325,6 +325,7 @@ struct azx {
 	/* CORB/RIRB */
 	struct azx_rb corb;
 	struct azx_rb rirb;
+	int max_rirb_cmds;
 
 	/* BDL, CORB/RIRB and position buffers */
 	struct snd_dma_buffer bdl;
@@ -480,6 +481,8 @@ static int azx_corb_send_cmd(struct hda_
 
 	spin_lock_irq(&chip->reg_lock);
 	chip->rirb.cmds++;
+	if (chip->rirb.cmds > chip->max_rirb_cmds)
+		chip->max_rirb_cmds = chip->rirb.cmds;
 	chip->corb.buf[wp] = cpu_to_le32(val);
 	azx_writel(chip, CORBWP, wp);
 	spin_unlock_irq(&chip->reg_lock);
@@ -538,12 +541,16 @@ static unsigned int azx_rirb_get_respons
 	if (!chip->polling_mode) {
 		snd_printk(KERN_WARNING "hda_intel: azx_get_response timeout, "
 			   "switching to polling mode...\n");
+		snd_printk(KERN_WARNING "           RIRB pending = %d, peak = %d\n",
+			   chip->rirb.cmds, chip->max_rirb_cmds);
 		chip->polling_mode = 1;
 		goto again;
 	}
 
 	snd_printk(KERN_ERR "hda_intel: azx_get_response timeout, "
 		   "switching to single_cmd mode...\n");
+	snd_printk(KERN_ERR "           RIRB pending = %d, peak = %d\n",
+		   chip->rirb.cmds, chip->max_rirb_cmds);
 	chip->rirb.rp = azx_readb(chip, RIRBWP);
 	chip->rirb.cmds = 0;
 	/* switch to single_cmd mode */

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Jeremy Fitzhardinge]

Takashi Iwai wrote:
> A counter of RIRB pending commands could overflow the size of RIRB 
> when a bunch of commands are sent but not synced.  This may lead to
> the azx_get_response error, theoretically.
>
> Could you apply the patch below and check what values are shown there?
>   
I'll try it, but I re-enabled the modem in the bios, and I no longer get 
this message and it appears to work (there seems to be a secondary 
problem that the volume hotkeys have stopped working, but I suspect 
that's more ACPI-related).

    J

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Takashi Iwai]

At Wed, 04 Oct 2006 13:07:56 -0700,
Jeremy Fitzhardinge wrote:
> 
> Takashi Iwai wrote:
> > A counter of RIRB pending commands could overflow the size of RIRB 
> > when a bunch of commands are sent but not synced.  This may lead to
> > the azx_get_response error, theoretically.
> >
> > Could you apply the patch below and check what values are shown there?
> >   
> I'll try it, but I re-enabled the modem in the bios, and I no longer get 
> this message and it appears to work (there seems to be a secondary 
> problem that the volume hotkeys have stopped working, but I suspect 
> that's more ACPI-related).

Ah, that's good to hear.

Is the modem also HD-audio modem?  If so, you have two codec#* files
in /proc/asound/card0.


Takashi

Re: 2.6.18: hda_intel:azx_get_response timeout, switching to single_cmd mode...

[Shai Peretz]

Jeremy Fitzhardinge <jeremy <at> goop.org> writes:

> 
> Takashi Iwai wrote:
> > You must see difference with mm1 (suppose that mm1 already includes
> > the latest ALSA patches).  When the CORB/RIRB interrupt gets broken,
> > the driver first switches to poling mode, then single_cmd mode as
> > fallback.
> >   
> 
> I tried -mm2, and I'm seeing the same problem.
> 
> > Also, try disable_msi=1 option for mm1.  MSI seems broken on some
> > systems.
> >   
> 
> This made no difference.
> 
>     J
> 
> -------------------------------------------------------------------------
> Take Surveys. Earn Cash. Influence the Future of IT
> Join SourceForge.net's Techsay panel and you'll get the chance to share your
> opinions on IT & business topics through brief surveys -- and earn cash
> http://www.techsay.com/default.php?page=join.php&p=sourceforge&CID=DEVDEV
> 

Hi,

I am trying to fight the same issue for few weeks now, with no progress.
under windows sound works fine, so seems like no hardware issue.
under ubuntu 6.10, with latest alsa drivers, I get the message above.
seems like the kernel only see the modem part of the sound card, and not the
other part.
on my system, I can't disable/enable the modem in the bios, only the whole sound
card.

Any idea what to look for next?

Thanks, Shai.

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Tomasz Torcz]

[-- Attachment #1: Type: text/plain, Size: 764 bytes --]

On Mon, Sep 25, 2006 at 12:58:08PM -0700, Jeremy Fitzhardinge wrote:
> I have a ThinkPad X60 which uses the Intel 82801G HDA audio chip.  This 
> used to work for me, but lately (sometime during 2.6.18-rcX series) it 
> stopped working - programs trying to use it tend to just block forever 
> waiting for /dev/dsp.
> 
> The only obvious symptom is:
> 
>    hda_intel: azx_get_response timeout, switching to single_cmd mode...
> 
> appearing in the kernel log when booting.


  Just a blind shot -- do you have modem enabled in BIOS? Sometimes
disabling (hiding) modem breaks sound.

-- 
Tomasz Torcz                        To co nierealne -- tutaj jest normalne.
zdzichu@irc.-nie.spam-.pl          Ziomale na życie mają tu patenty specjalne.


[-- Attachment #2: Type: application/pgp-signature, Size: 229 bytes --]

Re: 2.6.18: hda_intel: azx_get_response timeout, switching to single_cmd mode...

[Jeremy Fitzhardinge]

Tomasz Torcz wrote:
>   Just a blind shot -- do you have modem enabled in BIOS? Sometimes
> disabling (hiding) modem breaks sound.
>   

Good suggestion.   It might be disabled; I'll switch it around next time 
I reboot.

    J