Bug 51071 - Resume of T61 in docking stations may lead to freeze
Summary: Resume of T61 in docking stations may lead to freeze
Status: CLOSED CODE_FIX
Alias: None
Product: ACPI
Classification: Unclassified
Component: Other (show other bugs)
Hardware: All Linux
: P1 normal
Assignee: Rafael J. Wysocki
URL:
Keywords:
Depends on:
Blocks: 7216
  Show dependency tree
 
Reported: 2012-11-28 16:16 UTC by Zdenek Kabelac
Modified: 2013-02-08 17:39 UTC (History)
3 users (show)

See Also:
Kernel Version:
Subsystem:
Regression: No
Bisected commit-id:


Attachments
Snapshot of OOPS (173.30 KB, image/jpeg)
2012-11-28 16:16 UTC, Zdenek Kabelac
Details
Zoom of crash with Rafael's patch (127.88 KB, image/jpeg)
2012-11-29 08:48 UTC, Zdenek Kabelac
Details
Full snapshot (less readable) (158.61 KB, image/jpeg)
2012-11-29 08:56 UTC, Zdenek Kabelac
Details
PATCH: Invalidate ACPI device's handle on unregistration (1.02 KB, patch)
2012-11-29 14:54 UTC, Rafael J. Wysocki
Details | Diff
Snapshot with for comment 14 patch (122.04 KB, image/jpeg)
2012-11-29 16:56 UTC, Zdenek Kabelac
Details
Snapshot2 with for comment 14 patch (135.29 KB, image/jpeg)
2012-11-29 16:56 UTC, Zdenek Kabelac
Details
PATCH: Check dev->data for ACPIPNP devices in pnpacpi_set_resources() (960 bytes, patch)
2012-11-29 20:01 UTC, Rafael J. Wysocki
Details | Diff
Tested patch file (1.76 KB, patch)
2012-11-29 20:53 UTC, Zdenek Kabelac
Details | Diff

Description Zdenek Kabelac 2012-11-28 16:16:03 UTC
Created attachment 87581 [details]
Snapshot of OOPS

I'm opening this bug for tracking issue reported on lkml:

https://lkml.org/lkml/2012/11/15/369

Easiest to provide picture for me - since I cannot get OOPS easily in text.

My hw is: T61  C2D   4GB   GMA965
Docking station - default supplied for this laptop type.

Problem is that resume of my laptop suspended outside of docking station
usually leads to system freeze.

But there are multiple ways how the freeze lookalike -
sometimes I get only 'black screen'
and sometimes I get this OOPS (not complete - screen is too short)

I've tried few kernels back - and noticed that even 3.4 does not survive
multiple  'pm-suspend' & resume cycles  (usually 1 - at best 2, but 3 is 100% deadlock).

I'll try to add more details if I'll notice something new. For now I know this:

The problem is somehow related to the support of 'old hw' on docking station
(which is i.e. serial line port).
If I disable this support in BIOS it seems to be stable - no problem with suspend/resume.
Comment 1 Zdenek Kabelac 2012-11-28 17:16:02 UTC
Here is related disassembled code:

	/* Get the prefix scope. A null scope means use the root scope */

	if ((!scope_info) || (!scope_info->scope.node)) {
0000000000000054 <acpi_ns_lookup+0x54> test   %rdi,%rdi
0000000000000057 <acpi_ns_lookup+0x57> mov    %rsi,%r12
000000000000005a <acpi_ns_lookup+0x5a> mov    %r8d,%r14d
000000000000005d <acpi_ns_lookup+0x5d> je     0000000000000068 <acpi_ns_lookup+0x68>
000000000000005f <acpi_ns_lookup+0x5f> mov    0x10(%rdi),%rbx
0000000000000063 <acpi_ns_lookup+0x63> test   %rbx,%rbx
0000000000000066 <acpi_ns_lookup+0x66> jne    00000000000000a1 <acpi_ns_lookup+0xa1>
		ACPI_DEBUG_PRINT((ACPI_DB_NAMES,
0000000000000068 <acpi_ns_lookup+0x68> mov    %rax,(%rsp)
000000000000006c <acpi_ns_lookup+0x6c> mov    $0x0,%r9
0000000000000073 <acpi_ns_lookup+0x73> mov    $0x140,%esi
0000000000000078 <acpi_ns_lookup+0x78> mov    $0x10,%r8d
000000000000007e <acpi_ns_lookup+0x7e> mov    $0x0,%rcx
0000000000000085 <acpi_ns_lookup+0x85> xor    %eax,%eax
0000000000000087 <acpi_ns_lookup+0x87> mov    $0x0,%rdx
000000000000008e <acpi_ns_lookup+0x8e> mov    $0x400,%edi
0000000000000093 <acpi_ns_lookup+0x93> callq  0000000000000098 <acpi_ns_lookup+0x98>
				  "Null scope prefix, using root node (%p)\n",
				  acpi_gbl_root_node));

		prefix_node = acpi_gbl_root_node;
0000000000000098 <acpi_ns_lookup+0x98> mov    0x0(%rip),%rbx        # 000000000000009f <acpi_ns_lookup+0x9f>
000000000000009f <acpi_ns_lookup+0x9f> jmp    00000000000000f9 <acpi_ns_lookup+0xf9>
	} else {
		prefix_node = scope_info->scope.node;
		if (ACPI_GET_DESCRIPTOR_TYPE(prefix_node) !=
00000000000000a1 <acpi_ns_lookup+0xa1> cmpb   $0xf,0x8(%rbx)
00000000000000a5 <acpi_ns_lookup+0xa5> je     00000000000000da <acpi_ns_lookup+0xda>
		    ACPI_DESC_TYPE_NAMED) {
			ACPI_ERROR((AE_INFO, "%p is not a namespace node [%s]",
00000000000000a7 <acpi_ns_lookup+0xa7> mov    %rbx,%rdi
00000000000000aa <acpi_ns_lookup+0xaa> callq  00000000000000af <acpi_ns_lookup+0xaf>
00000000000000af <acpi_ns_lookup+0xaf> mov    %rbx,%rcx
00000000000000b2 <acpi_ns_lookup+0xb2> mov    $0x0,%rdx
00000000000000b9 <acpi_ns_lookup+0xb9> mov    %rax,%r8
00000000000000bc <acpi_ns_lookup+0xbc> mov    $0x149,%esi
00000000000000c1 <acpi_ns_lookup+0xc1> mov    $0x0,%rdi
00000000000000c8 <acpi_ns_lookup+0xc8> xor    %eax,%eax
00000000000000ca <acpi_ns_lookup+0xca> callq  00000000000000cf <acpi_ns_lookup+0xcf>
				    prefix_node,
				    acpi_ut_get_descriptor_name(prefix_node)));
			return_ACPI_STATUS(AE_AML_INTERNAL);
Comment 2 Zdenek Kabelac 2012-11-28 18:14:30 UTC
Here is my boot log - which is showing some APCI table errors.



Initializing cgroup subsys cpuset
Initializing cgroup subsys cpu
Linux version 3.7.0-rc6-00117-g17a96ce (kabi@linux) (gcc version 4.7.2 20121109 (Red Hat 4.7.2-8) (GCC) ) #102 SMP PREEMPT Fri Nov 23 11:22:49 CET 2012
Command line: ro root=/dev/sda2 selinux=0 no_console_suspend intel_iommu=on kmemleak=off lockdep.prove_locking=0 lockdep.lock_stat=0 SYSFONT=latarcyrheb-sun16 LANG=cs_CZ.UTF-8 KEYTABLE=us systemd.log_level=info systemd.log_target=kmsg console=ttyS0,115200n8 console=tty ipv6.disable=1
e820: BIOS-provided physical RAM map:
BIOS-e820: [mem 0x0000000000000000-0x000000000009d7ff] usable
BIOS-e820: [mem 0x000000000009d800-0x000000000009ffff] reserved
BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved
BIOS-e820: [mem 0x0000000000100000-0x00000000bf6affff] usable
BIOS-e820: [mem 0x00000000bf6b0000-0x00000000bf6cbfff] ACPI data
BIOS-e820: [mem 0x00000000bf6cc000-0x00000000bf6fffff] ACPI NVS
BIOS-e820: [mem 0x00000000bf700000-0x00000000bfffffff] reserved
BIOS-e820: [mem 0x00000000f0000000-0x00000000f3ffffff] reserved
BIOS-e820: [mem 0x00000000fec00000-0x00000000fec0ffff] reserved
BIOS-e820: [mem 0x00000000fed00000-0x00000000fed003ff] reserved
BIOS-e820: [mem 0x00000000fed14000-0x00000000fed19fff] reserved
BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed8ffff] reserved
BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved
BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved
BIOS-e820: [mem 0x0000000100000000-0x000000013bffffff] usable
kmemleak: Kernel memory leak detector disabled
NX (Execute Disable) protection: active
DMI present.
No AGP bridge found
e820: last_pfn = 0x13c000 max_arch_pfn = 0x400000000
x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
total RAM covered: 4023M
Found optimal setting for mtrr clean up
 gran_size: 64K 	chunk_size: 128M 	num_reg: 6  	lose cover RAM: 0G
e820: last_pfn = 0xbf6b0 max_arch_pfn = 0x400000000
found SMP MP-table at [mem 0x000f68f0-0x000f68ff] mapped at [ffff8800000f68f0]
init_memory_mapping: [mem 0x00000000-0xbf6affff]
init_memory_mapping: [mem 0x100000000-0x13bffffff]
RAMDISK: [mem 0x37830000-0x37feffff]
ACPI: RSDP 00000000000f68c0 00024 (v02 LENOVO)
ACPI: XSDT 00000000bf6bb496 0009C (v01 LENOVO TP-7U    00002290  LTP 00000000)
ACPI: FACP 00000000bf6bb600 000F4 (v03 LENOVO TP-7U    00002290 LNVO 00000001)
ACPI BIOS Bug: Warning: 32/64X length mismatch in FADT/Gpe1Block: 0/32 (20120913/tbfadt-567)
ACPI BIOS Bug: Warning: Optional FADT field Gpe1Block has zero address or length: 0x000000000000102C/0x0 (20120913/tbfadt-598)
ACPI: DSDT 00000000bf6bba1d 1003C (v01 LENOVO TP-7U    00002290 MSFT 03000000)
ACPI: FACS 00000000bf6e4000 00040
ACPI: SSDT 00000000bf6bb7b4 00269 (v01 LENOVO TP-7U    00002290 MSFT 03000000)
ACPI: ECDT 00000000bf6cba59 00052 (v01 LENOVO TP-7U    00002290 LNVO 00000001)
ACPI: TCPA 00000000bf6cbaab 00032 (v02 LENOVO TP-7U    00002290 LNVO 00000001)
ACPI: APIC 00000000bf6cbadd 00068 (v01 LENOVO TP-7U    00002290 LNVO 00000001)
ACPI: MCFG 00000000bf6cbb45 0003C (v01 LENOVO TP-7U    00002290 LNVO 00000001)
ACPI: HPET 00000000bf6cbb81 00038 (v01 LENOVO TP-7U    00002290 LNVO 00000001)
ACPI: SLIC 00000000bf6cbbb9 00176 (v01 LENOVO TP-7U    00002290  LTP 00000000)
ACPI: SLAC 00000000bf6cbdf0 00176 (v01 LENOVO TP-7U    00002290  LTP 00000000)
ACPI: BOOT 00000000bf6cbf66 00028 (v01 LENOVO TP-7U    00002290  LTP 00000001)
ACPI: ASF! 00000000bf6cbf8e 00072 (v16 LENOVO TP-7U    00002290 PTL  00000001)
ACPI: SSDT 00000000bf6e26d9 0025F (v01 LENOVO TP-7U    00002290 INTL 20050513)
ACPI: SSDT 00000000bf6e2938 000A6 (v01 LENOVO TP-7U    00002290 INTL 20050513)
ACPI: SSDT 00000000bf6e29de 004F7 (v01 LENOVO TP-7U    00002290 INTL 20050513)
ACPI: SSDT 00000000bf6e2ed5 001D8 (v01 LENOVO TP-7U    00002290 INTL 20050513)
ACPI: DMI detected: Lenovo ThinkPad T61
Zone ranges:
  DMA      [mem 0x00010000-0x00ffffff]
  DMA32    [mem 0x01000000-0xffffffff]
  Normal   [mem 0x100000000-0x13bffffff]
Movable zone start for each node
Early memory node ranges
  node   0: [mem 0x00010000-0x0009cfff]
  node   0: [mem 0x00100000-0xbf6affff]
  node   0: [mem 0x100000000-0x13bffffff]
ACPI: PM-Timer IO Port: 0x1008
ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
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)
Using ACPI (MADT) for SMP configuration information
ACPI: HPET id: 0x8086a201 base: 0xfed00000
smpboot: Allowing 2 CPUs, 0 hotplug CPUs
PM: Registered nosave memory: 000000000009d000 - 000000000009e000
PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
PM: Registered nosave memory: 00000000000a0000 - 00000000000e0000
PM: Registered nosave memory: 00000000000e0000 - 0000000000100000
PM: Registered nosave memory: 00000000bf6b0000 - 00000000bf6cc000
PM: Registered nosave memory: 00000000bf6cc000 - 00000000bf700000
PM: Registered nosave memory: 00000000bf700000 - 00000000c0000000
PM: Registered nosave memory: 00000000c0000000 - 00000000f0000000
PM: Registered nosave memory: 00000000f0000000 - 00000000f4000000
PM: Registered nosave memory: 00000000f4000000 - 00000000fec00000
PM: Registered nosave memory: 00000000fec00000 - 00000000fec10000
PM: Registered nosave memory: 00000000fec10000 - 00000000fed00000
PM: Registered nosave memory: 00000000fed00000 - 00000000fed14000
PM: Registered nosave memory: 00000000fed14000 - 00000000fed1a000
PM: Registered nosave memory: 00000000fed1a000 - 00000000fed1c000
PM: Registered nosave memory: 00000000fed1c000 - 00000000fed90000
PM: Registered nosave memory: 00000000fed90000 - 00000000fee00000
PM: Registered nosave memory: 00000000fee00000 - 00000000fee01000
PM: Registered nosave memory: 00000000fee01000 - 00000000ff000000
PM: Registered nosave memory: 00000000ff000000 - 0000000100000000
e820: [mem 0xc0000000-0xefffffff] available for PCI devices
setup_percpu: NR_CPUS:2 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
PERCPU: Embedded 476 pages/cpu @ffff880137200000 s1918400 r8192 d23104 u2097152
Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 1009463
Kernel command line: ro root=/dev/sda2 selinux=0 no_console_suspend intel_iommu=on kmemleak=off lockdep.prove_locking=0 lockdep.lock_stat=0 SYSFONT=latarcyrheb-sun16 LANG=cs_CZ.UTF-8 KEYTABLE=us systemd.log_level=info systemd.log_target=kmsg console=ttyS0,115200n8 console=tty ipv6.disable=1
PID hash table entries: 4096 (order: 3, 32768 bytes)
Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
__ex_table already sorted, skipping sort
Checking aperture...
No AGP bridge found
Memory: 3944524k/5177344k available (5520k kernel code, 1058572k absent, 174248k reserved, 5503k data, 2612k init)
SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
Preemptible hierarchical RCU implementation.
	RCU debugfs-based tracing is enabled.
	RCU dyntick-idle grace-period acceleration is enabled.
	RCU lockdep checking is enabled.
	Additional per-CPU info printed with stalls.
NR_IRQS:4352 nr_irqs:512 16
Extended CMOS year: 2000
Console: colour VGA+ 80x25
console [tty0] enabled
console [ttyS0] enabled
Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
... MAX_LOCKDEP_SUBCLASSES:  8
... MAX_LOCK_DEPTH:          48
... MAX_LOCKDEP_KEYS:        8191
... CLASSHASH_SIZE:          4096
... MAX_LOCKDEP_ENTRIES:     16384
... MAX_LOCKDEP_CHAINS:      32768
... CHAINHASH_SIZE:          16384
 memory used by lock dependency info: 6367 kB
 per task-struct memory footprint: 2688 bytes
allocated 16777216 bytes of page_cgroup
please try 'cgroup_disable=memory' option if you don't want memory cgroups
tsc: Fast TSC calibration using PIT
tsc: Detected 2194.524 MHz processor
Calibrating delay loop (skipped), value calculated using timer frequency.. 4390.92 BogoMIPS (lpj=7315080)
pid_max: default: 32768 minimum: 301
Security Framework initialized
SELinux:  Disabled at boot.
Mount-cache hash table entries: 256
Initializing cgroup subsys cpuacct
Initializing cgroup subsys memory
Initializing cgroup subsys devices
Initializing cgroup subsys freezer
Initializing cgroup subsys blkio
Initializing cgroup subsys hugetlb
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 0
mce: CPU supports 6 MCE banks
CPU0: Thermal monitoring enabled (TM2)
process: using mwait in idle threads
Last level iTLB entries: 4KB 128, 2MB 4, 4MB 4
Last level dTLB entries: 4KB 256, 2MB 0, 4MB 32
tlb_flushall_shift: -1
Freeing SMP alternatives: 20k freed
ACPI: Core revision 20120913
ftrace: allocating 18620 entries in 73 pages
..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
smpboot: CPU0: Intel(R) Core(TM)2 Duo CPU     T7500  @ 2.20GHz (fam: 06, model: 0f, stepping: 0a)
Performance Events: PEBS fmt0+, 4-deep LBR, Core2 events, Intel PMU driver.
perf_event_intel: PEBS disabled due to CPU errata
... version:                2
... bit width:              40
... generic registers:      2
... value mask:             000000ffffffffff
... max period:             000000007fffffff
... fixed-purpose events:   3
... event mask:             0000000700000003
SMP alternatives: lockdep: fixing up alternatives
smpboot: Booting Node   0, Processors  #1 OK
TSC synchronization [CPU#0 -> CPU#1]:
Measured 399476 cycles TSC warp between CPUs, turning off TSC clock.
tsc: Marking TSC unstable due to check_tsc_sync_source failed
NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
Brought up 2 CPUs
smpboot: Total of 2 processors activated (8781.85 BogoMIPS)
devtmpfs: initialized
EVM: security.selinux
EVM: security.capability
PM: Registering ACPI NVS region [mem 0xbf6cc000-0xbf6fffff] (212992 bytes)
regulator-dummy: no parameters
RTC time: 10:47:02, date: 11/28/12
NET: Registered protocol family 16
ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
ACPI: bus type pci registered
PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf0000000-0xf3ffffff] (base 0xf0000000)
PCI: MMCONFIG at [mem 0xf0000000-0xf3ffffff] reserved in E820
PCI: Using configuration type 1 for base access
bio: create slab <bio-0> at 0
ACPI: Added _OSI(Module Device)
ACPI: Added _OSI(Processor Device)
ACPI: Added _OSI(3.0 _SCP Extensions)
ACPI: Added _OSI(Processor Aggregator Device)
ACPI: Added _OSI(Linux)
ACPI: EC: EC description table is found, configuring boot EC
[Firmware Bug]: ACPI: BIOS _OSI(Linux) query honored via DMI
ACPI: SSDT 00000000bf6e1b32 002C4 (v01  PmRef  Cpu0Ist 00000100 INTL 20050513)
ACPI: Dynamic OEM Table Load:
ACPI: SSDT           (null) 002C4 (v01  PmRef  Cpu0Ist 00000100 INTL 20050513)
ACPI: SSDT 00000000bf6e1e7b 0085E (v01  PmRef  Cpu0Cst 00000100 INTL 20050513)
ACPI: Dynamic OEM Table Load:
ACPI: SSDT           (null) 0085E (v01  PmRef  Cpu0Cst 00000100 INTL 20050513)
ACPI: SSDT 00000000bf6e1a6a 000C8 (v01  PmRef  Cpu1Ist 00000100 INTL 20050513)
ACPI: Dynamic OEM Table Load:
ACPI: SSDT           (null) 000C8 (v01  PmRef  Cpu1Ist 00000100 INTL 20050513)
ACPI: SSDT 00000000bf6e1df6 00085 (v01  PmRef  Cpu1Cst 00000100 INTL 20050513)
ACPI: Dynamic OEM Table Load:
ACPI: SSDT           (null) 00085 (v01  PmRef  Cpu1Cst 00000100 INTL 20050513)
ACPI: Interpreter enabled
ACPI: (supports S0 S3 S4 S5)
ACPI: Using IOAPIC for interrupt routing
ACPI: Power Resource [PUBS] (on)
ACPI: EC: GPE = 0x12, I/O: command/status = 0x66, data = 0x62
ACPI: ACPI Dock Station Driver: 3 docks/bays found
PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
pci_root PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge
PCI host bridge to bus 0000:00
pci_bus 0000:00: root bus resource [bus 00-ff]
pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
pci_bus 0000:00: root bus resource [mem 0x000d0000-0x000d3fff]
pci_bus 0000:00: root bus resource [mem 0x000d4000-0x000d7fff]
pci_bus 0000:00: root bus resource [mem 0x000d8000-0x000dbfff]
pci_bus 0000:00: root bus resource [mem 0x000dc000-0x000dffff]
pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff]
pci_bus 0000:00: root bus resource [mem 0xfed40000-0xfed4bfff]
pci 0000:00:1f.0: quirk: [io  0x1000-0x107f] claimed by ICH6 ACPI/GPIO/TCO
pci 0000:00:1f.0: quirk: [io  0x1180-0x11bf] claimed by ICH6 GPIO
pci 0000:00:1f.0: ICH7 LPC Generic IO decode 1 PIO at 1600 (mask 007f)
pci 0000:00:1f.0: ICH7 LPC Generic IO decode 2 PIO at 15e0 (mask 000f)
pci 0000:00:1f.0: ICH7 LPC Generic IO decode 3 PIO at 1680 (mask 001f)
pci 0000:00:1c.0: PCI bridge to [bus 02]
pci 0000:00:1c.1: PCI bridge to [bus 03]
pci 0000:00:1c.2: PCI bridge to [bus 04]
pci 0000:00:1c.3: PCI bridge to [bus 05-0c]
pci 0000:00:1c.4: PCI bridge to [bus 0d-14]
pci 0000:15:00.0: proprietary Ricoh MMC controller disabled (via cardbus function)
pci 0000:15:00.0: MMC cards are now supported by standard SDHCI controller
pci 0000:00:1e.0: PCI bridge to [bus 15-18] (subtractive decode)
 pci0000:00: Requesting ACPI _OSC control (0x1d)
 pci0000:00: ACPI _OSC control (0x1d) granted
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)
vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
vgaarb: loaded
vgaarb: bridge control possible 0000:00:02.0
SCSI subsystem initialized
ACPI: bus type scsi registered
PCI: Using ACPI for IRQ routing
HPET: 3 timers in total, 0 timers will be used for per-cpu timer
hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
hpet0: 3 comparators, 64-bit 14.318180 MHz counter
Switching to clocksource hpet
pnp: PnP ACPI init
ACPI: bus type pnp registered
system 00:00: [mem 0x00000000-0x0009ffff] could not be reserved
system 00:00: [mem 0x000c0000-0x000c3fff] could not be reserved
system 00:00: [mem 0x000c4000-0x000c7fff] could not be reserved
system 00:00: [mem 0x000c8000-0x000cbfff] has been reserved
system 00:00: [mem 0x000cc000-0x000cffff] has been reserved
system 00:00: [mem 0x000e0000-0x000e3fff] could not be reserved
system 00:00: [mem 0x000e4000-0x000e7fff] could not be reserved
system 00:00: [mem 0x000e8000-0x000ebfff] could not be reserved
system 00:00: [mem 0x000ec000-0x000effff] could not be reserved
system 00:00: [mem 0x000f0000-0x000fffff] could not be reserved
system 00:00: [mem 0x00100000-0xbfffffff] could not be reserved
system 00:00: [mem 0xfec00000-0xfed3ffff] could not be reserved
system 00:00: [mem 0xfed4c000-0xffffffff] could not be reserved
system 00:02: [io  0x164e-0x164f] has been reserved
system 00:02: [io  0x1000-0x107f] has been reserved
system 00:02: [io  0x1180-0x11bf] has been reserved
system 00:02: [io  0x0800-0x080f] has been reserved
system 00:02: [io  0x15e0-0x15ef] has been reserved
system 00:02: [io  0x1600-0x165f] could not be reserved
system 00:02: [mem 0xf0000000-0xf3ffffff] has been reserved
system 00:02: [mem 0xfed1c000-0xfed1ffff] has been reserved
system 00:02: [mem 0xfed14000-0xfed17fff] has been reserved
system 00:02: [mem 0xfed18000-0xfed18fff] has been reserved
system 00:02: [mem 0xfed19000-0xfed19fff] has been reserved
system 00:02: [mem 0xfed45000-0xfed4bfff] has been reserved
pnp: PnP ACPI: found 12 devices
ACPI: ACPI bus type pnp unregistered
pci 0000:00:1c.0: PCI bridge to [bus 02]
pci 0000:00:1c.0:   bridge window [io  0x2000-0x2fff]
pci 0000:00:1c.0:   bridge window [mem 0xfc000000-0xfdffffff]
pci 0000:00:1c.0:   bridge window [mem 0xf8000000-0xf80fffff 64bit pref]
pci 0000:00:1c.1: PCI bridge to [bus 03]
pci 0000:00:1c.1:   bridge window [io  0x3000-0x3fff]
pci 0000:00:1c.1:   bridge window [mem 0xdc000000-0xdf3fffff]
pci 0000:00:1c.1:   bridge window [mem 0xdfe00000-0xdfefffff 64bit pref]
pci 0000:00:1c.2: PCI bridge to [bus 04]
pci 0000:00:1c.2:   bridge window [io  0x4000-0x4fff]
pci 0000:00:1c.2:   bridge window [mem 0xd8000000-0xd9ffffff]
pci 0000:00:1c.2:   bridge window [mem 0xdfb00000-0xdfbfffff 64bit pref]
pci 0000:00:1c.3: PCI bridge to [bus 05-0c]
pci 0000:00:1c.3:   bridge window [io  0x5000-0x5fff]
pci 0000:00:1c.3:   bridge window [mem 0xd4000000-0xd5ffffff]
pci 0000:00:1c.3:   bridge window [mem 0xdf800000-0xdf8fffff 64bit pref]
pci 0000:00:1c.4: PCI bridge to [bus 0d-14]
pci 0000:00:1c.4:   bridge window [io  0x6000-0x6fff]
pci 0000:00:1c.4:   bridge window [mem 0xd0000000-0xd1ffffff]
pci 0000:00:1c.4:   bridge window [mem 0xdf500000-0xdf5fffff 64bit pref]
pci 0000:15:00.0: BAR 15: assigned [mem 0xf4000000-0xf7ffffff pref]
pci 0000:15:00.0: BAR 16: assigned [mem 0xc0000000-0xc3ffffff]
pci 0000:15:00.0: BAR 13: assigned [io  0x7000-0x70ff]
pci 0000:15:00.0: BAR 14: assigned [io  0x7400-0x74ff]
pci 0000:15:00.0: CardBus bridge to [bus 16-17]
pci 0000:15:00.0:   bridge window [io  0x7000-0x70ff]
pci 0000:15:00.0:   bridge window [io  0x7400-0x74ff]
pci 0000:15:00.0:   bridge window [mem 0xf4000000-0xf7ffffff pref]
pci 0000:15:00.0:   bridge window [mem 0xc0000000-0xc3ffffff]
pci 0000:00:1e.0: PCI bridge to [bus 15-18]
pci 0000:00:1e.0:   bridge window [io  0x7000-0xafff]
pci 0000:00:1e.0:   bridge window [mem 0xf8300000-0xfbffffff]
pci 0000:00:1e.0:   bridge window [mem 0xf4000000-0xf7ffffff 64bit pref]
pci 0000:00:1e.0: enabling device (0005 -> 0007)
NET: Registered protocol family 2
TCP established hash table entries: 262144 (order: 10, 4194304 bytes)
TCP bind hash table entries: 32768 (order: 9, 2621440 bytes)
TCP: Hash tables configured (established 262144 bind 32768)
TCP: reno registered
UDP hash table entries: 2048 (order: 6, 393216 bytes)
UDP-Lite hash table entries: 2048 (order: 6, 393216 bytes)
NET: Registered protocol family 1
pci 0000:00:1a.1: power state changed by ACPI to D0
pci 0000:00:1d.0: power state changed by ACPI to D0
pci 0000:00:1d.2: power state changed by ACPI to D0
Trying to unpack rootfs image as initramfs...
Freeing initrd memory: 7936k freed
DMA-API: preallocated 32768 debug entries
DMA-API: debugging enabled by kernel config
PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
software IO TLB [mem 0xbb6ae000-0xbf6adfff] (64MB) mapped at [ffff8800bb6ae000-ffff8800bf6adfff]
Simple Boot Flag at 0x35 set to 0x1
sha1_ssse3: Using SSSE3 optimized SHA-1 implementation
audit: initializing netlink socket (disabled)
type=2000 audit(1354099621.543:1): initialized
HugeTLB registered 2 MB page size, pre-allocated 0 pages
msgmni has been set to 7719
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
io scheduler noop registered
io scheduler deadline registered (default)
pcieport 0000:00:1c.0: Signaling PME through PCIe PME interrupt
pcieport 0000:00:1c.1: Signaling PME through PCIe PME interrupt
pci 0000:03:00.0: Signaling PME through PCIe PME interrupt
pcieport 0000:00:1c.2: Signaling PME through PCIe PME interrupt
pcieport 0000:00:1c.3: Signaling PME through PCIe PME interrupt
pcieport 0000:00:1c.4: Signaling PME through PCIe PME interrupt
pci_hotplug: PCI Hot Plug PCI Core version: 0.5
ACPI: Deprecated procfs I/F for AC is loaded, please retry with CONFIG_ACPI_PROCFS_POWER cleared
ACPI: AC Adapter [AC] (on-line)
input: Lid Switch as /devices/LNXSYSTM:00/device:00/PNP0C0D:00/input/input0
ACPI: Lid Switch [LID]
input: Sleep Button as /devices/LNXSYSTM:00/device:00/PNP0C0E:00/input/input1
ACPI: Sleep Button [SLPB]
input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
ACPI: Power Button [PWRF]
ACPI: Requesting acpi_cpufreq
thermal LNXTHERM:00: registered as thermal_zone0
ACPI: Thermal Zone [THM0] (58 C)
thermal LNXTHERM:01: registered as thermal_zone1
ACPI: Thermal Zone [THM1] (60 C)
Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
00:0a: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
agpgart-intel 0000:00:00.0: detected gtt size: 524288K total, 262144K mappable
agpgart-intel 0000:00:00.0: detected 8192K stolen memory
agpgart-intel 0000:00:00.0: AGP aperture is 256M @ 0xe0000000
brd: module loaded
ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 3 ports 3 Gbps 0x5 impl SATA mode
ahci 0000:00:1f.2: flags: 64bit ncq sntf pm led clo pio slum part ccc 
ACPI: Deprecated procfs I/F for battery is loaded, please retry with CONFIG_ACPI_PROCFS_POWER cleared
scsi0 : ahci
ACPI: Battery Slot [BAT0] (battery present)
scsi1 : ahci
scsi2 : ahci
ata1: SATA max UDMA/133 abar m2048@0xfe226000 port 0xfe226100 irq 45
ata2: DUMMY
ata3: SATA max UDMA/133 abar m2048@0xfe226000 port 0xfe226200 irq 45
scsi3 : ata_piix
scsi4 : ata_piix
ata4: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0x1c00 irq 14
ata5: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0x1c08 irq 15
i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
serio: i8042 KBD port at 0x60,0x64 irq 1
serio: i8042 AUX port at 0x60,0x64 irq 12
mousedev: PS/2 mouse device common for all mice
rtc_cmos 00:07: RTC can wake from S4
rtc_cmos 00:07: rtc core: registered rtc_cmos as rtc0
rtc0: alarms up to one month, y3k, 114 bytes nvram, hpet irqs
cpuidle: using governor ladder
cpuidle: using governor menu
hdaps: inverting axis (3) readings
hdaps: LENOVO ThinkPad T61 detected
input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input3
input: hdaps as /devices/platform/hdaps/input/input4
hdaps: driver successfully loaded
TCP: cubic registered
NET: Registered protocol family 17
Key type dns_resolver registered
registered taskstats version 1
Key type encrypted registered
EVM: Error registering secfs
  Magic number: 4:431:781
rtc_cmos 00:07: setting system clock to 2012-11-28 10:47:04 UTC (1354099624)
ata4.00: ATAPI: MATSHITADVD-RAM UJ-842 z, RC01, max UDMA/33
ata4.00: configured for UDMA/33
ata3: SATA link down (SStatus 0 SControl 300)
ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
ata1.00: ATA-9: SAMSUNG SSD 830 Series, CXM03B1Q, max UDMA/133
ata1.00: 500118192 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
ata1.00: configured for UDMA/133
scsi 0:0:0:0: Direct-Access     ATA      SAMSUNG SSD 830  CXM0 PQ: 0 ANSI: 5
sd 0:0:0:0: [sda] 500118192 512-byte logical blocks: (256 GB/238 GiB)
sd 0:0:0:0: Attached scsi generic sg0 type 0
sd 0:0:0:0: [sda] Write Protect is off
sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
scsi 3:0:0:0: CD-ROM            MATSHITA DVD-RAM UJ-842 z RC01 PQ: 0 ANSI: 5
scsi 3:0:0:0: Attached scsi generic sg1 type 5
 sda: sda1 sda2 sda3 sda4 < sda5 sda6 sda7 >
sd 0:0:0:0: [sda] Attached SCSI disk
Freeing unused kernel memory: 2612k freed
Write protecting the kernel read-only data: 10240k
Freeing unused kernel memory: 612k freed
Freeing unused kernel memory: 1844k freed
ACPI: bus type usb registered
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
uhci_hcd: USB Universal Host Controller Interface driver
yenta_cardbus 0000:15:00.0: CardBus bridge found [17aa:20c6]
ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
ehci_hcd 0000:00:1a.7: EHCI Host Controller
sdhci: Secure Digital Host Controller Interface driver
sdhci: Copyright(c) Pierre Ossman
ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 1
sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
cdrom: Uniform CD-ROM driver Revision: 3.20
ehci_hcd 0000:00:1a.7: irq 22, io mem 0xfe226c00
ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00
usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb1: Product: EHCI Host Controller
usb usb1: Manufacturer: Linux 3.7.0-rc6-00117-g17a96ce ehci_hcd
usb usb1: SerialNumber: 0000:00:1a.7
hub 1-0:1.0: USB hub found
yenta_cardbus 0000:15:00.0: ISA IRQ mask 0x0428, PCI irq 16
yenta_cardbus 0000:15:00.0: Socket status: 30000006
yenta_cardbus 0000:15:00.0: pcmcia: parent PCI bridge window: [io  0x7000-0xafff]
yenta_cardbus 0000:15:00.0: pcmcia: parent PCI bridge window: [mem 0xf8300000-0xfbffffff]
pcmcia_socket pcmcia_socket0: cs: memory probe 0xf8300000-0xfbffffff:
 excluding 0xf8300000-0xf86cffff
yenta_cardbus 0000:15:00.0: pcmcia: parent PCI bridge window: [mem 0xf4000000-0xf7ffffff 64bit pref]
pcmcia_socket pcmcia_socket0: cs: memory probe 0xf4000000-0xf7ffffff:
 excluding 0xf4000000-0xf7ffffff
hub 1-0:1.0: 4 ports detected
sdhci-pci 0000:15:00.2: SDHCI controller found [1180:0822] (rev 21)
uhci_hcd 0000:00:1a.0: UHCI Host Controller
uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 2
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
mmc0: no vqmmc regulator found
mmc0: no vmmc regulator found
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
uhci_hcd 0000:00:1a.0: irq 20, io base 0x00001860
mmc0: SDHCI controller on PCI [0000:15:00.2] using DMA
usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb2: Product: UHCI Host Controller
usb usb2: Manufacturer: Linux 3.7.0-rc6-00117-g17a96ce uhci_hcd
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
usb usb2: SerialNumber: 0000:00:1a.0
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 2 ports detected
uhci_hcd 0000:00:1a.1: UHCI Host Controller
uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 3
uhci_hcd 0000:00:1a.1: irq 21, io base 0x00001880
usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb3: Product: UHCI Host Controller
usb usb3: Manufacturer: Linux 3.7.0-rc6-00117-g17a96ce uhci_hcd
usb usb3: SerialNumber: 0000:00:1a.1
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
ehci_hcd 0000:00:1d.7: EHCI Host Controller
ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 4
ehci_hcd 0000:00:1d.7: debug port 1
ehci_hcd 0000:00:1d.7: irq 19, io mem 0xfe227000
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00
usb usb4: New USB device found, idVendor=1d6b, idProduct=0002
usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb4: Product: EHCI Host Controller
usb usb4: Manufacturer: Linux 3.7.0-rc6-00117-g17a96ce ehci_hcd
usb usb4: SerialNumber: 0000:00:1d.7
hub 4-0:1.0: USB hub found
hub 4-0:1.0: 6 ports detected
uhci_hcd 0000:00:1d.0: UHCI Host Controller
uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 5
uhci_hcd 0000:00:1d.0: irq 16, io base 0x000018a0
usb usb5: New USB device found, idVendor=1d6b, idProduct=0001
usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb5: Product: UHCI Host Controller
usb usb5: Manufacturer: Linux 3.7.0-rc6-00117-g17a96ce uhci_hcd
usb usb5: SerialNumber: 0000:00:1d.0
hub 5-0:1.0: USB hub found
hub 5-0:1.0: 2 ports detected
uhci_hcd 0000:00:1d.1: UHCI Host Controller
uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 6
uhci_hcd 0000:00:1d.1: irq 17, io base 0x000018c0
usb usb6: New USB device found, idVendor=1d6b, idProduct=0001
usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb6: Product: UHCI Host Controller
usb usb6: Manufacturer: Linux 3.7.0-rc6-00117-g17a96ce uhci_hcd
usb usb6: SerialNumber: 0000:00:1d.1
hub 6-0:1.0: USB hub found
hub 6-0:1.0: 2 ports detected
uhci_hcd 0000:00:1d.2: UHCI Host Controller
uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 7
uhci_hcd 0000:00:1d.2: irq 18, io base 0x000018e0
usb usb7: New USB device found, idVendor=1d6b, idProduct=0001
usb usb7: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb7: Product: UHCI Host Controller
usb usb7: Manufacturer: Linux 3.7.0-rc6-00117-g17a96ce uhci_hcd
usb usb7: SerialNumber: 0000:00:1d.2
hub 7-0:1.0: USB hub found
hub 7-0:1.0: 2 ports detected
usb 1-4: new high-speed USB device number 3 using ehci_hcd
usb 1-4: New USB device found, idVendor=04b3, idProduct=4485
usb 1-4: New USB device strings: Mfr=0, Product=0, SerialNumber=0
hub 1-4:1.0: USB hub found
hub 1-4:1.0: 4 ports detected
EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null)
EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: data=ordered
usb 2-2: new full-speed USB device number 2 using uhci_hcd
usb 2-2: New USB device found, idVendor=0483, idProduct=2016
usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 2-2: Product: Biometric Coprocessor
usb 2-2: Manufacturer: STMicroelectronics
usb 1-4.4: new low-speed USB device number 4 using ehci_hcd
usb 1-4.4: New USB device found, idVendor=046d, idProduct=c016
usb 1-4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 1-4.4: Product: Optical USB Mouse
usb 1-4.4: Manufacturer: Logitech
device-mapper: uevent: version 1.0.3
device-mapper: ioctl: 4.23.0-ioctl (2012-07-25) initialised: dm-devel@redhat.com
RPC: Registered named UNIX socket transport module.
RPC: Registered udp transport module.
RPC: Registered tcp transport module.
RPC: Registered tcp NFSv4.1 backchannel transport module.
Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
loop: module loaded
EXT4-fs (sda2): re-mounted. Opts: data=ordered
Non-volatile memory driver v1.3
wmi: Mapper loaded
thinkpad_acpi: ThinkPad ACPI Extras v0.24
thinkpad_acpi: http://ibm-acpi.sf.net/
thinkpad_acpi: ThinkPad BIOS 7LETC9WW (2.29 ), EC 7KHT24WW-1.08
thinkpad_acpi: Lenovo ThinkPad T61, model 6464CTO
thinkpad_acpi: detected a 8-level brightness capable ThinkPad
e1000e: Intel(R) PRO/1000 Network Driver - 2.1.4-k
e1000e: Copyright(c) 1999 - 2012 Intel Corporation.
e1000e 0000:00:19.0: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode
thinkpad_acpi: ACPI backlight control delay disabled
thinkpad_acpi: radio switch found; radios are enabled
thinkpad_acpi: This ThinkPad has standard ACPI backlight brightness control, supported by the ACPI video driver
thinkpad_acpi: Disabling thinkpad-acpi brightness events by default...
r592: driver successfully loaded
thinkpad_acpi: rfkill switch tpacpi_bluetooth_sw: radio is blocked
pcmcia_socket pcmcia_socket0: cs: memory probe 0x0c0000-0x0fffff:
 excluding 0xc0000-0xcffff 0xe0000-0xfffff
pcmcia_socket pcmcia_socket0: cs: memory probe 0xa0000000-0xa0ffffff:
 excluding 0xa0000000-0xa0ffffff
pcmcia_socket pcmcia_socket0: cs: memory probe 0x60000000-0x60ffffff:
 excluding 0x60000000-0x60ffffff
r852: driver loaded successfully
cfg80211: Calling CRDA to update world regulatory domain
microcode: CPU0 sig=0x6fa, pf=0x80, revision=0x95
usbcore: registered new interface driver usbhid
usbhid: USB HID core driver
microcode: CPU1 sig=0x6fa, pf=0x80, revision=0x95
microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
thinkpad_acpi: Standard ACPI backlight interface available, not loading native one
thinkpad_acpi: Console audio control enabled, mode: monitor (read only)
input: ThinkPad Extra Buttons as /devices/platform/thinkpad_acpi/input/input5
iwl3945: Intel(R) PRO/Wireless 3945ABG/BG Network Connection driver for Linux, in-tree:s
iwl3945: Copyright(c) 2003-2011 Intel Corporation
cfg80211: World regulatory domain updated:
e1000e 0000:00:19.0 eth0: (PCI Express:2.5GT/s:Width x1) 00:1c:25:14:4a:e2
e1000e 0000:00:19.0 eth0: Intel(R) PRO/1000 Network Connection
e1000e 0000:00:19.0 eth0: MAC: 6, PHY: 6, PBA No: FFFFFF-0FF
ACPI Warning: 0x0000000000001028-0x000000000000102f SystemIO conflicts with Region \_SB_.PCI0.LPC_.PMIO 1 (20120913/utaddress-251)
ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
ACPI Warning: 0x00000000000011b0-0x00000000000011bf SystemIO conflicts with Region \_SB_.PCI0.LPC_.LPIO 1 (20120913/utaddress-251)
ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
ACPI Warning: 0x0000000000001180-0x00000000000011af SystemIO conflicts with Region \_SB_.PCI0.LPC_.LPIO 1 (20120913/utaddress-251)
ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
lpc_ich: Resource conflict(s) found affecting gpio_ich
i801_smbus 0000:00:1f.3: SMBus using PCI Interrupt
cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
cfg80211:   (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
cfg80211:   (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
cfg80211:   (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
input: Logitech Optical USB Mouse as /devices/pci0000:00/0000:00:1a.7/usb1/1-4/1-4.4/1-4.4:1.0/input/input6
hid-generic 0003:046D:C016.0001: input: USB HID v1.10 Mouse [Logitech Optical USB Mouse] on usb-0000:00:1a.7-4.4/input0
iTCO_vendor_support: vendor-support=0
hda_intel: probe_mask set to 0x1 for device 17aa:20ac
iTCO_wdt: Intel TCO WatchDog Timer Driver v1.10
iTCO_wdt: Found a ICH8M-E TCO device (Version=2, TCOBASE=0x1060)
iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
iwl3945 0000:03:00.0: Tunable channels: 13 802.11bg, 23 802.11a channels
iwl3945 0000:03:00.0: Detected Intel Wireless WiFi Link 3945ABG
EXT4-fs (sda5): mounted filesystem with ordered data mode. Opts: data=ordered,user_xattr
psmouse serio1: synaptics: Touchpad model: 1, fw: 6.2, id: 0x81a0b1, caps: 0xa04793/0x300000/0x0, board id: 71, fw id: 67352
psmouse serio1: synaptics: serio: Synaptics pass-through port at isa0060/serio1/input0
input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input7
usb 2-1: new full-speed USB device number 3 using uhci_hcd
usb 2-1: New USB device found, idVendor=0a5c, idProduct=2110
usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
usb 2-1: Product: BCM2045B
usb 2-1: Manufacturer: Broadcom Corp
Bluetooth: Core ver 2.16
NET: Registered protocol family 31
Bluetooth: HCI device and connection manager initialized
Bluetooth: HCI socket layer initialized
Bluetooth: L2CAP socket layer initialized
Bluetooth: SCO socket layer initialized
usbcore: registered new interface driver btusb
Comment 3 Zdenek Kabelac 2012-11-29 08:48:33 UTC
Created attachment 87741 [details]
Zoom of crash with Rafael's patch 

This is zoomed picture of crash with applied patch
from https://lkml.org/lkml/2012/11/28/469

Index: linux/drivers/pnp/pnpacpi/rsparser.c
===================================================================
--- linux.orig/drivers/pnp/pnpacpi/rsparser.c
+++ linux/drivers/pnp/pnpacpi/rsparser.c
@@ -610,6 +610,14 @@ int pnpacpi_build_resource_template(stru
 	struct acpi_resource *resource;
 	int res_cnt = 0;
 	acpi_status status;
+	int ret;
+
+	/* Sanity check. */
+	ret = acpi_bus_get_device(handle, &acpi_dev);
+	if (ret) {
+		dev_err(&dev->dev, "ACPI node is invalid in %s\n", __func__);
+		return ret;
+	}
 
 	status = acpi_walk_resources(handle, METHOD_NAME__CRS,
 				     pnpacpi_count_resources, &res_cnt);
Comment 4 Zdenek Kabelac 2012-11-29 08:56:50 UTC
Created attachment 87751 [details]
Full snapshot (less readable)

This is full picture showing whole stack.

And here is my compiled version of acpi_ns_validate_handle().

0000000000000527 <acpi_ns_validate_handle>:
 527:   e8 00 00 00 00          callq  52c <acpi_ns_validate_handle+0x5>
 52c:   48 8d 57 ff             lea    -0x1(%rdi),%rdx
 530:   55                      push   %rbp
 531:   48 89 f8                mov    %rdi,%rax
 534:   48 83 fa fd             cmp    $0xfffffffffffffffd,%rdx
 538:   48 89 e5                mov    %rsp,%rbp
 53b:   76 09                   jbe    546 <acpi_ns_validate_handle+0x1f>
 53d:   48 8b 05 00 00 00 00    mov    0x0(%rip),%rax        # 544 <acpi_ns_validate_handle+0x1d>
 544:   eb 0d                   jmp    553 <acpi_ns_validate_handle+0x2c>
 546:   80 7f 08 0f             cmpb   $0xf,0x8(%rdi)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 54a:   ba 00 00 00 00          mov    $0x0,%edx
 54f:   48 0f 45 c2             cmovne %rdx,%rax
 553:   5d                      pop    %rbp
 554:   c3                      retq
Comment 5 Zdenek Kabelac 2012-11-29 09:00:17 UTC
It's probably worth to note - that first suspend/resume in docking station is always successful - the problem starts with 2nd. cycle (when Legacy HW support is enabled in T61 Bios)
Comment 6 Rafael J. Wysocki 2012-11-29 09:22:07 UTC
(In reply to comment #3)
> Created an attachment (id=87741) [details]
> Zoom of crash with Rafael's patch 
> 
> This is zoomed picture of crash with applied patch
> from https://lkml.org/lkml/2012/11/28/469

OK, so definitely the handle we passed to acpi_bus_get_device() was invalid, but ACPICA couldn't recover (no surprises there).
Comment 7 Rafael J. Wysocki 2012-11-29 09:22:57 UTC
(In reply to comment #5)
> It's probably worth to note - that first suspend/resume in docking station is
> always successful - the problem starts with 2nd. cycle (when Legacy HW
> support
> is enabled in T61 Bios)

Yes, this is a known problem.  We're going to fix it, but it's hard to say when that happens.
Comment 8 Zdenek Kabelac 2012-11-29 10:11:29 UTC
Testing code from post: https://lkml.org/lkml/2012/11/28/411

diff --git a/drivers/acpi/acpica/nsaccess.c b/drivers/acpi/acpica/nsaccess.c
index 23db53c..3238cab 100644
--- a/drivers/acpi/acpica/nsaccess.c
+++ b/drivers/acpi/acpica/nsaccess.c
@@ -320,6 +320,8 @@ acpi_ns_lookup(union acpi_generic_state *scope_info,
                                  acpi_gbl_root_node));
 
                prefix_node = acpi_gbl_root_node;
+       } else if (WARN_ON_ONCE(scope_info->common.descriptor_type != ACPI_DESC_
+               prefix_node = acpi_gbl_root_node;
        } else {
                prefix_node = scope_info->scope.node;
                if (ACPI_GET_DESCRIPTOR_TYPE(prefix_node) !=



Stabilized suspend/resume - but at the same time made the docking somehow unusable - at least the mouse plugged in dock's USB just weirdly jumps on the screen, during suspend/resume dock remains 'red' (if you know what I mean) - thus no safe undocking is probably possible. Laptop doesn't wake-up on pressing 'Fn' key - only I/O button wakes it.

But I've repeated 5 cycles with lock (though things are running slower).


And here is the kernel Warning trace:

ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
ACPI: bus type pci registered
PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf0000000-0xf3ffffff] (base 0xf0000000)
PCI: MMCONFIG at [mem 0xf0000000-0xf3ffffff] reserved in E820
PCI: Using configuration type 1 for base access
bio: create slab <bio-0> at 0
ACPI: Added _OSI(Module Device)
ACPI: Added _OSI(Processor Device)
ACPI: Added _OSI(3.0 _SCP Extensions)
ACPI: Added _OSI(Processor Aggregator Device)
ACPI: Added _OSI(Linux)
ACPI: EC: EC description table is found, configuring boot EC
------------[ cut here ]------------
WARNING: at drivers/acpi/acpica/nsaccess.c:323 acpi_ns_lookup+0xc5/0x600()
Hardware name: 6464CTO
Modules linked in:
Pid: 1, comm: swapper/0 Not tainted 3.7.0-rc7-00060-g30145b2 #105
Call Trace:
 [<ffffffff810415ff>] warn_slowpath_common+0x7f/0xc0
 [<ffffffff8104165a>] warn_slowpath_null+0x1a/0x20
 [<ffffffff81382e09>] acpi_ns_lookup+0xc5/0x600
 [<ffffffff8136534f>] ? acpi_os_wait_semaphore+0x136/0x149
 [<ffffffff813874e8>] acpi_ns_get_node+0x96/0x102
 [<ffffffff8155529e>] ? mutex_unlock+0xe/0x10
 [<ffffffff81cc3d46>] ? acpi_sleep_proc_init+0x2a/0x2a
 [<ffffffff81387f70>] acpi_get_handle+0x8c/0xa3
 [<ffffffff81cc3d46>] ? acpi_sleep_proc_init+0x2a/0x2a
 [<ffffffff81cc3d46>] ? acpi_sleep_proc_init+0x2a/0x2a
 [<ffffffff81cc43ea>] acpi_ec_ecdt_probe+0x99/0x1d4
 [<ffffffff81392c14>] ? acpi_enable_subsystem+0x142/0x14e
 [<ffffffff81cc3dcf>] acpi_init+0x89/0x28b
 [<ffffffff813e92b3>] ? __class_create+0x63/0xb0
 [<ffffffff81cc1bc5>] ? video_setup+0x81/0x81
 [<ffffffff81cc1c2e>] ? fbmem_init+0x69/0x98
 [<ffffffff810002e2>] do_one_initcall+0x122/0x170
 [<ffffffff81536dcc>] kernel_init+0x15c/0x2e0
 [<ffffffff81c9a5af>] ? do_early_param+0x8c/0x8c
 [<ffffffff81536c70>] ? rest_init+0x140/0x140
 [<ffffffff8156045c>] ret_from_fork+0x7c/0xb0
 [<ffffffff81536c70>] ? rest_init+0x140/0x140
---[ end trace 85d8246b5b2bb9bd ]---
ACPI: Interpreter enabled
ACPI: (supports S0 S3 S4 S5)
ACPI: Using IOAPIC for interrupt routing
ACPI: No dock devices found.
PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
vgaarb: loaded
SCSI subsystem initialized
Comment 9 Rafael J. Wysocki 2012-11-29 10:30:20 UTC
Well, this works because scope_info->common.descriptor_type is not initialized by acpi_ns_get_node(), as far as I can say.
Comment 10 Zdenek Kabelac 2012-11-29 12:25:28 UTC
So taking the patch from: https://lkml.org/lkml/2012/11/29/186
(and not using those 2 earlier - and moving my git master head to
commit e9296e89b85604862bd9ec2d54dc43edad775c0d)
 

I've got new interesting oops now - related to the press of 'Undock' button.
(or eventually using 'echo 1 >/sys/devices/platform/dock.0/undock')

This time full serial log output - since it happens before suspend
(after resume my serial console line is basically useless - unsure why,
it's just giving me garbage output - probably suspend resume completely
changes my serial line setting 115200n8  to something completely different)

[   37.192078] systemd[1]: Starting Getty on tty3...
[   37.230529] systemd[1]: Started Getty on tty3.
[   42.562469] BUG: unable to handle kernel paging request at fffffffffffffff5
[   42.568996] IP: [<ffffffff81387362>] acpi_ns_validate_handle+0x1f/0x2e
[   42.569818] PGD 1a0e067 PUD 1a0f067 PMD 0 
[   42.569818] Oops: 0000 [#1] PREEMPT SMP 
[   42.569818] Modules linked in: i915 i2c_algo_bit drm_kms_helper drm ip6_tables ebtable_nat ebtables ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack ipt_REJECT iptable_mangle xt_tcpudp iptable_filter ip_tables x_tables bridge stp llc ipv6 rfcomm bnep btusb bluetooth snd_hda_codec_analog arc4 iTCO_wdt iTCO_vendor_support hid_generic iwl3945 iwlegacy coretemp mac80211 usbhid hid microcode snd_hda_intel snd_hda_codec r852 sm_common nand psmouse snd_seq r592 serio_raw nand_ecc nand_ids snd_seq_device memstick mtd lpc_ich mfd_core snd_pcm i2c_i801 cfg80211 i2c_core e1000e snd_page_alloc snd_timer wmi thinkpad_acpi binfmt_misc nvram snd soundcore evdev loop vhost_net tun kvm_intel kvm nfsd exportfs auth_rpcgss nfs_acl lockd sunrpc dm_mod pcmcia ehci_hcd sr_mod cdrom sdhci_pci sdhci mmc_core uhci_hcd yenta_socket usbcore usb_common video backlight autofs4
[   42.569818] CPU 0 
[   42.569818] Pid: 4, comm: kworker/0:0 Not tainted 3.7.0-rc7-00078-g1e3c74e #106 LENOVO 6464CTO/6464CTO
[   42.569818] RIP: 0010:[<ffffffff81387362>]  [<ffffffff81387362>] acpi_ns_validate_handle+0x1f/0x2e
[   42.569818] RSP: 0018:ffff88013590baf8  EFLAGS: 00010293
[   42.569818] RAX: ffffffffffffffed RBX: ffffffff817bbd8d RCX: 0000000000000006
[   42.569818] RDX: ffffffffffffffec RSI: ffffffff817bbd8d RDI: ffffffffffffffed
[   42.569818] RBP: ffff88013590baf8 R08: 0000000000000000 R09: 0000000000000000
[   42.569818] R10: 0000000000000000 R11: 0000000000000000 R12: dead000000100100
[   42.569818] R13: ffff88013590bb50 R14: ffff880135aa5000 R15: 0000000000000001
[   42.569818] FS:  0000000000000000(0000) GS:ffff880137200000(0000) knlGS:0000000000000000
[   42.569818] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[   42.569818] CR2: fffffffffffffff5 CR3: 0000000001a0c000 CR4: 00000000000007f0
[   42.569818] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   42.569818] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[   42.569818] Process kworker/0:0 (pid: 4, threadinfo ffff88013590a000, task ffff880135910000)
[   42.569818] Stack:
[   42.569818]  ffff88013590bb38 ffffffff81387ee3 ffff88013590bb38 0000000000000000
[   42.569818]  0000000000000006 ffff880135ab0000 dead000000100100 0000000000000000
[   42.569818]  ffff88013590bb68 ffffffff8136894c ffff880135ab03a8 0000000000000000
[   42.569818] Call Trace:
[   42.569818]  [<ffffffff81387ee3>] acpi_get_handle+0x3b/0xa3
[   42.569818]  [<ffffffff8136894c>] acpi_device_unregister.isra.5+0xb9/0x153
[   42.569818]  [<ffffffff81368a19>] acpi_bus_remove.part.6+0x33/0x39
[   42.569818]  [<ffffffff81368abc>] acpi_bus_trim+0x9d/0x10a
[   42.569818]  [<ffffffff8136b247>] hotplug_dock_devices+0xaf/0x168
[   42.569818]  [<ffffffff8136b806>] handle_eject_request+0x3e/0x107
[   42.569818]  [<ffffffff8136bda5>] acpi_dock_deferred_cb+0x13f/0x17e
[   42.569818]  [<ffffffff8136450c>] acpi_os_execute_deferred+0x25/0x32
[   42.569818]  [<ffffffff81064afd>] process_one_work+0x1ad/0x750
[   42.569818]  [<ffffffff81064a99>] ? process_one_work+0x149/0x750
[   42.569818]  [<ffffffff8106552b>] ? worker_thread+0x21b/0x450
[   42.569818]  [<ffffffff81557809>] ? _raw_spin_lock_irq+0x19/0x80
[   42.569818]  [<ffffffff813644e7>] ? acpi_os_wait_events_complete+0x23/0x23
[   42.569818]  [<ffffffff8106546d>] worker_thread+0x15d/0x450
[   42.569818]  [<ffffffff81065310>] ? rescuer_thread+0x230/0x230
[   42.569818]  [<ffffffff8106f52b>] kthread+0xdb/0xe0
[   42.569818]  [<ffffffff8106f450>] ? kthread_create_on_node+0x140/0x140
[   42.569818]  [<ffffffff8156041c>] ret_from_fork+0x7c/0xb0
[   42.569818]  [<ffffffff8106f450>] ? kthread_create_on_node+0x140/0x140
[   42.569818] Code: 18 5b 41 5c 41 5d 41 5e 41 5f 5d c3 66 66 66 66 90 48 8d 57 ff 55 48 89 f8 48 83 fa fd 48 89 e5 76 09 48 8b 05 58 a0 42 01 eb 0d <80> 7f 08 0f ba 00 00 00 00 48 0f 45 c2 5d c3 66 66 66 66 90 48 
[   42.569818] RIP  [<ffffffff81387362>] acpi_ns_validate_handle+0x1f/0x2e
[   42.569818]  RSP <ffff88013590baf8>
[   42.569818] CR2: fffffffffffffff5
[   42.569818] ---[ end trace 720e593b76709822 ]---
[   42.569818] BUG: sleeping function called from invalid context at kernel/rwsem.c:20
[   42.569818] in_atomic(): 0, irqs_disabled(): 1, pid: 4, name: kworker/0:0
[   42.569818] INFO: lockdep is turned off.
[   42.569818] irq event stamp: 26898
[   42.569818] hardirqs last  enabled at (26897): [<ffffffff81558415>] _raw_spin_unlock_irqrestore+0x65/0x80
[   42.569818] hardirqs last disabled at (26898): [<ffffffff81558c63>] error_sti+0x5/0x6
[   42.569818] softirqs last  enabled at (26420): [<ffffffff8104b4df>] __do_softirq+0x14f/0x3f0
[   42.569818] softirqs last disabled at (26393): [<ffffffff8156180c>] call_softirq+0x1c/0x30
[   42.569818] Pid: 4, comm: kworker/0:0 Tainted: G      D      3.7.0-rc7-00078-g1e3c74e #106
[   42.569818] Call Trace:
[   42.569818]  [<ffffffff810af0b0>] ? print_irqtrace_events+0xd0/0xe0
[   42.569818]  [<ffffffff8107bd61>] __might_sleep+0x141/0x200
[   42.569818]  [<ffffffff8155560a>] down_read+0x2a/0x93
[   42.569818]  [<ffffffff8105b024>] exit_signals+0x24/0x130
[   42.569818]  [<ffffffff81077296>] ? blocking_notifier_call_chain+0x16/0x20
[   42.569818]  [<ffffffff81047e54>] do_exit+0xb4/0xa90
[   42.569818]  [<ffffffff810450cd>] ? kmsg_dump+0x1bd/0x230
[   42.569818]  [<ffffffff81044f35>] ? kmsg_dump+0x25/0x230
[   42.569818]  [<ffffffff81559636>] oops_end+0x96/0xe0
[   42.569818]  [<ffffffff81043625>] ? console_unlock+0x1e5/0x490
[   42.569818]  [<ffffffff8154c625>] no_context+0x258/0x283
[   42.569818]  [<ffffffff8154c814>] __bad_area_nosemaphore+0x1c4/0x1e3
[   42.569818]  [<ffffffff8154c846>] bad_area_nosemaphore+0x13/0x15
[   42.569818]  [<ffffffff8155bbee>] __do_page_fault+0x30e/0x4e0
[   42.569818]  [<ffffffff8136548f>] ? acpi_os_release_object+0xe/0x12
[   42.569818]  [<ffffffff8117c350>] ? kmem_cache_free+0x240/0x2a0
[   42.569818]  [<ffffffff81558c63>] ? error_sti+0x5/0x6
[   42.569818]  [<ffffffff8131fbdd>] ? trace_hardirqs_off_thunk+0x3a/0x3c
[   42.569818]  [<ffffffff8155bdce>] do_page_fault+0xe/0x10
[   42.569818]  [<ffffffff81558a62>] page_fault+0x22/0x30
[   42.569818]  [<ffffffff81387362>] ? acpi_ns_validate_handle+0x1f/0x2e
[   42.569818]  [<ffffffff81387ee3>] acpi_get_handle+0x3b/0xa3
[   42.569818]  [<ffffffff8136894c>] acpi_device_unregister.isra.5+0xb9/0x153
[   42.569818]  [<ffffffff81368a19>] acpi_bus_remove.part.6+0x33/0x39
[   42.569818]  [<ffffffff81368abc>] acpi_bus_trim+0x9d/0x10a
[   42.569818]  [<ffffffff8136b247>] hotplug_dock_devices+0xaf/0x168
[   42.569818]  [<ffffffff8136b806>] handle_eject_request+0x3e/0x107
[   42.569818]  [<ffffffff8136bda5>] acpi_dock_deferred_cb+0x13f/0x17e
[   42.569818]  [<ffffffff8136450c>] acpi_os_execute_deferred+0x25/0x32
[   42.569818]  [<ffffffff81064afd>] process_one_work+0x1ad/0x750
[   42.569818]  [<ffffffff81064a99>] ? process_one_work+0x149/0x750
[   42.569818]  [<ffffffff8106552b>] ? worker_thread+0x21b/0x450
[   42.569818]  [<ffffffff81557809>] ? _raw_spin_lock_irq+0x19/0x80
[   42.569818]  [<ffffffff813644e7>] ? acpi_os_wait_events_complete+0x23/0x23
[   42.569818]  [<ffffffff8106546d>] worker_thread+0x15d/0x450
[   42.569818]  [<ffffffff81065310>] ? rescuer_thread+0x230/0x230
[   42.569818]  [<ffffffff8106f52b>] kthread+0xdb/0xe0
[   42.569818]  [<ffffffff8106f450>] ? kthread_create_on_node+0x140/0x140
[   42.569818]  [<ffffffff8156041c>] ret_from_fork+0x7c/0xb0
[   42.569818]  [<ffffffff8106f450>] ? kthread_create_on_node+0x140/0x140
[   43.432702] BUG: unable to handle kernel paging request at ffffffffffffff98
[   43.433365] IP: [<ffffffff8106f831>] kthread_data+0x11/0x20
[   43.433365] PGD 1a0e067 PUD 1a0f067 PMD 0 
[   43.433365] Oops: 0000 [#2] PREEMPT SMP 
[   43.433365] Modules linked in: i915 i2c_algo_bit drm_kms_helper drm ip6_tables ebtable_nat ebtables ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack ipt_REJECT iptable_mangle xt_tcpudp iptable_filter ip_tables x_tables bridge stp llc ipv6 rfcomm bnep btusb bluetooth snd_hda_codec_analog arc4 iTCO_wdt iTCO_vendor_support hid_generic iwl3945 iwlegacy coretemp mac80211 usbhid hid microcode snd_hda_intel snd_hda_codec r852 sm_common nand psmouse snd_seq r592 serio_raw nand_ecc nand_ids snd_seq_device memstick mtd lpc_ich mfd_core snd_pcm i2c_i801 cfg80211 i2c_core e1000e snd_page_alloc snd_timer wmi thinkpad_acpi binfmt_misc nvram snd soundcore evdev loop vhost_net tun kvm_intel kvm nfsd exportfs auth_rpcgss nfs_acl lockd sunrpc dm_mod pcmcia ehci_hcd sr_mod cdrom sdhci_pci sdhci mmc_core uhci_hcd yenta_socket usbcore usb_common video backlight autofs4
[   43.433365] CPU 0 
[   43.433365] Pid: 4, comm: kworker/0:0 Tainted: G      D      3.7.0-rc7-00078-g1e3c74e #106 LENOVO 6464CTO/6464CTO
[   43.433365] RIP: 0010:[<ffffffff8106f831>]  [<ffffffff8106f831>] kthread_data+0x11/0x20
[   43.433365] RSP: 0018:ffff88013590b6f0  EFLAGS: 00010092
[   43.433365] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
[   43.433365] RDX: ffffffff81e8d880 RSI: 0000000000000000 RDI: ffff880135910000
[   43.433365] RBP: ffff88013590b708 R08: 0000000000989680 R09: ffffffff81e8d880
[   43.433365] R10: 0000000000000400 R11: 0000000000000000 R12: ffff8801373d37c0
[   43.433365] R13: 0000000000000000 R14: ffff8801358a8000 R15: ffff88013590fff0
[   43.433365] FS:  0000000000000000(0000) GS:ffff880137200000(0000) knlGS:0000000000000000
[   43.433365] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[   43.433365] CR2: ffffffffffffff98 CR3: 0000000001a0c000 CR4: 00000000000007f0
[   43.433365] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   43.433365] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[   43.433365] Process kworker/0:0 (pid: 4, threadinfo ffff88013590a000, task ffff880135910000)
[   43.433365] Stack:
[   43.433365]  ffffffff81066315 ffff88013590b708 ffff8801359103c0 ffff88013590b788
[   43.433365]  ffffffff81556338 ffff88013590b738 0000000000000000 ffff880135910000
[   43.433365]  ffff88013590bfd8 ffff88013590bfd8 ffff88013590bfd8 ffff880132cd45e8
[   43.433365] Call Trace:
[   43.433365]  [<ffffffff81066315>] ? wq_worker_sleeping+0x15/0xc0
[   43.433365]  [<ffffffff81556338>] __schedule+0x738/0x9a0
[   43.433365]  [<ffffffff81556629>] schedule+0x29/0x70
[   43.433365]  [<ffffffff810483c3>] do_exit+0x623/0xa90
[   43.433365]  [<ffffffff81559636>] oops_end+0x96/0xe0
[   43.433365]  [<ffffffff81043625>] ? console_unlock+0x1e5/0x490
[   43.433365]  [<ffffffff8154c625>] no_context+0x258/0x283
[   43.433365]  [<ffffffff8154c814>] __bad_area_nosemaphore+0x1c4/0x1e3
[   43.433365]  [<ffffffff8154c846>] bad_area_nosemaphore+0x13/0x15
[   43.433365]  [<ffffffff8155bbee>] __do_page_fault+0x30e/0x4e0
[   43.433365]  [<ffffffff8136548f>] ? acpi_os_release_object+0xe/0x12
[   43.433365]  [<ffffffff8117c350>] ? kmem_cache_free+0x240/0x2a0
[   43.433365]  [<ffffffff81558c63>] ? error_sti+0x5/0x6
[   43.433365]  [<ffffffff8131fbdd>] ? trace_hardirqs_off_thunk+0x3a/0x3c
[   43.433365]  [<ffffffff8155bdce>] do_page_fault+0xe/0x10
[   43.433365]  [<ffffffff81558a62>] page_fault+0x22/0x30
[   43.433365]  [<ffffffff81387362>] ? acpi_ns_validate_handle+0x1f/0x2e
[   43.433365]  [<ffffffff81387ee3>] acpi_get_handle+0x3b/0xa3
[   43.433365]  [<ffffffff8136894c>] acpi_device_unregister.isra.5+0xb9/0x153
[   43.433365]  [<ffffffff81368a19>] acpi_bus_remove.part.6+0x33/0x39
[   43.433365]  [<ffffffff81368abc>] acpi_bus_trim+0x9d/0x10a
[   43.433365]  [<ffffffff8136b247>] hotplug_dock_devices+0xaf/0x168
[   43.433365]  [<ffffffff8136b806>] handle_eject_request+0x3e/0x107
[   43.433365]  [<ffffffff8136bda5>] acpi_dock_deferred_cb+0x13f/0x17e
[   43.433365]  [<ffffffff8136450c>] acpi_os_execute_deferred+0x25/0x32
[   43.433365]  [<ffffffff81064afd>] process_one_work+0x1ad/0x750
[   43.433365]  [<ffffffff81064a99>] ? process_one_work+0x149/0x750
[   43.433365]  [<ffffffff8106552b>] ? worker_thread+0x21b/0x450
[   43.433365]  [<ffffffff81557809>] ? _raw_spin_lock_irq+0x19/0x80
[   43.433365]  [<ffffffff813644e7>] ? acpi_os_wait_events_complete+0x23/0x23
[   43.433365]  [<ffffffff8106546d>] worker_thread+0x15d/0x450
[   43.433365]  [<ffffffff81065310>] ? rescuer_thread+0x230/0x230
[   43.433365]  [<ffffffff8106f52b>] kthread+0xdb/0xe0
[   43.433365]  [<ffffffff8106f450>] ? kthread_create_on_node+0x140/0x140
[   43.433365]  [<ffffffff8156041c>] ret_from_fork+0x7c/0xb0
[   43.433365]  [<ffffffff8106f450>] ? kthread_create_on_node+0x140/0x140
[   43.433365] Code: 48 89 e5 5d 48 8b 40 88 48 c1 e8 02 83 e0 01 c3 66 2e 0f 1f 84 00 00 00 00 00 66 66 66 66 90 48 8b 87 68 03 00 00 55 48 89 e5 5d <48> 8b 40 98 c3 66 2e 0f 1f 84 00 00 00 00 00 66 66 66 66 90 55 
[   43.433365] RIP  [<ffffffff8106f831>] kthread_data+0x11/0x20
[   43.433365]  RSP <ffff88013590b6f0>
[   43.433365] CR2: ffffffffffffff98
[   43.433365] ---[ end trace 720e593b76709823 ]---
[   43.433365] Fixing recursive fault but reboot is needed!
Comment 11 Zdenek Kabelac 2012-11-29 12:29:34 UTC
Seems like  acpi_ns_validate_handle  doesn't count with IS_ERR(handle).
Comment 12 Zdenek Kabelac 2012-11-29 12:58:53 UTC
Using pm-debug 

'echo core > /sys/power/pm_test'

and 

'echo mem > /sys/power/state'


seems to have no problem with resume - I've checked 10 cycles without an issue.
But during the test dock has been always powered.

Also I'm pretty curious how to trap OOPS from resume when now the only supported resume is 'via' intel kernel driver -  there used to be a way to 'safely' suspend and resume with plain good old VGA mode.  Now this option seems to be gone - if I boot without modesetting driver - and I've 80x25 VGA screen,
there is no way to resume - intel driver must be loaded for successful resume.

There is obvious delay in logging from resume and the moment intel driver turns the screen on - and quite often the resume stays completely black - and I do no see any trace log even there there is probably one logged.

Is there some trick to resume with VGA ?
Comment 13 Rafael J. Wysocki 2012-11-29 14:53:10 UTC
(In reply to comment #11)
> Seems like  acpi_ns_validate_handle  doesn't count with IS_ERR(handle).

Sorry, my bad.  I didn't notice that acpi_device_remove_files() uses device->handle.
Comment 14 Rafael J. Wysocki 2012-11-29 14:54:30 UTC
Created attachment 87791 [details]
PATCH: Invalidate ACPI device's handle on unregistration

Can you please try this one instead?
Comment 15 Zdenek Kabelac 2012-11-29 15:44:36 UTC
So tested - and got nearly the same result - except once it has survived 4 suspends ;) and failed on the 5th.

The only noticable difference from the Attachment 1 [details] is - the RBX has now different value: 6c623a370a2f3a61   - so the value 0x1000 before is just some garbage like this value.

But there are no problems with undocking.

And my boot log has this warning:

PM: noirq resume of devices complete after 244.002 msecs
PM: early resume of devices complete after 0.542 msecs
e1000e 0000:00:19.0: wake-up capability disabled by ACPI
usb usb1: root hub lost power or was reset
usb usb2: root hub lost power or was reset
usb usb3: root hub lost power or was reset
usb usb4: root hub lost power or was reset
usb usb5: root hub lost power or was reset
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
------------[ cut here ]------------
WARNING: at drivers/pnp/pnpacpi/rsparser.c:846 pnpacpi_build_resource_template+0x141/0x150()
Hardware name: 6464CTO
Modules linked in: i915 i2c_algo_bit drm_kms_helper drm ip6_tables ebtable_nat ebtables ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack ipt_REJECT iptable_mangle xt_tcpudp iptable_filter ip_tables x_tables bridge stp llc ipv6 rfcomm bnep btusb bluetooth snd_hda_codec_analog iTCO_wdt iTCO_vendor_support arc4 iwl3945 iwlegacy coretemp mac80211 microcode i2c_i801 psmouse i2c_core serio_raw snd_hda_intel snd_hda_codec snd_seq snd_seq_device r852 sm_common cfg80211 snd_pcm nand nand_ecc r592 nand_ids mtd memstick lpc_ich mfd_core e1000e snd_page_alloc snd_timer wmi thinkpad_acpi binfmt_misc nvram snd soundcore evdev loop vhost_net tun kvm_intel kvm nfsd exportfs auth_rpcgss nfs_acl lockd sunrpc dm_mod hid_generic usbhid hid pcmcia ehci_hcd sr_mod cdrom sdhci_pci sdhci mmc_core uhci_hcd yenta_socket usbcore usb_common video backlight autofs4
Pid: 1416, comm: pm-suspend Not tainted 3.7.0-rc7-00079-g4cb4ded #108
Call Trace:
 [<ffffffff810415ff>] warn_slowpath_common+0x7f/0xc0
 [<ffffffff8104165a>] warn_slowpath_null+0x1a/0x20
 [<ffffffff813a0f01>] pnpacpi_build_resource_template+0x141/0x150
 [<ffffffff81367444>] ? acpi_bus_get_device+0x2a/0x79
 [<ffffffff813a033c>] pnpacpi_set_resources+0x6c/0xf0
 [<ffffffff8139c4d0>] ? pnp_device_shutdown+0x30/0x30
 [<ffffffff8139dd46>] pnp_start_dev+0x46/0x80
 [<ffffffff8139c548>] pnp_bus_resume+0x78/0x80
 [<ffffffff813ef0c8>] dpm_run_callback+0x58/0x90
 [<ffffffff813efb26>] device_resume+0x126/0x210
 [<ffffffff813f0991>] dpm_resume+0x131/0x260
 [<ffffffff813f0cf5>] dpm_resume_end+0x15/0x30
 [<ffffffff8136659e>] ? acpi_suspend_begin_old+0x2d/0x2d
 [<ffffffff81098f75>] suspend_devices_and_enter+0xb5/0x4c0
 [<ffffffff81099514>] pm_suspend+0x194/0x230
 [<ffffffff81098067>] state_store+0x87/0xf0
 [<ffffffff8131413f>] kobj_attr_store+0xf/0x20
 [<ffffffff81209060>] sysfs_write_file+0xe0/0x150
 [<ffffffff8119073f>] vfs_write+0xaf/0x190
 [<ffffffff81190a95>] sys_write+0x55/0xa0
 [<ffffffff815604c6>] system_call_fastpath+0x1a/0x1f
---[ end trace 7b4dd4e69080d90a ]---
serial 00:0a: activation failed
dpm_run_callback(): pnp_bus_resume+0x0/0x80 returns -5
PM: Device 00:0a failed to resume: error -5
ata4.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
ata4.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
ata4.00: configured for UDMA/33
ata3: SATA link down (SStatus 0 SControl 300)
ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Comment 16 Zdenek Kabelac 2012-11-29 16:11:56 UTC
I guess 'serial 00:0a: activation failed'  may explain the garbage I usually get on my serial output after suspend/resume ?

On the other hand - I'm quite sure I've been getting some proper output on my serial driver in the past - possible with some 2.6.XX kernel.
Comment 17 Rafael J. Wysocki 2012-11-29 16:44:12 UTC
(In reply to comment #15)
> So tested - and got nearly the same result - except once it has survived 4
> suspends ;) and failed on the 5th.

Nearly the same with respect to what?

Did it crash on the 5th attempt to suspend?

> The only noticable difference from the Attachment 1 [details] is - the
> RBX has now different value: 6c623a370a2f3a61   - so the value 0x1000
> before is just some garbage like this value.

Well, this is just a bad pointer. 

Can you attach that call trace, please?

> But there are no problems with undocking.

Good.

> And my boot log has this warning:
> 
> PM: noirq resume of devices complete after 244.002 msecs
> PM: early resume of devices complete after 0.542 msecs
> e1000e 0000:00:19.0: wake-up capability disabled by ACPI
> usb usb1: root hub lost power or was reset
> usb usb2: root hub lost power or was reset
> usb usb3: root hub lost power or was reset
> usb usb4: root hub lost power or was reset
> usb usb5: root hub lost power or was reset
> sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim
> to
> support it.
> sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim
> to
> support it.
> ------------[ cut here ]------------
> WARNING: at drivers/pnp/pnpacpi/rsparser.c:846
> pnpacpi_build_resource_template+0x141/0x150()
> Hardware name: 6464CTO
> Modules linked in: i915 i2c_algo_bit drm_kms_helper drm ip6_tables
> ebtable_nat
> ebtables ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat nf_conntrack_ipv4
> nf_defrag_ipv4 xt_conntrack nf_conntrack ipt_REJECT iptable_mangle xt_tcpudp
> iptable_filter ip_tables x_tables bridge stp llc ipv6 rfcomm bnep btusb
> bluetooth snd_hda_codec_analog iTCO_wdt iTCO_vendor_support arc4 iwl3945
> iwlegacy coretemp mac80211 microcode i2c_i801 psmouse i2c_core serio_raw
> snd_hda_intel snd_hda_codec snd_seq snd_seq_device r852 sm_common cfg80211
> snd_pcm nand nand_ecc r592 nand_ids mtd memstick lpc_ich mfd_core e1000e
> snd_page_alloc snd_timer wmi thinkpad_acpi binfmt_misc nvram snd soundcore
> evdev loop vhost_net tun kvm_intel kvm nfsd exportfs auth_rpcgss nfs_acl
> lockd
> sunrpc dm_mod hid_generic usbhid hid pcmcia ehci_hcd sr_mod cdrom sdhci_pci
> sdhci mmc_core uhci_hcd yenta_socket usbcore usb_common video backlight
> autofs4
> Pid: 1416, comm: pm-suspend Not tainted 3.7.0-rc7-00079-g4cb4ded #108
> Call Trace:
>  [<ffffffff810415ff>] warn_slowpath_common+0x7f/0xc0
>  [<ffffffff8104165a>] warn_slowpath_null+0x1a/0x20
>  [<ffffffff813a0f01>] pnpacpi_build_resource_template+0x141/0x150
>  [<ffffffff81367444>] ? acpi_bus_get_device+0x2a/0x79
>  [<ffffffff813a033c>] pnpacpi_set_resources+0x6c/0xf0
>  [<ffffffff8139c4d0>] ? pnp_device_shutdown+0x30/0x30
>  [<ffffffff8139dd46>] pnp_start_dev+0x46/0x80
>  [<ffffffff8139c548>] pnp_bus_resume+0x78/0x80
>  [<ffffffff813ef0c8>] dpm_run_callback+0x58/0x90
>  [<ffffffff813efb26>] device_resume+0x126/0x210
>  [<ffffffff813f0991>] dpm_resume+0x131/0x260
>  [<ffffffff813f0cf5>] dpm_resume_end+0x15/0x30
>  [<ffffffff8136659e>] ? acpi_suspend_begin_old+0x2d/0x2d
>  [<ffffffff81098f75>] suspend_devices_and_enter+0xb5/0x4c0
>  [<ffffffff81099514>] pm_suspend+0x194/0x230
>  [<ffffffff81098067>] state_store+0x87/0xf0
>  [<ffffffff8131413f>] kobj_attr_store+0xf/0x20
>  [<ffffffff81209060>] sysfs_write_file+0xe0/0x150
>  [<ffffffff8119073f>] vfs_write+0xaf/0x190
>  [<ffffffff81190a95>] sys_write+0x55/0xa0
>  [<ffffffff815604c6>] system_call_fastpath+0x1a/0x1f
> ---[ end trace 7b4dd4e69080d90a ]---
> serial 00:0a: activation failed
> dpm_run_callback(): pnp_bus_resume+0x0/0x80 returns -5
> PM: Device 00:0a failed to resume: error -5
> ata4.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
> ata4.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
> ata4.00: configured for UDMA/33
> ata3: SATA link down (SStatus 0 SControl 300)
> ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
> ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
> ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out

So the WARN_ON_ONCE() added by the patch from comment #14 actually did trigger.

Well, we may need more checks like this in different places.
Comment 18 Zdenek Kabelac 2012-11-29 16:50:03 UTC
(In reply to comment #17)
> (In reply to comment #15)
> > So tested - and got nearly the same result - except once it has survived 4
> > suspends ;) and failed on the 5th.
> 
> Nearly the same with respect to what?
> 
> Did it crash on the 5th attempt to suspend?

The reported oops after 5th resume was the same as initial report from comment 1

And in the second test I've ended with black screen.


> > RBX has now different value: 6c623a370a2f3a61   - so the value 0x1000
> > before is just some garbage like this value.
> 
> Well, this is just a bad pointer. 
> 
> Can you attach that call trace, please?

Really the very same as first snapshot - but I'll attach it.
Comment 19 Zdenek Kabelac 2012-11-29 16:56:24 UTC
Created attachment 87801 [details]
Snapshot with for comment 14 patch

Snapshot with for comment 13 patch
Comment 20 Zdenek Kabelac 2012-11-29 16:56:51 UTC
Created attachment 87811 [details]
Snapshot2 with for comment 14 patch

Snapshot2 with for comment 13 patch
Comment 21 Rafael J. Wysocki 2012-11-29 19:34:45 UTC
Well, that means we have another bug in there that is not caught by the patch from comment #14.
Comment 22 Rafael J. Wysocki 2012-11-29 20:01:38 UTC
Created attachment 87831 [details]
PATCH: Check dev->data for ACPIPNP devices in pnpacpi_set_resources()

Let's try a different approach, then.  Since pnpacpi_set_resources() kind of validates the ACPI handle from dev->dev and finds the ACPI device node for it, which apparently succeeds, let's try to simply use that to update dev->data if necessary.
Comment 23 Zdenek Kabelac 2012-11-29 20:52:16 UTC
I think now you hit the nail on the head.


WARNING: at drivers/pnp/pnpacpi/core.c:98 pnpacpi_set_resources+0x131/0x140()
Hardware name: 6464CTO
Modules linked in: i915 i2c_algo_bit drm_kms_helper drm ip6_tables ebtable_nat ebtables ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack ipt_REJECT iptable_mangle xt_tcpudp iptable_filter ip_tables x_tables bridge stp llc ipv6 rfcomm bnep btusb bluetooth snd_hda_codec_analog arc4 iTCO_wdt iTCO_vendor_support iwl3945 iwlegacy mac80211 snd_hda_intel snd_hda_codec snd_seq coretemp snd_seq_device snd_pcm microcode i2c_i801 r852 psmouse sm_common cfg80211 i2c_core nand serio_raw e1000e nand_ecc lpc_ich r592 mfd_core nand_ids memstick mtd snd_page_alloc snd_timer wmi thinkpad_acpi nvram snd binfmt_misc soundcore evdev loop vhost_net tun kvm_intel kvm nfsd exportfs auth_rpcgss nfs_acl lockd sunrpc dm_mod pcmcia sr_mod cdrom sdhci_pci sdhci mmc_core yenta_socket ehci_hcd uhci_hcd usbcore usb_common video backlight autofs4
Pid: 1125, comm: pm-suspend Not tainted 3.7.0-rc7-00080-g19d21bf #109
Call Trace:
 [<ffffffff810415ff>] warn_slowpath_common+0x7f/0xc0
 [<ffffffff8104165a>] warn_slowpath_null+0x1a/0x20
 [<ffffffff813a0401>] pnpacpi_set_resources+0x131/0x140
 [<ffffffff8139c4d0>] ? pnp_device_shutdown+0x30/0x30
 [<ffffffff8139dd46>] pnp_start_dev+0x46/0x80
 [<ffffffff8139c548>] pnp_bus_resume+0x78/0x80
 [<ffffffff813ef118>] dpm_run_callback+0x58/0x90
 [<ffffffff813efb76>] device_resume+0x126/0x210
 [<ffffffff813f09e1>] dpm_resume+0x131/0x260
 [<ffffffff813f0d45>] dpm_resume_end+0x15/0x30
 [<ffffffff8136659e>] ? acpi_suspend_begin_old+0x2d/0x2d
 [<ffffffff81098f75>] suspend_devices_and_enter+0xb5/0x4c0
 [<ffffffff81099514>] pm_suspend+0x194/0x230
 [<ffffffff81098067>] state_store+0x87/0xf0
 [<ffffffff8131413f>] kobj_attr_store+0xf/0x20
 [<ffffffff81209060>] sysfs_write_file+0xe0/0x150
 [<ffffffff8119073f>] vfs_write+0xaf/0x190
 [<ffffffff81190a95>] sys_write+0x55/0xa0
 [<ffffffff81560506>] system_call_fastpath+0x1a/0x1f


Just for completeness I'll attach my patch I've tested - and even with over 20 suspend/resume cycles everything went just fine
Comment 24 Zdenek Kabelac 2012-11-29 20:53:37 UTC
Created attachment 87841 [details]
Tested patch file

Combines both suggested variants.
Comment 25 Rafael J. Wysocki 2012-11-29 20:59:38 UTC
Can you please test just this thing alone?  It should work by itself in theory:

diff --git a/drivers/pnp/pnpacpi/core.c b/drivers/pnp/pnpacpi/core.c
index 26b5d4b..ec8e914 100644
--- a/drivers/pnp/pnpacpi/core.c
+++ b/drivers/pnp/pnpacpi/core.c
@@ -95,6 +95,9 @@ static int pnpacpi_set_resources(struct pnp_dev *dev)
 		return -ENODEV;
 	}
 
+	if (WARN_ON_ONCE(acpi_dev != dev->data))
+		dev->data = acpi_dev;
+
 	ret = pnpacpi_build_resource_template(dev, &buffer);
 	if (ret)
 		return ret;
Comment 26 Zdenek Kabelac 2012-11-29 21:39:11 UTC
Yes, I can confirm the patch from comment 25 is enough to make the resume with T61 docking with legacy hw support enabled in BIOS usable.

And there is yet another thing I've not mentioned:

To actually get warning from comment 23 - one has to boot in docking station.
If the laptop is booted outside - it's basically not a problem.
So now I've realized that problem is only present, if the laptop is booted
in docking station and resumed there multiple times.
Comment 27 Rafael J. Wysocki 2012-11-29 21:50:16 UTC
Thanks for testing.  I'll submit that patch to the list as a workaround for the problem you have reported.
Comment 28 Rafael J. Wysocki 2012-11-29 23:12:36 UTC
Patch submitted as: https://patchwork.kernel.org/patch/1823231/
Comment 29 Florian Mickler 2012-12-22 09:27:03 UTC
A patch referencing this bug report has been merged in Linux v3.8-rc1:

commit a6b5e88c0e42093b9057856f35770966c8c591e3
Author: Rafael J. Wysocki <rafael.j.wysocki@intel.com>
Date:   Fri Nov 30 13:05:05 2012 +0100

    ACPI / PNP: Do not crash due to stale pointer use during system resume
Comment 30 Len Brown 2013-02-08 17:39:21 UTC
patch mentioned in comment #29 shipped in Linux-3.8
I guess from here we file a new bug against the
new warning we will see from pnpacpi_set_resources()

closed.

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