Most recent kernel where this bug did not occur: Distribution: debian /DeMuDi Hardware Environment: HP t3120.it desktop PC Software Environment: Problem Description: output of dmesg: IC P0P4 P0P5 P0P6 P0P7 PS2K PS2M USB1 USB2 USB3 USB4 EUSB MC97 ACPI: (supports S0 S1 S3 S4 S5) RAMDISK: cramfs filesystem found at block 0 RAMDISK: Loading 1424KiB [1 disk] into ram disk... done. VFS: Mounted root (cramfs filesystem) readonly. ***************************************************************************** * * * REMINDER, the following debugging option is turned on in your .config: * * * * CONFIG_DEBUG_DEADLOCKS * * * * it may increase runtime overhead and latencies. * * * ***************************************************************************** Freeing unused kernel memory: 148k freed NET: Registered protocol family 1 SCSI subsystem initialized usbcore: registered new driver usbfs usbcore: registered new driver hub Initializing USB Mass Storage driver... usbcore: registered new driver usb-storage USB Mass Storage support registered. libata version 1.12 loaded. ata_piix version 1.04 ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11 PCI: setting IRQ 11 as level-triggered ACPI: PCI Interrupt 0000:00:1f.2[B] -> Link [LNKD] -> GSI 11 (level, low) -> IRQ 11 PCI: Setting latency timer of device 0000:00:1f.2 to 64 ata1: SATA max UDMA/133 cmd 0x9400 ctl 0x9002 bmdma 0x8000 irq 11 ata2: SATA max UDMA/133 cmd 0x8800 ctl 0x8402 bmdma 0x8008 irq 11 ata1: dev 0 cfg 49:2f00 82:3069 83:7d01 84:4023 85:3069 86:3c01 87:4023 88:203f ata1: dev 0 ATA, max UDMA/100, 312581808 sectors: lba48 ata1: dev 0 configured for UDMA/100 scsi0 : ata_piix ATA: abnormal status 0x7F on port 0x8807 ata2: disabling port scsi1 : ata_piix Vendor: ATA Model: ST3160023AS Rev: 3.43 Type: Direct-Access ANSI SCSI revision: 05 SCSI device sda: 312581808 512-byte hdwr sectors (160042 MB) SCSI device sda: drive cache: write back SCSI device sda: 312581808 512-byte hdwr sectors (160042 MB) SCSI device sda: drive cache: write back sda: sda1 sda2 sda3 < sda5 sda6 > Attached scsi disk sda at scsi0, channel 0, id 0, lun 0 EXT3-fs: mounted filesystem with ordered data mode. kjournald starting. Commit interval 5 seconds input: PC Speaker mice: PS/2 mouse device common for all mice Real Time Clock Driver v1.12 pci_hotplug: PCI Hot Plug PCI Core version: 0.5 shpchp: shpc_init : shpc_cap_offset == 0 shpchp: shpc_init : shpc_cap_offset == 0 shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 hdb: max request size: 1024KiB hdb: 490234752 sectors (251000 MB) w/16384KiB Cache, CHS=30515/255/63, UDMA(33) hdb: cache flushes supported hdb: hdb1 hdb2 hdb3 < hdb5 hdb6 hdb7 > hda: ATAPI 40X DVD-ROM DVD-R CD-R/RW drive, 2048kB Cache, UDMA(33) Uniform CD-ROM driver Revision: 3.20 hw_random hardware driver 1.0.0 loaded USB Universal Host Controller Interface driver v2.3 ACPI: PCI Interrupt Link [LNKH] enabled at IRQ 5 PCI: setting IRQ 5 as level-triggered ACPI: PCI Interrupt 0000:00:1d.0[A] -> Link [LNKH] -> GSI 5 (level, low) -> IRQ 5 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 5, io base 0x00009800 hub 1-0:1.0: USB hub found hub 1-0:1.0: 2 ports detected Linux agpgart interface v0.101 (c) Dave Jones agpgart: Detected an Intel 915G Chipset. agpgart: AGP aperture is 256M @ 0x0 ACPI: PCI Interrupt 0000:00:1d.1[B] -> Link [LNKD] -> GSI 11 (level, low) -> IRQ 11 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 11, io base 0x0000a000 input: ImPS/2 Generic Wheel Mouse on isa0060/serio1 ieee1394: Initialized config rom entry `ip1394' usb 1-2: new full speed USB device using uhci_hcd and address 2 ath_hal: module license 'Proprietary' taints kernel. ath_hal: 0.9.14.9 (AR5210, AR5211, AR5212, RF5111, RF5112, RF2413) wlan: 0.8.6.0 (EXPERIMENTAL) ath_rate_sample: 1.2 ath_pci: 0.9.6.0 (EXPERIMENTAL) hub 2-0:1.0: USB hub found hub 2-0:1.0: 2 ports detected ACPI: PCI Interrupt 0000:00:1d.2[C] -> Link [LNKC] -> GSI 3 (level, low) -> IRQ 3 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 3, io base 0x0000a400 usb 2-2: new full speed USB device using uhci_hcd and address 2 hub 3-0:1.0: USB hub found hub 3-0:1.0: 2 ports detected ACPI: PCI Interrupt 0000:00:1d.3[D] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10 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 10, io base 0x0000a800 hub 4-0:1.0: USB hub found hub 4-0:1.0: 2 ports detected ACPI: PCI Interrupt 0000:00:1d.7[A] -> Link [LNKH] -> GSI 5 (level, low) -> IRQ 5 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: debug port 1 ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 5 ehci_hcd 0000:00:1d.7: irq 5, io mem 0xccfffc00 PCI: cache line size of 128 is not supported by device 0000:00:1d.7 ehci_hcd 0000:00:1d.7: USB 2.0 initialized, EHCI 1.00, driver 10 Dec 2004 usb 2-2: USB disconnect, address 2 usb 1-2: USB disconnect, address 2 hub 5-0:1.0: USB hub found hub 5-0:1.0: 8 ports detected ohci1394: $Rev: 1313 $ Ben Collins <bcollins@debian.org> ACPI: PCI Interrupt Link [LNKE] enabled at IRQ 7 PCI: setting IRQ 7 as level-triggered ACPI: PCI Interrupt 0000:03:01.0[A] -> Link [LNKE] -> GSI 7 (level, low) -> IRQ 7 ohci1394: fw-host0: OHCI-1394 1.0 (PCI): IRQ=[7] MMIO=[cffff800-cfffffff] Max Packet=[2048] ACPI: PCI Interrupt 0000:03:03.0[A] -> Link [LNKD] -> GSI 11 (level, low) -> IRQ 11 Build date: Dec 27 2005 Debugging version (IEEE80211) ath0: 11b rates: 1Mbps 2Mbps 5.5Mbps 11Mbps ath0: 11g rates: 1Mbps 2Mbps 5.5Mbps 11Mbps 6Mbps 9Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps ath0: turboG rates: 6Mbps 9Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps ath0: H/W encryption support: WEP AES AES_CCM TKIP ath0: mac 5.9 phy 4.3 radio 4.6 ath0: Use hw queue 1 for WME_AC_BE traffic ath0: Use hw queue 0 for WME_AC_BK traffic ath0: Use hw queue 2 for WME_AC_VI traffic ath0: Use hw queue 3 for WME_AC_VO traffic ath0: Use hw queue 8 for CAB traffic ath0: Use hw queue 9 for beacons Debugging version (ATH) ath0: Atheros 5212: mem=0xcffe0000, irq=11 ACPI: PCI Interrupt 0000:03:04.0[A] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10 Consumer PCM code does not work well at the moment --jk usb 2-2: new full speed USB device using uhci_hcd and address 3 usb 1-2: new full speed USB device using uhci_hcd and address 3 ieee1394: Host added: ID:BUS[0-00:1023] GUID[0011d8000051e481] eth1394: $Rev: 1312 $ Ben Collins <bcollins@debian.org> eth1394: eth0: IEEE-1394 IPv4 over 1394 Ethernet (fw-host0) usb 4-1: new full speed USB device using uhci_hcd and address 2 scsi2 : SCSI emulation for USB Mass Storage devices usb-storage: device found at 2 usb-storage: waiting for device to settle before scanning drivers/usb/class/usblp.c: usblp0: USB Bidirectional printer dev 3 if 0 alt 0 proto 2 vid 0x04E8 pid 0x323A usbcore: registered new driver usblp drivers/usb/class/usblp.c: v0.13: USB Printer Device Class driver usbcore: registered new driver snd-usb-audio Adding 3515360k swap on /dev/sda6. Priority:-1 extents:1 across:3515360k EXT3 FS on sda2, internal journal Probing IDE interface ide1... sbp2: $Rev: 1306 $ Ben Collins <bcollins@debian.org> ieee1394: sbp2: Driver forced to serialize I/O (serialize_io=1) ieee1394: sbp2: Try serialize_io=0 for better performance do_settimeofday() was called! do_settimeofday() was called! Vendor: Generic Model: USB SD Reader Rev: 1.00 Type: Direct-Access ANSI SCSI revision: 00 Attached scsi removable disk sdb at scsi2, channel 0, id 0, lun 0 Vendor: Generic Model: USB CF Reader Rev: 1.01 Type: Direct-Access ANSI SCSI revision: 00 Attached scsi removable disk sdc at scsi2, channel 0, id 0, lun 1 Vendor: Generic Model: USB SM Reader Rev: 1.02 Type: Direct-Access ANSI SCSI revision: 00 Attached scsi removable disk sdd at scsi2, channel 0, id 0, lun 2 Vendor: Generic Model: USB MS Reader Rev: 1.03 Type: Direct-Access ANSI SCSI revision: 00 Attached scsi removable disk sde at scsi2, channel 0, id 0, lun 3 usb-storage: device scan complete kjournald starting. Commit interval 5 seconds EXT3 FS on sda5, internal journal EXT3-fs: mounted filesystem with ordered data mode. EXT3-fs warning: maximal mount count reached, running e2fsck is recommended kjournald starting. Commit interval 5 seconds EXT3 FS on hdb5, internal journal EXT3-fs: mounted filesystem with ordered data mode. EXT3-fs warning: maximal mount count reached, running e2fsck is recommended kjournald starting. Commit interval 5 seconds EXT3 FS on hdb6, internal journal EXT3-fs: mounted filesystem with ordered data mode. EXT3-fs warning: maximal mount count reached, running e2fsck is recommended kjournald starting. Commit interval 5 seconds EXT3 FS on hdb7, internal journal EXT3-fs: mounted filesystem with ordered data mode. NET: Registered protocol family 17 do_settimeofday() was called! Realtime LSM initialized (group 29, mlock=1) ACPI: CPU0 (power states: C1[C1]) ACPI: Processor [CPU1] (supports 8 throttling states) ACPI: Power Button (FF) [PWRF] ACPI: Power Button (CM) [PWRB] lp: driver loaded but no devices found ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] Bluetooth: Core ver 2.7 NET: Registered protocol family 31 Bluetooth: HCI device and connection manager initialized Bluetooth: HCI socket layer initialized Bluetooth: L2CAP ver 2.7 Bluetooth: L2CAP socket layer initialized Bluetooth: RFCOMM ver 1.5 Bluetooth: RFCOMM socket layer initialized Bluetooth: RFCOMM TTY layer initialized ACPI: PCI Interrupt 0000:01:00.0[A] -> Link [LNKA] -> GSI 10 (level, low) -> IRQ 10 PCI: Setting latency timer of device 0000:01:00.0 to 64 NVRM: loading NVIDIA Linux x86 Kernel Module 1.0-8762 Mon May 15 13:06:38 PDT 2006 WARNING: modprobe/2669 changed soft IRQ-flags. [<f952b810>] __nv_setup_pat_entries+0x13/0xaf [nvidia] (8) [<f952b9a2>] __nv_enable_pat_support+0x43/0x69 [nvidia] (24) [<f8855244>] nvidia_init_module+0x244/0x332 [nvidia] (28) [<c0137626>] sys_init_module+0x92/0x1b4 (20) [<c0103329>] syscall_call+0x7/0xb (16) ------------------------------ | showing all locks held by: | (modprobe/2669 [dfd56cb0, 118]): ------------------------------ #001: [f6ee3604] {(struct semaphore *)(&os_sema->wait)} ... acquired at: os_alloc_sema+0x31/0x55 [nvidia] BUG: modprobe/2669, lock held at task exit time! NVRM: Trying to sleep during raised irql!! NVRM: are we holding a lock? NVRM: skipping os_delay NVRM: Trying to sleep during raised irql!! NVRM: are we holding a lock? NVRM: skipping os_delay NVRM: Trying to sleep during raised irql!! NVRM: are we holding a lock? NVRM: skipping os_delay [f6ee3604] {(struct semaphore *)(&os_sema->wait)} .. held by: modprobe: 2669 [dfd56cb0, 118] ... acquired at: os_alloc_sema+0x31/0x55 [nvidia] NVRM: Trying to sleep during raised irql!! NVRM: are we holding a lock? NVRM: skipping os_delay NVRM: Trying to sleep during raised irql!! NVRM: are we holding a lock? NVRM: skipping os_delay ISO 9660 Extensions: Microsoft Joliet Level 1 ISOFS: changing to secondary root ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0] ACPI-0339: *** Error: Looking up [\_TZ_.THRM] in namespace, AE_NOT_FOUND search_node dfff7800 start_node dfff7800 return_node 00000000 ACPI-0508: *** Error: Method execution failed [\_GPE._L1C] (Node dfff7800), AE_NOT_FOUND ACPI-0549: *** Error: AE_NOT_FOUND while evaluating method [_L1C] for GPE[ 0]
Created attachment 8254 [details] output of acpidump
Can this be reproduced without the Nvidia module, please?
Reply-To: emiliano.grilli@poste.it luned
besides the error message of AE_NOT_FOUND, do you perceive anything NOT functional?
What kernel and ACPICA version do we have here -- This is 2.6.16, so it is running 20060127? please _attach_ (not paste) the output from dmesg -s64000 so it goes back to the beginning. cat /proc/acpi/info should tell us the ACPICA version. Is it possible to boot the latest -mm kernel which includes the latest version of the ACPI patch?
Reply-To: emiliano.grilli@poste.it mercoled
Reply-To: emiliano.grilli@poste.it gioved
Created attachment 8281 [details] This is the output of dmesg -s64000
I disassembled the DSDT, and indeed _TZ_.THRM does not exist there. Notify (\_TZ.THRM, 0x80) Perhaps this is a bug, or an SSDT that should have been loaded was not loaded for some reason.
Your BIOS does not have _TZ_.THRM object, which is refered in one other ACPI event handlers. You have several choices: Update BIOS of your machine. Look for thermal control in BIOS settings and enable it if it's disabled. Manually patch your DSDT to remove event handler with problematic reference.
I also had a look at the DSDT and there seems a SSDT exists that should get loaded explicitly. This is in _PDC path so I expect it gets loaded when the cpufreq driver gets loaded. Try to get rid of the nvidia module first. I expect when you try to modprobe the cpufreq driver, the SSDT will get loaded and possibly the THRM device is in it.
Emiliano Grilli, would you please try as Thomas suggested in comment# 12? Or we have no choice but to close this bug due to it's obivously a BIOS issue...thanks.
I'll mark this bug as wontfix, as it's apparently a bios bug and lack of response from bug reporter. please reopen with action requested in comment# 11.. thanks.