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.
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);
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
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);
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
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)
(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).
(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.
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
Well, this works because scope_info->common.descriptor_type is not initialized by acpi_ns_get_node(), as far as I can say.
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!
Seems like acpi_ns_validate_handle doesn't count with IS_ERR(handle).
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 ?
(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.
Created attachment 87791 [details] PATCH: Invalidate ACPI device's handle on unregistration Can you please try this one instead?
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
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.
(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.
(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.
Created attachment 87801 [details] Snapshot with for comment 14 patch Snapshot with for comment 13 patch
Created attachment 87811 [details] Snapshot2 with for comment 14 patch Snapshot2 with for comment 13 patch
Well, that means we have another bug in there that is not caught by the patch from comment #14.
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.
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
Created attachment 87841 [details] Tested patch file Combines both suggested variants.
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;
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.
Thanks for testing. I'll submit that patch to the list as a workaround for the problem you have reported.
Patch submitted as: https://patchwork.kernel.org/patch/1823231/
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
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.