You are not logged in.

#1 2018-09-02 16:23:08

Naruni
Member
Registered: 2010-08-05
Posts: 34

Resume after suspend broken

Hello, I realize there's a few topics on this but I haven't seen a solid solution and did not want to hijack.
Hardware is an Asustor AS3204T (Celeron J3160) with 2GB RAM and IGD, no additional GPU.  One hardwired DOM and one 128GB SSD (hosting OS).

Software is latest Arch with nothing more than Kodi-standalone, Cyberpower UPS daemon, docker, and a few utilities.  I'm currently on the linux-lts package after seeing it recommended in some other posts.

[2018-09-01 17:36] [PACMAN] Running 'pacman -S btrfs'
[2018-09-01 17:36] [PACMAN] Running 'pacman -S btrfs-progs'
[2018-09-01 18:07] [PACMAN] Running 'pacman -S intel-ucode'
[2018-09-01 18:07] [PACMAN] Running 'pacman -S grub'
[2018-09-01 18:13] [PACMAN] Running 'pacman -S opensshd'
[2018-09-01 18:13] [PACMAN] Running 'pacman -S openssh'
[2018-09-01 18:13] [PACMAN] Running 'pacman -Syy'
[2018-09-01 18:13] [PACMAN] synchronizing package lists
[2018-09-01 18:13] [PACMAN] Running 'pacman -S openssh'
[2018-09-01 18:15] [PACMAN] Running 'pacman -S kodi polkit xorg-server xorg-xinit pulseaudio'
[2018-09-01 18:16] [PACMAN] Running 'pacman -U kodi-standalone-service-1.94-1-x86_64.pkg.tar.xz powerpanel-1.3.2-5-x86_64.pkg.tar.xz'
[2018-09-01 19:51] [PACMAN] Running 'pacman -S libva-intel-driver mesa'
[2018-09-01 21:15] [PACMAN] Running 'pacman -S mlocate'
[2018-09-01 22:09] [PACMAN] Running 'pacman -S hdparm'
[2018-09-01 22:14] [PACMAN] Running 'pacman -S hd-idle'
[2018-09-01 22:16] [PACMAN] Running 'pacman -S smartmontools'
[2018-09-01 22:59] [PACMAN] Running 'pacman -S docker'
[2018-09-01 23:02] [PACMAN] Running 'pacman -S sudo'
[2018-09-02 08:16] [PACMAN] Running 'pacman -S pkgfile'
[2018-09-02 08:20] [PACMAN] Running 'pacman -S xf86-video-intel'
[2018-09-02 08:21] [PACMAN] Running 'pacman -Rns xf86-video-intel'
[2018-09-02 08:42] [PACMAN] Running 'pacman -Rs acpi'
[2018-09-02 08:42] [PACMAN] Running 'pacman -S acpi'
[2018-09-02 08:42] [PACMAN] Running 'pacman -S linux-lts linux-lts-headers'
[2018-09-02 08:44] [PACMAN] Running 'pacman -S intel-ucode'

The system appears to suspend correctly, but will not resume on keyboard press.  Power and network LEDs stay solid but disk LED blinks, this is normal operation when the system boots up so I'm not sure if it's related.
In dmesg I noticed some ACPI alarms:

[root@ArchServer ~]# dmesg
[    0.000000] Linux version 4.14.67-1-lts (builduser@andyrtr) (gcc version 8.2.0 (GCC)) #1 SMP Fri Aug 24 16:54:09 CEST 2018
[    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-linux-lts root=UUID=6c67a5cc-1d8c-4a16-9993-022d57fdfddc rw quiet resume=UUID=ec056a40-708f-470b-9c3d-4a0d5d44f590
[    0.000000] x86/fpu: x87 FPU will use FXSAVE
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009f7ff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009f800-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007a4befff] usable
[    0.000000] BIOS-e820: [mem 0x000000007a4bf000-0x000000007aebefff] reserved
[    0.000000] BIOS-e820: [mem 0x000000007aebf000-0x000000007bfbefff] ACPI NVS
[    0.000000] BIOS-e820: [mem 0x000000007bfbf000-0x000000007bffefff] ACPI data
[    0.000000] BIOS-e820: [mem 0x000000007bfff000-0x000000007bffffff] usable
[    0.000000] BIOS-e820: [mem 0x000000007c400000-0x000000007fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000e0000000-0x00000000e3ffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fea00000-0x00000000feafffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed01000-0x00000000fed01fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed03000-0x00000000fed03fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed08000-0x00000000fed09fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1cfff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fed80000-0x00000000fedbffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.8 present.
[    0.000000] DMI: Insyde AS31xx/Type2 - Board Product Name, BIOS V2.16 04/21/2016
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] e820: last_pfn = 0x7c000 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-FFFFF write-protect
[    0.000000] MTRR variable ranges enabled:
[    0.000000]   0 base 0FFC00000 mask FFFC00000 write-protect
[    0.000000]   1 base 000000000 mask F80000000 write-back
[    0.000000]   2 base 07E000000 mask FFE000000 uncachable
[    0.000000]   3 base 07D000000 mask FFF000000 uncachable
[    0.000000]   4 base 07C800000 mask FFF800000 uncachable
[    0.000000]   5 base 07C400000 mask FFFC00000 uncachable
[    0.000000]   6 disabled
[    0.000000]   7 disabled
[    0.000000] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
[    0.000000] Scanning 1 areas for low memory corruption
[    0.000000] Base memory trampoline at [ffff92a780099000] 99000 size 24576
[    0.000000] BRK [0x04638000, 0x04638fff] PGTABLE
[    0.000000] BRK [0x04639000, 0x04639fff] PGTABLE
[    0.000000] BRK [0x0463a000, 0x0463afff] PGTABLE
[    0.000000] BRK [0x0463b000, 0x0463bfff] PGTABLE
[    0.000000] BRK [0x0463c000, 0x0463cfff] PGTABLE
[    0.000000] BRK [0x0463d000, 0x0463dfff] PGTABLE
[    0.000000] BRK [0x0463e000, 0x0463efff] PGTABLE
[    0.000000] RAMDISK: [mem 0x36a97000-0x37542fff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000FE020 000024 (v02 INSYDE)
[    0.000000] ACPI: XSDT 0x000000007BFFE120 00008C (v01 INSYDE INSYDE   00000003      01000013)
[    0.000000] ACPI: FACP 0x000000007BFFA000 00010C (v05 INSYDE INSYDE   00000003 ACPI 00040000)
[    0.000000] ACPI: DSDT 0x000000007BFEA000 00ABBE (v02 INSYDE INSYDE   00000003 ACPI 00040000)
[    0.000000] ACPI: FACS 0x000000007BFBB000 000040
[    0.000000] ACPI: UEFI 0x000000007BFFD000 000236 (v01 INSYDE INSYDE   00000001 ACPI 00040000)
[    0.000000] ACPI: UEFI 0x000000007BFFB000 000042 (v01 INSYDE INSYDE   00000000 ACPI 00040000)
[    0.000000] ACPI: APIC 0x000000007BFF9000 000084 (v03 INSYDE INSYDE   00000003 ACPI 00040000)
[    0.000000] ACPI: MCFG 0x000000007BFF8000 00003C (v01 INSYDE INSYDE   00000003 ACPI 00040000)
[    0.000000] ACPI: SLIC 0x000000007BFF7000 000176 (v01 INSYDE INSYDE   00000003 ACPI 00040000)
[    0.000000] ACPI: WDAT 0x000000007BFF6000 0001C4 (v01 INSYDE INSYDE   00000003 ACPI 00040000)
[    0.000000] ACPI: WDRT 0x000000007BFF5000 000047 (v01 INSYDE INSYDE   00000003 ACPI 00040000)
[    0.000000] ACPI: SSDT 0x000000007BFE9000 000763 (v01 INSYDE CpuPm    00003000 ACPI 00040000)
[    0.000000] ACPI: SSDT 0x000000007BFE8000 000290 (v01 INSYDE Cpu0Tst  00003000 ACPI 00040000)
[    0.000000] ACPI: SSDT 0x000000007BFE7000 00017A (v01 INSYDE ApTst    00003000 ACPI 00040000)
[    0.000000] ACPI: SSDT 0x000000007BFE6000 000DF9 (v01 INSYDE SIOACPI  00001000 ACPI 00040000)
[    0.000000] ACPI: FPDT 0x000000007BFE5000 000044 (v01 INSYDE INSYDE   00000002 ACPI 00040000)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000007bffffff]
[    0.000000] NODE_DATA(0) allocated [mem 0x7a4bb000-0x7a4befff]
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   DMA32    [mem 0x0000000001000000-0x000000007bffffff]
[    0.000000]   Normal   empty
[    0.000000]   Device   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x000000007a4befff]
[    0.000000]   node   0: [mem 0x000000007bfff000-0x000000007bffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000007bffffff]
[    0.000000] On node 0 totalpages: 500830
[    0.000000]   DMA zone: 64 pages used for memmap
[    0.000000]   DMA zone: 21 pages reserved
[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 7872 pages used for memmap
[    0.000000]   DMA32 zone: 496832 pages, LIFO batch:31
[    0.000000] Reserving Intel graphics memory at 0x000000007cc00000-0x000000007ebfffff
[    0.000000] ACPI: PM-Timer IO Port: 0x408
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high level lint[0x1])
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0x02] high level lint[0x1])
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0x03] high level lint[0x1])
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0x04] high level lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-114
[    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] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[    0.000000] PM: Registered nosave memory: [mem 0x0009f000-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 0x7a4bf000-0x7aebefff]
[    0.000000] PM: Registered nosave memory: [mem 0x7aebf000-0x7bfbefff]
[    0.000000] PM: Registered nosave memory: [mem 0x7bfbf000-0x7bffefff]
[    0.000000] e820: [mem 0x80000000-0xdfffffff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on bare hardware
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.000000] random: get_random_bytes called from start_kernel+0x93/0x4cc with crng_init=0
[    0.000000] setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:4 nr_node_ids:1
[    0.000000] percpu: Embedded 42 pages/cpu @ffff92a7fa200000 s132504 r8192 d31336 u524288
[    0.000000] pcpu-alloc: s132504 r8192 d31336 u524288 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 1 2 3 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 492873
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-linux-lts root=UUID=6c67a5cc-1d8c-4a16-9993-022d57fdfddc rw quiet resume=UUID=ec056a40-708f-470b-9c3d-4a0d5d44f590
[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[    0.000000] Calgary: detecting Calgary via BIOS EBDA area
[    0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
[    0.000000] Memory: 1935956K/2003320K available (10252K kernel code, 1150K rwdata, 2836K rodata, 1416K init, 988K bss, 67364K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Kernel/User page tables isolation: enabled
[    0.000000] ftrace: allocating 29153 entries in 114 pages
[    0.000000] Hierarchical RCU implementation.
[    0.000000]  RCU restricting CPUs from NR_CPUS=128 to nr_cpu_ids=4.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 8448, nr_irqs: 1024, preallocated irqs: 16
[    0.000000] Console: colour dummy device 80x25
[    0.000000] console [tty0] enabled
[    0.000000] tsc: Detected 1600.000 MHz processor
[    0.000019] Calibrating delay loop (skipped), value calculated using timer frequency.. 3200.00 BogoMIPS (lpj=16000000)
[    0.000025] pid_max: default: 32768 minimum: 301
[    0.000056] ACPI: Core revision 20170728
[    0.014692] ACPI: 5 ACPI AML tables successfully acquired and loaded
[    0.014765] Security Framework initialized
[    0.014768] Yama: becoming mindful.
[    0.015599] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
[    0.016050] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.016107] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes)
[    0.016124] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes)
[    0.016559] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
[    0.016562] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
[    0.016576] mce: CPU supports 6 MCE banks
[    0.016586] CPU0: Thermal monitoring enabled (TM1)
[    0.016593] process: using mwait in idle threads
[    0.016598] Last level iTLB entries: 4KB 48, 2MB 0, 4MB 0
[    0.016601] Last level dTLB entries: 4KB 256, 2MB 16, 4MB 16, 1GB 0
[    0.016605] Spectre V2 : Mitigation: Full generic retpoline
[    0.016606] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.016873] Freeing SMP alternatives memory: 28K
[    0.020197] smpboot: Max logical packages: 1
[    0.030753] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.130808] TSC deadline timer enabled
[    0.130812] smpboot: CPU0: Intel(R) Celeron(R) CPU  J3160  @ 1.60GHz (family: 0x6, model: 0x4c, stepping: 0x4)
[    0.131019] Performance Events: PEBS fmt2+, 8-deep LBR, Silvermont events, 8-deep LBR, full-width counters, Intel PMU driver.
[    0.131042] ... version:                3
[    0.131044] ... bit width:              40
[    0.131045] ... generic registers:      2
[    0.131047] ... value mask:             000000ffffffffff
[    0.131048] ... max period:             0000007fffffffff
[    0.131049] ... fixed-purpose events:   3
[    0.131050] ... event mask:             0000000700000003
[    0.131140] Hierarchical SRCU implementation.
[    0.132495] NMI watchdog: Enabled. Permanently consumes one hw-PMU counter.
[    0.132542] smp: Bringing up secondary CPUs ...
[    0.132847] x86: Booting SMP configuration:
[    0.132850] .... node  #0, CPUs:      #1 #2 #3
[    0.134085] smp: Brought up 1 node, 4 CPUs
[    0.134085] smpboot: Total of 4 processors activated (12800.00 BogoMIPS)
[    0.134085] devtmpfs: initialized
[    0.134085] x86/mm: Memory block size: 128MB
[    0.134085] PM: Registering ACPI NVS region [mem 0x7aebf000-0x7bfbefff] (17825792 bytes)
[    0.134085] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.134085] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    0.134085] pinctrl core: initialized pinctrl subsystem
[    0.134085] RTC time: 15:59:10, date: 09/02/18
[    0.134085] NET: Registered protocol family 16
[    0.140346] cpuidle: using governor ladder
[    0.140346] cpuidle: using governor menu
[    0.140346] ACPI: bus type PCI registered
[    0.140346] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.140346] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000)
[    0.140346] PCI: MMCONFIG at [mem 0xe0000000-0xe3ffffff] reserved in E820
[    0.140346] PCI: Using configuration type 1 for base access
[    0.141563] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.141563] ACPI: Added _OSI(Module Device)
[    0.141563] ACPI: Added _OSI(Processor Device)
[    0.141563] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.141563] ACPI: Added _OSI(Processor Aggregator Device)
[    0.150978] ACPI: Dynamic OEM Table Load:
[    0.150994] ACPI: SSDT 0xFFFF92A7F732E800 000654 (v01 PmRef  Cpu0Ist  00003000 INTL 20130117)
[    0.151294] ACPI: Dynamic OEM Table Load:
[    0.151294] ACPI: SSDT 0xFFFF92A7F738F200 00015F (v01 PmRef  ApIst    00003000 INTL 20130117)
[    0.152495] ACPI: Interpreter enabled
[    0.152542] ACPI: (supports S0 S3 S4 S5)
[    0.152545] ACPI: Using IOAPIC for interrupt routing
[    0.152610] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.153525] ACPI: Enabled 8 GPEs in block 00 to 3F
[    0.161424] ACPI Error: Field [IURH] at bit offset/length 104/8 exceeds size of target Buffer (104 bits) (20170728/dsopcode-235)
[    0.161445] ACPI Error: Method parse/execution failed \_SB.PCI0.LPCB.SIO0.ECP._CRS, AE_AML_BUFFER_LIMIT (20170728/psparse-550)
[    0.161468] ACPI Error: Method execution failed \_SB.PCI0.LPCB.SIO0.ECP._CRS, AE_AML_BUFFER_LIMIT (20170728/uteval-103)
[    0.162083] ACPI: Power Resource [USBC] (on)
[    0.164683]  (null): Device [PWM1] is in always present list
[    0.169586] ACPI: Power Resource [CLK0] (on)
[    0.170240] ACPI: Power Resource [CLK0] (on)
[    0.170333] ACPI: Power Resource [CLK1] (on)
[    0.177416] ACPI: Power Resource [ID3C] (off)
[    0.182219]  (null): Device [GPED] is in always present list
[    0.183863] ACPI: Power Resource [FN00] (off)
[    0.184907] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.184918] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[    0.185034] acpi PNP0A08:00: _OSC failed (AE_ERROR); disabling ASPM
[    0.185059] acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge
[    0.185300] acpi PNP0A08:00: host bridge window expanded to [mem 0x80000000-0xdfffffff window]; [mem 0x80000000-0xdfffffff window] ignored
[    0.185737] PCI host bridge to bus 0000:00
[    0.185743] pci_bus 0000:00: root bus resource [io  0x0070-0x0077]
[    0.185746] pci_bus 0000:00: root bus resource [io  0x0000-0x006f window]
[    0.185749] pci_bus 0000:00: root bus resource [io  0x0078-0x0cf7 window]
[    0.185752] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.185755] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.185758] pci_bus 0000:00: root bus resource [mem 0x000c0000-0x000dffff window]
[    0.185761] pci_bus 0000:00: root bus resource [mem 0x000e0000-0x000fffff window]
[    0.185764] pci_bus 0000:00: root bus resource [mem 0x80000000-0xdfffffff window]
[    0.185768] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.185782] pci 0000:00:00.0: [8086:2280] type 00 class 0x060000
[    0.186094] pci 0000:00:02.0: [8086:22b1] type 00 class 0x030000
[    0.186121] pci 0000:00:02.0: reg 0x10: [mem 0x90000000-0x90ffffff 64bit]
[    0.186134] pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff 64bit pref]
[    0.186144] pci 0000:00:02.0: reg 0x20: [io  0x2000-0x203f]
[    0.186383] pci 0000:00:13.0: [8086:22a3] type 00 class 0x010601
[    0.186451] pci 0000:00:13.0: reg 0x20: [io  0x2060-0x207f]
[    0.186463] pci 0000:00:13.0: reg 0x24: [mem 0x91414000-0x914147ff]
[    0.186530] pci 0000:00:13.0: PME# supported from D3hot
[    0.186706] pci 0000:00:14.0: [8086:22b5] type 00 class 0x0c0330
[    0.186740] pci 0000:00:14.0: reg 0x10: [mem 0x91400000-0x9140ffff 64bit]
[    0.186842] pci 0000:00:14.0: PME# supported from D3hot D3cold
[    0.187048] pci 0000:00:1a.0: [8086:2298] type 00 class 0x108000
[    0.187077] pci 0000:00:1a.0: reg 0x10: [mem 0x91300000-0x913fffff]
[    0.187090] pci 0000:00:1a.0: reg 0x14: [mem 0x91200000-0x912fffff]
[    0.187181] pci 0000:00:1a.0: PME# supported from D0 D3hot
[    0.187420] pci 0000:00:1b.0: [8086:2284] type 00 class 0x040300
[    0.187458] pci 0000:00:1b.0: reg 0x10: [mem 0x91410000-0x91413fff 64bit]
[    0.190086] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[    0.190258] pci 0000:00:1c.0: [8086:22c8] type 01 class 0x060400
[    0.190376] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[    0.190557] pci 0000:00:1c.1: [8086:22ca] type 01 class 0x060400
[    0.190677] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[    0.190859] pci 0000:00:1c.3: [8086:22ce] type 01 class 0x060400
[    0.190977] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
[    0.191166] pci 0000:00:1f.0: [8086:229c] type 00 class 0x060100
[    0.191457] pci 0000:00:1f.3: [8086:2292] type 00 class 0x0c0500
[    0.191527] pci 0000:00:1f.3: reg 0x10: [mem 0x91415000-0x9141501f]
[    0.191644] pci 0000:00:1f.3: reg 0x20: [io  0x2040-0x205f]
[    0.192037] pci 0000:00:1c.0: PCI bridge to [bus 01]
[    0.192167] pci 0000:02:00.0: [1b21:0612] type 00 class 0x010601
[    0.192204] pci 0000:02:00.0: reg 0x10: [io  0x1028-0x102f]
[    0.192220] pci 0000:02:00.0: reg 0x14: [io  0x1034-0x1037]
[    0.192235] pci 0000:02:00.0: reg 0x18: [io  0x1020-0x1027]
[    0.192250] pci 0000:02:00.0: reg 0x1c: [io  0x1030-0x1033]
[    0.192265] pci 0000:02:00.0: reg 0x20: [io  0x1000-0x101f]
[    0.192281] pci 0000:02:00.0: reg 0x24: [mem 0x91100000-0x911001ff]
[    0.192297] pci 0000:02:00.0: reg 0x30: [mem 0xffff0000-0xffffffff pref]
[    0.192492] pci 0000:00:1c.1: PCI bridge to [bus 02]
[    0.192499] pci 0000:00:1c.1:   bridge window [io  0x1000-0x1fff]
[    0.192505] pci 0000:00:1c.1:   bridge window [mem 0x91100000-0x911fffff]
[    0.192635] pci 0000:03:00.0: [14e4:16b1] type 00 class 0x020000
[    0.192695] pci 0000:03:00.0: reg 0x10: [mem 0x91010000-0x9101ffff 64bit pref]
[    0.192721] pci 0000:03:00.0: reg 0x18: [mem 0x91000000-0x9100ffff 64bit pref]
[    0.192770] pci 0000:03:00.0: reg 0x30: [mem 0xfffff800-0xffffffff pref]
[    0.192910] pci 0000:03:00.0: PME# supported from D0 D3hot D3cold
[    0.220048] pci 0000:00:1c.3: PCI bridge to [bus 03]
[    0.220063] pci 0000:00:1c.3:   bridge window [mem 0x91000000-0x910fffff 64bit pref]
[    0.222786] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 10 11 12 14 15) *7
[    0.222930] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 *10 11 12 14 15)
[    0.223072] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 10 *11 12 14 15)
[    0.223214] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 *10 11 12 14 15)
[    0.223357] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 10 *11 12 14 15)
[    0.223499] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 10 *11 12 14 15)
[    0.223641] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 10 11 12 14 15) *7
[    0.223794] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
[    0.225130] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.225130] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.225130] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.225130] vgaarb: loaded
[    0.225130] EDAC MC: Ver: 3.0.0
[    0.225130] PCI: Using ACPI for IRQ routing
[    0.225130] PCI: pci_cache_line_size set to 64 bytes
[    0.225130] e820: reserve RAM buffer [mem 0x0009f800-0x0009ffff]
[    0.225130] e820: reserve RAM buffer [mem 0x7a4bf000-0x7bffffff]
[    0.225130] NetLabel: Initializing
[    0.225130] NetLabel:  domain hash size = 128
[    0.225130] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[    0.225130] NetLabel:  unlabeled traffic allowed by default
[    0.225130] clocksource: Switched to clocksource refined-jiffies
[    0.250017] VFS: Disk quotas dquot_6.6.0
[    0.250017] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.250017] pnp: PnP ACPI init
[    0.250017] system 00:00: [io  0x0680-0x069f] has been reserved
[    0.250017] system 00:00: [io  0x0400-0x047f] could not be reserved
[    0.250017] system 00:00: [io  0x0500-0x05fe] has been reserved
[    0.250017] system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.250564] pnp 00:01: Plug and Play ACPI device, IDs PNP0f03 PNP0f13 (active)
[    0.253037] system 00:02: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.253216] system 00:03: [mem 0xe0000000-0xefffffff] could not be reserved
[    0.253221] system 00:03: [mem 0xfea00000-0xfeafffff] has been reserved
[    0.253225] system 00:03: [mem 0xfed01000-0xfed01fff] has been reserved
[    0.253228] system 00:03: [mem 0xfed03000-0xfed03fff] has been reserved
[    0.253231] system 00:03: [mem 0xfed06000-0xfed06fff] has been reserved
[    0.253235] system 00:03: [mem 0xfed08000-0xfed09fff] has been reserved
[    0.253239] system 00:03: [mem 0xfed80000-0xfedbffff] could not be reserved
[    0.253242] system 00:03: [mem 0xfed1c000-0xfed1cfff] has been reserved
[    0.253245] system 00:03: [mem 0xfee00000-0xfeefffff] could not be reserved
[    0.253255] system 00:03: Plug and Play ACPI device, IDs PNP0c02 (active)
[    0.253535] pnp 00:04: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.253837] pnp: PnP ACPI: found 5 devices
[    0.262281] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.262328] clocksource: Switched to clocksource acpi_pm
[    0.262341] pci 0000:02:00.0: can't claim BAR 6 [mem 0xffff0000-0xffffffff pref]: no compatible bridge window
[    0.262346] pci 0000:03:00.0: can't claim BAR 6 [mem 0xfffff800-0xffffffff pref]: no compatible bridge window
[    0.262369] pci 0000:00:1c.0: bridge window [io  0x1000-0x0fff] to [bus 01] add_size 1000
[    0.262375] pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 01] add_size 200000 add_align 100000
[    0.262379] pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff] to [bus 01] add_size 200000 add_align 100000
[    0.262416] pci 0000:00:1c.0: BAR 14: assigned [mem 0x91500000-0x916fffff]
[    0.262426] pci 0000:00:1c.0: BAR 15: assigned [mem 0x91700000-0x918fffff 64bit pref]
[    0.262432] pci 0000:00:1c.3: BAR 14: assigned [mem 0x91900000-0x919fffff]
[    0.262438] pci 0000:00:1c.0: BAR 13: assigned [io  0x3000-0x3fff]
[    0.262444] pci 0000:00:1c.0: PCI bridge to [bus 01]
[    0.262449] pci 0000:00:1c.0:   bridge window [io  0x3000-0x3fff]
[    0.262456] pci 0000:00:1c.0:   bridge window [mem 0x91500000-0x916fffff]
[    0.262462] pci 0000:00:1c.0:   bridge window [mem 0x91700000-0x918fffff 64bit pref]
[    0.262473] pci 0000:02:00.0: BAR 6: assigned [mem 0x91110000-0x9111ffff pref]
[    0.262477] pci 0000:00:1c.1: PCI bridge to [bus 02]
[    0.262481] pci 0000:00:1c.1:   bridge window [io  0x1000-0x1fff]
[    0.262488] pci 0000:00:1c.1:   bridge window [mem 0x91100000-0x911fffff]
[    0.262502] pci 0000:03:00.0: BAR 6: assigned [mem 0x91900000-0x919007ff pref]
[    0.262505] pci 0000:00:1c.3: PCI bridge to [bus 03]
[    0.262512] pci 0000:00:1c.3:   bridge window [mem 0x91900000-0x919fffff]
[    0.262518] pci 0000:00:1c.3:   bridge window [mem 0x91000000-0x910fffff 64bit pref]
[    0.262528] pci_bus 0000:00: resource 4 [io  0x0070-0x0077]
[    0.262531] pci_bus 0000:00: resource 5 [io  0x0000-0x006f window]
[    0.262534] pci_bus 0000:00: resource 6 [io  0x0078-0x0cf7 window]
[    0.262537] pci_bus 0000:00: resource 7 [io  0x0d00-0xffff window]
[    0.262540] pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000bffff window]
[    0.262543] pci_bus 0000:00: resource 9 [mem 0x000c0000-0x000dffff window]
[    0.262547] pci_bus 0000:00: resource 10 [mem 0x000e0000-0x000fffff window]
[    0.262550] pci_bus 0000:00: resource 11 [mem 0x80000000-0xdfffffff window]
[    0.262553] pci_bus 0000:01: resource 0 [io  0x3000-0x3fff]
[    0.262556] pci_bus 0000:01: resource 1 [mem 0x91500000-0x916fffff]
[    0.262559] pci_bus 0000:01: resource 2 [mem 0x91700000-0x918fffff 64bit pref]
[    0.262563] pci_bus 0000:02: resource 0 [io  0x1000-0x1fff]
[    0.262566] pci_bus 0000:02: resource 1 [mem 0x91100000-0x911fffff]
[    0.262569] pci_bus 0000:03: resource 1 [mem 0x91900000-0x919fffff]
[    0.262572] pci_bus 0000:03: resource 2 [mem 0x91000000-0x910fffff 64bit pref]
[    0.262813] NET: Registered protocol family 2
[    0.263136] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[    0.263221] TCP bind hash table entries: 16384 (order: 6, 262144 bytes)
[    0.263315] TCP: Hash tables configured (established 16384 bind 16384)
[    0.263395] UDP hash table entries: 1024 (order: 3, 32768 bytes)
[    0.263418] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes)
[    0.263527] NET: Registered protocol family 1
[    0.263561] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.265830] PCI: CLS 64 bytes, default 64
[    0.265927] Unpacking initramfs...
[    0.549565] Freeing initrd memory: 10928K
[    0.549653] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x171024fa93b, max_idle_ns: 440795253189 ns
[    0.549743] clocksource: Switched to clocksource tsc
[    0.549953] Scanning for low memory corruption every 60 seconds
[    0.551092] Initialise system trusted keyrings
[    0.551118] Key type blacklist registered
[    0.551244] workingset: timestamp_bits=41 max_order=19 bucket_order=0
[    0.553651] zbud: loaded
[    0.556846] Key type asymmetric registered
[    0.556941] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
[    0.557014] io scheduler noop registered
[    0.557016] io scheduler deadline registered (default)
[    0.557117] io scheduler cfq registered
[    0.557120] io scheduler mq-deadline registered
[    0.557121] io scheduler kyber registered
[    0.557177] io scheduler bfq registered
[    0.558019] efifb: probing for efifb
[    0.558037] efifb: framebuffer at 0xa0000, using 64k, total 64k
[    0.558039] efifb: mode is 640x480x1, linelength=80, pages=1
[    0.558040] efifb: scrolling: redraw
[    0.558043] efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
[    0.561405] Console: switching to colour frame buffer device 80x30
[    0.564576] fb0: EFI VGA frame buffer device
[    0.564598] intel_idle: MWAIT substates: 0x33000020
[    0.564600] intel_idle: v0.4.1 model 0x4C
[    0.564934] intel_idle: lapic_timer_reliable_states 0xffffffff
[    0.569156] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.590399] serial8250: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    0.611992] serial8250: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[    0.613868] rtc_cmos 00:04: RTC can wake from S4
[    0.613890] rtc_cmos: probe of 00:04 failed with error -16
[    0.613928] intel_pstate: Intel P-state driver initializing
[    0.614857] ledtrig-cpu: registered to indicate activity on CPUs
[    0.615073] vlv2_plat_clk vlv2_plat_clk: vlv2_plat_clk initialized
[    0.616916] NET: Registered protocol family 10
[    0.642223] Segment Routing with IPv6
[    0.642317] NET: Registered protocol family 17
[    0.644169] RAS: Correctable Errors collector initialized.
[    0.644326] microcode: sig=0x406c4, pf=0x1, revision=0x40a
[    0.644972] microcode: Microcode Update Driver: v2.2.
[    0.645021] sched_clock: Marking stable (644933940, 0)->(651408963, -6475023)
[    0.646322] registered taskstats version 1
[    0.646349] Loading compiled-in X.509 certificates
[    0.646425] zswap: loaded using pool lzo/zbud
[    0.664438] Key type big_key registered
[    0.665896]   Magic number: 2:202:992
[    0.666099] hctosys: unable to open rtc device (rtc0)
[    0.683524] Freeing unused kernel memory: 1416K
[    0.740289] Write protecting the kernel read-only data: 16384k
[    0.743601] Freeing unused kernel memory: 2016K
[    0.761528] Freeing unused kernel memory: 1260K
[    0.812845] Linux agpgart interface v0.103
[    0.833714] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:01/input/input0
[    0.833736] ACPI: Power Button [PWR2]
[    0.833845] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1
[    0.833860] ACPI: Sleep Button [SLPB]
[    0.833932] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
[    0.834064] ACPI: Power Button [PWRF]
[    0.881358] [drm] Memory usable by graphics device = 2048M
[    0.881363] checking generic (a0000 10000) vs hw (80000000 10000000)
[    0.881365] fb: switching to inteldrmfb from EFI VGA
[    0.881404] Console: switching to colour dummy device 80x25
[    0.882120] [drm] Replacing VGA console driver
[    0.882263] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    0.882264] [drm] Driver supports precise vblank timestamp query.
[    0.903423] i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem
[    0.946254] [drm] Initialized i915 1.6.0 20170818 for 0000:00:02.0 on minor 0
[    0.949696] ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
[    0.951376] acpi device:2b: registered as cooling_device4
[    0.951545] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input3
[    1.143077] random: fast init done
[    1.288068] fbcon: inteldrmfb (fb0) is primary device
[    1.405918] Console: switching to colour frame buffer device 240x67
[    1.420137] NOHZ: local_softirq_pending 282
[    1.438960] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
[    1.500025] NOHZ: local_softirq_pending 80
[    1.615465] i8042: PNP: PS/2 Controller [PNP0f03:PS2M] at 0x60,0x64 irq 12
[    1.615468] i8042: PNP: PS/2 controller doesn't have KBD irq; using default 1
[    1.616063] serio: i8042 KBD port at 0x60,0x64 irq 1
[    1.616072] serio: i8042 AUX port at 0x60,0x64 irq 12
[    1.632748] SCSI subsystem initialized
[    1.635389] ACPI: bus type USB registered
[    1.635434] usbcore: registered new interface driver usbfs
[    1.635454] usbcore: registered new interface driver hub
[    1.635497] usbcore: registered new device driver usb
[    1.638864] libata version 3.00 loaded.
[    1.640495] xhci_hcd 0000:00:14.0: xHCI Host Controller
[    1.640508] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1
[    1.641680] xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x01509810
[    1.641693] xhci_hcd 0000:00:14.0: cache line size of 64 is not supported
[    1.642647] hub 1-0:1.0: USB hub found
[    1.642738] hub 1-0:1.0: 7 ports detected
[    1.644206] xhci_hcd 0000:00:14.0: xHCI Host Controller
[    1.644214] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2
[    1.644222] xhci_hcd 0000:00:14.0: Host supports USB 3.0  SuperSpeed
[    1.644721] hub 2-0:1.0: USB hub found
[    1.644754] hub 2-0:1.0: 6 ports detected
[    1.645645] ahci 0000:00:13.0: version 3.0
[    1.645946] ahci 0000:00:13.0: AHCI 0001.0301 32 slots 2 ports 6 Gbps 0x3 impl SATA mode
[    1.645952] ahci 0000:00:13.0: flags: 64bit ncq led clo only pio slum part deso sadm sds apst 
[    1.650183] scsi host0: ahci
[    1.660156] scsi host1: ahci
[    1.660286] ata1: SATA max UDMA/133 abar m2048@0x91414000 port 0x91414100 irq 117
[    1.660294] ata2: SATA max UDMA/133 abar m2048@0x91414000 port 0x91414180 irq 117
[    1.660629] ahci 0000:02:00.0: SSS flag set, parallel bus scan disabled
[    1.660677] ahci 0000:02:00.0: AHCI 0001.0200 32 slots 2 ports 6 Gbps 0x3 impl SATA mode
[    1.660681] ahci 0000:02:00.0: flags: 64bit ncq sntf stag led clo pmp pio slum part ccc sxs 
[    1.664476] scsi host2: ahci
[    1.666006] scsi host3: ahci
[    1.666112] ata3: SATA max UDMA/133 abar m512@0x91100000 port 0x91100100 irq 118
[    1.666116] ata4: SATA max UDMA/133 abar m512@0x91100000 port 0x91100180 irq 118
[    1.993802] ata2: SATA link down (SStatus 0 SControl 300)
[    1.994036] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    1.994135] ata3: SATA link down (SStatus 0 SControl 300)
[    1.994691] ata1.00: ATA-9: SanDisk SDSSDP128G, 2.0.0, max UDMA/133
[    1.994704] ata1.00: 250069680 sectors, multi 1: LBA48 NCQ (depth 31/32)
[    1.995532] ata1.00: configured for UDMA/133
[    1.996378] scsi 0:0:0:0: Direct-Access     ATA      SanDisk SDSSDP12 0    PQ: 0 ANSI: 5
[    2.010179] usb 1-2: new full-speed USB device number 2 using xhci_hcd
[    2.205794] hidraw: raw HID events driver (C) Jiri Kosina
[    2.210106] NOHZ: local_softirq_pending 282
[    2.210517] usbcore: registered new interface driver usbhid
[    2.210520] usbhid: USB HID core driver
[    2.214499] hid-generic 0003:0764:0501.0001: hiddev0,hidraw0: USB HID v1.10 Device [CPS CP1000PFCLCD] on usb-0000:00:14.0-2/input0
[    2.323295] ata4: SATA link down (SStatus 0 SControl 300)
[    2.335017] sd 0:0:0:0: [sda] 250069680 512-byte logical blocks: (128 GB/119 GiB)
[    2.335043] sd 0:0:0:0: [sda] Write Protect is off
[    2.335046] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    2.335087] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    2.337038]  sda: sda1 sda2
[    2.338242] sd 0:0:0:0: [sda] Attached SCSI disk
[    2.340044] usb 1-3: new high-speed USB device number 3 using xhci_hcd
[    2.535350] usb-storage 1-3:1.0: USB Mass Storage device detected
[    2.536872] scsi host4: usb-storage 1-3:1.0
[    2.537042] usbcore: registered new interface driver usb-storage
[    2.537944] usbcore: registered new interface driver uas
[    2.560162] raid6: sse2x1   gen()  1632 MB/s
[    2.690209] usb 1-5: new low-speed USB device number 4 using xhci_hcd
[    2.730154] raid6: sse2x1   xor()  2382 MB/s
[    2.900146] raid6: sse2x2   gen()  2878 MB/s
[    2.921950] input: HID 04d9:1203 as /devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.0/0003:04D9:1203.0002/input/input6
[    3.000621] hid-generic 0003:04D9:1203.0002: input,hidraw1: USB HID v1.11 Keyboard [HID 04d9:1203] on usb-0000:00:14.0-5/input0
[    3.014365] input: HID 04d9:1203 as /devices/pci0000:00/0000:00:14.0/usb1/1-5/1-5:1.1/0003:04D9:1203.0003/input/input7
[    3.070151] raid6: sse2x2   xor()  2756 MB/s
[    3.090575] hid-generic 0003:04D9:1203.0003: input,hidraw2: USB HID v1.11 Device [HID 04d9:1203] on usb-0000:00:14.0-5/input1
[    3.130142] NOHZ: local_softirq_pending 02
[    3.150152] NOHZ: local_softirq_pending 02
[    3.170176] NOHZ: local_softirq_pending 02
[    3.190152] NOHZ: local_softirq_pending 02
[    3.210152] NOHZ: local_softirq_pending 02
[    3.230183] NOHZ: local_softirq_pending 02
[    3.240174] raid6: sse2x4   gen()  2324 MB/s
[    3.250152] NOHZ: local_softirq_pending 02
[    3.410150] raid6: sse2x4   xor()  2165 MB/s
[    3.410153] raid6: using algorithm sse2x2 gen() 2878 MB/s
[    3.410154] raid6: .... xor() 2756 MB/s, rmw enabled
[    3.410155] raid6: using ssse3x2 recovery algorithm
[    3.417653] xor: measuring software checksum speed
[    3.510187]    prefetch64-sse:  7062.000 MB/sec
[    3.591630] scsi 4:0:0:0: Direct-Access     ADATA    IUM01-512MFHL    0100 PQ: 0 ANSI: 0 CCS
[    3.593553] sd 4:0:0:0: [sdb] 1007616 512-byte logical blocks: (516 MB/492 MiB)
[    3.594300] sd 4:0:0:0: [sdb] Write Protect is off
[    3.594304] sd 4:0:0:0: [sdb] Mode Sense: 43 00 00 00
[    3.595001] sd 4:0:0:0: [sdb] No Caching mode page found
[    3.595077] sd 4:0:0:0: [sdb] Assuming drive cache: write through
[    3.606892]  sdb: sdb1 sdb2 sdb3
[    3.610015]    generic_sse:  6374.000 MB/sec
[    3.610019] xor: using function: prefetch64-sse (7062.000 MB/sec)
[    3.611870] sd 4:0:0:0: [sdb] Attached SCSI removable disk
[    3.641704] Btrfs loaded, crc32c=crc32c-intel
[    3.642682] BTRFS: device fsid 6c67a5cc-1d8c-4a16-9993-022d57fdfddc devid 1 transid 335 /dev/sda2
[    3.863244] PM: Starting manual resume from disk
[    3.863662] PM: Image not found (code -22)
[    3.922130] BTRFS info (device sda2): disk space caching is enabled
[    3.922134] BTRFS info (device sda2): has skinny extents
[    3.930815] BTRFS info (device sda2): enabling ssd optimizations
[    4.209488] ip_tables: (C) 2000-2006 Netfilter Core Team
[    4.219225] systemd[1]: systemd 239 running in system mode. (+PAM -AUDIT -SELINUX -IMA -APPARMOR +SMACK -SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN +PCRE2 default-hierarchy=hybrid)
[    4.240559] systemd[1]: Detected architecture x86-64.
[    4.247538] systemd[1]: Set hostname to <ArchServer>.
[    4.427810] random: systemd: uninitialized urandom read (16 bytes read)
[    4.427842] systemd[1]: Reached target Login Prompts.
[    4.427981] random: systemd: uninitialized urandom read (16 bytes read)
[    4.436711] systemd[1]: Listening on Process Core Dump Socket.
[    4.436800] random: systemd: uninitialized urandom read (16 bytes read)
[    4.437049] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    4.438273] systemd[1]: Listening on LVM2 poll daemon socket.
[    4.440735] systemd[1]: Created slice User and Session Slice.
[    4.441021] systemd[1]: Listening on Network Service Netlink Socket.
[    4.442475] systemd[1]: Created slice system-getty.slice.
[    4.485763] BTRFS info (device sda2): disk space caching is enabled
[    4.613042] systemd-journald[249]: Received request to flush runtime journal from PID 1
[    4.773076] systemd-journald[249]: File /var/log/journal/6389085b159746b7b628074e9816e593/system.journal corrupted or uncleanly shut down, renaming and replacing.
[    4.832475] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[    4.833720] (NULL device *): hwmon_device_register() is deprecated. Please convert the driver to use hwmon_device_register_with_info().
[    4.833840] thermal LNXTHERM:00: registered as thermal_zone0
[    4.833842] ACPI: Thermal Zone [TZ01] (27 C)
[    4.834608] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
[    4.870719] pps_core: LinuxPPS API ver. 1 registered
[    4.870722] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    4.874997] input: PC Speaker as /devices/platform/pcspkr/input/input8
[    4.891552] PTP clock support registered
[    4.928118] SSE version of gcm_enc/dec engaged.
[    4.971828] tg3.c:v3.137 (May 11, 2014)
[    5.002545] snd_hda_intel 0000:00:1b.0: bound 0000:00:02.0 (ops i915_audio_component_bind_ops [i915])
[    5.034867] Adding 8388604k swap on /dev/sda1.  Priority:-2 extents:1 across:8388604k SSFS
[    5.052613] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10
[    5.052729] input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input11
[    5.134622] intel_rapl: Found RAPL domain package
[    5.134626] intel_rapl: Found RAPL domain core
[    5.906948] tg3 0000:03:00.0 eth0: Tigon3 [partno(BCM57781) rev 57785100] (PCI Express) MAC address 10:bf:48:8b:7a:f5
[    5.906958] tg3 0000:03:00.0 eth0: attached PHY is 57765 (10/100/1000Base-T Ethernet) (WireSpeed[1], EEE[1])
[    5.906964] tg3 0000:03:00.0 eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[0] TSOcap[1]
[    5.906969] tg3 0000:03:00.0 eth0: dma_rwctrl[00000001] dma_mask[64-bit]
[    5.912488] tg3 0000:03:00.0 enp3s0: renamed from eth0
[    6.043003] IPv6: ADDRCONF(NETDEV_UP): enp3s0: link is not ready
[    9.764321] tg3 0000:03:00.0 enp3s0: Link is up at 1000 Mbps, full duplex
[    9.764362] tg3 0000:03:00.0 enp3s0: Flow control is on for TX and on for RX
[    9.764377] tg3 0000:03:00.0 enp3s0: EEE is enabled
[    9.764443] IPv6: ADDRCONF(NETDEV_CHANGE): enp3s0: link becomes ready
[   35.439292] random: crng init done
[   35.439305] random: 7 urandom warning(s) missed due to ratelimiting
[   35.781641] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
[   35.784728] Bridge firewalling registered
[   35.805314] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[   36.346549] Initializing XFRM netlink socket
[   36.356952] Netfilter messages via NETLINK v0.30.
[   36.362268] ctnetlink v0.93: registering with nfnetlink.
[   36.911306] IPv6: ADDRCONF(NETDEV_UP): docker0: link is not ready
[   38.086044] docker0: port 1(veth5b3c938) entered blocking state
[   38.086049] docker0: port 1(veth5b3c938) entered disabled state
[   38.086151] device veth5b3c938 entered promiscuous mode
[   38.086293] IPv6: ADDRCONF(NETDEV_UP): veth5b3c938: link is not ready
[   38.612416] eth0: renamed from veth6c74c1f
[   38.651710] IPv6: ADDRCONF(NETDEV_CHANGE): veth5b3c938: link becomes ready
[   38.651872] docker0: port 1(veth5b3c938) entered blocking state
[   38.651883] docker0: port 1(veth5b3c938) entered forwarding state
[   38.652051] IPv6: ADDRCONF(NETDEV_CHANGE): docker0: link becomes ready

You can see my resume kernel parameter, even though I'm not using hibernate (yet?) and it shouldn't conflict with this issue, correct?

[root@ArchServer ~]# blkid
/dev/sda1: UUID="ec056a40-708f-470b-9c3d-4a0d5d44f590" TYPE="swap" PARTUUID="dc0e38bd-01"
/dev/sda2: UUID="6c67a5cc-1d8c-4a16-9993-022d57fdfddc" UUID_SUB="7b771c56-9db7-4e42-989c-6edbf39a794f" TYPE="btrfs" PARTUUID="dc0e38bd-02"
/dev/sdb1: SEC_TYPE="msdos" UUID="D23B-9538" TYPE="vfat" PARTLABEL="EFI system Partition" PARTUUID="44bd8886-a310-4eb2-a113-3b469e290b0a"
/dev/sdb2: UUID="fedc0a1d-291a-4be5-922d-c2bf5d7df7d2" TYPE="ext4" PARTLABEL="Linux data" PARTUUID="6389a74b-5e65-4b7c-a680-60e077b02495"
/dev/sdb3: UUID="7cd00f7d-f83a-40fe-9db8-70a315c87925" TYPE="ext4" PARTLABEL="Linux data" PARTUUID="048ee7a4-8451-4e4c-aff5-63bced9e3128"

And here's the last entry from journalctl, similar to the other issues:

Sep 02 08:45:42 ArchServer systemd[1]: Startup finished in 4.056s (kernel) + 28.615s (userspace) = 32.672s.
Sep 02 08:45:43 ArchServer systemd-networkd[336]: docker0: Gained IPv6LL
Sep 02 08:45:43 ArchServer systemd-networkd[336]: vethc52dfbf: Gained IPv6LL
Sep 02 08:46:23 ArchServer sshd[714]: Accepted password for root from 192.168.10.104 port 46586 ssh2
Sep 02 08:46:23 ArchServer sshd[714]: pam_unix(sshd:session): session opened for user root by (uid=0)
Sep 02 08:46:23 ArchServer systemd[1]: Started /run/user/0 mount wrapper.
Sep 02 08:46:23 ArchServer systemd[1]: Created slice User Slice of UID 0.
Sep 02 08:46:23 ArchServer systemd[1]: Starting User Manager for UID 0...
Sep 02 08:46:23 ArchServer systemd-logind[343]: New session c2 of user root.
Sep 02 08:46:23 ArchServer systemd[1]: Started Session c2 of user root.
Sep 02 08:46:23 ArchServer systemd[717]: pam_unix(systemd-user:session): session opened for user root by (uid=0)
Sep 02 08:46:23 ArchServer systemd[717]: Listening on p11-kit server.
Sep 02 08:46:23 ArchServer systemd[717]: Starting D-Bus User Message Bus Socket.
Sep 02 08:46:23 ArchServer systemd[717]: Listening on GnuPG network certificate management daemon.
Sep 02 08:46:23 ArchServer systemd[717]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Sep 02 08:46:23 ArchServer systemd[717]: Listening on GnuPG cryptographic agent and passphrase cache.
Sep 02 08:46:23 ArchServer systemd[717]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Sep 02 08:46:23 ArchServer systemd[717]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Sep 02 08:46:23 ArchServer systemd[717]: Reached target Paths.
Sep 02 08:46:23 ArchServer systemd[717]: Reached target Timers.
Sep 02 08:46:23 ArchServer systemd[717]: Listening on D-Bus User Message Bus Socket.
Sep 02 08:46:23 ArchServer systemd[717]: Reached target Sockets.
Sep 02 08:46:23 ArchServer systemd[717]: Reached target Basic System.
Sep 02 08:46:23 ArchServer systemd[1]: Started User Manager for UID 0.
Sep 02 08:46:23 ArchServer systemd[717]: Reached target Default.
Sep 02 08:46:23 ArchServer systemd[717]: Startup finished in 104ms.
Sep 02 08:46:42 ArchServer systemd[1]: Reached target Sleep.
Sep 02 08:46:42 ArchServer systemd[1]: Starting Suspend...
Sep 02 08:46:42 ArchServer systemd[1]: Stopping Kodi standalone...
Sep 02 08:46:42 ArchServer pulseaudio[374]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Sep 02 08:46:42 ArchServer pulseaudio[374]:       after 12 requests (6 known processed) with 0 events remaining.
Sep 02 08:46:42 ArchServer systemd[354]: pulseaudio.service: Main process exited, code=exited, status=1/FAILURE
Sep 02 08:46:42 ArchServer systemd[354]: pulseaudio.service: Failed with result 'exit-code'.
Sep 02 08:46:42 ArchServer systemd[354]: pulseaudio.service: Service RestartSec=100ms expired, scheduling restart.
Sep 02 08:46:42 ArchServer systemd[354]: pulseaudio.service: Scheduled restart job, restart counter is at 1.
Sep 02 08:46:42 ArchServer systemd[354]: Stopped Sound Service.
Sep 02 08:46:42 ArchServer systemd[354]: Starting Sound Service...
Sep 02 08:46:42 ArchServer rtkit-daemon[375]: Successfully made thread 732 of process 732 (/usr/bin/pulseaudio) owned by '420' high priority at nice level >
Sep 02 08:46:42 ArchServer rtkit-daemon[375]: Supervising 1 threads of 1 processes of 1 users.
Sep 02 08:46:42 ArchServer pulseaudio[732]: W: [pulseaudio] pid.c: Stale PID file, overwriting.
Sep 02 08:46:42 ArchServer systemd[354]: Started Sound Service.
Sep 02 08:46:42 ArchServer rtkit-daemon[375]: Supervising 1 threads of 1 processes of 1 users.
Sep 02 08:46:42 ArchServer rtkit-daemon[375]: Successfully made thread 736 of process 732 (/usr/bin/pulseaudio) owned by '420' RT at priority 5.
Sep 02 08:46:42 ArchServer rtkit-daemon[375]: Supervising 2 threads of 1 processes of 1 users.
Sep 02 08:46:43 ArchServer systemd[1]: kodi.service: Main process exited, code=exited, status=1/FAILURE
Sep 02 08:46:43 ArchServer systemd[1]: kodi.service: Failed with result 'exit-code'.
Sep 02 08:46:43 ArchServer systemd[1]: Stopped Kodi standalone.
Sep 02 08:46:43 ArchServer systemd-logind[343]: Session c1 logged out. Waiting for processes to exit.
Sep 02 08:46:43 ArchServer systemd-logind[343]: Removed session c1.
Sep 02 08:46:43 ArchServer kernel: PM: suspend entry (deep)
Sep 02 08:46:43 ArchServer systemd-sleep[727]: Suspending system...
Sep 02 08:46:43 ArchServer systemd[1]: user-runtime-dir@420.service: Unit not needed anymore. Stopping.
-- Reboot --
Sep 02 08:54:15 ArchServer kernel: Linux version 4.14.67-1-lts (builduser@andyrtr) (gcc version 8.2.0 (GCC)) #1 SMP Fri Aug 24 16:54:09 CEST 2018
Sep 02 08:54:15 ArchServer kernel: Command line: BOOT_IMAGE=/boot/vmlinuz-linux-lts root=UUID=6c67a5cc-1d8c-4a16-9993-022d57fdfddc rw quiet resume=UUID=ec0>
...

This behavior occurs no matter the system state.  I've tried it with the kodi service disabled, enabled, issued suspend over ssh, through the kodi interface, nothing seems to bring the system back.  The network is also dead, so I can't ssh in to troubleshoot.  Odd thing is, resume did work just yesterday on this same hardware, sans the SSD.  I was testing the difference between HDD and SSD.  Had the exact same setup with HDD and resume would work.  Very odd.

Disclaimer: this is a funky Asustor NAS hack-job.  They have some really strange UEFI boot things taking place.  Every single time I boot the system I have to go into boot menu and choose the SSD.  I'm not quite ready to remove the DOM or overwrite it yet.  Changing the boot order in BIOS does not allow the system to boot from the SSD.  I wonder if there is some hidden UEFI function which forces the system to try and read from the DOM on resume?

Thanks for any help, I'd really like to get this fixed!

Offline

#2 2018-09-03 06:03:52

seth
Member
Registered: 2012-09-03
Posts: 8,665

Re: Resume after suspend broken

cat /proc/acpi/wakeup ?

Offline

#3 2018-09-04 23:44:13

Naruni
Member
Registered: 2010-08-05
Posts: 34

Re: Resume after suspend broken

Hi seth, thanks for the reply.  I do see that there is no S3 capability here, although the device advertises it.  I went into the mobo's BIOS config, and confirmed all ACPI Table / Features are enabled (including DSDT - ACPI S3 Support).  The does remind me about the ACPI errors in dmesg, but not sure if they are related:

[root@ArchServer ~]# cat /proc/acpi/wakeup
Device  S-state   Status   Sysfs node
XHC1      S4    *enabled   pci:0000:00:14.0
BRCM      S0    *disabled
BRC1      S0    *disabled
HDEF      S4    *disabled  pci:0000:00:1b.0
RP01      S4    *disabled  pci:0000:00:1c.0
PXSX      S4    *disabled
RP02      S4    *disabled  pci:0000:00:1c.1
PXSX      S4    *disabled  pci:0000:02:00.0
RP03      S4    *disabled
PXSX      S4    *disabled
RP04      S4    *disabled  pci:0000:00:1c.3
PXSX      S4    *enabled   pci:0000:03:00.0
PWRB      S4    *disabled
[    0.140346] ACPI: bus type PCI registered
[    0.140346] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    0.140346] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000)
[    0.140346] PCI: MMCONFIG at [mem 0xe0000000-0xe3ffffff] reserved in E820
[    0.140346] PCI: Using configuration type 1 for base access
[    0.141563] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.141563] ACPI: Added _OSI(Module Device)
[    0.141563] ACPI: Added _OSI(Processor Device)
[    0.141563] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.141563] ACPI: Added _OSI(Processor Aggregator Device)
[    0.150978] ACPI: Dynamic OEM Table Load:
[    0.150994] ACPI: SSDT 0xFFFF92A7F732E800 000654 (v01 PmRef  Cpu0Ist  00003000 INTL 20130117)
[    0.151294] ACPI: Dynamic OEM Table Load:
[    0.151294] ACPI: SSDT 0xFFFF92A7F738F200 00015F (v01 PmRef  ApIst    00003000 INTL 20130117)
[    0.152495] ACPI: Interpreter enabled
[    0.152542] ACPI: (supports S0 S3 S4 S5)
[    0.152545] ACPI: Using IOAPIC for interrupt routing
[    0.152610] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.153525] ACPI: Enabled 8 GPEs in block 00 to 3F
[    0.161424] ACPI Error: Field [IURH] at bit offset/length 104/8 exceeds size of target Buffer (104 bits) (20170728/dsopcode-235)
[    0.161445] ACPI Error: Method parse/execution failed \_SB.PCI0.LPCB.SIO0.ECP._CRS, AE_AML_BUFFER_LIMIT (20170728/psparse-550)
[    0.161468] ACPI Error: Method execution failed \_SB.PCI0.LPCB.SIO0.ECP._CRS, AE_AML_BUFFER_LIMIT (20170728/uteval-103)
[    0.162083] ACPI: Power Resource [USBC] (on)
[    0.164683]  (null): Device [PWM1] is in always present list
[    0.169586] ACPI: Power Resource [CLK0] (on)
[    0.170240] ACPI: Power Resource [CLK0] (on)
[    0.170333] ACPI: Power Resource [CLK1] (on)
[    0.177416] ACPI: Power Resource [ID3C] (off)
[    0.182219]  (null): Device [GPED] is in always present list
[    0.183863] ACPI: Power Resource [FN00] (off)
[    0.184907] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.184918] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[    0.185034] acpi PNP0A08:00: _OSC failed (AE_ERROR); disabling ASPM
[    0.185059] acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge
[    0.185300] acpi PNP0A08:00: host bridge window expanded to [mem 0x80000000-0xdfffffff window]; [mem 0x80000000-0xdfffffff window] ignored

Offline

#4 2018-09-12 13:55:39

seth
Member
Registered: 2012-09-03
Posts: 8,665

Re: Resume after suspend broken

Hi, sorry for the delay.

S4 should™ wake from S3 as well.
ACPI errors are "standard" (means your board vendor poked his way to fit the MS OS of today, this is "normal")

I assume the keyboard is wired via USB?
You could try to enable "echo PWRB | sudo tee /proc/acpi/wakeup" and see whether the power button brings up the system.

Another thing is the SSD remark, the system may struggle to power it up. Since you say you have some ultra-hackish UEFI: does it allow you to not move SATA devices to D3 on S3? What about other SATA settings? (Using AHCI mode?)

Offline

Board footer

Powered by FluxBB