public inbox for linux-kernel@vger.kernel.org
 help / color / mirror / Atom feed
* 4.5 Regression - mouse not working after resume from suspend
@ 2016-02-06  8:37 Chris Clayton
  2016-02-06 11:38 ` Chris Clayton
  0 siblings, 1 reply; 4+ messages in thread
From: Chris Clayton @ 2016-02-06  8:37 UTC (permalink / raw)
  To: LKML

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

There seems to be a regression in resuming my laptop from a suspend to RAM or disk. The symptom is that my bluetooth
mouse doesn't work after the resume. The kernel is built after a pull of Linus' tree this morning (v4.5-rc2-340-g5af9c2e).

Attached is the output from dmesg showing the boot, suspend (to RAM) and resume. You'll see that during the resume,
error -517 is being reported for some devices. Suspend/resume has worked perfectly with a 4.[234].x kernels.

I'll start a bisection, but thought I'd give a heads up in case someone can see the problem before I get done with the
bisect.

Chris

[-- Attachment #2: no-bt-mouse-after-s2r-4.5.0-rc2+.dmesg.txt --]
[-- Type: text/plain, Size: 54711 bytes --]

[    0.000000] Linux version 4.5.0-rc2+ (chris@laptop) (gcc version 5.3.1 20160202 (GCC) ) #318 SMP PREEMPT Sat Feb 6 06:38:55 GMT 2016
[    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-4.5.0-rc2+ ro root=/dev/sda2 resume=/dev/sda6 rootfstype=ext4 net.ifnames=0
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Supporting XSAVE feature 0x01: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x02: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x04: 'AVX registers'
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000] x86/fpu: Using 'eager' FPU context switches.
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009d7ff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009d800-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000d7216fff] usable
[    0.000000] BIOS-e820: [mem 0x00000000d7217000-0x00000000d721dfff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x00000000d721e000-0x00000000d7a0cfff] usable
[    0.000000] BIOS-e820: [mem 0x00000000d7a0d000-0x00000000d7ca1fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000d7ca2000-0x00000000db4dffff] usable
[    0.000000] BIOS-e820: [mem 0x00000000db4e0000-0x00000000db82dfff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000db82e000-0x00000000db88afff] usable
[    0.000000] BIOS-e820: [mem 0x00000000db88b000-0x00000000db9bcfff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x00000000db9bd000-0x00000000dbffefff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000dbfff000-0x00000000dbffffff] usable
[    0.000000] BIOS-e820: [mem 0x00000000dd000000-0x00000000df1fffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000f8000000-0x00000000fbffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed00000-0x00000000fed03fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000041fdfffff] usable
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.7 present.
[    0.000000] DMI: Notebook                         W65_67SZ                        /W65_67SZ                        , BIOS 1.03.05 02/26/2014
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] e820: last_pfn = 0x41fe00 max_arch_pfn = 0x400000000
[    0.000000] MTRR default type: uncachable
[    0.000000] MTRR fixed ranges enabled:
[    0.000000]   00000-9FFFF write-back
[    0.000000]   A0000-BFFFF uncachable
[    0.000000]   C0000-CFFFF write-protect
[    0.000000]   D0000-E7FFF uncachable
[    0.000000]   E8000-FFFFF write-protect
[    0.000000] MTRR variable ranges enabled:
[    0.000000]   0 base 0000000000 mask 7C00000000 write-back
[    0.000000]   1 base 0400000000 mask 7FE0000000 write-back
[    0.000000]   2 base 00E0000000 mask 7FE0000000 uncachable
[    0.000000]   3 base 00DE000000 mask 7FFE000000 uncachable
[    0.000000]   4 base 00DD000000 mask 7FFF000000 uncachable
[    0.000000]   5 base 041FE00000 mask 7FFFE00000 uncachable
[    0.000000]   6 disabled
[    0.000000]   7 disabled
[    0.000000]   8 disabled
[    0.000000]   9 disabled
[    0.000000] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- WT  
[    0.000000] e820: update [mem 0xdd000000-0xffffffff] usable ==> reserved
[    0.000000] e820: last_pfn = 0xdc000 max_arch_pfn = 0x400000000
[    0.000000] found SMP MP-table at [mem 0x000fd820-0x000fd82f] mapped at [ffff8800000fd820]
[    0.000000] Base memory trampoline at [ffff880000097000] 97000 size 24576
[    0.000000] Using GB pages for direct mapping
[    0.000000] BRK [0x01a05000, 0x01a05fff] PGTABLE
[    0.000000] BRK [0x01a06000, 0x01a06fff] PGTABLE
[    0.000000] BRK [0x01a07000, 0x01a07fff] PGTABLE
[    0.000000] BRK [0x01a08000, 0x01a08fff] PGTABLE
[    0.000000] BRK [0x01a09000, 0x01a09fff] PGTABLE
[    0.000000] BRK [0x01a0a000, 0x01a0afff] PGTABLE
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F0490 000024 (v02 ALASKA)
[    0.000000] ACPI: XSDT 0x00000000DB993088 00008C (v01 ALASKA A M I    01072009 AMI  00010013)
[    0.000000] ACPI: FACP 0x00000000DB99FEA8 00010C (v05 ALASKA A M I    01072009 AMI  00010013)
[    0.000000] ACPI: DSDT 0x00000000DB9931A8 00CCFA (v02 ALASKA A M I    00000024 INTL 20091112)
[    0.000000] ACPI: FACS 0x00000000DB9BB080 000040
[    0.000000] ACPI: APIC 0x00000000DB99FFB8 000092 (v03 ALASKA A M I    01072009 AMI  00010013)
[    0.000000] ACPI: FPDT 0x00000000DB9A0050 000044 (v01 ALASKA A M I    01072009 AMI  00010013)
[    0.000000] ACPI: ASF! 0x00000000DB9A0098 0000A5 (v32 INTEL   HCG     00000001 TFSM 000F4240)
[    0.000000] ACPI: SSDT 0x00000000DB9A0140 000F92 (v01 TrmRef PtidDevc 00001000 INTL 20091112)
[    0.000000] ACPI: SSDT 0x00000000DB9A10D8 000539 (v01 PmRef  Cpu0Ist  00003000 INTL 20051117)
[    0.000000] ACPI: SSDT 0x00000000DB9A1618 000AD8 (v01 PmRef  CpuPm    00003000 INTL 20051117)
[    0.000000] ACPI: MCFG 0x00000000DB9A20F0 00003C (v01 ALASKA A M I    01072009 MSFT 00000097)
[    0.000000] ACPI: HPET 0x00000000DB9A2130 000038 (v01 ALASKA A M I    01072009 AMI. 00000005)
[    0.000000] ACPI: SSDT 0x00000000DB9A2168 000315 (v01 SataRe SataTabl 00001000 INTL 20091112)
[    0.000000] ACPI: SSDT 0x00000000DB9A2480 001BFB (v01 SaSsdt SaSsdt   00003000 INTL 20091112)
[    0.000000] ACPI: SSDT 0x00000000DB9A4080 000EA8 (v01 SgRef  SgPeg    00001000 INTL 20091112)
[    0.000000] ACPI: DMAR 0x00000000DB9A4F28 000090 (v01 INTEL  HSW      00000001 INTL 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.000000]   Normal   [mem 0x0000000100000000-0x000000041fdfffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009cfff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x00000000d7216fff]
[    0.000000]   node   0: [mem 0x00000000d721e000-0x00000000d7a0cfff]
[    0.000000]   node   0: [mem 0x00000000d7ca2000-0x00000000db4dffff]
[    0.000000]   node   0: [mem 0x00000000db82e000-0x00000000db88afff]
[    0.000000]   node   0: [mem 0x00000000dbfff000-0x00000000dbffffff]
[    0.000000]   node   0: [mem 0x0000000100000000-0x000000041fdfffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000041fdfffff]
[    0.000000] On node 0 totalpages: 4173886
[    0.000000]   DMA zone: 64 pages used for memmap
[    0.000000]   DMA zone: 21 pages reserved
[    0.000000]   DMA zone: 3996 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 13963 pages used for memmap
[    0.000000]   DMA32 zone: 893602 pages, LIFO batch:31
[    0.000000]   Normal zone: 51192 pages used for memmap
[    0.000000]   Normal zone: 3276288 pages, LIFO batch:31
[    0.000000] Reserving Intel graphics stolen memory at 0xdd200000-0xdf1fffff
[    0.000000] ACPI: PM-Timer IO Port: 0x1808
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ACPI: IRQ0 used by override.
[    0.000000] ACPI: IRQ9 used by override.
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a701 base: 0xfed00000
[    0.000000] smpboot: Allowing 8 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.000000] PM: Registered nosave memory: [mem 0x0009d000-0x0009dfff]
[    0.000000] PM: Registered nosave memory: [mem 0x0009e000-0x0009ffff]
[    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000dffff]
[    0.000000] PM: Registered nosave memory: [mem 0x000e0000-0x000fffff]
[    0.000000] PM: Registered nosave memory: [mem 0xd7217000-0xd721dfff]
[    0.000000] PM: Registered nosave memory: [mem 0xd7a0d000-0xd7ca1fff]
[    0.000000] PM: Registered nosave memory: [mem 0xdb4e0000-0xdb82dfff]
[    0.000000] PM: Registered nosave memory: [mem 0xdb88b000-0xdb9bcfff]
[    0.000000] PM: Registered nosave memory: [mem 0xdb9bd000-0xdbffefff]
[    0.000000] PM: Registered nosave memory: [mem 0xdc000000-0xdcffffff]
[    0.000000] PM: Registered nosave memory: [mem 0xdd000000-0xdf1fffff]
[    0.000000] PM: Registered nosave memory: [mem 0xdf200000-0xf7ffffff]
[    0.000000] PM: Registered nosave memory: [mem 0xf8000000-0xfbffffff]
[    0.000000] PM: Registered nosave memory: [mem 0xfc000000-0xfebfffff]
[    0.000000] PM: Registered nosave memory: [mem 0xfec00000-0xfec00fff]
[    0.000000] PM: Registered nosave memory: [mem 0xfec01000-0xfecfffff]
[    0.000000] PM: Registered nosave memory: [mem 0xfed00000-0xfed03fff]
[    0.000000] PM: Registered nosave memory: [mem 0xfed04000-0xfed1bfff]
[    0.000000] PM: Registered nosave memory: [mem 0xfed1c000-0xfed1ffff]
[    0.000000] PM: Registered nosave memory: [mem 0xfed20000-0xfedfffff]
[    0.000000] PM: Registered nosave memory: [mem 0xfee00000-0xfee00fff]
[    0.000000] PM: Registered nosave memory: [mem 0xfee01000-0xfeffffff]
[    0.000000] PM: Registered nosave memory: [mem 0xff000000-0xffffffff]
[    0.000000] e820: [mem 0xdf200000-0xf7ffffff] available for PCI devices
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:8 nr_node_ids:1
[    0.000000] PERCPU: Embedded 30 pages/cpu @ffff88041fa00000 s85400 r8192 d29288 u262144
[    0.000000] pcpu-alloc: s85400 r8192 d29288 u262144 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 1 2 3 4 5 6 7 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 4108646
[    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.5.0-rc2+ ro root=/dev/sda2 resume=/dev/sda6 rootfstype=ext4 net.ifnames=0
[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[    0.000000] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes)
[    0.000000] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[    0.000000] Memory: 16331268K/16695544K available (6126K kernel code, 560K rwdata, 2188K rodata, 812K init, 520K bss, 364276K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] 	Build-time adjustment of leaf fanout to 64.
[    0.000000] NR_IRQS:4352 nr_irqs:488 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns
[    0.000000] hpet clockevent registered
[    0.000000] tsc: Fast TSC calibration using PIT
[    0.000000] tsc: Detected 2494.213 MHz processor
[    0.000018] Calibrating delay loop (skipped), value calculated using timer frequency.. 4988.42 BogoMIPS (lpj=9976852)
[    0.000119] pid_max: default: 32768 minimum: 301
[    0.000168] ACPI: Core revision 20160108
[    0.006337] ACPI: 7 ACPI AML tables successfully acquired and loaded

[    0.006480] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.006532] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.006736] CPU: Physical Processor ID: 0
[    0.006782] CPU: Processor Core ID: 0
[    0.006830] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
[    0.006880] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
[    0.006934] mce: CPU supports 9 MCE banks
[    0.006990] CPU0: Thermal monitoring enabled (TM1)
[    0.007045] process: using mwait in idle threads
[    0.007093] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024
[    0.007144] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4
[    0.007457] Freeing SMP alternatives memory: 24K (ffffffff8197b000 - ffffffff81981000)
[    0.018823] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.058558] TSC deadline timer enabled
[    0.058559] smpboot: CPU0: Intel(R) Core(TM) i7-4710MQ CPU @ 2.50GHz (family: 0x6, model: 0x3c, stepping: 0x3)
[    0.058728] Performance Events: PEBS fmt2+, 16-deep LBR, Haswell events, full-width counters, Intel PMU driver.
[    0.058959] ... version:                3
[    0.059006] ... bit width:              48
[    0.059053] ... generic registers:      4
[    0.059099] ... value mask:             0000ffffffffffff
[    0.059148] ... max period:             0000ffffffffffff
[    0.059196] ... fixed-purpose events:   3
[    0.059243] ... event mask:             000000070000000f
[    0.090621] x86: Booting SMP configuration:
[    0.090669] .... node  #0, CPUs:      #1 #2 #3 #4 #5 #6 #7
[    0.165148] x86: Booted up 1 node, 8 CPUs
[    0.165241] smpboot: Total of 8 processors activated (39907.40 BogoMIPS)
[    0.170167] devtmpfs: initialized
[    0.170325] PM: Registering ACPI NVS region [mem 0xd7217000-0xd721dfff] (28672 bytes)
[    0.170379] PM: Registering ACPI NVS region [mem 0xdb88b000-0xdb9bcfff] (1253376 bytes)
[    0.170488] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.170645] NET: Registered protocol family 16
[    0.182109] cpuidle: using governor ladder
[    0.194113] cpuidle: using governor menu
[    0.194218] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
[    0.194274] ACPI: bus type PCI registered
[    0.194323] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.194407] PCI: Using configuration type 1 for base access
[    0.194621] perf_event_intel: PMU erratum BJ122, BV98, HSD29 worked around, HT is on
[    0.210276] ACPI: Added _OSI(Module Device)
[    0.210326] ACPI: Added _OSI(Processor Device)
[    0.210376] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.210426] ACPI: Added _OSI(Processor Aggregator Device)
[    0.211865] ACPI: Executed 1 blocks of module-level executable AML code
[    0.213371] [Firmware Bug]: ACPI: BIOS _OSI(Linux) query ignored
[    0.213723] ACPI: Dynamic OEM Table Load:
[    0.213832] ACPI: SSDT 0xFFFF88040DAAB400 0003D3 (v01 PmRef  Cpu0Cst  00003001 INTL 20051117)
[    0.214349] ACPI: Dynamic OEM Table Load:
[    0.214459] ACPI: SSDT 0xFFFF88040DB32000 0005AA (v01 PmRef  ApIst    00003000 INTL 20051117)
[    0.214990] ACPI: Dynamic OEM Table Load:
[    0.215098] ACPI: SSDT 0xFFFF88040DB23000 000119 (v01 PmRef  ApCst    00003000 INTL 20051117)
[    0.216919] ACPI : EC: EC started
[    0.217181] ACPI: Interpreter enabled
[    0.217244] ACPI: (supports S0 S3 S4 S5)
[    0.217290] ACPI: Using IOAPIC for interrupt routing
[    0.217354] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.221940] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-3e])
[    0.221993] acpi PNP0A08:00: _OSC: OS supports [ASPM ClockPM Segments]
[    0.222123] acpi PNP0A08:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
[    0.222375] PCI host bridge to bus 0000:00
[    0.222423] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.222474] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.222526] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.222579] pci_bus 0000:00: root bus resource [mem 0x000d0000-0x000d3fff window]
[    0.222632] pci_bus 0000:00: root bus resource [mem 0x000d4000-0x000d7fff window]
[    0.222684] pci_bus 0000:00: root bus resource [mem 0x000d8000-0x000dbfff window]
[    0.222737] pci_bus 0000:00: root bus resource [mem 0x000dc000-0x000dffff window]
[    0.222790] pci_bus 0000:00: root bus resource [mem 0x000e0000-0x000e3fff window]
[    0.222843] pci_bus 0000:00: root bus resource [mem 0x000e4000-0x000e7fff window]
[    0.222896] pci_bus 0000:00: root bus resource [mem 0xdf200000-0xfeafffff window]
[    0.222949] pci_bus 0000:00: root bus resource [bus 00-3e]
[    0.223002] pci 0000:00:00.0: [8086:0c04] type 00 class 0x060000
[    0.223055] pci 0000:00:01.0: [8086:0c01] type 01 class 0x060400
[    0.223077] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold
[    0.223126] pci 0000:00:01.0: System wakeup disabled by ACPI
[    0.223199] pci 0000:00:02.0: [8086:0416] type 00 class 0x030000
[    0.223206] pci 0000:00:02.0: reg 0x10: [mem 0xf7800000-0xf7bfffff 64bit]
[    0.223210] pci 0000:00:02.0: reg 0x18: [mem 0xe0000000-0xefffffff 64bit pref]
[    0.223213] pci 0000:00:02.0: reg 0x20: [io  0xf000-0xf03f]
[    0.223262] pci 0000:00:03.0: [8086:0c0c] type 00 class 0x040300
[    0.223267] pci 0000:00:03.0: reg 0x10: [mem 0xf7f14000-0xf7f17fff 64bit]
[    0.223338] pci 0000:00:14.0: [8086:8c31] type 00 class 0x0c0330
[    0.223352] pci 0000:00:14.0: reg 0x10: [mem 0xf7f00000-0xf7f0ffff 64bit]
[    0.223402] pci 0000:00:14.0: PME# supported from D3hot D3cold
[    0.223424] pci 0000:00:14.0: System wakeup disabled by ACPI
[    0.223494] pci 0000:00:16.0: [8086:8c3a] type 00 class 0x078000
[    0.223509] pci 0000:00:16.0: reg 0x10: [mem 0xf7f1e000-0xf7f1e00f 64bit]
[    0.223561] pci 0000:00:16.0: PME# supported from D0 D3hot D3cold
[    0.223610] pci 0000:00:1a.0: [8086:8c2d] type 00 class 0x0c0320
[    0.223624] pci 0000:00:1a.0: reg 0x10: [mem 0xf7f1c000-0xf7f1c3ff]
[    0.223696] pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold
[    0.223728] pci 0000:00:1a.0: System wakeup disabled by ACPI
[    0.223800] pci 0000:00:1b.0: [8086:8c20] type 00 class 0x040300
[    0.223811] pci 0000:00:1b.0: reg 0x10: [mem 0xf7f10000-0xf7f13fff 64bit]
[    0.223863] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[    0.223886] pci 0000:00:1b.0: System wakeup disabled by ACPI
[    0.223956] pci 0000:00:1c.0: [8086:8c10] type 01 class 0x060400
[    0.224004] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[    0.224046] pci 0000:00:1c.0: System wakeup disabled by ACPI
[    0.224116] pci 0000:00:1c.1: [8086:8c12] type 01 class 0x060400
[    0.224165] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[    0.224204] pci 0000:00:1c.1: System wakeup disabled by ACPI
[    0.224274] pci 0000:00:1c.2: [8086:8c14] type 01 class 0x060400
[    0.224323] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold
[    0.224362] pci 0000:00:1c.2: System wakeup disabled by ACPI
[    0.224432] pci 0000:00:1c.3: [8086:8c16] type 01 class 0x060400
[    0.224481] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
[    0.224520] pci 0000:00:1c.3: System wakeup disabled by ACPI
[    0.224595] pci 0000:00:1d.0: [8086:8c26] type 00 class 0x0c0320
[    0.224609] pci 0000:00:1d.0: reg 0x10: [mem 0xf7f1b000-0xf7f1b3ff]
[    0.224680] pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold
[    0.224711] pci 0000:00:1d.0: System wakeup disabled by ACPI
[    0.224784] pci 0000:00:1f.0: [8086:8c49] type 00 class 0x060100
[    0.224910] pci 0000:00:1f.2: [8086:8c03] type 00 class 0x010601
[    0.224920] pci 0000:00:1f.2: reg 0x10: [io  0xf0b0-0xf0b7]
[    0.224926] pci 0000:00:1f.2: reg 0x14: [io  0xf0a0-0xf0a3]
[    0.224931] pci 0000:00:1f.2: reg 0x18: [io  0xf090-0xf097]
[    0.224937] pci 0000:00:1f.2: reg 0x1c: [io  0xf080-0xf083]
[    0.224942] pci 0000:00:1f.2: reg 0x20: [io  0xf060-0xf07f]
[    0.224948] pci 0000:00:1f.2: reg 0x24: [mem 0xf7f1a000-0xf7f1a7ff]
[    0.224976] pci 0000:00:1f.2: PME# supported from D3hot
[    0.225016] pci 0000:00:1f.3: [8086:8c22] type 00 class 0x0c0500
[    0.225027] pci 0000:00:1f.3: reg 0x10: [mem 0xf7f19000-0xf7f190ff 64bit]
[    0.225043] pci 0000:00:1f.3: reg 0x20: [io  0xf040-0xf05f]
[    0.225113] pci 0000:00:01.0: PCI bridge to [bus 01]
[    0.225201] acpiphp: Slot [1] registered
[    0.225249] pci 0000:00:1c.0: PCI bridge to [bus 02]
[    0.225350] pci 0000:03:00.0: [10ec:5229] type 00 class 0xff0000
[    0.225364] pci 0000:03:00.0: reg 0x10: [mem 0xf7e00000-0xf7e00fff]
[    0.225476] pci 0000:03:00.0: supports D1 D2
[    0.225477] pci 0000:03:00.0: PME# supported from D1 D2 D3hot
[    0.225492] pci 0000:03:00.0: System wakeup disabled by ACPI
[    0.230207] pci 0000:00:1c.1: PCI bridge to [bus 03]
[    0.230262] pci 0000:00:1c.1:   bridge window [mem 0xf7e00000-0xf7efffff]
[    0.230330] pci 0000:04:00.0: [8086:08b1] type 00 class 0x028000
[    0.230361] pci 0000:04:00.0: reg 0x10: [mem 0xf7d00000-0xf7d01fff 64bit]
[    0.230519] pci 0000:04:00.0: PME# supported from D0 D3hot D3cold
[    0.230542] pci 0000:04:00.0: System wakeup disabled by ACPI
[    0.238212] pci 0000:00:1c.2: PCI bridge to [bus 04]
[    0.238266] pci 0000:00:1c.2:   bridge window [mem 0xf7d00000-0xf7dfffff]
[    0.238326] pci 0000:05:00.0: [10ec:5289] type 00 class 0xff0000
[    0.238341] pci 0000:05:00.0: reg 0x10: [mem 0xf7c00000-0xf7c0ffff]
[    0.238463] pci 0000:05:00.0: supports D1 D2
[    0.238464] pci 0000:05:00.0: PME# supported from D1 D2 D3hot D3cold
[    0.238484] pci 0000:05:00.0: System wakeup disabled by ACPI
[    0.238571] pci 0000:05:00.2: [10ec:8168] type 00 class 0x020000
[    0.238586] pci 0000:05:00.2: reg 0x10: [io  0xe000-0xe0ff]
[    0.238613] pci 0000:05:00.2: reg 0x18: [mem 0xf0004000-0xf0004fff 64bit pref]
[    0.238630] pci 0000:05:00.2: reg 0x20: [mem 0xf0000000-0xf0003fff 64bit pref]
[    0.238701] pci 0000:05:00.2: supports D1 D2
[    0.238702] pci 0000:05:00.2: PME# supported from D0 D1 D2 D3hot D3cold
[    0.238722] pci 0000:05:00.2: System wakeup disabled by ACPI
[    0.246214] pci 0000:00:1c.3: PCI bridge to [bus 05]
[    0.246266] pci 0000:00:1c.3:   bridge window [io  0xe000-0xefff]
[    0.246269] pci 0000:00:1c.3:   bridge window [mem 0xf7c00000-0xf7cfffff]
[    0.246273] pci 0000:00:1c.3:   bridge window [mem 0xf0000000-0xf00fffff 64bit pref]
[    0.246293] pci_bus 0000:00: on NUMA node 0
[    0.246821] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 10 *11 12 14 15)
[    0.247249] ACPI: PCI Interrupt Link [LNKB] (IRQs *3 4 5 6 10 11 12 14 15)
[    0.247675] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 *4 5 6 10 11 12 14 15)
[    0.248097] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 *10 11 12 14 15)
[    0.248506] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
[    0.248985] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
[    0.249454] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 *5 6 10 11 12 14 15)
[    0.249861] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 10 *11 12 14 15)
[    0.250396] ACPI: Enabled 4 GPEs in block 00 to 3F
[    0.250525] ACPI : EC: GPE = 0x17, I/O: command/status = 0x66, data = 0x62
[    0.250612] vgaarb: setting as boot device: PCI:0000:00:02.0
[    0.250662] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    0.250716] vgaarb: loaded
[    0.250761] vgaarb: bridge control possible 0000:00:02.0
[    0.250838] SCSI subsystem initialized
[    0.250888] libata version 3.00 loaded.
[    0.250891] ACPI: bus type USB registered
[    0.250947] usbcore: registered new interface driver usbfs
[    0.251000] usbcore: registered new interface driver hub
[    0.251060] usbcore: registered new device driver usb
[    0.251119] Linux video capture interface: v2.00
[    0.251198] Advanced Linux Sound Architecture Driver Initialized.
[    0.251250] PCI: Using ACPI for IRQ routing
[    0.251298] PCI: pci_cache_line_size set to 64 bytes
[    0.251345] e820: reserve RAM buffer [mem 0x0009d800-0x0009ffff]
[    0.251345] e820: reserve RAM buffer [mem 0xd7217000-0xd7ffffff]
[    0.251346] e820: reserve RAM buffer [mem 0xd7a0d000-0xd7ffffff]
[    0.251347] e820: reserve RAM buffer [mem 0xdb4e0000-0xdbffffff]
[    0.251347] e820: reserve RAM buffer [mem 0xdb88b000-0xdbffffff]
[    0.251348] e820: reserve RAM buffer [mem 0x41fe00000-0x41fffffff]
[    0.251409] Bluetooth: Core ver 2.21
[    0.251457] NET: Registered protocol family 31
[    0.251504] Bluetooth: HCI device and connection manager initialized
[    0.251555] Bluetooth: HCI socket layer initialized
[    0.251604] Bluetooth: L2CAP socket layer initialized
[    0.251654] Bluetooth: SCO socket layer initialized
[    0.251766] clocksource: Switched to clocksource hpet
[    0.251899] pnp: PnP ACPI init
[    0.251989] system 00:00: [mem 0xfed40000-0xfed44fff] has been reserved
[    0.252043] system 00:00: Plug and Play ACPI device, IDs PNP0c01 (active)
[    0.252229] system 00:01: [io  0x0680-0x069f] has been reserved
[    0.252281] system 00:01: [io  0xffff] has been reserved
[    0.252332] system 00:01: [io  0xffff] has been reserved
[    0.252383] system 00:01: [io  0xffff] has been reserved
[    0.252434] system 00:01: [io  0x1c00-0x1cfe] has been reserved
[    0.252486] system 00:01: [io  0x1d00-0x1dfe] has been reserved
[    0.252537] system 00:01: [io  0x1e00-0x1efe] has been reserved
[    0.252589] system 00:01: [io  0x1f00-0x1ffe] has been reserved
[    0.252641] system 00:01: [io  0x1800-0x18fe] could not be reserved
[    0.252701] system 00:01: [io  0x164e-0x164f] has been reserved
[    0.252751] system 00:01: [io  0x3322-0x3323] has been reserved
[    0.252802] system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.252814] pnp 00:02: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.252838] system 00:03: [io  0x1854-0x1857] has been reserved
[    0.252889] system 00:03: Plug and Play ACPI device, IDs INT3f0d PNP0c02 (active)
[    0.252903] pnp 00:04: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.252946] pnp 00:05: Plug and Play ACPI device, IDs SYN1212 PNP0f13 (active)
[    0.252971] system 00:06: [io  0x04d0-0x04d1] has been reserved
[    0.253022] system 00:06: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.253197] system 00:07: [mem 0xfed1c000-0xfed1ffff] has been reserved
[    0.253249] system 00:07: [mem 0xfed10000-0xfed17fff] has been reserved
[    0.253301] system 00:07: [mem 0xfed18000-0xfed18fff] has been reserved
[    0.253352] system 00:07: [mem 0xfed19000-0xfed19fff] has been reserved
[    0.253403] system 00:07: [mem 0xf8000000-0xfbffffff] has been reserved
[    0.253455] system 00:07: [mem 0xfed20000-0xfed3ffff] has been reserved
[    0.253506] system 00:07: [mem 0xfed90000-0xfed93fff] has been reserved
[    0.253558] system 00:07: [mem 0xfed45000-0xfed8ffff] has been reserved
[    0.253609] system 00:07: [mem 0xff000000-0xffffffff] has been reserved
[    0.253661] system 00:07: [mem 0xfee00000-0xfeefffff] could not be reserved
[    0.253713] system 00:07: [mem 0xf7ffe000-0xf7ffefff] has been reserved
[    0.253764] system 00:07: [mem 0xf7fe0000-0xf7fe0fff] has been reserved
[    0.253816] system 00:07: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.253930] pnp: PnP ACPI: found 8 devices
[    0.259309] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.259402] pci 0000:00:01.0: PCI bridge to [bus 01]
[    0.259454] pci 0000:00:1c.0: PCI bridge to [bus 02]
[    0.259510] pci 0000:00:1c.1: PCI bridge to [bus 03]
[    0.259561] pci 0000:00:1c.1:   bridge window [mem 0xf7e00000-0xf7efffff]
[    0.259617] pci 0000:00:1c.2: PCI bridge to [bus 04]
[    0.259668] pci 0000:00:1c.2:   bridge window [mem 0xf7d00000-0xf7dfffff]
[    0.259724] pci 0000:00:1c.3: PCI bridge to [bus 05]
[    0.259777] pci 0000:00:1c.3:   bridge window [io  0xe000-0xefff]
[    0.259829] pci 0000:00:1c.3:   bridge window [mem 0xf7c00000-0xf7cfffff]
[    0.259883] pci 0000:00:1c.3:   bridge window [mem 0xf0000000-0xf00fffff 64bit pref]
[    0.259940] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.259941] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.259941] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.259942] pci_bus 0000:00: resource 7 [mem 0x000d0000-0x000d3fff window]
[    0.259943] pci_bus 0000:00: resource 8 [mem 0x000d4000-0x000d7fff window]
[    0.259944] pci_bus 0000:00: resource 9 [mem 0x000d8000-0x000dbfff window]
[    0.259944] pci_bus 0000:00: resource 10 [mem 0x000dc000-0x000dffff window]
[    0.259945] pci_bus 0000:00: resource 11 [mem 0x000e0000-0x000e3fff window]
[    0.259946] pci_bus 0000:00: resource 12 [mem 0x000e4000-0x000e7fff window]
[    0.259947] pci_bus 0000:00: resource 13 [mem 0xdf200000-0xfeafffff window]
[    0.259948] pci_bus 0000:03: resource 1 [mem 0xf7e00000-0xf7efffff]
[    0.259948] pci_bus 0000:04: resource 1 [mem 0xf7d00000-0xf7dfffff]
[    0.259949] pci_bus 0000:05: resource 0 [io  0xe000-0xefff]
[    0.259950] pci_bus 0000:05: resource 1 [mem 0xf7c00000-0xf7cfffff]
[    0.259951] pci_bus 0000:05: resource 2 [mem 0xf0000000-0xf00fffff 64bit pref]
[    0.259967] NET: Registered protocol family 2
[    0.260092] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.260245] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[    0.260380] TCP: Hash tables configured (established 131072 bind 65536)
[    0.260441] UDP hash table entries: 8192 (order: 6, 262144 bytes)
[    0.260515] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes)
[    0.260611] NET: Registered protocol family 1
[    0.260666] pci 0000:00:02.0: Video device with shadowed ROM
[    0.260742] PCI: CLS 64 bytes, default 64
[    0.260768] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    0.260820] software IO TLB [mem 0xd3217000-0xd7217000] (64MB) mapped at [ffff8800d3217000-ffff8800d7216fff]
[    0.260924] RAPL PMU detected, API unit is 2^-32 Joules, 4 fixed counters 655360 ms ovfl timer
[    0.260990] hw unit of domain pp0-core 2^-14 Joules
[    0.261038] hw unit of domain package 2^-14 Joules
[    0.261086] hw unit of domain dram 2^-14 Joules
[    0.261134] hw unit of domain pp1-gpu 2^-14 Joules
[    0.261341] futex hash table entries: 2048 (order: 5, 131072 bytes)
[    0.262735] fuse init (API version 7.24)
[    0.263505] io scheduler noop registered
[    0.263580] io scheduler cfq registered (default)
[    0.264030] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[    0.264085] intel_idle: MWAIT substates: 0x42120
[    0.264086] intel_idle: v0.4 model 0x3C
[    0.264087] intel_idle: lapic_timer_reliable_states 0xffffffff
[    0.264330] ACPI: Deprecated procfs I/F for AC is loaded, please retry with CONFIG_ACPI_PROCFS_POWER cleared
[    0.264433] ACPI: AC Adapter [AC] (on-line)
[    0.264537] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
[    0.264597] ACPI: Power Button [PWRB]
[    0.264677] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1
[    0.264736] ACPI: Sleep Button [SLPB]
[    0.264818] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input2
[    0.264897] ACPI: Lid Switch [LID0]
[    0.264978] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
[    0.265044] ACPI: Power Button [PWRF]
[    0.265341] thermal LNXTHERM:00: registered as thermal_zone0
[    0.265392] ACPI: Thermal Zone [TZ0] (14 C)
[    0.265799] ACPI: Deprecated procfs I/F for battery is loaded, please retry with CONFIG_ACPI_PROCFS_POWER cleared
[    0.265890] ACPI: Battery Slot [BAT0] (battery present)
[    0.269301] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    0.269536] Linux agpgart interface v0.103
[    0.269602] [drm] Initialized drm 1.1.0 20060810
[    0.269933] pmd_set_huge: Cannot satisfy [mem 0xf7800000-0xf7a00000] with a huge-page mapping due to MTRR override.
[    0.270086] [drm] Memory usable by graphics device = 2048M
[    0.270137] [drm] Replacing VGA console driver
[    0.270696] Console: switching to colour dummy device 80x25
[    0.277061] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    0.277064] [drm] Driver supports precise vblank timestamp query.
[    0.277240] vgaarb: device changed decodes: PCI:0000:00:02.0,olddecodes=io+mem,decodes=io+mem:owns=io+mem
[    0.322414] ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
[    0.322674] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:01/input/input4
[    0.322695] [drm] Initialized i915 1.6.0 20151218 for 0000:00:02.0 on minor 0
[    0.323292] rtsx_pci 0000:03:00.0: rtsx_pci_acquire_irq: pcr->msi_en = 0, pci->irq = 17
[    0.323794] rtsx_pci 0000:05:00.0: rtsx_pci_acquire_irq: pcr->msi_en = 0, pci->irq = 16
[    0.324270] ahci 0000:00:1f.2: version 3.0
[    0.324293] ahci 0000:00:1f.2: SSS flag set, parallel bus scan disabled
[    0.324315] ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 4 ports 6 Gbps 0x25 impl SATA mode
[    0.324318] ahci 0000:00:1f.2: flags: 64bit ncq stag led clo pio slum part ems sxs apst 
[    0.340237] scsi host0: ahci
[    0.340520] scsi host1: ahci
[    0.340749] scsi host2: ahci
[    0.340863] scsi host3: ahci
[    0.340951] scsi host4: ahci
[    0.341052] scsi host5: ahci
[    0.341092] ata1: SATA max UDMA/133 abar m2048@0xf7f1a000 port 0xf7f1a100 irq 19
[    0.341095] ata2: DUMMY
[    0.341098] ata3: SATA max UDMA/133 abar m2048@0xf7f1a000 port 0xf7f1a200 irq 19
[    0.341100] ata4: DUMMY
[    0.341102] ata5: DUMMY
[    0.341104] ata6: SATA max UDMA/133 abar m2048@0xf7f1a000 port 0xf7f1a380 irq 19
[    0.341129] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.341141] ehci-pci: EHCI PCI platform driver
[    0.341228] ehci-pci 0000:00:1a.0: EHCI Host Controller
[    0.341235] ehci-pci 0000:00:1a.0: new USB bus registered, assigned bus number 1
[    0.341249] ehci-pci 0000:00:1a.0: debug port 2
[    0.345138] ehci-pci 0000:00:1a.0: cache line size of 64 is not supported
[    0.345141] ehci-pci 0000:00:1a.0: irq 16, io mem 0xf7f1c000
[    0.355792] ehci-pci 0000:00:1a.0: USB 2.0 started, EHCI 1.00
[    0.355820] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    0.355823] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.355826] usb usb1: Product: EHCI Host Controller
[    0.355828] usb usb1: Manufacturer: Linux 4.5.0-rc2+ ehci_hcd
[    0.355831] usb usb1: SerialNumber: 0000:00:1a.0
[    0.355919] hub 1-0:1.0: USB hub found
[    0.355924] hub 1-0:1.0: 2 ports detected
[    0.356086] ehci-pci 0000:00:1d.0: EHCI Host Controller
[    0.356092] ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 2
[    0.356102] ehci-pci 0000:00:1d.0: debug port 2
[    0.360001] ehci-pci 0000:00:1d.0: cache line size of 64 is not supported
[    0.360007] ehci-pci 0000:00:1d.0: irq 23, io mem 0xf7f1b000
[    0.371796] ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00
[    0.371819] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002
[    0.371822] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.371825] usb usb2: Product: EHCI Host Controller
[    0.371828] usb usb2: Manufacturer: Linux 4.5.0-rc2+ ehci_hcd
[    0.371830] usb usb2: SerialNumber: 0000:00:1d.0
[    0.371948] hub 2-0:1.0: USB hub found
[    0.371954] hub 2-0:1.0: 2 ports detected
[    0.372037] uhci_hcd: USB Universal Host Controller Interface driver
[    0.372121] xhci_hcd 0000:00:14.0: xHCI Host Controller
[    0.372127] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 3
[    0.373196] xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x00009810
[    0.373201] xhci_hcd 0000:00:14.0: cache line size of 64 is not supported
[    0.373227] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002
[    0.373230] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.373232] usb usb3: Product: xHCI Host Controller
[    0.373234] usb usb3: Manufacturer: Linux 4.5.0-rc2+ xhci-hcd
[    0.373236] usb usb3: SerialNumber: 0000:00:14.0
[    0.373330] hub 3-0:1.0: USB hub found
[    0.373346] hub 3-0:1.0: 14 ports detected
[    0.374778] xhci_hcd 0000:00:14.0: xHCI Host Controller
[    0.374782] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 4
[    0.374804] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003
[    0.374806] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.374808] usb usb4: Product: xHCI Host Controller
[    0.374810] usb usb4: Manufacturer: Linux 4.5.0-rc2+ xhci-hcd
[    0.374812] usb usb4: SerialNumber: 0000:00:14.0
[    0.374894] hub 4-0:1.0: USB hub found
[    0.374903] hub 4-0:1.0: 4 ports detected
[    0.375321] usbcore: registered new interface driver usb-storage
[    0.375328] usbcore: registered new interface driver ums-realtek
[    0.375347] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:SYNM] at 0x60,0x64 irq 1,12
[    0.378999] i8042: Detected active multiplexing controller, rev 1.1
[    0.380669] serio: i8042 KBD port at 0x60,0x64 irq 1
[    0.380687] serio: i8042 AUX0 port at 0x60,0x64 irq 12
[    0.380701] serio: i8042 AUX1 port at 0x60,0x64 irq 12
[    0.380713] serio: i8042 AUX2 port at 0x60,0x64 irq 12
[    0.380727] serio: i8042 AUX3 port at 0x60,0x64 irq 12
[    0.380833] mousedev: PS/2 mouse device common for all mice
[    0.381041] rtc_cmos 00:02: RTC can wake from S4
[    0.381140] rtc_cmos 00:02: rtc core: registered rtc_cmos as rtc0
[    0.381160] rtc_cmos 00:02: alarms up to one month, y3k, 242 bytes nvram, hpet irqs
[    0.381166] i2c /dev entries driver
[    0.381313] ACPI Warning: SystemIO range 0x000000000000F040-0x000000000000F05F conflicts with OpRegion 0x000000000000F040-0x000000000000F04F (\_SB.PCI0.SBUS.SMBI) (20160108/utaddress-255)
[    0.381321] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[    0.381372] usbcore: registered new interface driver uvcvideo
[    0.381374] USB Video Class driver (1.1.1)
[    0.383771] usbcore: registered new interface driver usbhid
[    0.383773] usbhid: USB HID core driver
[    0.383881] ip_tables: (C) 2000-2006 Netfilter Core Team
[    0.383886] NET: Registered protocol family 17
[    0.383894] NET: Registered protocol family 15
[    0.384022] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input5
[    0.384091] microcode: CPU0 sig=0x306c3, pf=0x10, revision=0x17
[    0.384099] microcode: CPU1 sig=0x306c3, pf=0x10, revision=0x17
[    0.384113] microcode: CPU2 sig=0x306c3, pf=0x10, revision=0x17
[    0.384141] microcode: CPU3 sig=0x306c3, pf=0x10, revision=0x17
[    0.384319] microcode: CPU4 sig=0x306c3, pf=0x10, revision=0x17
[    0.384323] microcode: CPU5 sig=0x306c3, pf=0x10, revision=0x17
[    0.384346] microcode: CPU6 sig=0x306c3, pf=0x10, revision=0x17
[    0.384384] microcode: CPU7 sig=0x306c3, pf=0x10, revision=0x17
[    0.384444] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[    0.384592] registered taskstats version 1
[    0.385076] rtc_cmos 00:02: setting system clock to 2016-02-06 08:17:21 UTC (1454746641)
[    0.460339] fbcon: inteldrmfb (fb0) is primary device
[    0.650543] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[    0.652114] ata1.00: ATAPI: MATSHITABD-MLT UJ260AF, 1.00, max UDMA/133
[    0.653506] ata1.00: configured for UDMA/133
[    0.671809] usb 1-1: new high-speed USB device number 2 using ehci-pci
[    0.683818] usb 3-7: new full-speed USB device number 2 using xhci_hcd
[    0.683826] usb 2-1: new high-speed USB device number 2 using ehci-pci
[    0.804268] usb 1-1: New USB device found, idVendor=8087, idProduct=8008
[    0.804270] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    0.804672] hub 1-1:1.0: USB hub found
[    0.804887] hub 1-1:1.0: 6 ports detected
[    0.812875] usb 3-7: New USB device found, idVendor=8087, idProduct=07dc
[    0.812876] usb 3-7: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    0.816221] usb 2-1: New USB device found, idVendor=8087, idProduct=8000
[    0.816222] usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    0.816488] hub 2-1:1.0: USB hub found
[    0.816585] hub 2-1:1.0: 8 ports detected
[    0.979839] usb 3-8: new high-speed USB device number 3 using xhci_hcd
[    1.178058] usb 3-8: New USB device found, idVendor=04f2, idProduct=b43b
[    1.178059] usb 3-8: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[    1.178060] usb 3-8: Product: Chicony USB 2.0 Camera
[    1.178061] usb 3-8: Manufacturer: Chicony Electronics Co.,Ltd.
[    1.178061] usb 3-8: SerialNumber: 0x0001
[    1.182558] uvcvideo: Found UVC 1.00 device Chicony USB 2.0 Camera (04f2:b43b)
[    1.259839] tsc: Refined TSC clocksource calibration: 2494.224 MHz
[    1.259841] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x23f3e9a353a, max_idle_ns: 440795330815 ns
[    1.882271] Console: switching to colour frame buffer device 200x56
[    1.884502] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
[    1.897343] scsi 0:0:0:0: CD-ROM            MATSHITA BD-MLT UJ260AF   1.00 PQ: 0 ANSI: 5
[    1.914294] sr 0:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
[    1.914319] cdrom: Uniform CD-ROM driver Revision: 3.20
[    1.914483] sr 0:0:0:0: Attached scsi CD-ROM sr0
[    1.914544] sr 0:0:0:0: Attached scsi generic sg0 type 5
[    2.227237] ata3: SATA link down (SStatus 0 SControl 300)
[    2.259956] clocksource: Switched to clocksource tsc
[    2.539200] ata6: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    2.541254] ata6.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
[    2.541257] ata6.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
[    2.541912] ata6.00: ACPI cmd b1/c1:00:00:00:00:00 (DEVICE CONFIGURATION OVERLAY) filtered out
[    2.543858] ata6.00: ATA-8: HGST HTS541010A9E680, JA0OA560, max UDMA/133
[    2.544517] ata6.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[    2.546693] ata6.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
[    2.546696] ata6.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
[    2.547364] ata6.00: ACPI cmd b1/c1:00:00:00:00:00 (DEVICE CONFIGURATION OVERLAY) filtered out
[    2.549415] ata6.00: configured for UDMA/133
[    2.550244] scsi 5:0:0:0: Direct-Access     ATA      HGST HTS541010A9 A560 PQ: 0 ANSI: 5
[    2.572011] sd 5:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB)
[    2.572012] sd 5:0:0:0: Attached scsi generic sg1 type 0
[    2.573289] sd 5:0:0:0: [sda] 4096-byte physical blocks
[    2.574008] sd 5:0:0:0: [sda] Write Protect is off
[    2.574542] sd 5:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    2.574611] sd 5:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    2.681494]  sda: sda1 sda2 sda3 sda4 < sda5 sda6 sda7 sda8 sda9 sda10 sda11 >
[    2.683034] sd 5:0:0:0: [sda] Attached SCSI disk
[    2.703325] ALSA device list:
[    2.703948]   No soundcards found.
[    2.740929] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null)
[    2.741679] VFS: Mounted root (ext4 filesystem) readonly on device 8:2.
[    2.766294] devtmpfs: mounted
[    2.767157] Freeing unused kernel memory: 812K (ffffffff818b0000 - ffffffff8197b000)
[    3.996787] microcode: CPU0 sig=0x306c3, pf=0x10, revision=0x17
[    3.998922] microcode: CPU0 updated to revision 0x1e, date = 2015-08-13
[    3.999656] microcode: CPU1 sig=0x306c3, pf=0x10, revision=0x17
[    4.001062] microcode: CPU1 updated to revision 0x1e, date = 2015-08-13
[    4.001749] microcode: CPU2 sig=0x306c3, pf=0x10, revision=0x17
[    4.003108] microcode: CPU2 updated to revision 0x1e, date = 2015-08-13
[    4.003792] microcode: CPU3 sig=0x306c3, pf=0x10, revision=0x17
[    4.005175] microcode: CPU3 updated to revision 0x1e, date = 2015-08-13
[    4.005848] microcode: CPU4 sig=0x306c3, pf=0x10, revision=0x17
[    4.007592] microcode: CPU4 updated to revision 0x1e, date = 2015-08-13
[    4.008679] microcode: CPU5 sig=0x306c3, pf=0x10, revision=0x17
[    4.010041] microcode: CPU5 updated to revision 0x1e, date = 2015-08-13
[    4.010726] microcode: CPU6 sig=0x306c3, pf=0x10, revision=0x17
[    4.012097] microcode: CPU6 updated to revision 0x1e, date = 2015-08-13
[    4.012796] microcode: CPU7 sig=0x306c3, pf=0x10, revision=0x17
[    4.014159] microcode: CPU7 updated to revision 0x1e, date = 2015-08-13
[    4.226239] udevd[233]: starting version 3.1.2
[    4.353033] random: udevd urandom read with 125 bits of entropy available
[    4.428676] random: nonblocking pool is initialized
[    4.913996] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded
[    4.914569] r8169 0000:05:00.2: can't disable ASPM; OS doesn't have ASPM control
[    4.915720] r8169 0000:05:00.2 eth0: RTL8411 at 0xffffc9000032e000, 80:fa:5b:08:d0:3d, XID 08800800 IRQ 19
[    4.916367] r8169 0000:05:00.2 eth0: jumbo features [frames: 9200 bytes, tx checksumming: ko]
[    5.179953] snd_hda_intel 0000:00:03.0: bound 0000:00:02.0 (ops 0xffffffff8166bef0)
[    5.301950] usbcore: registered new interface driver btusb
[    5.314851] Bluetooth: hci0: read Intel version: 3707100180012d0d1a
[    5.315569] Bluetooth: hci0: Intel device is already patched. patch num: 1a
[    5.500385] snd_hda_codec_via hdaudioC1D0: autoconfig for VT1802: line_outs=1 (0x24/0x0/0x0/0x0/0x0) type:speaker
[    5.501359] snd_hda_codec_via hdaudioC1D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
[    5.502321] snd_hda_codec_via hdaudioC1D0:    hp_outs=1 (0x25/0x0/0x0/0x0/0x0)
[    5.503272] snd_hda_codec_via hdaudioC1D0:    mono: mono_out=0x0
[    5.504242] snd_hda_codec_via hdaudioC1D0:    inputs:
[    5.505167] snd_hda_codec_via hdaudioC1D0:      Internal Mic=0x30
[    5.506081] snd_hda_codec_via hdaudioC1D0:      Mic=0x2b
[    5.512644] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card1/input10
[    5.513496] input: HDA Intel PCH Front Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card1/input11
[    5.532778] input: HDA Intel HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:03.0/sound/card0/input12
[    5.533550] input: HDA Intel HDMI HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:03.0/sound/card0/input13
[    5.534177] input: HDA Intel HDMI HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:03.0/sound/card0/input14
[    8.694470] Adding 16777212k swap on /dev/sda6.  Priority:1 extents:1 across:16777212k 
[    8.722117] EXT4-fs (sda2): re-mounted. Opts: (null)
[    8.892912] EXT4-fs (sda2): re-mounted. Opts: (null)
[    9.474281] EXT4-fs (sda8): mounted filesystem with ordered data mode. Opts: (null)
[    9.530072] EXT4-fs (sda9): mounted filesystem with ordered data mode. Opts: (null)
[    9.586088] EXT4-fs (sda10): mounted filesystem with ordered data mode. Opts: (null)
[   11.801647] nf_conntrack version 0.5.0 (65536 buckets, 262144 max)
[   12.062779] r8169 0000:05:00.2 eth0: link down
[   12.062779] r8169 0000:05:00.2 eth0: link down
[   13.681533] r8169 0000:05:00.2 eth0: link up
[   14.683181] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   14.684025] Bluetooth: BNEP filters: protocol multicast
[   14.684801] Bluetooth: BNEP socket layer initialized
[   49.416065] Bluetooth: RFCOMM TTY layer initialized
[   49.416070] Bluetooth: RFCOMM socket layer initialized
[   49.416073] Bluetooth: RFCOMM ver 1.11
[   61.566023] Bluetooth: HIDP (Human Interface Emulation) ver 1.2
[   61.566028] Bluetooth: HIDP socket layer initialized
[   61.566498] hid-generic 0005:0A5C:0001.0001: unknown main item tag 0x0
[   61.566540] input: Bluetooth 3.0 mouse as /devices/pci0000:00/0000:00:14.0/usb3/3-7/3-7:1.0/bluetooth/hci0/hci0:256/0005:0A5C:0001.0001/input/input15
[   61.566644] hid-generic 0005:0A5C:0001.0001: input: BLUETOOTH HID v1.29 Mouse [Bluetooth 3.0 mouse] on 80:19:34:5a:67:51
[  117.254420] ata6.00: configured for UDMA/133
[  117.254424] ata6: EH complete
[  117.283062] EXT4-fs (sda2): re-mounted. Opts: commit=0
[  117.289181] EXT4-fs (sda8): re-mounted. Opts: commit=0
[  117.290569] EXT4-fs (sda9): re-mounted. Opts: commit=0
[  117.291683] EXT4-fs (sda10): re-mounted. Opts: commit=0
[  117.618277] PM: Syncing filesystems ... done.
[  117.693961] Freezing user space processes ... (elapsed 0.001 seconds) done.
[  117.695256] Freezing remaining freezable tasks ... (elapsed 2.102 seconds) done.
[  119.797815] Suspending console(s) (use no_console_suspend to debug)
[  119.798002] sd 5:0:0:0: [sda] Synchronizing SCSI cache
[  119.798155] sd 5:0:0:0: [sda] Stopping disk
[  120.588328] PM: suspend of devices complete after 790.379 msecs
[  120.612399] PM: late suspend of devices complete after 24.067 msecs
[  120.612933] ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
[  120.612935] r8169 0000:05:00.2: System wakeup enabled by ACPI
[  120.613034] ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI
[  120.613043] xhci_hcd 0000:00:14.0: System wakeup enabled by ACPI
[  120.628344] PM: noirq suspend of devices complete after 15.943 msecs
[  120.628620] ACPI: Preparing to enter system sleep state S3
[  120.629598] ACPI : EC: EC stopped
[  120.629598] PM: Saving platform NVS memory
[  120.629603] Disabling non-boot CPUs ...
[  120.645368] smpboot: CPU 1 is now offline
[  120.665370] smpboot: CPU 2 is now offline
[  120.681363] smpboot: CPU 3 is now offline
[  120.697365] smpboot: CPU 4 is now offline
[  120.713355] smpboot: CPU 5 is now offline
[  120.729365] smpboot: CPU 6 is now offline
[  120.745346] smpboot: CPU 7 is now offline
[  120.746463] ACPI: Low-level resume complete
[  120.746494] ACPI : EC: EC started
[  120.746495] PM: Restoring platform NVS memory
[  120.746787] microcode: CPU0 sig=0x306c3, pf=0x10, revision=0x1e
[  120.746788] Enabling non-boot CPUs ...
[  120.746823] x86: Booting SMP configuration:
[  120.746824] smpboot: Booting Node 0 Processor 1 APIC 0x2
[  120.748830] microcode: CPU1 microcode updated early to revision 0x1e, date = 2015-08-13
[  120.750974]  cache: parent cpu1 should not be sleeping
[  120.751039] microcode: CPU1 sig=0x306c3, pf=0x10, revision=0x1e
[  120.751126] CPU1 is up
[  120.751139] smpboot: Booting Node 0 Processor 2 APIC 0x4
[  120.752303] microcode: CPU2 microcode updated early to revision 0x1e, date = 2015-08-13
[  120.754433]  cache: parent cpu2 should not be sleeping
[  120.754497] microcode: CPU2 sig=0x306c3, pf=0x10, revision=0x1e
[  120.754580] CPU2 is up
[  120.754592] smpboot: Booting Node 0 Processor 3 APIC 0x6
[  120.755756] microcode: CPU3 microcode updated early to revision 0x1e, date = 2015-08-13
[  120.757883]  cache: parent cpu3 should not be sleeping
[  120.757948] microcode: CPU3 sig=0x306c3, pf=0x10, revision=0x1e
[  120.758029] CPU3 is up
[  120.758042] smpboot: Booting Node 0 Processor 4 APIC 0x1
[  120.759210] microcode: CPU4 microcode updated early to revision 0x1e, date = 2015-08-13
[  120.761333]  cache: parent cpu4 should not be sleeping
[  120.761375] microcode: CPU4 sig=0x306c3, pf=0x10, revision=0x1e
[  120.761439] CPU4 is up
[  120.761448] smpboot: Booting Node 0 Processor 5 APIC 0x3
[  120.763873]  cache: parent cpu5 should not be sleeping
[  120.763917] microcode: CPU5 sig=0x306c3, pf=0x10, revision=0x1e
[  120.763978] CPU5 is up
[  120.763988] smpboot: Booting Node 0 Processor 6 APIC 0x5
[  120.766311]  cache: parent cpu6 should not be sleeping
[  120.766355] microcode: CPU6 sig=0x306c3, pf=0x10, revision=0x1e
[  120.766417] CPU6 is up
[  120.766426] smpboot: Booting Node 0 Processor 7 APIC 0x7
[  120.768758]  cache: parent cpu7 should not be sleeping
[  120.768809] microcode: CPU7 sig=0x306c3, pf=0x10, revision=0x1e
[  120.768880] CPU7 is up
[  120.773625] ACPI: Waking up from system sleep state S3
[  120.777624] xhci_hcd 0000:00:14.0: System wakeup disabled by ACPI
[  120.777655] ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
[  120.777677] ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI
[  120.789736] PM: noirq resume of devices complete after 15.487 msecs
[  120.812196] PM: early resume of devices complete after 22.448 msecs
[  120.812297] r8169 0000:05:00.2: System wakeup disabled by ACPI
[  120.812334] rtc_cmos 00:02: System wakeup disabled by ACPI
[  120.812544] sd 5:0:0:0: [sda] Starting disk
[  120.849819] xhci_hcd 0000:00:14.0: port 6 resume PLC timeout
[  120.900580] r8169 0000:05:00.2 eth0: link down
[  121.073745] usb 3-7: reset full-speed USB device number 2 using xhci_hcd
[  121.136506] ata3: SATA link down (SStatus 0 SControl 300)
[  121.136555] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  121.140301] ata1.00: configured for UDMA/133
[  121.614678] serio serio1: device_attach() failed for isa0060/serio1 (i8042 AUX0 port), error: -517
[  121.614680] serio serio2: device_attach() failed for isa0060/serio2 (i8042 AUX1 port), error: -517
[  121.614681] serio serio3: device_attach() failed for isa0060/serio3 (i8042 AUX2 port), error: -517
[  121.614682] serio serio4: device_attach() failed for isa0060/serio4 (i8042 AUX3 port), error: -517
[  122.443085] r8169 0000:05:00.2 eth0: link up
[  122.533541] ata6: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[  122.534949] ata6.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
[  122.534950] ata6.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
[  122.534952] ata6.00: ACPI cmd b1/c1:00:00:00:00:00 (DEVICE CONFIGURATION OVERLAY) filtered out
[  122.537891] ata6.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
[  122.537893] ata6.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
[  122.537894] ata6.00: ACPI cmd b1/c1:00:00:00:00:00 (DEVICE CONFIGURATION OVERLAY) filtered out
[  122.539272] ata6.00: configured for UDMA/133
[  122.558628] PM: resume of devices complete after 1746.422 msecs
[  122.566915] usb 3-7:1.0: rebind failed: -517
[  122.566919] usb 3-7:1.1: rebind failed: -517
[  122.567057] Restarting tasks ... done.
[  122.652854] ata6.00: configured for UDMA/133
[  122.652859] ata6: EH complete
[  122.658877] EXT4-fs (sda2): re-mounted. Opts: commit=0
[  122.661365] EXT4-fs (sda8): re-mounted. Opts: commit=0
[  122.662206] EXT4-fs (sda9): re-mounted. Opts: commit=0
[  122.663044] EXT4-fs (sda10): re-mounted. Opts: commit=0
[  122.711385] Bluetooth: hci0: read Intel version: 3707100180012d0d00
[  122.744439] Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.7.10-fw-1.80.1.2d.d.bseq
[  122.895434] Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated

^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: 4.5 Regression - mouse not working after resume from suspend
  2016-02-06  8:37 4.5 Regression - mouse not working after resume from suspend Chris Clayton
@ 2016-02-06 11:38 ` Chris Clayton
  2016-02-06 13:18   ` Chris Clayton
  0 siblings, 1 reply; 4+ messages in thread
From: Chris Clayton @ 2016-02-06 11:38 UTC (permalink / raw)
  To: LKML, johan.hedberg, marcel



On 06/02/16 08:37, Chris Clayton wrote:
> There seems to be a regression in resuming my laptop from a suspend to RAM or disk. The symptom is that my bluetooth
> mouse doesn't work after the resume. The kernel is built after a pull of Linus' tree this morning (v4.5-rc2-340-g5af9c2e).
> 
> Attached is the output from dmesg showing the boot, suspend (to RAM) and resume. You'll see that during the resume,
> error -517 is being reported for some devices. Suspend/resume has worked perfectly with a 4.[234].x kernels.
> 
> I'll start a bisection, but thought I'd give a heads up in case someone can see the problem before I get done with the
> bisect.
> 

The bisection ended up at:

2ff13894cfb877cb3d02d96a8402202f0a6f3efd is the first bad commit
commit 2ff13894cfb877cb3d02d96a8402202f0a6f3efd
Author: Johan Hedberg <johan.hedberg@intel.com>
Date:   Wed Nov 25 16:15:44 2015 +0200

    Bluetooth: Perform HCI update for power on synchronously

    The request to update HCI during power on is always coming either from
    hdev->req_workqueue or through an ioctl, so it's safe to use
    hci_req_sync for it. This way we also eliminate potential races with
    incoming mgmt commands or other actions while powering on.

    Part of this refactoring is the splitting of mgmt_powered() into
    mgmt_power_on() and __mgmt_power_off() functions. The main reason is
    the different requirements as far as hdev locking is concerned, as
    highlighted with the __ prefix of the power off API.

    Since the power on in the case of clearing the AUTO_OFF flag cannot be
    done synchronously in the set_powered mgmt handler, the hci_power_on
    work callback is extended to cover this (which also simplifies the
    set_powered helper a lot).

    Signed-off-by: Johan Hedberg <johan.hedberg@intel.com>
    Signed-off-by: Marcel Holtmann <marcel@holtmann.org>

:040000 040000 a093d0be66f39f99c33a6a4725b2330ca9b41d03 a1eff79cec3ee7208e5aa200ab5069726bbeea8e M      include
:040000 040000 d2d122193b33d45fcb9c2bc69f2024487a7528a0 0036e1ec2e125f2432cfd420b5f79ca133ec34f7 M      net


The bisect log is:

git bisect start
# bad: [5af9c2e19da6514a1a50b07d97d93b74a7711873] Merge branch 'akpm' (patches from Andrew)
git bisect bad 5af9c2e19da6514a1a50b07d97d93b74a7711873
# good: [afd2ff9b7e1b367172f18ba7f693dfb62bdcb2dc] Linux 4.4
git bisect good afd2ff9b7e1b367172f18ba7f693dfb62bdcb2dc
# bad: [63b6da39bb38e8f1a1ef3180d32a39d6baf9da84] perf: Fix perf_event_exit_task() race
git bisect bad 63b6da39bb38e8f1a1ef3180d32a39d6baf9da84
# bad: [aee3bfa3307cd0da2126bdc0ea359dabea5ee8f7] Merge git://git.kernel.org/pub/scm/linux/kernel/git/davem/net-next
git bisect bad aee3bfa3307cd0da2126bdc0ea359dabea5ee8f7
# good: [60b7eca1dc2ec066916b3b7ac6ad89bea13cb9af] Merge tag 'upstream-4.5-rc1' of git://git.infradead.org/linux-ubifs
git bisect good 60b7eca1dc2ec066916b3b7ac6ad89bea13cb9af
# bad: [a188222b6ed29404ac2d4232d35d1fe0e77af370] net: Rename NETIF_F_ALL_CSUM to NETIF_F_CSUM_MASK
git bisect bad a188222b6ed29404ac2d4232d35d1fe0e77af370
# good: [1343c65f70ee1b1f968a08b30e1836a4e37116cd] fm10k: always check init_hw for errors
git bisect good 1343c65f70ee1b1f968a08b30e1836a4e37116cd
# good: [bc9b145a092aca91a7f6ef40cdb3628b6ada7ec9] Merge branch 'for-4.5-ancestor-test' of
git://git.kernel.org/pub/scm/linux/kernel/git/tj/cgroup
git bisect good bc9b145a092aca91a7f6ef40cdb3628b6ada7ec9
# good: [a4fcad656e1100bdda9b0b752b93a1a276810469] fm10k: whitespace cleanups
git bisect good a4fcad656e1100bdda9b0b752b93a1a276810469
# bad: [7302b9d90117496049dd4bfa28755f7c2ed55b27] ieee802154/adf7242: Driver for ADF7242 MAC IEEE802154
git bisect bad 7302b9d90117496049dd4bfa28755f7c2ed55b27
# bad: [a0c38245153abe1fd844af9b166d1a5d5dafe7b1] Bluetooth: hci_intel: Use shorter timeout for HCI commands
git bisect bad a0c38245153abe1fd844af9b166d1a5d5dafe7b1
# good: [bf943cbf76ecd3b9838a80d5e08777b0f4ccc665] Bluetooth: Move fast connectable code to hci_request.c
git bisect good bf943cbf76ecd3b9838a80d5e08777b0f4ccc665
# bad: [742c59516822f4a4bc23b0961d88c569a7f1bf71] Bluetooth: Simplify setting Configuration Field
git bisect bad 742c59516822f4a4bc23b0961d88c569a7f1bf71
# bad: [02c04afea93fbba7925984df455bc63e7d92da97] Bluetooth: Simplify read_adv_features code
git bisect bad 02c04afea93fbba7925984df455bc63e7d92da97
# bad: [2ff13894cfb877cb3d02d96a8402202f0a6f3efd] Bluetooth: Perform HCI update for power on synchronously
git bisect bad 2ff13894cfb877cb3d02d96a8402202f0a6f3efd
# first bad commit: [2ff13894cfb877cb3d02d96a8402202f0a6f3efd] Bluetooth: Perform HCI update for power on synchronously


Just shout if you need any additional diagnotics.


> Chris
> 

^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: 4.5 Regression - mouse not working after resume from suspend
  2016-02-06 11:38 ` Chris Clayton
@ 2016-02-06 13:18   ` Chris Clayton
       [not found]     ` <20160206143300.GA18790@t440s.P-661HNU-F1>
  0 siblings, 1 reply; 4+ messages in thread
From: Chris Clayton @ 2016-02-06 13:18 UTC (permalink / raw)
  To: LKML, johan.hedberg, marcel



On 06/02/16 11:38, Chris Clayton wrote:
> 
> 
> On 06/02/16 08:37, Chris Clayton wrote:
>> There seems to be a regression in resuming my laptop from a suspend to RAM or disk. The symptom is that my bluetooth
>> mouse doesn't work after the resume. The kernel is built after a pull of Linus' tree this morning (v4.5-rc2-340-g5af9c2e).
>>
>> Attached is the output from dmesg showing the boot, suspend (to RAM) and resume. You'll see that during the resume,
>> error -517 is being reported for some devices. Suspend/resume has worked perfectly with a 4.[234].x kernels.
>>
>> I'll start a bisection, but thought I'd give a heads up in case someone can see the problem before I get done with the
>> bisect.
>>
> 
> The bisection ended up at:
> 
> 2ff13894cfb877cb3d02d96a8402202f0a6f3efd is the first bad commit
> commit 2ff13894cfb877cb3d02d96a8402202f0a6f3efd
> Author: Johan Hedberg <johan.hedberg@intel.com>
> Date:   Wed Nov 25 16:15:44 2015 +0200
> 
>     Bluetooth: Perform HCI update for power on synchronously
> 
>     The request to update HCI during power on is always coming either from
>     hdev->req_workqueue or through an ioctl, so it's safe to use
>     hci_req_sync for it. This way we also eliminate potential races with
>     incoming mgmt commands or other actions while powering on.
> 
>     Part of this refactoring is the splitting of mgmt_powered() into
>     mgmt_power_on() and __mgmt_power_off() functions. The main reason is
>     the different requirements as far as hdev locking is concerned, as
>     highlighted with the __ prefix of the power off API.
> 
>     Since the power on in the case of clearing the AUTO_OFF flag cannot be
>     done synchronously in the set_powered mgmt handler, the hci_power_on
>     work callback is extended to cover this (which also simplifies the
>     set_powered helper a lot).
> 
>     Signed-off-by: Johan Hedberg <johan.hedberg@intel.com>
>     Signed-off-by: Marcel Holtmann <marcel@holtmann.org>
> 
> :040000 040000 a093d0be66f39f99c33a6a4725b2330ca9b41d03 a1eff79cec3ee7208e5aa200ab5069726bbeea8e M      include
> :040000 040000 d2d122193b33d45fcb9c2bc69f2024487a7528a0 0036e1ec2e125f2432cfd420b5f79ca133ec34f7 M      net
> 
> 

I've just built a kernel at bf943cbf76ecd3b9838a80d5e08777b0f4ccc665 (the commit prior to the one the bisect landed on)
and my BT mouse works fine after a suspend/resume. With a kernel built at 2ff13894cfb877cb3d02d96a8402202f0a6f3efd, the
mouse does not work after resume.

> The bisect log is:
> 
> git bisect start
> # bad: [5af9c2e19da6514a1a50b07d97d93b74a7711873] Merge branch 'akpm' (patches from Andrew)
> git bisect bad 5af9c2e19da6514a1a50b07d97d93b74a7711873
> # good: [afd2ff9b7e1b367172f18ba7f693dfb62bdcb2dc] Linux 4.4
> git bisect good afd2ff9b7e1b367172f18ba7f693dfb62bdcb2dc
> # bad: [63b6da39bb38e8f1a1ef3180d32a39d6baf9da84] perf: Fix perf_event_exit_task() race
> git bisect bad 63b6da39bb38e8f1a1ef3180d32a39d6baf9da84
> # bad: [aee3bfa3307cd0da2126bdc0ea359dabea5ee8f7] Merge git://git.kernel.org/pub/scm/linux/kernel/git/davem/net-next
> git bisect bad aee3bfa3307cd0da2126bdc0ea359dabea5ee8f7
> # good: [60b7eca1dc2ec066916b3b7ac6ad89bea13cb9af] Merge tag 'upstream-4.5-rc1' of git://git.infradead.org/linux-ubifs
> git bisect good 60b7eca1dc2ec066916b3b7ac6ad89bea13cb9af
> # bad: [a188222b6ed29404ac2d4232d35d1fe0e77af370] net: Rename NETIF_F_ALL_CSUM to NETIF_F_CSUM_MASK
> git bisect bad a188222b6ed29404ac2d4232d35d1fe0e77af370
> # good: [1343c65f70ee1b1f968a08b30e1836a4e37116cd] fm10k: always check init_hw for errors
> git bisect good 1343c65f70ee1b1f968a08b30e1836a4e37116cd
> # good: [bc9b145a092aca91a7f6ef40cdb3628b6ada7ec9] Merge branch 'for-4.5-ancestor-test' of
> git://git.kernel.org/pub/scm/linux/kernel/git/tj/cgroup
> git bisect good bc9b145a092aca91a7f6ef40cdb3628b6ada7ec9
> # good: [a4fcad656e1100bdda9b0b752b93a1a276810469] fm10k: whitespace cleanups
> git bisect good a4fcad656e1100bdda9b0b752b93a1a276810469
> # bad: [7302b9d90117496049dd4bfa28755f7c2ed55b27] ieee802154/adf7242: Driver for ADF7242 MAC IEEE802154
> git bisect bad 7302b9d90117496049dd4bfa28755f7c2ed55b27
> # bad: [a0c38245153abe1fd844af9b166d1a5d5dafe7b1] Bluetooth: hci_intel: Use shorter timeout for HCI commands
> git bisect bad a0c38245153abe1fd844af9b166d1a5d5dafe7b1
> # good: [bf943cbf76ecd3b9838a80d5e08777b0f4ccc665] Bluetooth: Move fast connectable code to hci_request.c
> git bisect good bf943cbf76ecd3b9838a80d5e08777b0f4ccc665
> # bad: [742c59516822f4a4bc23b0961d88c569a7f1bf71] Bluetooth: Simplify setting Configuration Field
> git bisect bad 742c59516822f4a4bc23b0961d88c569a7f1bf71
> # bad: [02c04afea93fbba7925984df455bc63e7d92da97] Bluetooth: Simplify read_adv_features code
> git bisect bad 02c04afea93fbba7925984df455bc63e7d92da97
> # bad: [2ff13894cfb877cb3d02d96a8402202f0a6f3efd] Bluetooth: Perform HCI update for power on synchronously
> git bisect bad 2ff13894cfb877cb3d02d96a8402202f0a6f3efd
> # first bad commit: [2ff13894cfb877cb3d02d96a8402202f0a6f3efd] Bluetooth: Perform HCI update for power on synchronously
> 
> 
> Just shout if you need any additional diagnotics.
> 
> 
>> Chris
>>

^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: 4.5 Regression - mouse not working after resume from suspend
       [not found]         ` <56C26202.4070101@googlemail.com>
@ 2016-02-18 19:59           ` Chris Clayton
  0 siblings, 0 replies; 4+ messages in thread
From: Chris Clayton @ 2016-02-18 19:59 UTC (permalink / raw)
  To: linux-bluetooth, marcel, johan.hedberg, LKML

I can only assume that although a non-working bluetooth mouse is a symptom of this regression, the silence of the
bluetooth folks is because the fault does not lie in the BT subsystem. Consequently, I'm transferring the problem back
to LKML in the hope that someone else can solve the problem.

On 15/02/16 23:40, Chris Clayton wrote:
> Hi,
> 
> Is there anything else I can do to help diagnose this regression.
> 
> To summarise my BT mouse does not work after resuming from suspend to disk or ram. IT works perfectly in earlier 4.4,
> 4.3 and 4.2 kernels. I bisected and found the first bad commit is:
> 
> 2ff13894cfb877cb3d02d96a8402202f0a6f3efd is the first bad commit
> commit 2ff13894cfb877cb3d02d96a8402202f0a6f3efd
> Author: Johan Hedberg <johan.hedberg@intel.com>
> Date:   Wed Nov 25 16:15:44 2015 +0200
> 
>     Bluetooth: Perform HCI update for power on synchronously
> 
> Johan requested additional information, which I provided. Checking the archive at marc.info, it seems the mail didn't
> make it to the mailing list. Maybe it exceeded a size limit, I don't know. Anyway I copied the mail to Johan and Marcel.
> 
> A bit more experimentation revealed that I can reactivate the mouse if I restart the bluetooth daemon after the machine
> resumes.
> 
> Please let me know if I can provide anything else.
> 
> Thanks
> 
> Chris
> 
> On 06/02/16 15:23, Chris Clayton wrote:
>> Hi Johan,
>>
>> The information you requested has been captured from v4.5-rc2-340-g5af9c2e and is included below.
>>
>> On 06/02/16 14:33, Johan Hedberg wrote:
>>> Hi Chris,
>>>
>>> On Sat, Feb 06, 2016, Chris Clayton wrote:
>>>> On 06/02/16 11:38, Chris Clayton wrote:
>>>>> On 06/02/16 08:37, Chris Clayton wrote:
>>>>>> There seems to be a regression in resuming my laptop from a suspend
>>>>>> to RAM or disk. The symptom is that my bluetooth
>>>>>> mouse doesn't work after the resume. The kernel is built after a
>>>>>> pull of Linus' tree this morning (v4.5-rc2-340-g5af9c2e).
>>>>>>
>>>>>> Attached is the output from dmesg showing the boot, suspend (to
>>>>>> RAM) and resume. You'll see that during the resume,
>>>>>> error -517 is being reported for some devices. Suspend/resume has worked perfectly with a 4.[234].x kernels.
>>>>>>
>>>>>> I'll start a bisection, but thought I'd give a heads up in case
>>>>>> someone can see the problem before I get done with the
>>>>>> bisect.
>>>>>
>>>>> The bisection ended up at:
>>>>>
>>>>> 2ff13894cfb877cb3d02d96a8402202f0a6f3efd is the first bad commit
>>>>> commit 2ff13894cfb877cb3d02d96a8402202f0a6f3efd
>>>>> Author: Johan Hedberg <johan.hedberg@intel.com>
>>>>> Date:   Wed Nov 25 16:15:44 2015 +0200
>>>>>
>>>>>     Bluetooth: Perform HCI update for power on synchronously
>>>>>
>>>>>     The request to update HCI during power on is always coming either from
>>>>>     hdev->req_workqueue or through an ioctl, so it's safe to use
>>>>>     hci_req_sync for it. This way we also eliminate potential races with
>>>>>     incoming mgmt commands or other actions while powering on.
>>>>>
>>>>>     Part of this refactoring is the splitting of mgmt_powered() into
>>>>>     mgmt_power_on() and __mgmt_power_off() functions. The main reason is
>>>>>     the different requirements as far as hdev locking is concerned, as
>>>>>     highlighted with the __ prefix of the power off API.
>>>>>
>>>>>     Since the power on in the case of clearing the AUTO_OFF flag cannot be
>>>>>     done synchronously in the set_powered mgmt handler, the hci_power_on
>>>>>     work callback is extended to cover this (which also simplifies the
>>>>>     set_powered helper a lot).
>>>>>
>>>>>     Signed-off-by: Johan Hedberg <johan.hedberg@intel.com>
>>>>>     Signed-off-by: Marcel Holtmann <marcel@holtmann.org>
>>>>>
>>>>> :040000 040000 a093d0be66f39f99c33a6a4725b2330ca9b41d03 a1eff79cec3ee7208e5aa200ab5069726bbeea8e M      include
>>>>> :040000 040000 d2d122193b33d45fcb9c2bc69f2024487a7528a0 0036e1ec2e125f2432cfd420b5f79ca133ec34f7 M      net
>>>>
>>>> I've just built a kernel at bf943cbf76ecd3b9838a80d5e08777b0f4ccc665
>>>> (the commit prior to the one the bisect landed on)
>>>> and my BT mouse works fine after a suspend/resume. With a kernel built
>>>> at 2ff13894cfb877cb3d02d96a8402202f0a6f3efd, the mouse does not work
>>>> after resume.
>>>
>>> I've moved the thread over to the linux-bluetooth list, since that's where
>>> Bluetooth issues are primarily discussed. You had already removed the dmesg
>>> output by the time you added me to the thread so I'll copy the relevant
>>> (Bluetooth related) parts here that I found in the online archives:
>>>
>>> [    5.314851] Bluetooth: hci0: read Intel version: 3707100180012d0d1a
>>> [    5.315569] Bluetooth: hci0: Intel device is already patched. patch num: 1a
>>> [   61.566028] Bluetooth: HIDP socket layer initialized
>>> [   61.566498] hid-generic 0005:0A5C:0001.0001: unknown main item tag 0x0
>>> [   61.566540] input: Bluetooth 3.0 mouse as /devices/pci0000:00/0000:00:14.0/usb3/3-7/3-7:1.0/bluetooth/hci0/hci0:256/0005:0A5C:0001.0001/input/input15
>>> [   61.566644] hid-generic 0005:0A5C:0001.0001: input: BLUETOOTH HID v1.29 Mouse [Bluetooth 3.0 mouse] on 80:19:34:5a:67:51
>>> [  122.711385] Bluetooth: hci0: read Intel version: 3707100180012d0d00
>>> [  122.744439] Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.7.10-fw-1.80.1.2d.d.bseq
>>> [  122.895434] Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated
>>>
>>> There's some more information needed to investigate this further:
>>>
>>>  - What's the state of Bluetooth on your machine after resume? If you do
>>>    "hciconfig" does it show hci0 as being "UP"? Does it show "PSCAN"
>>>    being enabled? (assuming your mouse is a BR/EDR one)
>>
>> hci0:   Type: BR/EDR  Bus: USB
>>         BD Address: 80:19:34:5A:67:51  ACL MTU: 1021:5  SCO MTU: 96:6
>>         DOWN
>>         RX bytes:1139 acl:0 sco:0 events:122 errors:0
>>         TX bytes:17708 acl:0 sco:0 commands:121 errors:0
>>
>>>  - Do you see any errors from bluetoothd when you suspend/resume?
>>
>> Feb  6 15:06:24 laptop bluetoothd[888]: Endpoint unregistered: sender=:1.37 path=/MediaEndpoint/A2DPSource
>> Feb  6 15:06:24 laptop bluetoothd[888]: Endpoint unregistered: sender=:1.37 path=/MediaEndpoint/A2DPSink
>> Feb  6 15:06:25 laptop bluetoothd[888]: Failed to obtain handles for "Service Changed" characteristic
>> Feb  6 15:06:25 laptop bluetoothd[888]: Endpoint registered: sender=:1.37 path=/MediaEndpoint/A2DPSource
>> Feb  6 15:06:25 laptop bluetoothd[888]: Endpoint registered: sender=:1.37 path=/MediaEndpoint/A2DPSink
>>
>>>  - Could you provide the HCI log from btmon for what happens when you
>>>    suspend/resume (just keep btmon running over this time)
>>
>> That log's a bit long, so I've attached it.
>>
>> Hope this helps. Thanks
>>
>> Chris
>>>
>>> Thanks.
>>>
>>> Johan
>>>

^ permalink raw reply	[flat|nested] 4+ messages in thread

end of thread, other threads:[~2016-02-18 19:59 UTC | newest]

Thread overview: 4+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2016-02-06  8:37 4.5 Regression - mouse not working after resume from suspend Chris Clayton
2016-02-06 11:38 ` Chris Clayton
2016-02-06 13:18   ` Chris Clayton
     [not found]     ` <20160206143300.GA18790@t440s.P-661HNU-F1>
     [not found]       ` <56B61000.6060008@googlemail.com>
     [not found]         ` <56C26202.4070101@googlemail.com>
2016-02-18 19:59           ` Chris Clayton

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox