Bug 8451 - Vaio hangs when power connected
Summary: Vaio hangs when power connected
Status: REJECTED INVALID
Alias: None
Product: Power Management
Classification: Unclassified
Component: Other (show other bugs)
Hardware: i386 Linux
: P2 blocking
Assignee: Zhang Rui
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2007-05-08 03:36 UTC by Jim McElwaine
Modified: 2008-07-09 03:17 UTC (History)
4 users (show)

See Also:
Kernel Version: kernel-2.6.20-1.2948.fc6
Subsystem:
Regression: ---
Bisected commit-id:


Attachments
print out which GPE is fired when ac is plugged in (1.10 KB, patch)
2007-11-19 17:28 UTC, Zhang Rui
Details | Diff
/var/log/messages of crash with and without patch (393.99 KB, text/plain)
2007-11-20 04:10 UTC, Jim McElwaine
Details
acpidump output (133.62 KB, application/octet-stream)
2007-12-07 07:48 UTC, Jim McElwaine
Details
.config from kernel compile (77.60 KB, application/octet-stream)
2007-12-10 15:12 UTC, Jim McElwaine
Details
./acpidump > acpidump_output (137.45 KB, application/octet-stream)
2008-03-03 13:47 UTC, Jim McElwaine
Details
dmesg from after a crash (25.12 KB, text/plain)
2008-03-03 14:30 UTC, Jim McElwaine
Details
/var/log/messages (62.63 KB, application/octet-stream)
2008-03-03 14:32 UTC, Jim McElwaine
Details
smartctl -a /dev/sda >smart (4.55 KB, text/plain)
2008-03-03 15:53 UTC, Jim McElwaine
Details
./acpidump --addr 0x7FE76C73 --length 0x000001EA -o aslb1 (490 bytes, application/octet-stream)
2008-03-04 15:33 UTC, Jim McElwaine
Details
./acpidump --addr 0x7FE76E5D --length 0x00000089 -o aslb2 (137 bytes, application/octet-stream)
2008-03-04 15:33 UTC, Jim McElwaine
Details
./acpidump --addr 0x7FE769B9 --length 0x00000235 -o aslb3 (565 bytes, application/octet-stream)
2008-03-04 15:34 UTC, Jim McElwaine
Details
./acpidump --addr 0x7FE76BEE --length 0x00000085 -o aslb4 (133 bytes, application/octet-stream)
2008-03-04 15:34 UTC, Jim McElwaine
Details
Patch to eliminate improper warning message (1.82 KB, patch)
2008-03-05 13:12 UTC, Robert Moore
Details | Diff
Linuxized version of previous patch (1.75 KB, patch)
2008-03-06 09:35 UTC, Robert Moore
Details | Diff

Description Jim McElwaine 2007-05-08 03:36:41 UTC
Most recent kernel where this bug did *NOT* occur: occurred in all tried kernels
Distribution: Fedora Core 6
Hardware Environment: Sony Vaio
Software Environment:
Problem Description: Laptop hangs when power cord is connected

Steps to reproduce: 
disconnect power cable
connect power cable
The laptop then hangs. I've looked in /var/log/messages after a reboot but there
is nothing there. The same problem occurs if the laptop is started under battery
power and then the power cable connected. What can I do to find out more
information about this type of crash.

lspci

00:00.0 Host bridge: Intel Corporation Mobile 945GM/PM/GMS/940GML and 945GT
Express Memory Controller Hub (rev 03)
00:02.0 VGA compatible controller: Intel Corporation Mobile 945GM/GMS/940GML
Express Integrated Graphics Controller (rev 03)
00:02.1 Display controller: Intel Corporation Mobile 945GM/GMS/940GML Express
Integrated Graphics Controller (rev 03)
00:1b.0 Audio device: Intel Corporation 82801G (ICH7 Family) High Definition
Audio Controller (rev 02)
00:1c.0 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 1
(rev 02)
00:1c.1 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 2
(rev 02)
00:1c.2 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 3
(rev 02)
00:1c.3 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 4
(rev 02)
00:1d.0 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #1 (rev 02)
00:1d.1 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #2 (rev 02)
00:1d.2 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #3 (rev 02)
00:1d.3 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI #4 (rev 02)
00:1d.7 USB Controller: Intel Corporation 82801G (ICH7 Family) USB2 EHCI
Controller (rev 02)
00:1e.0 PCI bridge: Intel Corporation 82801 Mobile PCI Bridge (rev e2)
00:1f.0 ISA bridge: Intel Corporation 82801GBM (ICH7-M) LPC Interface Bridge
(rev 02)
00:1f.1 IDE interface: Intel Corporation 82801G (ICH7 Family) IDE Controller
(rev 02)
00:1f.2 IDE interface: Intel Corporation 82801GBM/GHM (ICH7 Family) Serial ATA
Storage Controller IDE (rev 02)
00:1f.3 SMBus: Intel Corporation 82801G (ICH7 Family) SMBus Controller (rev 02)
06:00.0 Network controller: Intel Corporation PRO/Wireless 3945ABG Network
Connection (rev 02)
07:00.0 Ethernet controller: Marvell Technology Group Ltd. 88E8036 PCI-E Fast
Ethernet Controller (rev 15)
09:04.0 CardBus bridge: Texas Instruments PCIxx12 Cardbus Controller
09:04.1 FireWire (IEEE 1394): Texas Instruments PCIxx12 OHCI Compliant IEEE 1394
Host Controller
09:04.2 Mass storage controller: Texas Instruments 5-in-1 Multimedia Card Reader
(SD/MMC/MS/MS PRO/xD)

dmesg
[jnm11@localhost ~]$ dmesg
Linux version 2.6.20-1.2948.fc6 (brewbuilder@hs20-bc1-7.build.redhat.com) (gcc
version 4.1.1 20070105 (Red Hat 4.1.1-51)) #1 SMP Fri Apr 27 19:48:40 EDT 2007
BIOS-provided physical RAM map:
sanitize start
sanitize end
copy_e820_map() start: 0000000000000000 size: 000000000009f800 end:
000000000009f800 type: 1
copy_e820_map() type is E820_RAM
copy_e820_map() start: 000000000009f800 size: 0000000000000800 end:
00000000000a0000 type: 2
copy_e820_map() start: 00000000000dc000 size: 0000000000024000 end:
0000000000100000 type: 2
copy_e820_map() start: 0000000000100000 size: 000000007f570000 end:
000000007f670000 type: 1
copy_e820_map() type is E820_RAM
copy_e820_map() start: 000000007f670000 size: 000000000000e000 end:
000000007f67e000 type: 3
copy_e820_map() start: 000000007f67e000 size: 0000000000082000 end:
000000007f700000 type: 4
copy_e820_map() start: 000000007f700000 size: 0000000000900000 end:
0000000080000000 type: 2
copy_e820_map() start: 00000000e0000000 size: 0000000010000000 end:
00000000f0000000 type: 2
copy_e820_map() start: 00000000fec00000 size: 0000000000010000 end:
00000000fec10000 type: 2
copy_e820_map() start: 00000000fed14000 size: 0000000000006000 end:
00000000fed1a000 type: 2
copy_e820_map() start: 00000000fed1c000 size: 0000000000074000 end:
00000000fed90000 type: 2
copy_e820_map() start: 00000000fee00000 size: 0000000000001000 end:
00000000fee01000 type: 2
copy_e820_map() start: 00000000ff000000 size: 0000000001000000 end:
0000000100000000 type: 2
 BIOS-e820: 0000000000000000 - 000000000009f800 (usable)
 BIOS-e820: 000000000009f800 - 00000000000a0000 (reserved)
 BIOS-e820: 00000000000dc000 - 0000000000100000 (reserved)
 BIOS-e820: 0000000000100000 - 000000007f670000 (usable)
 BIOS-e820: 000000007f670000 - 000000007f67e000 (ACPI data)
 BIOS-e820: 000000007f67e000 - 000000007f700000 (ACPI NVS)
 BIOS-e820: 000000007f700000 - 0000000080000000 (reserved)
 BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved)
 BIOS-e820: 00000000fec00000 - 00000000fec10000 (reserved)
 BIOS-e820: 00000000fed14000 - 00000000fed1a000 (reserved)
 BIOS-e820: 00000000fed1c000 - 00000000fed90000 (reserved)
 BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
 BIOS-e820: 00000000ff000000 - 0000000100000000 (reserved)
1142MB HIGHMEM available.
896MB LOWMEM available.
found SMP MP-table at 000f6480
Using x86 segment limits to approximate NX protection
Entering add_active_range(0, 0, 521840) 0 entries of 256 used
Zone PFN ranges:
  DMA             0 ->     4096
  Normal       4096 ->   229376
  HighMem    229376 ->   521840
early_node_map[1] active PFN ranges
    0:        0 ->   521840
On node 0 totalpages: 521840
  DMA zone: 40 pages used for memmap
  DMA zone: 0 pages reserved
  DMA zone: 4056 pages, LIFO batch:0
  Normal zone: 2200 pages used for memmap
  Normal zone: 223080 pages, LIFO batch:31
  HighMem zone: 2856 pages used for memmap
  HighMem zone: 289608 pages, LIFO batch:31
DMI present.
Using APIC driver default
ACPI: RSDP (v000 PTLTD                                 ) @ 0x000f63b0
ACPI: RSDT (v001   Sony       N0 0x20060710 PTL  0x00000000) @ 0x7f67648f
ACPI: FADT (v002   Sony       N0 0x20060710 PTL  0x0000005a) @ 0x7f67ddde
ACPI: MADT (v001   Sony       N0 0x20060710 PTL  0x0000005a) @ 0x7f67de62
ACPI: BOOT (v001   Sony       N0 0x20060710 PTL  0x00000001) @ 0x7f67dfd8
ACPI: MCFG (v001   Sony       N0 0x20060710 PTL  0x0000005a) @ 0x7f67df02
ACPI: TCPA (v001   Sony       N0 0x20060710 PTL  0x00005a52) @ 0x7f67df3e
ACPI: MADT (v001   Sony       N0 0x20060710 PTL  0x00000000) @ 0x7f67df70
ACPI: SSDT (v001   Sony       N0 0x20060710 PTL  0x20050624) @ 0x7f6776b1
ACPI: SSDT (v001   Sony       N0 0x20060710 PTL  0x20050624) @ 0x7f676ee6
ACPI: SSDT (v001   Sony       N0 0x20060710 PTL  0x20050624) @ 0x7f6764d7
ACPI: DSDT (v001   Sony       N0 0x20060710 PTL  0x0100000e) @ 0x00000000
ACPI: PM-Timer IO Port: 0x1008
ACPI: Local APIC address 0xfee00000
ACPI: 2 duplicate APIC table ignored.
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
Using ACPI (MADT) for SMP configuration information
Allocating PCI resources starting at 88000000 (gap: 80000000:60000000)
Detected 2000.222 MHz processor.
Built 1 zonelists.  Total pages: 516744
Kernel command line: ro root=LABEL=/1
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=c07ab000 soft=c078b000
PID hash table entries: 4096 (order: 12, 16384 bytes)
Console: colour VGA+ 80x25
Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Memory: 2058852k/2087360k available (2189k kernel code, 27180k reserved, 1159k
data, 236k init, 1169856k highmem)
virtual kernel memory layout:
    fixmap  : 0xffc56000 - 0xfffff000   (3748 kB)
    pkmap   : 0xff800000 - 0xffc00000   (4096 kB)
    vmalloc : 0xf8800000 - 0xff7fe000   ( 111 MB)
    lowmem  : 0xc0000000 - 0xf8000000   ( 896 MB)
      .init : 0xc074b000 - 0xc0786000   ( 236 kB)
      .data : 0xc06236e9 - 0xc0745494   (1159 kB)
      .text : 0xc0400000 - 0xc06236e9   (2189 kB)
Checking if this processor honours the WP bit even in supervisor mode... Ok.
Calibrating delay using timer specific routine.. 4003.26 BogoMIPS (lpj=2001631)
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
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: bfe9f3ff 00100000 00000000 00002940 0000c1a9
00000000 00000000
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#0.
Checking 'hlt' instruction... OK.
SMP alternatives: switching to UP code
ACPI: Core revision 20060707
CPU0: Intel Genuine Intel(R) CPU           T2500  @ 2.00GHz stepping 08
SMP alternatives: switching to SMP code
Booting processor 1/1 eip 3000
CPU 1 irqstacks, hard=c07ac000 soft=c078c000
Initializing CPU#1
Calibrating delay using timer specific routine.. 3999.68 BogoMIPS (lpj=1999841)
CPU: After generic 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: bfe9f3ff 00100000 00000000 00002940 0000c1a9
00000000 00000000
Intel machine check architecture supported.
Intel machine check reporting enabled on CPU#1.
CPU1: Intel Genuine Intel(R) CPU           T2500  @ 2.00GHz stepping 08
Total of 2 processors activated (8002.94 BogoMIPS).
ENABLING IO-APIC IRQs
..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1
checking TSC synchronization across 2 CPUs: passed.
Brought up 2 CPUs
sizeof(vma)=84 bytes
sizeof(page)=40 bytes
sizeof(inode)=420 bytes
sizeof(dentry)=144 bytes
sizeof(ext3inode)=596 bytes
sizeof(buffer_head)=56 bytes
sizeof(skbuff)=176 bytes
sizeof(task_struct)=1408 bytes
migration_cost=673
NET: Registered protocol family 16
ACPI: bus type pci registered
PCI: PCI BIOS revision 2.10 entry at 0xfd823, last bus=10
PCI: Using configuration type 1
Setting up standard PCI resources
ACPI: Interpreter enabled
ACPI: Using IOAPIC for interrupt routing
ACPI: PCI Root Bridge [PCI0] (0000:00)
PCI: Probing PCI hardware (bus 00)
Boot video device is 0000:00:02.0
PCI quirk: region 1000-107f claimed by ICH6 ACPI/GPIO/TCO
PCI quirk: region 1180-11bf claimed by ICH6 GPIO
0000:00:1f.1: trying to change BAR0 from 0000 to 01F0
0000:00:1f.1: trying to change BAR1 from 0000 to 03F4
0000:00:1f.1: trying to change BAR2 from 0000 to 0170
0000:00:1f.1: trying to change BAR3 from 0000 to 0374
PCI: Transparent bridge - 0000:00:1e.0
PCI: Bus #0a (-#0d) is hidden behind transparent bridge #09 (-#0a) (try
'pci=assign-busses')
Please report the result to linux-kernel to fix this permanently
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP02._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP03._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP04._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT]
ACPI: PCI Interrupt Link [LNKA] (IRQs 10) *5
ACPI: PCI Interrupt Link [LNKB] (IRQs *10)
ACPI: PCI Interrupt Link [LNKC] (IRQs *10)
ACPI: PCI Interrupt Link [LNKD] (IRQs *10)
ACPI: PCI Interrupt Link [LNKE] (IRQs 10) *0, disabled.
ACPI: PCI Interrupt Link [LNKF] (IRQs *10)
ACPI: PCI Interrupt Link [LNKG] (IRQs *10)
ACPI: PCI Interrupt Link [LNKH] (IRQs *10)
Linux Plug and Play Support v0.97 (c) Adam Belay
pnp: PnP ACPI init
pnp: PnP ACPI: found 11 devices
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
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: d6000000-d7ffffff
  PREFETCH window: d0000000-d1ffffff
PCI: Bridge: 0000:00:1c.1
  IO window: disabled.
  MEM window: dc100000-dc1fffff
  PREFETCH window: disabled.
PCI: Bridge: 0000:00:1c.2
  IO window: 3000-3fff
  MEM window: d8000000-d9ffffff
  PREFETCH window: d2000000-d3ffffff
PCI: Bridge: 0000:00:1c.3
  IO window: 4000-4fff
  MEM window: da000000-dbffffff
  PREFETCH window: d4000000-d5ffffff
PCI: Bus 10, cardbus bridge: 0000:09:04.0
  IO window: 00005000-000050ff
  IO window: 00005400-000054ff
  PREFETCH window: 88000000-8bffffff
  MEM window: 8c000000-8fffffff
PCI: Bridge: 0000:00:1e.0
  IO window: 5000-5fff
  MEM window: dc000000-dc0fffff
  PREFETCH window: 88000000-8bffffff
ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:1c.0 to 64
ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 17 (level, low) -> IRQ 17
PCI: Setting latency timer of device 0000:00:1c.1 to 64
ACPI: PCI Interrupt 0000:00:1c.2[C] -> GSI 18 (level, low) -> IRQ 18
PCI: Setting latency timer of device 0000:00:1c.2 to 64
ACPI: PCI Interrupt 0000:00:1c.3[D] -> GSI 19 (level, low) -> IRQ 19
PCI: Setting latency timer of device 0000:00:1c.3 to 64
PCI: Setting latency timer of device 0000:00:1e.0 to 64
ACPI: PCI Interrupt 0000:09:04.0[A] -> GSI 20 (level, low) -> IRQ 20
NET: Registered protocol family 2
IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
TCP established hash table entries: 131072 (order: 9, 2621440 bytes)
TCP bind hash table entries: 65536 (order: 8, 1310720 bytes)
TCP: Hash tables configured (established 131072 bind 65536)
TCP reno registered
checking if image is initramfs... it is
Freeing initrd memory: 1485k freed
Simple Boot Flag at 0x37 set to 0x1
apm: BIOS not found.
audit: initializing netlink socket (disabled)
audit(1178613342.974: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
ksign: Installing public key data
Loading keyring
- Added public key 41B40C132A183A53
- 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]
Allocate Port Service[0000:00:1c.0:pcie02]
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]
Allocate Port Service[0000:00:1c.1:pcie02]
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]
Allocate Port Service[0000:00:1c.2:pcie02]
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]
Allocate Port Service[0000:00:1c.3:pcie02]
pci_hotplug: PCI Hot Plug PCI Core version: 0.5
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [  Sony] OemTableId [      N0]
[20060707]
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [  Sony] OemTableId [      N0]
[20060707]
ACPI: CPU0 (power states: C1[C1] C2[C2])
ACPI: Processor [CPU0] (supports 8 throttling states)
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [  Sony] OemTableId [      N0]
[20060707]
ACPI (exconfig-0455): Dynamic SSDT Load - OemId [  Sony] OemTableId [      N0]
[20060707]
ACPI: CPU1 (power states: C1[C1] C2[C2])
ACPI: Processor [CPU1] (supports 8 throttling states)
ACPI: Thermal Zone [ATF0] (34 C)
ACPI: Thermal Zone [DTS0] (27 C)
ACPI: Thermal Zone [DTS1] (26 C)
isapnp: Scanning for PnP cards...
isapnp: No Plug & Play device found
Real Time Clock Driver v1.12ac
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 @ 0xc0000000
Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
RAMDISK driver initialized: 16 RAM disks of 16384K size 4096 blocksize
input: Macintosh mouse button emulation as /class/input/input0
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[B] -> GSI 22 (level, low) -> IRQ 21
ICH7: chipset revision 2
ICH7: not 100% native mode: will probe irqs later
    ide0: BM-DMA at 0x1810-0x1817, BIOS settings: hda:DMA, hdb:pio
Probing IDE interface ide0...
hda: MATSHITAUJ-832D, ATAPI CD/DVD-ROM drive
ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
Probing IDE interface ide1...
ide-floppy driver 0.99.newide
Yenta: CardBus bridge found at 0000:09:04.0 [104d:81e6]
Yenta: Enabling burst memory read transactions
Yenta: Using CSCINT to route CSC interrupts to PCI
Yenta: Routing CardBus interrupts to PCI
Yenta TI: socket 0000:09:04.0, mfunc 0x01a21b22, devctl 0x64
Yenta: ISA IRQ mask 0x0cf8, PCI irq 20
Socket status: 30000006
Yenta: Raising subordinate bus# of parent bus (#09) from #0a to #0d
pcmcia: parent PCI bridge I/O window: 0x5000 - 0x5fff
cs: IO port probe 0x5000-0x5fff: clean.
pcmcia: parent PCI bridge Memory window: 0xdc000000 - 0xdc0fffff
pcmcia: parent PCI bridge Memory window: 0x88000000 - 0x8bffffff
usbcore: registered new interface driver libusual
usbcore: registered new interface driver hiddev
usbcore: registered new interface driver usbhid
drivers/usb/input/hid-core.c: v2.6:USB HID core driver
PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
serio: i8042 KBD port at 0x60,0x64 irq 1
serio: i8042 AUX port at 0x60,0x64 irq 12
mice: PS/2 mouse device common for all mice
input: AT Translated Set 2 keyboard as /class/input/input1
TCP bic registered
Initializing XFRM netlink socket
NET: Registered protocol family 1
NET: Registered protocol family 17
speedstep-centrino with X86_SPEEDSTEP_CENTRINO_ACPI config is deprecated.
 Use X86_ACPI_CPUFREQ (acpi-cpufreq) instead.
speedstep-centrino with X86_SPEEDSTEP_CENTRINO_ACPI config is deprecated.
 Use X86_ACPI_CPUFREQ (acpi-cpufreq) instead.
Using IPI No-Shortcut mode
ACPI: (supports S0 S3 S4 S5)
Freeing unused kernel memory: 236k freed
Write protecting the kernel read-only data: 841k
Time: tsc clocksource has been installed.
Time: acpi_pm clocksource has been installed.
firmware_class: attempt to set timeout to 10
input: PS/2 Mouse as /class/input/input2
input: AlpsPS/2 ALPS GlidePoint as /class/input/input3
USB Universal Host Controller Interface driver v3.0
ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 19 (level, low) -> IRQ 19
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 19, io base 0x00001820
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
PCI: Setting latency timer of device 0000:00:1d.1 to 64
uhci_hcd 0000:00:1d.1: UHCI Host Controller
uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2
uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001840
usb usb2: configuration #1 chosen from 1 choice
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 19 (level, low) -> IRQ 19
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 19, io base 0x00001860
usb usb3: configuration #1 chosen from 1 choice
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1d.3[A] -> GSI 19 (level, low) -> IRQ 19
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 19, io base 0x00001880
usb usb4: configuration #1 chosen from 1 choice
hub 4-0:1.0: USB hub found
hub 4-0:1.0: 2 ports detected
ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver (PCI)
ACPI: PCI Interrupt 0000:00:1d.7[D] -> GSI 23 (level, low) -> IRQ 22
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 22, io mem 0xdc544000
ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
usb usb5: configuration #1 chosen from 1 choice
hub 5-0:1.0: USB hub found
hub 5-0:1.0: 8 ports detected
SCSI subsystem initialized
libata version 2.00 loaded.
ata_piix 0000:00:1f.2: version 2.00ac7
ata_piix 0000:00:1f.2: MAP [ P0 P2 XX XX ]
ata_piix 0000:00:1f.2: invalid MAP value 0
ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 22 (level, low) -> IRQ 21
PCI: Setting latency timer of device 0000:00:1f.2 to 64
ata1: SATA max UDMA/133 cmd 0x18D0 ctl 0x18C6 bmdma 0x18B0 irq 21
ata2: SATA max UDMA/133 cmd 0x18C8 ctl 0x18C2 bmdma 0x18B8 irq 21
scsi0 : ata_piix
ata1.00: ATA-7, max UDMA/133, 195371568 sectors: LBA48 NCQ (depth 0/32)
ata1.00: ata1: dev 0 multi count 16
ata1.00: configured for UDMA/133
scsi1 : ata_piix
ATA: abnormal status 0x7F on port 0x18CF
scsi 0:0:0:0: Direct-Access     ATA      ST9100824AS      3.14 PQ: 0 ANSI: 5
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: write cache: enabled, read cache: enabled, doesn't support DPO
or FUA
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: write cache: enabled, read cache: enabled, doesn't support DPO
or FUA
 sda:<6>usb 5-6: new high speed USB device using ehci_hcd and address 3
 sda1 sda2 sda3
sd 0:0:0:0: Attached scsi disk sda
usb 5-6: configuration #1 chosen from 1 choice
EXT3-fs: INFO: recovery required on readonly filesystem.
EXT3-fs: write access will be enabled during recovery.
usb 3-1: new full speed USB device using uhci_hcd and address 3
usb 3-1: configuration #1 chosen from 1 choice
usb 4-2: new full speed USB device using uhci_hcd and address 2
usb 4-2: configuration #1 chosen from 1 choice
kjournald starting.  Commit interval 5 seconds
EXT3-fs: sda1: orphan cleanup on readonly fs
ext3_orphan_cleanup: deleting unreferenced inode 324169
ext3_orphan_cleanup: deleting unreferenced inode 324168
ext3_orphan_cleanup: deleting unreferenced inode 324167
ext3_orphan_cleanup: deleting unreferenced inode 324166
ext3_orphan_cleanup: deleting unreferenced inode 324165
EXT3-fs: sda1: 5 orphan inodes deleted
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
SELinux:  Disabled at runtime.
SELinux:  Unregistering netfilter hooks
audit(1178613352.009:2): selinux=0 auid=4294967295
input: PC Speaker as /class/input/input4
ieee1394: Initialized config rom entry `ip1394'
ACPI: PCI Interrupt 0000:09:04.2[C] -> GSI 22 (level, low) -> IRQ 21
ieee80211_crypt: registered algorithm 'NULL'
Bluetooth: Core ver 2.11
NET: Registered protocol family 31
Bluetooth: HCI device and connection manager initialized
Bluetooth: HCI socket layer initialized
ACPI: PCI Interrupt 0000:07:00.0[A] -> GSI 18 (level, low) -> IRQ 18
PCI: Setting latency timer of device 0000:07:00.0 to 64
sky2 v1.10 addr 0xd8000000 irq 18 Yukon-FE (0xb7) rev 1
sky2 eth0: addr 00:13:a9:3e:e8:a5
intel_rng: FWH not detected
ACPI: PCI Interrupt 0000:09:04.1[B] -> GSI 21 (level, low) -> IRQ 23
ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[23]  MMIO=[dc005000-dc0057ff]  Max
Packet=[2048]  IR/IT contexts=[4/8]
ieee80211: 802.11 data/management/control stack, git-1.1.13
ieee80211: Copyright (C) 2004-2005 Intel Corporation <jketreno@linux.intel.com>
tpm_inf_pnp 00:07: Found TPM with ID IFX0102
tpm_inf_pnp 00:07: TPM found: config base 0x2e, io base 0x1670, chip version
0x000b, vendor id 0x15d1 (Infineon), product id 0x000b (SLB 9635 TT 1.2)
hda: ATAPI 24X DVD-ROM DVD-R CD-R/RW drive, 2048kB Cache, UDMA(33)
Uniform CD-ROM driver Revision: 3.20
Bluetooth: HCI USB driver ver 2.9
usbcore: registered new interface driver hci_usb
iTCO_vendor_support: vendor-support=0
iTCO_wdt: Intel TCO WatchDog Timer Driver v1.01 (11-Nov-2006)
iTCO_wdt: failed to reset NO_REBOOT flag, reboot disabled by hardware
iTCO_wdt: No card detected
sd 0:0:0:0: Attached scsi generic sg0 type 0
cs: IO port probe 0x100-0x3af: clean.
cs: IO port probe 0x3e0-0x4ff: excluding 0x4d0-0x4d7
cs: IO port probe 0x820-0x8ff: clean.
cs: IO port probe 0xc00-0xcf7: clean.
cs: IO port probe 0xa00-0xaff: clean.
ipw3945: Intel(R) PRO/Wireless 3945 Network Connection driver for Linux, 1.2.0d
ipw3945: Copyright(c) 2003-2006 Intel Corporation
ACPI: PCI Interrupt 0000:06:00.0[A] -> GSI 17 (level, low) -> IRQ 17
PCI: Setting latency timer of device 0000:06:00.0 to 64
ipw3945: Detected Intel PRO/Wireless 3945ABG Network Connection
ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 21 (level, low) -> IRQ 23
PCI: Setting latency timer of device 0000:00:1b.0 to 64
ieee1394: Host added: ID:BUS[0-00:1023]  GUID[08004603022580ec]
floppy0: no floppy controllers found
lp: driver loaded but no devices found
sonypi: Sony Programmable I/O Controller Driver v1.26.
sonypi: detected type3 model, verbose = 0, fnkeyinit = off, camera = off, compat
= off, mask = 0xffffffff, useinput = on, acpi = on
sonypi: enabled at irq=11, port1=0x1080, port2=0x1084
sonypi: device allocated minor is 63
input: Sony Vaio Jogdial as /class/input/input5
input: Sony Vaio Keys as /class/input/input6
ACPI: AC Adapter [ACAD] (on-line)
ACPI: Battery Slot [BAT1] (battery present)
input: Lid Switch as /class/input/input7
ACPI: Lid Switch [LID0]
input: Power Button (CM) as /class/input/input8
ACPI: Power Button (CM) [PWRB]
ACPI: ACPI Dock Station Driver 
ibm_acpi: ec object not found
md: Autodetecting RAID arrays.
md: autorun ...
md: ... autorun DONE.
device-mapper: ioctl: 4.11.0-ioctl (2006-10-12) initialised: dm-devel@redhat.com
device-mapper: multipath: version 1.0.5 loaded
EXT3 FS on sda1, internal journal
kjournald starting.  Commit interval 5 seconds
EXT3 FS on sda3, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
Adding 2096472k swap on /dev/sda2.  Priority:-1 extents:1 across:2096472k
NET: Registered protocol family 10
lo: Disabled Privacy Extensions
Mobile IPv6
ipw3945: Detected geography ABG (13 802.11bg channels, 23 802.11a channels)
ADDRCONF(NETDEV_UP): eth1: link is not ready
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
ADDRCONF(NETDEV_UP): eth1: link is not ready
sky2 eth0: enabling interface
sky2 eth0: ram buffer 4K
ADDRCONF(NETDEV_UP): eth0: link is not ready
[drm] Initialized drm 1.1.0 20060810
ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level, low) -> IRQ 16
[drm] Initialized i915 1.6.0 20060119 on minor 0
usb 1-1: new low speed USB device using uhci_hcd and address 2
usb 1-1: configuration #1 chosen from 1 choice
input: Microsoft Microsoft 5-Button Mouse with IntelliEye(TM) as /class/input/input9
input: USB HID v1.10 Mouse [Microsoft Microsoft 5-Button Mouse with
IntelliEye(TM)] on usb-0000:00:1d.0-1
ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
eth1: no IPv6 routers present
[jnm11@localhost ~]$
Comment 1 Natalie Protasevich 2007-11-16 17:01:11 UTC
Jim,
Is the problem still there? Sounds like hardware problem. Does it work with any other kernel/OS?
Thanks.
Comment 2 Jim McElwaine 2007-11-19 02:28:40 UTC
I upgraded to fedora core 8 last week and the problem still exists. There is something related to the time the power is disconnected. If it is up  to around 5 seconds it doesn't tend to crash. If it is disconnectd longer before reconnection then it crashes. This suggests to me that it is not a hardware problem though I suppose it could be.

I don't know how to find out the cause. How do I disable all power management or enable more verbose logging?
Comment 3 Zhang Rui 2007-11-19 17:28:55 UTC
Created attachment 13637 [details]
print out which GPE is fired when ac is plugged in

please apply this patch and see if there is something print out when the ac adapter is plugged in.
And please attach the acpidump as well.
Comment 4 Jim McElwaine 2007-11-20 00:53:40 UTC
It is definitely not the hardware. If I keep the system in grub rather than booting linux there are no problems with removing and inserting the power.
 
Where do I find acpidump. I need either an rpm package or the source code. All I can find are .deb packages

I'm compiling the patch
Comment 5 Zhang Rui 2007-11-20 01:01:19 UTC
Please download and build the pmtools-20070511.tar.gz at http://www.kernel.org/pub/linux/kernel/people/lenb/acpi/utils/
Comment 6 Jim McElwaine 2007-11-20 04:10:37 UTC
Created attachment 13644 [details]
/var/log/messages of crash with and without patch

This attachment shows the laptop crashing twice. once with the original kernel and once with the patch apply and compiled. I had trouble applying the patch with the rpm build system and ended up modifying the file by hand.
Comment 7 Zhang Rui 2007-12-06 00:10:58 UTC
Hi, Jim,

It seems that GPE 0x17 keeps on firing when you connect the power.
> There is something related to the time the power is disconnected.
Please do the following test:
dmesg -c
echo 0x40 > /sys/module/acpi/parameters/debug_layer
echo 0x8800001f > /sys/module/acpi/parameters/debug_level
disconnect and connect the power
and attach the dmesg output in both crash and non-crash case.
In order to get to know what the GPE 0x17 stands for, please attach the acpidump.
Comment 8 Jim McElwaine 2007-12-07 07:48:38 UTC
Created attachment 13904 [details]
acpidump output

I can't execute 
echo 0x40 > /sys/module/acpi/parameters/debug_layer
echo 0x8800001f > /sys/module/acpi/parameters/debug_level
since /sys/module/acpi/parameters/debug_layer does not exist on my system.
I get an error permission denied.
I've tried recompiling my kernel with acpi debugging but it didn't help.
How do I get this to work
Comment 9 Zhang Rui 2007-12-09 17:12:57 UTC
Please try the latest kernel release, say 2.6.23
And please make sure CONFIG_ACPI_DEBUG is set.
Comment 10 Jim McElwaine 2007-12-10 15:09:37 UTC
I am using 2.6.23 and I have compiled with 2.6.23 but there is only one file in the directory
[jnm11@thalay parameters]$ ls /sys/module/acpi/parameters/
acpica_version
I'm attaching my .config. What do I need to change?
Comment 11 Jim McElwaine 2007-12-10 15:12:13 UTC
Created attachment 13960 [details]
.config from kernel compile
Comment 12 Zhang Rui 2008-01-04 00:08:36 UTC
please set CONFIG_ACPI_DEBUG
Comment 13 Zhang Rui 2008-02-18 18:25:15 UTC
close this bug because there is no response from the bug reporter.
Comment 14 Jim McElwaine 2008-03-03 13:17:18 UTC
I have compiled it with the flags.

then if i plug and unplug and it doesn't crash when I run dmesg again I get
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
[root@thalay parameters]# 
Comment 15 Alexey Starikovskiy 2008-03-03 13:29:00 UTC
Jim, could you please make acpidump by utility from pmtools package available here: http://www.lesswatts.org/projects/acpi/utilities.php
Comment 16 Jim McElwaine 2008-03-03 13:47:41 UTC
Created attachment 15126 [details]
./acpidump > acpidump_output

here is the current acpidump
Comment 17 Jim McElwaine 2008-03-03 13:50:59 UTC
so far I have been unable to get it to crash with debugging enabled
Comment 18 Alexey Starikovskiy 2008-03-03 14:20:38 UTC
Could you crash it with debugging disabled?
Comment 19 Jim McElwaine 2008-03-03 14:25:23 UTC
It will still crash but less often Seems to need to be disconnected for longer to  crash on reconnection and then not every time.

What information should I attach
/var/log/dmesg 
contains information from the next time I boot up
There is nothing in /var/log/messages

exert form /var/log/messages
...
Mar  3 22:02:49 thalay kernel:last message repeated 3 times
Mar  3 22:02:49 thalay kernel: dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
Mar  3 22:02:50 thalay kernel: dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
Mar  3 22:02:50 thalay kernel:last message repeated 3 times
Mar  3 22:02:50 thalay kernel: dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
Mar  3 22:02:52 thalay smartd[2544]: Device: /dev/sda, SMART Usage Attribute: 195 Hardware_ECC_Recovered changed from 73 to 72
Mar  3 22:07:39 thalay ntpd[2065]: synchronized to 212.13.194.71, stratum 2

crash occurred here then reboot

Mar  3 22:14:06 thalay rsyslogd: [origin software="rsyslogd" swVersion="2.0.2" x-pid="1968" x-info="http://www.rsyslog.com"][x-configInfo udpReception="No" udpPort="514" tcpReception="No" tcpPort="0"] restart
Mar  3 22:14:06 thalay kernel: rklogd 2.0.2, log source = /proc/kmsg started.
...
Comment 20 Jim McElwaine 2008-03-03 14:30:43 UTC
Created attachment 15127 [details]
dmesg from after a crash

this is dmesg from after a crash but nothing seems to be there relating to the crash
Comment 21 Jim McElwaine 2008-03-03 14:32:06 UTC
Created attachment 15128 [details]
/var/log/messages

/var/log/messages 
from after a crash and reboot. Nothing form the crash appears to be there
Comment 22 Jim McElwaine 2008-03-03 14:35:28 UTC
Just realised my comments are a little ambiguous. It crashes less often with the kernel I have compiled with CONFIG_ACPI_DEBUG true, but still crashes. I don't know how to collect any information from a crash however.
Comment 23 Alexey Starikovskiy 2008-03-03 15:22:00 UTC
Jim, there is some message from potentially dangerous sources:
smartd and iTCO watchdog timer...
Could you please check that disk is ok  and disable watchdog altogether?
Also, is it possible for you to upgrade to more recent 2.6.24 kernel?
I've added Robert Moore to CC list, as he is an expert in ACPICA internals.
Comment 24 Jim McElwaine 2008-03-03 15:51:26 UTC
smartctl tests indicate that the disc is ok. I will attach the file

I am downloading the 2.6.24 kernel and will report when that is compiled

How do I disable the watchdog? 
Comment 25 Jim McElwaine 2008-03-03 15:53:10 UTC
Created attachment 15129 [details]
smartctl  -a /dev/sda >smart

disc test
smartctl -t short /dev/sda
smartctl  -a /dev/sda > smart
Comment 26 Robert Moore 2008-03-04 10:03:32 UTC
I don't see anything overtly suspicious in the DSDT and 3 SSDTs. However, there exist 4 different SSDTs that can be dynamically loaded:

        Name (SSDT, Package (0x0C)
        {
            "CPU0IST ", 
            0x7FE76C73, 
            0x000001EA, 
            "CPU1IST ", 
            0x7FE76E5D, 
            0x00000089, 
            "CPU0CST ", 
            0x7FE769B9, 
            0x00000235, 
            "CPU1CST ", 
            0x7FE76BEE, 
            0x00000085
        })

Commands to dump these tables should look something like this:

acpidump --addr 0x7FE76C73 --length 0x000001EA -o aslb
acpidump --addr 0x7FE76E5D --length 0x00000089 -o aslb
acpidump --addr 0x7FE769B9 --length 0x00000235 -o aslb
acpidump --addr 0x7FE76BEE --length 0x00000085 -o aslb

Please run these and post the results.
Comment 27 Jim McElwaine 2008-03-04 15:33:22 UTC
Created attachment 15142 [details]
./acpidump --addr 0x7FE76C73 --length 0x000001EA -o aslb1
Comment 28 Jim McElwaine 2008-03-04 15:33:50 UTC
Created attachment 15143 [details]
./acpidump --addr 0x7FE76E5D --length 0x00000089 -o aslb2
Comment 29 Jim McElwaine 2008-03-04 15:34:18 UTC
Created attachment 15144 [details]
./acpidump --addr 0x7FE769B9 --length 0x00000235 -o aslb3
Comment 30 Jim McElwaine 2008-03-04 15:34:38 UTC
Created attachment 15145 [details]
./acpidump --addr 0x7FE76BEE --length 0x00000085 -o aslb4
Comment 31 Jim McElwaine 2008-03-04 15:45:38 UTC
now running with kernel 2.6.24.2 
echo 0x40 > /sys/module/acpi/parameters/debug_layer
echo 0x8800001f > /sys/module/acpi/parameters/debug_level

output of dmesg -c after unplugging power

CPU0 attaching NULL sched-domain.
CPU1 attaching NULL sched-domain.
CPU0 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000001 00000002
  domain 1: span 00000003
   groups: 00000003
CPU1 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000002 00000001
  domain 1: span 00000003
   groups: 00000003
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (5), truncated
Clocksource tsc unstable (delta = -141845786 ns)
[
Comment 32 Jim McElwaine 2008-03-04 15:46:44 UTC
output of dmesg -c on reinserting power if it doesn't crash
CPU0 attaching NULL sched-domain.
CPU1 attaching NULL sched-domain.
CPU0 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000001 00000002
CPU1 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000002 00000001
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (4), truncated
dsobject-0456 [00] ds_build_internal_pack: Package List length larger than NumElements count (3), truncated
[
Comment 33 Robert Moore 2008-03-05 12:24:06 UTC
>Package List length larger than NumElements count (4), truncated

This looks like a bug in the debug output code and does not necessarily mean that anything is wrong. The message is incorrectly emitted when the package is correct.
Comment 34 Robert Moore 2008-03-05 13:12:19 UTC
Created attachment 15155 [details]
Patch to eliminate improper warning message

Here's a patch to eliminate the package warning. It's not in Linux format, but should be easy to convert
Comment 35 Jim McElwaine 2008-03-06 01:09:33 UTC
The patch is a bit of a nuisance as the variable names are all different to 2.6.24.2

arg not Arg
element_count not ElementCount etc...

which kernel is the patch for ?
Comment 36 Alexey Starikovskiy 2008-03-06 01:15:28 UTC
It's the original untranslated ACPICA code. Robert maintains it, then Len translates it to Linux. FreeBSD uses it as-is.
Comment 37 Robert Moore 2008-03-06 09:35:01 UTC
Created attachment 15164 [details]
Linuxized version of previous patch

Here is the linuxized version of the patch, created with "acpisrc -l -d". Line numbers are not valid, however, but the variable names will be correct. Let me know if this is helpful.
Comment 38 Jim McElwaine 2008-03-06 09:39:47 UTC
Thanks, though, I think I successfully made all the changes by hand. I left it compiling when I came to work this morning so I'll see tonight.
Jim
 
Comment 39 Jim McElwaine 2008-03-07 01:39:42 UTC
These are the outputs now when power is unplugged and plugged back in when it doesn't crash

dmesh -c
CPU0 attaching NULL sched-domain.
CPU1 attaching NULL sched-domain.
CPU0 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000001 00000002
  domain 1: span 00000003
   groups: 00000003
CPU1 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000002 00000001
  domain 1: span 00000003
   groups: 00000003
[root@thalay jnm11]# dmesg -c
Clocksource tsc unstable (delta = -139949034 ns)
CPU0 attaching NULL sched-domain.
CPU1 attaching NULL sched-domain.
CPU0 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000001 00000002
CPU1 attaching sched-domain:
 domain 0: span 00000003
  groups: 00000002 00000001
[
Comment 40 Jim McElwaine 2008-03-10 15:34:25 UTC
What else can I do to help track down this bug?
Comment 41 Roland Kletzing 2008-03-31 13:31:51 UTC
did you try any other OS besides linux?
any possibility to try that? (temporarly swapping hdd or clonezilla the disk contents somewhere else)
Comment 42 Jim McElwaine 2008-04-01 01:57:09 UTC
I don't have the possibility of trying another OS
Comment 43 Zhang Rui 2008-05-05 01:46:55 UTC
is there any difference if you boot with "acpi_apic_instance=2"?
Does this still happen if you boot with "maxcpus=1"?
If yes, what about "maxcpus=0"?
Comment 44 Jim McElwaine 2008-05-07 09:13:25 UTC
I can't get it to crash anymore no matter how many times I plug and unplug.
Something in the recent updates must have fixed the bug.
Comment 45 Zhang Rui 2008-05-07 17:51:21 UTC
Okay.
Close it and mark it as UNREPRODUCIBLE
Comment 46 Jim McElwaine 2008-07-04 08:55:14 UTC
It turns out that the bug is still there. It's just that it occurs much less often. If the laptop is disconnected from mains power for a while then very occasionally it will hang when power is reconnected. Previously it was nearly every time.
Comment 47 Zhang Rui 2008-07-06 22:44:02 UTC
Well, I don't know how to debug this bug as it's random and hard to reproduce. :(
Comment 48 Jim McElwaine 2008-07-09 03:17:44 UTC
Well it's much less of a problem now so I don't mind if you decide to close it.
Is there any further way to instrument the kernel do trace what happens the power is reconnected. The problem at the moment is that there is never anything in the logs. I suppose this might require a serial connection or somesuch. Is there any other way to dump out data to the network or disks before the crash occurs for later analysis?

Note You need to log in before you can comment on or make changes to this bug.