Re: pciehp 0000:00:1c.0:pcie004: Timeout on hotplug command 0x1038 (issued 65284 msec ago)

From: Paul Menzel
Date: Thu May 03 2018 - 04:49:54 EST


Dear Bjorn,


On 04/27/18 21:22, Bjorn Helgaas wrote:
[+cc Lukas, Sinan]

On Thu, Apr 26, 2018 at 12:17:53PM +0200, Paul Menzel wrote:

On the Lenovo X60t, during resume from ACPI suspend and during shutdown, the
message below is shown in the logs.

pciehp 0000:00:1c.0:pcie004: Timeout on hotplug command 0x1038 (issued
65284 msec ago)

This is an Intel root port:

00:1c.0 PCI bridge: Intel Corporation NM10/ICH7 Family PCI Express Port 1 (rev 02) (prog-if 00 [Normal decode])

and probably has the CF118 erratum (see
http://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git/commit/?id=3461a068661c
for details). I bet if you changed "msecs" in pcie_wait_cmd() to 30000
you'd see a 30 second delay during shutdown because we write a command to
tell the port not to generate any more hotplug interrupts, and we wait for
that command to complete, but the port never tells us it has completed.

Lukas reported a similar issue in
https://lkml.kernel.org/r/20180112104929.GA10599@xxxxxxxxx, which we sort
of worked around by assuming that Thunderbolt controllers never support
that "command complete" interrupt (see
http://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git/commit/?id=493fb50e958c)

Sinan mooted the idea of using a "no-wait" path of sending the "don't
generate hotplug interrupts" command. I think we should work on this
idea a little more. If we're shutting down the whole system, I can't
believe there's much value in *anything* we do in the pciehp_remove()
path.

Maybe we should just get rid of pciehp_remove() (and probably
pcie_port_remove_service() and the other service driver remove methods)
completely. That dates from when the service drivers could be modules that
could be potentially unloaded, but unloading them hasn't been possible for
years.

As far as the resume path, my guess is that in pciehp_resume(), we
write a command to enable interrupts, then it looks like we get a
PCI_EXP_SLTSTA_DLLSC "Link Up" interrupt, and apparently we issue
another command. Not sure exactly what's going on here.

Could you try the following patch? The idea is to (1) do nothing on
shutdown, so you should see no message and no delay, and (2) collect
more information about the resume path.


diff --git a/drivers/pci/hotplug/pciehp_core.c b/drivers/pci/hotplug/pciehp_core.c
index 332b723ff9e6..99751cc52968 100644
--- a/drivers/pci/hotplug/pciehp_core.c
+++ b/drivers/pci/hotplug/pciehp_core.c
@@ -260,14 +260,6 @@ static int pciehp_probe(struct pcie_device *dev)
return -ENODEV;
}
-static void pciehp_remove(struct pcie_device *dev)
-{
- struct controller *ctrl = get_service_data(dev);
-
- cleanup_slot(ctrl);
- pciehp_release_ctrl(ctrl);
-}
-
#ifdef CONFIG_PM
static int pciehp_suspend(struct pcie_device *dev)
{
@@ -305,7 +297,6 @@ static struct pcie_port_service_driver hpdriver_portdrv = {
.service = PCIE_PORT_SERVICE_HP,
.probe = pciehp_probe,
- .remove = pciehp_remove,
#ifdef CONFIG_PM
.suspend = pciehp_suspend,
diff --git a/drivers/pci/hotplug/pciehp_hpc.c b/drivers/pci/hotplug/pciehp_hpc.c
index 18a42f8f5dc5..c3a9c47ed061 100644
--- a/drivers/pci/hotplug/pciehp_hpc.c
+++ b/drivers/pci/hotplug/pciehp_hpc.c
@@ -113,7 +113,7 @@ static int pcie_poll_cmd(struct controller *ctrl, int timeout)
return 0; /* timeout */
}
-static void pcie_wait_cmd(struct controller *ctrl)
+static void pcie_wait_cmd(struct controller *ctrl, u16 cmd, u16 mask)
{
unsigned int msecs = pciehp_poll_mode ? 2500 : 1000;
unsigned long duration = msecs_to_jiffies(msecs);
@@ -155,10 +155,13 @@ static void pcie_wait_cmd(struct controller *ctrl)
* don't change those bits, e.g., commands that merely enable
* interrupts.
*/
- if (!rc)
- ctrl_info(ctrl, "Timeout on hotplug command %#06x (issued %u msec ago)\n",
+ if (!rc) {
+ ctrl_info(ctrl, "Timeout on hotplug command %#06x (issued %u msec ago), new command %#06x/mask %#06x\n",
ctrl->slot_ctrl,
- jiffies_to_msecs(jiffies - ctrl->cmd_started));
+ jiffies_to_msecs(jiffies - ctrl->cmd_started),
+ cmd, mask);
+ dump_stack();
+ }
}
static void pcie_do_write_cmd(struct controller *ctrl, u16 cmd,
@@ -172,7 +175,7 @@ static void pcie_do_write_cmd(struct controller *ctrl, u16 cmd,
/*
* Always wait for any previous command that might still be in progress
*/
- pcie_wait_cmd(ctrl);
+ pcie_wait_cmd(ctrl, cmd, mask);
pcie_capability_read_word(pdev, PCI_EXP_SLTCTL, &slot_ctrl);
if (slot_ctrl == (u16) ~0) {
@@ -193,7 +196,7 @@ static void pcie_do_write_cmd(struct controller *ctrl, u16 cmd,
* indicating completion of the above issued command.
*/
if (wait)
- pcie_wait_cmd(ctrl);
+ pcie_wait_cmd(ctrl, cmd, mask);
out:
mutex_unlock(&ctrl->ctrl_lock);


Thank you for the quick reply and sorry for only being able to test it now. Please find the relevant bits from the ACPI S3 suspend âactionâ below. The full log is attached.

```
[ 190.600060] pciehp 0000:00:1c.0:pcie004: Timeout on hotplug command 0x1038 (issued 190084 msec ago), new command 0x1038/mask 0x103b
[ 190.600065] CPU: 0 PID: 1290 Comm: kworker/u4:37 Not tainted 4.17.0-rc3+ #20
[ 190.600067] Hardware name: LENOVO 636338U/636338U, BIOS CBET4000 TIMELESS 01/01/1970
[ 190.600077] Workqueue: events_unbound async_run_entry_fn
[ 190.600079] Call Trace:
[ 190.600087] dump_stack+0x66/0xa6
[ 190.600092] pcie_wait_cmd+0x153/0x2b0
[ 190.600097] ? prepare_to_wait+0x190/0x190
[ 190.600100] pcie_do_write_cmd+0x54/0x130
[ 190.600104] ? radix_tree_lookup+0x14/0x20
[ 190.600108] ? suspend_iter+0x80/0x80
[ 190.600111] pcie_enable_notification+0x64/0x150
[ 190.600115] ? irq_set_irq_wake+0x6b/0x170
[ 190.600117] ? suspend_iter+0x80/0x80
[ 190.600121] pciehp_resume+0x28/0xa0
[ 190.600124] ? klist_next+0x2d/0x170
[ 190.600127] resume_iter+0x4b/0x80
[ 190.600131] device_for_each_child+0x61/0xb0
[ 190.600134] pcie_port_device_resume+0x14/0x20
[ 190.600139] pci_pm_resume+0x75/0x100
[ 190.600143] dpm_run_callback+0x47/0x1b0
[ 190.600146] ? pci_pm_thaw+0xd0/0xd0
[ 190.600149] device_resume+0x97/0x190
[ 190.600152] ? device_resume+0x190/0x190
[ 190.600155] async_resume+0x1e/0x50
[ 190.600158] async_run_entry_fn+0x61/0x3a0
[ 190.600162] ? try_to_wake_up+0x4d/0x790
[ 190.600166] ? __switch_to_asm+0x33/0x4c
[ 190.600171] process_one_work+0x235/0x690
[ 190.600175] worker_thread+0x19d/0x6a0
[ 190.600179] kthread+0x14a/0x1f0
[ 190.600182] ? process_one_work+0x690/0x690
[ 190.600185] ? kthread_create_worker_on_cpu+0x30/0x30
[ 190.600187] ret_from_fork+0x2e/0x38
[ 190.664162] call 0000:05:00.1+ returned 0 after 67611 usecs
[ 190.700252] call usb1+ returned 0 after 102522 usecs
[ 190.700259] call usb2+ returned 0 after 102481 usecs
[ 190.704238] call usb3+ returned 0 after 106349 usecs
[ 190.704433] call ACPI0003:00+ returned 0 after 109837 usecs
```


Kind regards,

Paul
[ 0.000000] Linux version 4.17.0-rc3+ (root@92c307fb9fe6) (gcc version 7.3.0 (Debian 7.3.0-17)) #20 SMP Thu May 3 06:16:45 UTC 2018
[ 0.000000] Disabled fast string operations
[ 0.000000] x86/fpu: x87 FPU will use FXSAVE
[ 0.000000] e820: BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x0000000000000fff] type 16
[ 0.000000] BIOS-e820: [mem 0x0000000000001000-0x000000000009ffff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000000c0000-0x00000000000fffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007f6fbfff] usable
[ 0.000000] BIOS-e820: [mem 0x000000007f6fc000-0x000000007f7fffff] type 16
[ 0.000000] BIOS-e820: [mem 0x000000007f800000-0x000000007fffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000f0000000-0x00000000f3ffffff] reserved
[ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel!
[ 0.000000] SMBIOS 2.7 present.
[ 0.000000] DMI: LENOVO 636338U/636338U, BIOS CBET4000 TIMELESS 01/01/1970
[ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.000000] e820: last_pfn = 0x7f6fc max_arch_pfn = 0x100000
[ 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-back
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask 080000000 write-back
[ 0.000000] 1 base 07F800000 mask 0FF800000 uncachable
[ 0.000000] 2 base 0D0000000 mask 0F0000000 write-combining
[ 0.000000] 3 disabled
[ 0.000000] 4 disabled
[ 0.000000] 5 disabled
[ 0.000000] 6 disabled
[ 0.000000] 7 disabled
[ 0.000000] x86/PAT: PAT not supported by CPU.
[ 0.000000] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC
[ 0.000000] found SMP MP-table at [mem 0x000f0400-0x000f040f] mapped at [(ptrval)]
[ 0.000000] Scanning 1 areas for low memory corruption
[ 0.000000] initial memory mapped: [mem 0x00000000-0x19bfffff]
[ 0.000000] Base memory trampoline at [(ptrval)] 9b000 size 16384
[ 0.000000] BRK [0x19928000, 0x19928fff] PGTABLE
[ 0.000000] log_buf_len: 8388608 bytes
[ 0.000000] early log buf free: 128752(98%)
[ 0.000000] RAMDISK: [mem 0x37281000-0x37937fff]
[ 0.000000] Allocated new RAMDISK: [mem 0x363ca000-0x36a80092]
[ 0.000000] Move RAMDISK from [mem 0x37281000-0x37937092] to [mem 0x363ca000-0x36a80092]
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000F0800 000024 (v02 CORE )
[ 0.000000] ACPI: XSDT 0x000000007F70D0E0 000054 (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.000000] ACPI: FACP 0x000000007F7102A0 0000F4 (v04 CORE COREBOOT 00000000 CORE 00000000)
[ 0.000000] ACPI: DSDT 0x000000007F70D280 00301E (v03 COREv4 COREBOOT 20090419 INTL 20160831)
[ 0.000000] ACPI: FACS 0x000000007F70D240 000040
[ 0.000000] ACPI: FACS 0x000000007F70D240 000040
[ 0.000000] ACPI: SSDT 0x000000007F7103A0 000569 (v02 CORE COREBOOT 0000002A CORE 0000002A)
[ 0.000000] ACPI: MCFG 0x000000007F710910 00003C (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.000000] ACPI: TCPA 0x000000007F710950 000032 (v02 CORE COREBOOT 00000000 CORE 00000000)
[ 0.000000] ACPI: APIC 0x000000007F710990 000068 (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.000000] ACPI: HPET 0x000000007F712A00 000038 (v01 CORE COREBOOT 00000000 CORE 00000000)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] 1154MB HIGHMEM available.
[ 0.000000] 883MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 373fe000
[ 0.000000] low ram: 0 - 373fe000
[ 0.000000] tsc: Fast TSC calibration using PIT
[ 0.000000] BRK [0x19929000, 0x19929fff] PGTABLE
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.000000] Normal [mem 0x0000000001000000-0x00000000373fdfff]
[ 0.000000] HighMem [mem 0x00000000373fe000-0x000000007f6fbfff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009ffff]
[ 0.000000] node 0: [mem 0x0000000000100000-0x000000007f6fbfff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000007f6fbfff]
[ 0.000000] On node 0 totalpages: 521883
[ 0.000000] DMA zone: 36 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3999 pages, LIFO batch:0
[ 0.000000] Normal zone: 1953 pages used for memmap
[ 0.000000] Normal zone: 222206 pages, LIFO batch:31
[ 0.000000] HighMem zone: 295678 pages, LIFO batch:31
[ 0.000000] Reserved but unavailable: 97 pages
[ 0.000000] Using APIC driver default
[ 0.000000] Reserving Intel graphics memory at [mem 0x7f800000-0x7fffffff]
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] 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 high edge)
[ 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: 0x8086a201 base: 0xfed00000
[ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000bffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000c0000-0x000fffff]
[ 0.000000] e820: [mem 0x80000000-0xefffffff] 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: 7645519600211568 ns
[ 0.000000] random: get_random_bytes called from start_kernel+0x81/0x52b with crng_init=0
[ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] percpu: Embedded 28 pages/cpu @(ptrval) s84972 r0 d29716 u114688
[ 0.000000] pcpu-alloc: s84972 r0 d29716 u114688 alloc=28*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 519894
[ 0.000000] Kernel command line: BOOT_IMAGE=/vmlinuz-4.17.0-rc3+ root=UUID=0198e82a-32df-4f18-bec0-3e08802b084d ro noisapnp cryptomgr.notests pnpbios=off pcie_aspm=force pcie_aspm.policy=powersave nmi_watchdog=0 iomem=relaxed memory_corruption_check=1 memory_corruption_check_size=512k i915.fastboot=1 initcall_debug log_buf_len=8M clocksource=hpet apparmor=0
[ 0.000000] PCIe ASPM is forcibly enabled
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] BRK [0x1992a000, 0x1992afff] PGTABLE
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (000373fe:0007f6fc)
[ 0.000000] Initializing Movable for node 0 (00000000:00000000)
[ 0.000000] Memory: 2032860K/2087532K available (10559K kernel code, 4555K rwdata, 2364K rodata, 1180K init, 428K bss, 54672K reserved, 0K cma-reserved, 1182712K highmem)
[ 0.000000] virtual kernel memory layout:
fixmap : 0xfff15000 - 0xfffff000 ( 936 kB)
cpu_entry : 0xff800000 - 0xff939000 (1252 kB)
pkmap : 0xff400000 - 0xff800000 (4096 kB)
vmalloc : 0xf7bfe000 - 0xff3fe000 ( 120 MB)
lowmem : 0xc0000000 - 0xf73fe000 ( 883 MB)
.init : 0xd9727000 - 0xd984e000 (1180 kB)
.data : 0xd904fdd0 - 0xd9717ce0 (6943 kB)
.text : 0xd8600000 - 0xd904fdd0 (10559 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] random: get_random_u32 called from cache_alloc_refill+0x5bb/0x13d0 with crng_init=0
[ 0.000000] ftrace: allocating 27538 entries in 54 pages
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.000000] NR_IRQS: 2304, nr_irqs: 440, preallocated irqs: 16
[ 0.000000] CPU 0 irqstacks, hard=(ptrval) soft=(ptrval)
[ 0.000000] random: get_random_u32 called from cache_random_seq_create+0xa3/0x1f0 with crng_init=0
[ 0.000000] calling con_init+0x0/0x31c @ 0
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] initcall con_init+0x0/0x31c returned 0 after 0 usecs
[ 0.000000] calling univ8250_console_init+0x0/0x2a @ 0
[ 0.000000] initcall univ8250_console_init+0x0/0x2a returned 0 after 0 usecs
[ 0.000000] ACPI: Core revision 20180313
[ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns
[ 0.000000] hpet clockevent registered
[ 0.000000] APIC: Switch to symmetric I/O mode setup
[ 0.000000] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.000000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.020000] tsc: Fast TSC calibration using PIT
[ 0.024000] tsc: Detected 1662.431 MHz processor
[ 0.024000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x17f68547f8a, max_idle_ns: 440795243686 ns
[ 0.024000] Calibrating delay loop (skipped), value calculated using timer frequency.. 3324.86 BogoMIPS (lpj=6649724)
[ 0.024000] pid_max: default: 32768 minimum: 301
[ 0.024000] Security Framework initialized
[ 0.024000] Yama: becoming mindful.
[ 0.024000] calling selinux_init+0x0/0x1e2 @ 0
[ 0.024000] initcall selinux_init+0x0/0x1e2 returned 0 after 0 usecs
[ 0.024000] calling tomoyo_init+0x0/0x76 @ 0
[ 0.024000] initcall tomoyo_init+0x0/0x76 returned 0 after 0 usecs
[ 0.024000] calling apparmor_init+0x0/0x38b @ 0
[ 0.024000] AppArmor: AppArmor disabled by boot time parameter
[ 0.024000] initcall apparmor_init+0x0/0x38b returned 0 after 0 usecs
[ 0.024000] calling integrity_iintcache_init+0x0/0x2c @ 0
[ 0.024000] initcall integrity_iintcache_init+0x0/0x2c returned 0 after 0 usecs
[ 0.024000] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.024000] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.024000] Disabled fast string operations
[ 0.028008] CPU: Physical Processor ID: 0
[ 0.028074] CPU: Processor Core ID: 0
[ 0.028148] mce: CPU supports 6 MCE banks
[ 0.028228] CPU0: Thermal monitoring enabled (TM2)
[ 0.028298] process: using mwait in idle threads
[ 0.028374] Last level iTLB entries: 4KB 128, 2MB 0, 4MB 2
[ 0.028441] Last level dTLB entries: 4KB 128, 2MB 0, 4MB 8, 1GB 0
[ 0.028516] Spectre V2 : Mitigation: Full generic retpoline
[ 0.028584] Spectre V2 : Spectre v2 mitigation: Filling RSB on context switch
[ 0.028768] Freeing SMP alternatives memory: 28K
[ 0.136014] smpboot: CPU0: Intel(R) Core(TM) Duo CPU L2400 @ 1.66GHz (family: 0x6, model: 0xe, stepping: 0xc)
[ 0.136454] calling trace_init_flags_sys_exit+0x0/0x13 @ 1
[ 0.136459] initcall trace_init_flags_sys_exit+0x0/0x13 returned 0 after 0 usecs
[ 0.136462] calling trace_init_flags_sys_enter+0x0/0x13 @ 1
[ 0.136466] initcall trace_init_flags_sys_enter+0x0/0x13 returned 0 after 0 usecs
[ 0.136469] calling init_hw_perf_events+0x0/0x77c @ 1
[ 0.136470] Performance Events: Core events, core PMU driver.
[ 0.136552] ... version: 1
[ 0.136616] ... bit width: 40
[ 0.136681] ... generic registers: 2
[ 0.136745] ... value mask: 000000ffffffffff
[ 0.136813] ... max period: 000000007fffffff
[ 0.136880] ... fixed-purpose events: 0
[ 0.136945] ... event mask: 0000000000000003
[ 0.137035] initcall init_hw_perf_events+0x0/0x77c returned 0 after 0 usecs
[ 0.137038] calling init_real_mode+0x0/0x1fe @ 1
[ 0.137061] initcall init_real_mode+0x0/0x1fe returned 0 after 0 usecs
[ 0.137065] calling trace_init_perf_perm_irq_work_exit+0x0/0x16 @ 1
[ 0.137069] initcall trace_init_perf_perm_irq_work_exit+0x0/0x16 returned 0 after 0 usecs
[ 0.137073] calling validate_x2apic+0x0/0x55 @ 1
[ 0.137077] initcall validate_x2apic+0x0/0x55 returned 0 after 0 usecs
[ 0.137080] calling register_nmi_cpu_backtrace_handler+0x0/0x18 @ 1
[ 0.137085] initcall register_nmi_cpu_backtrace_handler+0x0/0x18 returned 0 after 0 usecs
[ 0.137088] calling spawn_ksoftirqd+0x0/0x48 @ 1
[ 0.137151] initcall spawn_ksoftirqd+0x0/0x48 returned 0 after 0 usecs
[ 0.137155] calling migration_init+0x0/0x76 @ 1
[ 0.137158] initcall migration_init+0x0/0x76 returned 0 after 0 usecs
[ 0.137162] calling check_cpu_stall_init+0x0/0x1b @ 1
[ 0.137167] initcall check_cpu_stall_init+0x0/0x1b returned 0 after 0 usecs
[ 0.137170] calling srcu_bootup_announce+0x0/0x30 @ 1
[ 0.137171] Hierarchical SRCU implementation.
[ 0.137240] initcall srcu_bootup_announce+0x0/0x30 returned 0 after 0 usecs
[ 0.137243] calling rcu_spawn_gp_kthread+0x0/0x11d @ 1
[ 0.137337] initcall rcu_spawn_gp_kthread+0x0/0x11d returned 0 after 0 usecs
[ 0.137340] calling cpu_stop_init+0x0/0xff @ 1
[ 0.137402] initcall cpu_stop_init+0x0/0xff returned 0 after 0 usecs
[ 0.137406] calling init_events+0x0/0xdf @ 1
[ 0.137426] initcall init_events+0x0/0xdf returned 0 after 0 usecs
[ 0.137429] calling init_trace_printk+0x0/0xf @ 1
[ 0.137433] initcall init_trace_printk+0x0/0xf returned 0 after 0 usecs
[ 0.137436] calling event_trace_enable_again+0x0/0x21 @ 1
[ 0.137440] initcall event_trace_enable_again+0x0/0x21 returned 0 after 0 usecs
[ 0.137444] calling jump_label_init_module+0x0/0x14 @ 1
[ 0.137448] initcall jump_label_init_module+0x0/0x14 returned 0 after 0 usecs
[ 0.137451] calling dynamic_debug_init+0x0/0x339 @ 1
[ 0.138270] initcall dynamic_debug_init+0x0/0x339 returned 0 after 0 usecs
[ 0.138275] calling rand_initialize+0x0/0x180 @ 1
[ 0.138373] initcall rand_initialize+0x0/0x180 returned 0 after 0 usecs
[ 0.138378] calling initialize_ptr_random+0x0/0x59 @ 1
[ 0.138382] initcall initialize_ptr_random+0x0/0x59 returned 0 after 0 usecs
[ 0.138579] smp: Bringing up secondary CPUs ...
[ 0.139192] CPU 1 irqstacks, hard=(ptrval) soft=(ptrval)
[ 0.139195] x86: Booting SMP configuration:
[ 0.139262] .... node #0, CPUs: #1
[ 0.004000] Initializing CPU#1
[ 0.004000] Disabled fast string operations
[ 0.140068] smp: Brought up 1 node, 2 CPUs
[ 0.140270] smpboot: Max logical packages: 1
[ 0.140336] smpboot: Total of 2 processors activated (6649.72 BogoMIPS)
[ 0.144559] devtmpfs: initialized
[ 0.147109] calling ipc_ns_init+0x0/0xc9 @ 1
[ 0.147122] initcall ipc_ns_init+0x0/0xc9 returned 0 after 0 usecs
[ 0.147126] calling init_mmap_min_addr+0x0/0x23 @ 1
[ 0.147130] initcall init_mmap_min_addr+0x0/0x23 returned 0 after 0 usecs
[ 0.147135] calling init_cpufreq_transition_notifier_list+0x0/0x1d @ 1
[ 0.147152] initcall init_cpufreq_transition_notifier_list+0x0/0x1d returned 0 after 0 usecs
[ 0.147155] calling net_ns_init+0x0/0xfe @ 1
[ 0.148038] initcall net_ns_init+0x0/0xfe returned 0 after 0 usecs
[ 0.148236] calling e820__register_nvs_regions+0x0/0x83 @ 1
[ 0.148241] initcall e820__register_nvs_regions+0x0/0x83 returned 0 after 0 usecs
[ 0.148245] calling cpufreq_register_tsc_scaling+0x0/0x51 @ 1
[ 0.148249] initcall cpufreq_register_tsc_scaling+0x0/0x51 returned 0 after 0 usecs
[ 0.148252] calling init_cpu_syscore+0x0/0x11 @ 1
[ 0.148257] initcall init_cpu_syscore+0x0/0x11 returned 0 after 0 usecs
[ 0.148260] calling reboot_init+0x0/0x22 @ 1
[ 0.148277] initcall reboot_init+0x0/0x22 returned 0 after 0 usecs
[ 0.148281] calling init_lapic_sysfs+0x0/0x36 @ 1
[ 0.148285] initcall init_lapic_sysfs+0x0/0x36 returned 0 after 0 usecs
[ 0.148288] calling cpu_hotplug_pm_sync_init+0x0/0x16 @ 1
[ 0.148292] initcall cpu_hotplug_pm_sync_init+0x0/0x16 returned 0 after 0 usecs
[ 0.148295] calling alloc_frozen_cpus+0x0/0xc @ 1
[ 0.148298] initcall alloc_frozen_cpus+0x0/0xc returned 0 after 0 usecs
[ 0.148301] calling wq_sysfs_init+0x0/0x29 @ 1
[ 0.148405] initcall wq_sysfs_init+0x0/0x29 returned 0 after 0 usecs
[ 0.148409] calling ksysfs_init+0x0/0x96 @ 1
[ 0.148449] initcall ksysfs_init+0x0/0x96 returned 0 after 0 usecs
[ 0.148453] calling pm_init+0x0/0x8d @ 1
[ 0.148521] initcall pm_init+0x0/0x8d returned 0 after 0 usecs
[ 0.148524] calling pm_disk_init+0x0/0x19 @ 1
[ 0.148545] initcall pm_disk_init+0x0/0x19 returned 0 after 0 usecs
[ 0.148550] calling swsusp_header_init+0x0/0x30 @ 1
[ 0.148554] initcall swsusp_header_init+0x0/0x30 returned 0 after 0 usecs
[ 0.148558] calling rcu_set_runtime_mode+0x0/0x16 @ 1
[ 0.148561] initcall rcu_set_runtime_mode+0x0/0x16 returned 0 after 0 usecs
[ 0.148565] calling init_jiffies_clocksource+0x0/0x1b @ 1
[ 0.148569] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.148662] initcall init_jiffies_clocksource+0x0/0x1b returned 0 after 0 usecs
[ 0.148666] calling futex_init+0x0/0x20e @ 1
[ 0.148673] futex hash table entries: 512 (order: 2, 16384 bytes)
[ 0.148758] initcall futex_init+0x0/0x20e returned 0 after 0 usecs
[ 0.148761] calling cgroup_wq_init+0x0/0x36 @ 1
[ 0.148785] initcall cgroup_wq_init+0x0/0x36 returned 0 after 0 usecs
[ 0.148788] calling cgroup1_wq_init+0x0/0x36 @ 1
[ 0.148809] initcall cgroup1_wq_init+0x0/0x36 returned 0 after 0 usecs
[ 0.148812] calling ftrace_mod_cmd_init+0x0/0xf @ 1
[ 0.148817] initcall ftrace_mod_cmd_init+0x0/0xf returned 0 after 0 usecs
[ 0.148820] calling init_graph_trace+0x0/0x5a @ 1
[ 0.148828] initcall init_graph_trace+0x0/0x5a returned 0 after 0 usecs
[ 0.148834] calling init_per_zone_wmark_min+0x0/0x66 @ 1
[ 0.148842] initcall init_per_zone_wmark_min+0x0/0x66 returned 0 after 0 usecs
[ 0.148846] calling init_zero_pfn+0x0/0x9e @ 1
[ 0.148850] initcall init_zero_pfn+0x0/0x9e returned 0 after 0 usecs
[ 0.148853] calling fsnotify_init+0x0/0x44 @ 1
[ 0.148898] initcall fsnotify_init+0x0/0x44 returned 0 after 0 usecs
[ 0.148901] calling filelock_init+0x0/0xcd @ 1
[ 0.148931] initcall filelock_init+0x0/0xcd returned 0 after 0 usecs
[ 0.148935] calling init_script_binfmt+0x0/0x18 @ 1
[ 0.148939] initcall init_script_binfmt+0x0/0x18 returned 0 after 0 usecs
[ 0.148942] calling init_elf_binfmt+0x0/0x18 @ 1
[ 0.148946] initcall init_elf_binfmt+0x0/0x18 returned 0 after 0 usecs
[ 0.148949] calling debugfs_init+0x0/0x4b @ 1
[ 0.148959] initcall debugfs_init+0x0/0x4b returned 0 after 0 usecs
[ 0.148962] calling tracefs_init+0x0/0x39 @ 1
[ 0.148970] initcall tracefs_init+0x0/0x39 returned 0 after 0 usecs
[ 0.148973] calling securityfs_init+0x0/0x63 @ 1
[ 0.149048] initcall securityfs_init+0x0/0x63 returned 0 after 0 usecs
[ 0.149052] calling prandom_init+0x0/0x100 @ 1
[ 0.149056] initcall prandom_init+0x0/0x100 returned 0 after 0 usecs
[ 0.149059] calling pinctrl_init+0x0/0x9d @ 1
[ 0.149060] pinctrl core: initialized pinctrl subsystem
[ 0.149216] initcall pinctrl_init+0x0/0x9d returned 0 after 0 usecs
[ 0.149219] calling gpiolib_dev_init+0x0/0xec @ 1
[ 0.149263] initcall gpiolib_dev_init+0x0/0xec returned 0 after 0 usecs
[ 0.149268] calling iommu_init+0x0/0x33 @ 1
[ 0.149280] initcall iommu_init+0x0/0x33 returned 0 after 0 usecs
[ 0.149283] calling component_debug_init+0x0/0x1d @ 1
[ 0.149294] initcall component_debug_init+0x0/0x1d returned 0 after 0 usecs
[ 0.149297] calling opp_debug_init+0x0/0x39 @ 1
[ 0.149308] initcall opp_debug_init+0x0/0x39 returned 0 after 0 usecs
[ 0.149312] calling cpufreq_core_init+0x0/0x50 @ 1
[ 0.149322] initcall cpufreq_core_init+0x0/0x50 returned 0 after 0 usecs
[ 0.149325] calling cpuidle_init+0x0/0x3b @ 1
[ 0.149341] initcall cpuidle_init+0x0/0x3b returned 0 after 0 usecs
[ 0.149344] calling bsp_pm_check_init+0x0/0x16 @ 1
[ 0.149347] initcall bsp_pm_check_init+0x0/0x16 returned 0 after 0 usecs
[ 0.149350] calling sock_init+0x0/0x98 @ 1
[ 0.149605] initcall sock_init+0x0/0x98 returned 0 after 0 usecs
[ 0.149608] calling net_inuse_init+0x0/0x24 @ 1
[ 0.149659] initcall net_inuse_init+0x0/0x24 returned 0 after 0 usecs
[ 0.149662] calling net_defaults_init+0x0/0x24 @ 1
[ 0.149665] initcall net_defaults_init+0x0/0x24 returned 0 after 0 usecs
[ 0.149668] calling init_default_flow_dissectors+0x0/0x48 @ 1
[ 0.149673] initcall init_default_flow_dissectors+0x0/0x48 returned 0 after 0 usecs
[ 0.149675] calling netpoll_init+0x0/0x34 @ 1
[ 0.149678] initcall netpoll_init+0x0/0x34 returned 0 after 0 usecs
[ 0.149682] calling netlink_proto_init+0x0/0x1d7 @ 1
[ 0.149860] NET: Registered protocol family 16
[ 0.149995] initcall netlink_proto_init+0x0/0x1d7 returned 0 after 0 usecs
[ 0.150194] calling irq_sysfs_init+0x0/0x99 @ 1
[ 0.150707] initcall irq_sysfs_init+0x0/0x99 returned 0 after 0 usecs
[ 0.150710] calling audit_init+0x0/0x1ac @ 1
[ 0.150716] audit: initializing netlink subsys (disabled)
[ 0.152102] initcall audit_init+0x0/0x1ac returned 0 after 3906 usecs
[ 0.152102] audit: type=2000 audit(1525328548.152:1): state=initialized audit_enabled=0 res=1
[ 0.152127] calling bdi_class_init+0x0/0x55 @ 1
[ 0.152168] initcall bdi_class_init+0x0/0x55 returned 0 after 0 usecs
[ 0.152171] calling mm_sysfs_init+0x0/0x27 @ 1
[ 0.152185] initcall mm_sysfs_init+0x0/0x27 returned 0 after 0 usecs
[ 0.152189] calling gpiolib_sysfs_init+0x0/0x9a @ 1
[ 0.152214] initcall gpiolib_sysfs_init+0x0/0x9a returned 0 after 0 usecs
[ 0.152217] calling pcibus_class_init+0x0/0x19 @ 1
[ 0.152234] initcall pcibus_class_init+0x0/0x19 returned 0 after 0 usecs
[ 0.152237] calling pci_driver_init+0x0/0x22 @ 1
[ 0.152312] initcall pci_driver_init+0x0/0x22 returned 0 after 0 usecs
[ 0.152316] calling backlight_class_init+0x0/0xcb @ 1
[ 0.152335] initcall backlight_class_init+0x0/0xcb returned 0 after 0 usecs
[ 0.152338] calling tty_class_init+0x0/0x44 @ 1
[ 0.152357] initcall tty_class_init+0x0/0x44 returned 0 after 0 usecs
[ 0.152360] calling vtconsole_class_init+0x0/0xcb @ 1
[ 0.152468] initcall vtconsole_class_init+0x0/0xcb returned 0 after 0 usecs
[ 0.152471] calling iommu_dev_init+0x0/0x19 @ 1
[ 0.152488] initcall iommu_dev_init+0x0/0x19 returned 0 after 0 usecs
[ 0.152491] calling mipi_dsi_bus_init+0x0/0x14 @ 1
[ 0.152528] initcall mipi_dsi_bus_init+0x0/0x14 returned 0 after 0 usecs
[ 0.152532] calling wakeup_sources_debugfs_init+0x0/0x24 @ 1
[ 0.152543] initcall wakeup_sources_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[ 0.152546] calling regmap_initcall+0x0/0x11 @ 1
[ 0.152557] initcall regmap_initcall+0x0/0x11 returned 0 after 0 usecs
[ 0.152560] calling spi_init+0x0/0x89 @ 1
[ 0.152618] initcall spi_init+0x0/0x89 returned 0 after 0 usecs
[ 0.152622] calling i2c_init+0x0/0xa5 @ 1
[ 0.152694] initcall i2c_init+0x0/0xa5 returned 0 after 0 usecs
[ 0.152697] calling init_ladder+0x0/0x3f @ 1
[ 0.152728] cpuidle: using governor ladder
[ 0.152728] initcall init_ladder+0x0/0x3f returned 0 after 0 usecs
[ 0.152728] calling init_menu+0x0/0x14 @ 1
[ 0.152728] cpuidle: using governor menu
[ 0.152728] initcall init_menu+0x0/0x14 returned 0 after 0 usecs
[ 0.152728] calling pcc_init+0x0/0x3ef @ 1
[ 0.152728] initcall pcc_init+0x0/0x3ef returned -19 after 0 usecs
[ 0.152728] calling amd_postcore_init+0x0/0xf5 @ 1
[ 0.152728] initcall amd_postcore_init+0x0/0xf5 returned 0 after 0 usecs
[ 0.152728] calling kobject_uevent_init+0x0/0xf @ 1
[ 0.152728] initcall kobject_uevent_init+0x0/0xf returned 0 after 0 usecs
[ 0.152728] calling bts_init+0x0/0xd1 @ 1
[ 0.152728] initcall bts_init+0x0/0xd1 returned -19 after 0 usecs
[ 0.152728] calling pt_init+0x0/0x408 @ 1
[ 0.152728] initcall pt_init+0x0/0x408 returned -19 after 0 usecs
[ 0.152728] calling boot_params_ksysfs_init+0x0/0x2d4 @ 1
[ 0.152728] initcall boot_params_ksysfs_init+0x0/0x2d4 returned 0 after 0 usecs
[ 0.152728] calling sbf_init+0x0/0xd5 @ 1
[ 0.152728] initcall sbf_init+0x0/0xd5 returned 0 after 0 usecs
[ 0.152728] calling arch_kdebugfs_init+0x0/0x23 @ 1
[ 0.152728] initcall arch_kdebugfs_init+0x0/0x23 returned 0 after 0 usecs
[ 0.152728] calling init_pit_clocksource+0x0/0x60 @ 1
[ 0.152728] initcall init_pit_clocksource+0x0/0x60 returned 0 after 0 usecs
[ 0.152728] calling intel_pconfig_init+0x0/0x102 @ 1
[ 0.152728] initcall intel_pconfig_init+0x0/0x102 returned 0 after 0 usecs
[ 0.152728] calling mtrr_if_init+0x0/0xa4 @ 1
[ 0.152728] initcall mtrr_if_init+0x0/0xa4 returned 0 after 0 usecs
[ 0.152728] calling ffh_cstate_init+0x0/0x41 @ 1
[ 0.152728] initcall ffh_cstate_init+0x0/0x41 returned 0 after 0 usecs
[ 0.152728] calling kdump_buf_page_init+0x0/0x3b @ 1
[ 0.152728] initcall kdump_buf_page_init+0x0/0x3b returned 0 after 0 usecs
[ 0.152728] calling kvm_setup_pv_tlb_flush+0x0/0xb9 @ 1
[ 0.152728] initcall kvm_setup_pv_tlb_flush+0x0/0xb9 returned 0 after 0 usecs
[ 0.152728] calling activate_jump_labels+0x0/0x35 @ 1
[ 0.152728] initcall activate_jump_labels+0x0/0x35 returned 0 after 0 usecs
[ 0.152728] calling kcmp_cookies_init+0x0/0xa7 @ 1
[ 0.152728] initcall kcmp_cookies_init+0x0/0xa7 returned 0 after 0 usecs
[ 0.152728] calling acpi_pci_init+0x0/0x60 @ 1
[ 0.152728] ACPI: bus type PCI registered
[ 0.152728] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[ 0.152728] initcall acpi_pci_init+0x0/0x60 returned 0 after 0 usecs
[ 0.152728] calling dma_bus_init+0x0/0x91 @ 1
[ 0.152728] initcall dma_bus_init+0x0/0x91 returned 0 after 0 usecs
[ 0.152728] calling dma_channel_table_init+0x0/0x14c @ 1
[ 0.152728] initcall dma_channel_table_init+0x0/0x14c returned 0 after 0 usecs
[ 0.152728] calling dmi_id_init+0x0/0x74d @ 1
[ 0.152728] initcall dmi_id_init+0x0/0x74d returned 0 after 0 usecs
[ 0.152728] calling pci_arch_init+0x0/0x6b @ 1
[ 0.152728] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf0000000-0xf3ffffff] (base 0xf0000000)
[ 0.152728] PCI: MMCONFIG at [mem 0xf0000000-0xf3ffffff] reserved in E820
[ 0.152728] PCI: Using MMCONFIG for extended config space
[ 0.152728] PCI: Using configuration type 1 for base access
[ 0.152728] initcall pci_arch_init+0x0/0x6b returned 0 after 0 usecs
[ 0.152728] calling fixup_ht_bug+0x0/0x9c @ 1
[ 0.152728] initcall fixup_ht_bug+0x0/0x9c returned 0 after 0 usecs
[ 0.152728] calling topology_init+0x0/0x30 @ 1
[ 0.152827] initcall topology_init+0x0/0x30 returned 0 after 0 usecs
[ 0.152831] calling mtrr_init_finialize+0x0/0x56 @ 1
[ 0.152835] initcall mtrr_init_finialize+0x0/0x56 returned 0 after 0 usecs
[ 0.152838] calling uid_cache_init+0x0/0xe5 @ 1
[ 0.152845] initcall uid_cache_init+0x0/0xe5 returned 0 after 0 usecs
[ 0.152848] calling param_sysfs_init+0x0/0x242 @ 1
[ 0.157449] initcall param_sysfs_init+0x0/0x242 returned 0 after 3906 usecs
[ 0.157453] calling user_namespace_sysctl_init+0x0/0x54 @ 1
[ 0.157486] initcall user_namespace_sysctl_init+0x0/0x54 returned 0 after 0 usecs
[ 0.157489] calling proc_schedstat_init+0x0/0x1f @ 1
[ 0.157497] initcall proc_schedstat_init+0x0/0x1f returned 0 after 0 usecs
[ 0.157500] calling pm_sysrq_init+0x0/0x1b @ 1
[ 0.157514] initcall pm_sysrq_init+0x0/0x1b returned 0 after 0 usecs
[ 0.157514] calling create_proc_profile+0x0/0xf0 @ 1
[ 0.157514] initcall create_proc_profile+0x0/0xf0 returned 0 after 0 usecs
[ 0.157514] calling crash_save_vmcoreinfo_init+0x0/0x4d8 @ 1
[ 0.157514] initcall crash_save_vmcoreinfo_init+0x0/0x4d8 returned 0 after 0 usecs
[ 0.157514] calling crash_notes_memory_init+0x0/0x36 @ 1
[ 0.157514] initcall crash_notes_memory_init+0x0/0x36 returned 0 after 0 usecs
[ 0.157514] calling cgroup_sysfs_init+0x0/0x19 @ 1
[ 0.157514] initcall cgroup_sysfs_init+0x0/0x19 returned 0 after 0 usecs
[ 0.157514] calling cgroup_namespaces_init+0x0/0xc @ 1
[ 0.157514] initcall cgroup_namespaces_init+0x0/0xc returned 0 after 0 usecs
[ 0.157514] calling user_namespaces_init+0x0/0x2c @ 1
[ 0.157514] initcall user_namespaces_init+0x0/0x2c returned 0 after 0 usecs
[ 0.157514] calling hung_task_init+0x0/0x49 @ 1
[ 0.157520] initcall hung_task_init+0x0/0x49 returned 0 after 0 usecs
[ 0.157520] calling dev_map_init+0x0/0x16 @ 1
[ 0.157520] initcall dev_map_init+0x0/0x16 returned 0 after 0 usecs
[ 0.157520] calling bpf_offload_init+0x0/0x16 @ 1
[ 0.157520] initcall bpf_offload_init+0x0/0x16 returned 0 after 0 usecs
[ 0.157520] calling oom_init+0x0/0x2e @ 1
[ 0.157520] initcall oom_init+0x0/0x2e returned 0 after 0 usecs
[ 0.157520] calling default_bdi_init+0x0/0x39 @ 1
[ 0.157520] initcall default_bdi_init+0x0/0x39 returned 0 after 3906 usecs
[ 0.157520] calling percpu_enable_async+0x0/0x13 @ 1
[ 0.157520] initcall percpu_enable_async+0x0/0x13 returned 0 after 0 usecs
[ 0.157520] calling kcompactd_init+0x0/0x49 @ 1
[ 0.160032] initcall kcompactd_init+0x0/0x49 returned 0 after 0 usecs
[ 0.160032] calling init_reserve_notifier+0x0/0x20 @ 1
[ 0.160032] initcall init_reserve_notifier+0x0/0x20 returned 0 after 0 usecs
[ 0.160032] calling init_admin_reserve+0x0/0x50 @ 1
[ 0.160032] initcall init_admin_reserve+0x0/0x50 returned 0 after 0 usecs
[ 0.160033] calling init_user_reserve+0x0/0x50 @ 1
[ 0.160036] initcall init_user_reserve+0x0/0x50 returned 0 after 0 usecs
[ 0.160039] calling swap_init_sysfs+0x0/0x5d @ 1
[ 0.160055] initcall swap_init_sysfs+0x0/0x5d returned 0 after 0 usecs
[ 0.160058] calling swapfile_init+0x0/0x62 @ 1
[ 0.160062] initcall swapfile_init+0x0/0x62 returned 0 after 0 usecs
[ 0.160065] calling hugetlb_init+0x0/0x5d5 @ 1
[ 0.160072] HugeTLB registered 4.00 MiB page size, pre-allocated 0 pages
[ 0.160181] initcall hugetlb_init+0x0/0x5d5 returned 0 after 0 usecs
[ 0.160184] calling ksm_init+0x0/0x177 @ 1
[ 0.160205] initcall ksm_init+0x0/0x177 returned 0 after 0 usecs
[ 0.160205] calling hugepage_init+0x0/0x165 @ 1
[ 0.160205] initcall hugepage_init+0x0/0x165 returned 0 after 0 usecs
[ 0.160205] calling mem_cgroup_swap_init+0x0/0x4e @ 1
[ 0.160205] initcall mem_cgroup_swap_init+0x0/0x4e returned 0 after 0 usecs
[ 0.160205] calling mem_cgroup_init+0x0/0x213 @ 1
[ 0.160205] initcall mem_cgroup_init+0x0/0x213 returned 0 after 0 usecs
[ 0.160205] calling sel_ib_pkey_init+0x0/0xb3 @ 1
[ 0.160205] initcall sel_ib_pkey_init+0x0/0xb3 returned 0 after 0 usecs
[ 0.160205] calling crypto_wq_init+0x0/0x2c @ 1
[ 0.160205] initcall crypto_wq_init+0x0/0x2c returned 0 after 0 usecs
[ 0.160205] calling cryptomgr_init+0x0/0x14 @ 1
[ 0.160205] initcall cryptomgr_init+0x0/0x14 returned 0 after 0 usecs
[ 0.160205] calling init_bio+0x0/0x17a @ 1
[ 0.160205] initcall init_bio+0x0/0x17a returned 0 after 0 usecs
[ 0.160205] calling blk_settings_init+0x0/0x22 @ 1
[ 0.160205] initcall blk_settings_init+0x0/0x22 returned 0 after 0 usecs
[ 0.160205] calling blk_ioc_init+0x0/0x29 @ 1
[ 0.160205] initcall blk_ioc_init+0x0/0x29 returned 0 after 0 usecs
[ 0.160205] calling blk_softirq_init+0x0/0xe5 @ 1
[ 0.160205] initcall blk_softirq_init+0x0/0xe5 returned 0 after 0 usecs
[ 0.160205] calling blk_mq_init+0x0/0x26 @ 1
[ 0.160205] initcall blk_mq_init+0x0/0x26 returned 0 after 0 usecs
[ 0.160205] calling genhd_device_init+0x0/0x66 @ 1
[ 0.160261] initcall genhd_device_init+0x0/0x66 returned 0 after 0 usecs
[ 0.160261] calling irq_poll_setup+0x0/0xe0 @ 1
[ 0.160261] initcall irq_poll_setup+0x0/0xe0 returned 0 after 0 usecs
[ 0.160261] calling byt_gpio_init+0x0/0x16 @ 1
[ 0.160261] initcall byt_gpio_init+0x0/0x16 returned 0 after 0 usecs
[ 0.160261] calling chv_pinctrl_init+0x0/0x16 @ 1
[ 0.160261] initcall chv_pinctrl_init+0x0/0x16 returned 0 after 0 usecs
[ 0.160261] calling bxt_pinctrl_init+0x0/0x16 @ 1
[ 0.160261] initcall bxt_pinctrl_init+0x0/0x16 returned 0 after 0 usecs
[ 0.160261] calling spt_pinctrl_init+0x0/0x16 @ 1
[ 0.160261] initcall spt_pinctrl_init+0x0/0x16 returned 0 after 0 usecs
[ 0.160261] calling gpiolib_debugfs_init+0x0/0x24 @ 1
[ 0.160261] initcall gpiolib_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[ 0.160261] calling pci_slot_init+0x0/0x50 @ 1
[ 0.160261] initcall pci_slot_init+0x0/0x50 returned 0 after 0 usecs
[ 0.160261] calling fbmem_init+0x0/0xc6 @ 1
[ 0.160377] initcall fbmem_init+0x0/0xc6 returned 0 after 0 usecs
[ 0.160380] calling acpi_init+0x0/0x34b @ 1
[ 0.160454] ACPI: Added _OSI(Module Device)
[ 0.160522] ACPI: Added _OSI(Processor Device)
[ 0.160588] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.160654] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.160727] ACPI: Added _OSI(Linux-Dell-Video)
[ 0.189097] ACPI: 2 ACPI AML tables successfully acquired and loaded
[ 0.192206] ACPI: [Firmware Bug]: BIOS _OSI(Linux) query ignored
[ 0.196745] ACPI: EC: EC started
[ 0.196810] ACPI: EC: interrupt blocked
[ 0.197080] ACPI: \_SB_.PCI0.LPCB.EC__: Used as first EC
[ 0.197152] ACPI: \_SB_.PCI0.LPCB.EC__: GPE=0x1c, EC_CMD/EC_SC=0x66, EC_DATA=0x62
[ 0.197240] ACPI: \_SB_.PCI0.LPCB.EC__: Used as boot DSDT EC to handle transactions
[ 0.199518] ACPI: Interpreter enabled
[ 0.199662] ACPI: (supports S0 S3 S4 S5)
[ 0.199730] ACPI: Using IOAPIC for interrupt routing
[ 0.199933] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
[ 0.201234] ACPI: Enabled 1 GPEs in block 00 to 1F
[ 0.237294] acpi ACPI0003:01: ACPI dock station (docks/bays count: 1)
[ 0.238019] ACPI: Power Resource [FPWR] (off)
[ 0.240130] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.240213] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[ 0.241178] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]
[ 0.241272] acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge
[ 0.241790] acpi PNP0A08:00: host bridge window [io 0x0000-0x0cf7 window] (ignored)
[ 0.241795] acpi PNP0A08:00: host bridge window [io 0x0cf8-0x0cff] (ignored)
[ 0.241799] acpi PNP0A08:00: host bridge window [io 0x0d00-0xffff window] (ignored)
[ 0.241803] acpi PNP0A08:00: host bridge window [mem 0x000a0000-0x000bffff window] (ignored)
[ 0.241807] acpi PNP0A08:00: host bridge window [mem 0x000c0000-0x000c3fff window] (ignored)
[ 0.241811] acpi PNP0A08:00: host bridge window [mem 0x000c4000-0x000c7fff window] (ignored)
[ 0.241814] acpi PNP0A08:00: host bridge window [mem 0x000c8000-0x000cbfff window] (ignored)
[ 0.241818] acpi PNP0A08:00: host bridge window [mem 0x000cc000-0x000cffff window] (ignored)
[ 0.241822] acpi PNP0A08:00: host bridge window [mem 0x000d0000-0x000d3fff window] (ignored)
[ 0.241826] acpi PNP0A08:00: host bridge window [mem 0x000d4000-0x000d7fff window] (ignored)
[ 0.241830] acpi PNP0A08:00: host bridge window [mem 0x000d8000-0x000dbfff window] (ignored)
[ 0.241834] acpi PNP0A08:00: host bridge window [mem 0x000dc000-0x000dffff window] (ignored)
[ 0.241838] acpi PNP0A08:00: host bridge window [mem 0x000e0000-0x000e3fff window] (ignored)
[ 0.241842] acpi PNP0A08:00: host bridge window [mem 0x000e4000-0x000e7fff window] (ignored)
[ 0.241845] acpi PNP0A08:00: host bridge window [mem 0x000e8000-0x000ebfff window] (ignored)
[ 0.241849] acpi PNP0A08:00: host bridge window [mem 0x000ec000-0x000effff window] (ignored)
[ 0.241853] acpi PNP0A08:00: host bridge window [mem 0x000f0000-0x000fffff window] (ignored)
[ 0.241857] acpi PNP0A08:00: host bridge window [mem 0x80000000-0xfebfffff window] (ignored)
[ 0.241861] acpi PNP0A08:00: host bridge window [mem 0xfed40000-0xfed44fff window] (ignored)
[ 0.241864] PCI: root bus 00: using default resources
[ 0.243426] PCI host bridge to bus 0000:00
[ 0.243498] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
[ 0.243572] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffff]
[ 0.243646] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.243736] pci 0000:00:00.0: [8086:27a0] type 00 class 0x060000
[ 0.243753] pci 0000:00:00.0: calling quirk_mmio_always_on+0x0/0x30 @ 1
[ 0.243827] pci 0000:00:00.0: quirk_mmio_always_on+0x0/0x30 took 0 usecs
[ 0.244497] pci 0000:00:02.0: [8086:27a2] type 00 class 0x030000
[ 0.244516] pci 0000:00:02.0: reg 0x10: [mem 0xe4300000-0xe437ffff]
[ 0.244524] pci 0000:00:02.0: reg 0x14: [io 0x50b0-0x50b7]
[ 0.244532] pci 0000:00:02.0: reg 0x18: [mem 0xd0000000-0xdfffffff pref]
[ 0.244540] pci 0000:00:02.0: reg 0x1c: [mem 0xe4400000-0xe443ffff]
[ 0.245108] pci 0000:00:02.1: [8086:27a6] type 00 class 0x038000
[ 0.245124] pci 0000:00:02.1: reg 0x10: [mem 0xe4380000-0xe43fffff]
[ 0.245744] pci 0000:00:1b.0: [8086:27d8] type 00 class 0x040300
[ 0.245782] pci 0000:00:1b.0: reg 0x10: [mem 0xe4440000-0xe4443fff 64bit]
[ 0.245924] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[ 0.246507] pci 0000:00:1c.0: [8086:27d0] type 01 class 0x060400
[ 0.246604] pci 0000:00:1c.0: calling pci_fixup_transparent_bridge+0x0/0x40 @ 1
[ 0.246692] pci 0000:00:1c.0: pci_fixup_transparent_bridge+0x0/0x40 took 0 usecs
[ 0.246845] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[ 0.247439] pci 0000:00:1c.1: [8086:27d2] type 01 class 0x060400
[ 0.247526] pci 0000:00:1c.1: calling pci_fixup_transparent_bridge+0x0/0x40 @ 1
[ 0.247614] pci 0000:00:1c.1: pci_fixup_transparent_bridge+0x0/0x40 took 0 usecs
[ 0.247768] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[ 0.248370] pci 0000:00:1c.2: [8086:27d4] type 01 class 0x060400
[ 0.248449] pci 0000:00:1c.2: calling pci_fixup_transparent_bridge+0x0/0x40 @ 1
[ 0.248536] pci 0000:00:1c.2: pci_fixup_transparent_bridge+0x0/0x40 took 0 usecs
[ 0.248689] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold
[ 0.249279] pci 0000:00:1c.3: [8086:27d6] type 01 class 0x060400
[ 0.249357] pci 0000:00:1c.3: calling pci_fixup_transparent_bridge+0x0/0x40 @ 1
[ 0.249445] pci 0000:00:1c.3: pci_fixup_transparent_bridge+0x0/0x40 took 0 usecs
[ 0.249600] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
[ 0.250199] pci 0000:00:1d.0: [8086:27c8] type 00 class 0x0c0300
[ 0.250266] pci 0000:00:1d.0: reg 0x20: [io 0x5000-0x501f]
[ 0.250854] pci 0000:00:1d.1: [8086:27c9] type 00 class 0x0c0300
[ 0.250921] pci 0000:00:1d.1: reg 0x20: [io 0x5020-0x503f]
[ 0.251510] pci 0000:00:1d.2: [8086:27ca] type 00 class 0x0c0300
[ 0.251577] pci 0000:00:1d.2: reg 0x20: [io 0x5040-0x505f]
[ 0.252170] pci 0000:00:1d.3: [8086:27cb] type 00 class 0x0c0300
[ 0.252237] pci 0000:00:1d.3: reg 0x20: [io 0x5060-0x507f]
[ 0.252838] pci 0000:00:1d.7: [8086:27cc] type 00 class 0x0c0320
[ 0.252869] pci 0000:00:1d.7: reg 0x10: [mem 0xe4444000-0xe44443ff]
[ 0.252995] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[ 0.253548] pci 0000:00:1e.0: [8086:2448] type 01 class 0x060401
[ 0.253626] pci 0000:00:1e.0: calling pci_fixup_transparent_bridge+0x0/0x40 @ 1
[ 0.253714] pci 0000:00:1e.0: pci_fixup_transparent_bridge+0x0/0x40 took 0 usecs
[ 0.254349] pci 0000:00:1f.0: [8086:27b9] type 00 class 0x060100
[ 0.254487] pci 0000:00:1f.0: calling ich_force_enable_hpet+0x0/0x1b0 @ 1
[ 0.254561] pci 0000:00:1f.0: ich_force_enable_hpet+0x0/0x1b0 took 0 usecs
[ 0.254637] pci 0000:00:1f.0: calling quirk_ich7_lpc+0x0/0x60 @ 1
[ 0.254715] pci 0000:00:1f.0: quirk: [io 0x0500-0x057f] claimed by ICH6 ACPI/GPIO/TCO
[ 0.254805] pci 0000:00:1f.0: quirk: [io 0x0480-0x04bf] claimed by ICH6 GPIO
[ 0.254879] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 1 PIO at 1600 (mask 007f)
[ 0.254967] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 2 PIO at 15e0 (mask 000f)
[ 0.255054] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 3 PIO at 1680 (mask 001f)
[ 0.255141] pci 0000:00:1f.0: quirk_ich7_lpc+0x0/0x60 took 0 usecs
[ 0.255214] pci 0000:00:1f.0: calling twinhead_reserve_killing_zone+0x0/0x60 @ 1
[ 0.255301] pci 0000:00:1f.0: twinhead_reserve_killing_zone+0x0/0x60 took 0 usecs
[ 0.255940] pci 0000:00:1f.1: [8086:27df] type 00 class 0x01018a
[ 0.255967] pci 0000:00:1f.1: reg 0x10: [io 0x50b8-0x50bf]
[ 0.255980] pci 0000:00:1f.1: reg 0x14: [io 0x50d8-0x50db]
[ 0.255993] pci 0000:00:1f.1: reg 0x18: [io 0x50c0-0x50c7]
[ 0.256012] pci 0000:00:1f.1: reg 0x1c: [io 0x50dc-0x50df]
[ 0.256026] pci 0000:00:1f.1: reg 0x20: [io 0x50a0-0x50af]
[ 0.256054] pci 0000:00:1f.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.256126] pci 0000:00:1f.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.256197] pci 0000:00:1f.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.256269] pci 0000:00:1f.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.256878] pci 0000:00:1f.2: [8086:27c5] type 00 class 0x010601
[ 0.256909] pci 0000:00:1f.2: reg 0x10: [io 0x50c8-0x50cf]
[ 0.256922] pci 0000:00:1f.2: reg 0x14: [io 0x50e0-0x50e3]
[ 0.256936] pci 0000:00:1f.2: reg 0x18: [io 0x50d0-0x50d7]
[ 0.256949] pci 0000:00:1f.2: reg 0x1c: [io 0x50e4-0x50e7]
[ 0.256962] pci 0000:00:1f.2: reg 0x20: [io 0x5080-0x508f]
[ 0.256976] pci 0000:00:1f.2: reg 0x24: [mem 0xe4445000-0xe44453ff]
[ 0.257052] pci 0000:00:1f.2: PME# supported from D3hot
[ 0.257605] pci 0000:00:1f.3: [8086:27da] type 00 class 0x0c0500
[ 0.257690] pci 0000:00:1f.3: reg 0x20: [io 0x0400-0x041f]
[ 0.258432] pci 0000:01:00.0: [8086:109a] type 00 class 0x020000
[ 0.258453] pci 0000:01:00.0: calling quirk_f0_vpd_link+0x0/0x80 @ 1
[ 0.258526] pci 0000:01:00.0: quirk_f0_vpd_link+0x0/0x80 took 0 usecs
[ 0.258636] pci 0000:01:00.0: reg 0x10: [mem 0xe4100000-0xe411ffff]
[ 0.258680] pci 0000:01:00.0: reg 0x18: [io 0x4000-0x401f]
[ 0.258921] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
[ 0.259219] pci 0000:00:1c.0: ASPM: current common clock configuration is broken, reconfiguring
[ 0.273205] pci 0000:00:1c.0: PCI bridge to [bus 01]
[ 0.273205] pci 0000:00:1c.0: bridge window [io 0x4000-0x4fff]
[ 0.273205] pci 0000:00:1c.0: bridge window [mem 0xe4100000-0xe41fffff]
[ 0.273205] pci 0000:02:00.0: [8086:4227] type 00 class 0x028000
[ 0.273205] pci 0000:02:00.0: reg 0x10: [mem 0xe4200000-0xe4200fff]
[ 0.276240] pci 0000:02:00.0: PME# supported from D0 D3hot
[ 0.276624] pci 0000:00:1c.1: ASPM: current common clock configuration is broken, reconfiguring
[ 0.288057] pci 0000:00:1c.1: PCI bridge to [bus 02]
[ 0.288132] pci 0000:00:1c.1: bridge window [mem 0xe4200000-0xe42fffff]
[ 0.288290] pci 0000:00:1c.2: PCI bridge to [bus 03]
[ 0.288526] pci 0000:00:1c.3: PCI bridge to [bus 04]
[ 0.289162] pci 0000:05:00.0: [1180:0476] type 02 class 0x060700
[ 0.289179] pci 0000:05:00.0: calling ricoh_mmc_fixup_rl5c476+0x0/0x110 @ 1
[ 0.289256] pci 0000:05:00.0: ricoh_mmc_fixup_rl5c476+0x0/0x110 took 0 usecs
[ 0.289349] pci 0000:05:00.0: reg 0x10: [mem 0xe2000000-0xe2000fff]
[ 0.289421] pci 0000:05:00.0: supports D1 D2
[ 0.289424] pci 0000:05:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.289809] pci 0000:05:00.1: [1180:0552] type 00 class 0x0c0010
[ 0.289840] pci 0000:05:00.1: reg 0x10: [mem 0xe2001000-0xe20017ff]
[ 0.289972] pci 0000:05:00.1: supports D1 D2
[ 0.289976] pci 0000:05:00.1: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.290265] pci 0000:05:00.2: [1180:0822] type 00 class 0x080500
[ 0.290296] pci 0000:05:00.2: reg 0x10: [mem 0xe2002000-0xe20020ff]
[ 0.290430] pci 0000:05:00.2: supports D1 D2
[ 0.290434] pci 0000:05:00.2: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.290775] pci 0000:00:1e.0: PCI bridge to [bus 05-06] (subtractive decode)
[ 0.290852] pci 0000:00:1e.0: bridge window [io 0x2000-0x3fff]
[ 0.290858] pci 0000:00:1e.0: bridge window [mem 0xe0000000-0xe20fffff]
[ 0.290868] pci 0000:00:1e.0: bridge window [mem 0xe2100000-0xe40fffff 64bit pref]
[ 0.290875] pci 0000:00:1e.0: bridge window [io 0x0000-0xffff] (subtractive decode)
[ 0.290881] pci 0000:00:1e.0: bridge window [mem 0x00000000-0xffffffff] (subtractive decode)
[ 0.291022] pci_bus 0000:06: busn_res: [bus 06] end can not be updated to 09
[ 0.291030] pci 0000:00:1e.0: bridge has subordinate 06 but max busn 09
[ 0.291141] pci_bus 0000:00: on NUMA node 0
[ 0.292090] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 10 12 14 15) *11
[ 0.292667] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 *11 12 14 15)
[ 0.293230] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 10 12 14 15) *11
[ 0.293799] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 *11 12 14 15)
[ 0.294365] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 12 14 15) *11
[ 0.294931] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 *11 12 14 15)
[ 0.295498] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 10 12 14 15) *11
[ 0.296078] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 *11 12 14 15)
[ 0.300266] ACPI: EC: interrupt unblocked
[ 0.300363] ACPI: EC: event unblocked
[ 0.300455] ACPI: \_SB_.PCI0.LPCB.EC__: GPE=0x1c, EC_CMD/EC_SC=0x66, EC_DATA=0x62
[ 0.300544] ACPI: \_SB_.PCI0.LPCB.EC__: Used as boot DSDT EC to handle transactions and events
[ 0.300751] initcall acpi_init+0x0/0x34b returned 0 after 136718 usecs
[ 0.300756] calling pnp_init+0x0/0x14 @ 1
[ 0.300798] initcall pnp_init+0x0/0x14 returned 0 after 0 usecs
[ 0.300801] calling misc_init+0x0/0xb7 @ 1
[ 0.300836] initcall misc_init+0x0/0xb7 returned 0 after 0 usecs
[ 0.300839] calling vga_arb_device_init+0x0/0x2a8 @ 1
[ 0.300929] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[ 0.300929] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[ 0.300929] pci 0000:00:02.0: vgaarb: bridge control possible
[ 0.300929] vgaarb: loaded
[ 0.300929] initcall vga_arb_device_init+0x0/0x2a8 returned 0 after 0 usecs
[ 0.300929] calling cn_init+0x0/0xc0 @ 1
[ 0.300929] initcall cn_init+0x0/0xc0 returned 0 after 0 usecs
[ 0.300929] calling dax_fs_init+0x0/0xbf @ 1
[ 0.300929] initcall dax_fs_init+0x0/0xbf returned 0 after 0 usecs
[ 0.300929] calling dma_buf_init+0x0/0xbf @ 1
[ 0.300929] initcall dma_buf_init+0x0/0xbf returned 0 after 0 usecs
[ 0.300929] calling typec_init+0x0/0x2d @ 1
[ 0.300929] initcall typec_init+0x0/0x2d returned 0 after 0 usecs
[ 0.300929] calling serio_init+0x0/0x2d @ 1
[ 0.300929] initcall serio_init+0x0/0x2d returned 0 after 0 usecs
[ 0.300929] calling input_init+0x0/0xe3 @ 1
[ 0.300929] initcall input_init+0x0/0xe3 returned 0 after 0 usecs
[ 0.300929] calling rtc_init+0x0/0x5d @ 1
[ 0.300929] initcall rtc_init+0x0/0x5d returned 0 after 0 usecs
[ 0.300929] calling pps_init+0x0/0xad @ 1
[ 0.300929] pps_core: LinuxPPS API ver. 1 registered
[ 0.300929] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@xxxxxxxx>
[ 0.300929] initcall pps_init+0x0/0xad returned 0 after 0 usecs
[ 0.300929] calling ptp_init+0x0/0x9e @ 1
[ 0.300929] PTP clock support registered
[ 0.300929] initcall ptp_init+0x0/0x9e returned 0 after 0 usecs
[ 0.300929] calling power_supply_class_init+0x0/0x4e @ 1
[ 0.300929] initcall power_supply_class_init+0x0/0x4e returned 0 after 0 usecs
[ 0.300929] calling hwmon_init+0x0/0xd5 @ 1
[ 0.300947] initcall hwmon_init+0x0/0xd5 returned 0 after 0 usecs
[ 0.300950] calling edac_init+0x0/0x6f @ 1
[ 0.300952] EDAC MC: Ver: 3.0.0
[ 0.301298] initcall edac_init+0x0/0x6f returned 0 after 0 usecs
[ 0.301298] calling leds_init+0x0/0x4b @ 1
[ 0.301298] initcall leds_init+0x0/0x4b returned 0 after 0 usecs
[ 0.301298] calling dmi_init+0x0/0xf4 @ 1
[ 0.301298] initcall dmi_init+0x0/0xf4 returned 0 after 0 usecs
[ 0.301298] calling devfreq_init+0x0/0xaa @ 1
[ 0.301298] initcall devfreq_init+0x0/0xaa returned 0 after 0 usecs
[ 0.301298] calling ras_init+0x0/0x14 @ 1
[ 0.301298] initcall ras_init+0x0/0x14 returned 0 after 0 usecs
[ 0.301298] calling nvmem_init+0x0/0x14 @ 1
[ 0.301298] initcall nvmem_init+0x0/0x14 returned 0 after 0 usecs
[ 0.301298] calling pci_subsys_init+0x0/0x81 @ 1
[ 0.301298] PCI: Using ACPI for IRQ routing
[ 0.302665] PCI: pci_cache_line_size set to 64 bytes
[ 0.302767] e820: reserve RAM buffer [mem 0x7f6fc000-0x7fffffff]
[ 0.302776] initcall pci_subsys_init+0x0/0x81 returned 0 after 3906 usecs
[ 0.302779] calling proto_init+0x0/0x14 @ 1
[ 0.302789] initcall proto_init+0x0/0x14 returned 0 after 0 usecs
[ 0.302792] calling net_dev_init+0x0/0x2f5 @ 1
[ 0.303265] initcall net_dev_init+0x0/0x2f5 returned 0 after 0 usecs
[ 0.303268] calling neigh_init+0x0/0x78 @ 1
[ 0.303283] initcall neigh_init+0x0/0x78 returned 0 after 0 usecs
[ 0.303286] calling fib_notifier_init+0x0/0x14 @ 1
[ 0.303289] initcall fib_notifier_init+0x0/0x14 returned 0 after 0 usecs
[ 0.303292] calling fib_rules_init+0x0/0xa6 @ 1
[ 0.303303] initcall fib_rules_init+0x0/0xa6 returned 0 after 0 usecs
[ 0.303307] calling init_cgroup_netprio+0x0/0x16 @ 1
[ 0.303311] initcall init_cgroup_netprio+0x0/0x16 returned 0 after 0 usecs
[ 0.303314] calling bpf_lwt_init+0x0/0x19 @ 1
[ 0.303317] initcall bpf_lwt_init+0x0/0x19 returned 0 after 0 usecs
[ 0.303320] calling pktsched_init+0x0/0xf6 @ 1
[ 0.303341] initcall pktsched_init+0x0/0xf6 returned 0 after 0 usecs
[ 0.303344] calling tc_filter_init+0x0/0x97 @ 1
[ 0.304080] initcall tc_filter_init+0x0/0x97 returned 0 after 0 usecs
[ 0.304080] calling tc_action_init+0x0/0x65 @ 1
[ 0.304080] initcall tc_action_init+0x0/0x65 returned 0 after 0 usecs
[ 0.304080] calling genl_init+0x0/0x33 @ 1
[ 0.304080] initcall genl_init+0x0/0x33 returned 0 after 0 usecs
[ 0.304080] calling wireless_nlevent_init+0x0/0x38 @ 1
[ 0.304080] initcall wireless_nlevent_init+0x0/0x38 returned 0 after 0 usecs
[ 0.304080] calling watchdog_init+0x0/0xe6 @ 1
[ 0.304080] initcall watchdog_init+0x0/0xe6 returned 0 after 0 usecs
[ 0.304254] calling nmi_warning_debugfs+0x0/0x26 @ 1
[ 0.304269] initcall nmi_warning_debugfs+0x0/0x26 returned 0 after 0 usecs
[ 0.304273] calling save_microcode_in_initrd+0x0/0xd3 @ 1
[ 0.304312] initcall save_microcode_in_initrd+0x0/0xd3 returned 0 after 0 usecs
[ 0.304316] calling hpet_late_init+0x0/0x14f @ 1
[ 0.304339] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[ 0.304418] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.304490] hpet0: 3 comparators, 64-bit 14.318180 MHz counter
[ 0.308041] initcall hpet_late_init+0x0/0x14f returned 0 after 3906 usecs
[ 0.308041] calling init_amd_nbs+0x0/0x135 @ 1
[ 0.308041] initcall init_amd_nbs+0x0/0x135 returned 0 after 0 usecs
[ 0.308041] calling sugov_register+0x0/0x14 @ 1
[ 0.308041] initcall sugov_register+0x0/0x14 returned 0 after 0 usecs
[ 0.308043] calling clocksource_done_booting+0x0/0x40 @ 1
[ 0.308065] clocksource: Switched to clocksource hpet
[ 0.308136] initcall clocksource_done_booting+0x0/0x40 returned 0 after 72 usecs
[ 0.308139] calling tracer_init_tracefs+0x0/0x1c3 @ 1
[ 0.318300] initcall tracer_init_tracefs+0x0/0x1c3 returned 0 after 9974 usecs
[ 0.318304] calling init_trace_printk_function_export+0x0/0x2d @ 1
[ 0.318317] initcall init_trace_printk_function_export+0x0/0x2d returned 0 after 7 usecs
[ 0.318320] calling init_graph_tracefs+0x0/0x2d @ 1
[ 0.318332] initcall init_graph_tracefs+0x0/0x2d returned 0 after 7 usecs
[ 0.318335] calling event_trace_init+0x0/0x280 @ 1
[ 0.373812] initcall event_trace_init+0x0/0x280 returned 0 after 54157 usecs
[ 0.373819] calling init_kprobe_trace+0x0/0x83 @ 1
[ 0.373840] initcall init_kprobe_trace+0x0/0x83 returned 0 after 16 usecs
[ 0.373845] calling bpf_init+0x0/0x42 @ 1
[ 0.373869] initcall bpf_init+0x0/0x42 returned 0 after 19 usecs
[ 0.373873] calling init_pipe_fs+0x0/0x42 @ 1
[ 0.373949] initcall init_pipe_fs+0x0/0x42 returned 0 after 69 usecs
[ 0.373953] calling cgroup_writeback_init+0x0/0x2c @ 1
[ 0.374009] initcall cgroup_writeback_init+0x0/0x2c returned 0 after 49 usecs
[ 0.374013] calling inotify_user_setup+0x0/0x4a @ 1
[ 0.374029] initcall inotify_user_setup+0x0/0x4a returned 0 after 11 usecs
[ 0.374032] calling eventpoll_init+0x0/0xb2 @ 1
[ 0.374089] initcall eventpoll_init+0x0/0xb2 returned 0 after 50 usecs
[ 0.374092] calling anon_inode_init+0x0/0x64 @ 1
[ 0.374156] initcall anon_inode_init+0x0/0x64 returned 0 after 57 usecs
[ 0.374159] calling init_dax_wait_table+0x0/0x2f @ 1
[ 0.374211] initcall init_dax_wait_table+0x0/0x2f returned 0 after 45 usecs
[ 0.374214] calling proc_locks_init+0x0/0x1f @ 1
[ 0.374228] initcall proc_locks_init+0x0/0x1f returned 0 after 9 usecs
[ 0.374232] calling dquot_init+0x0/0x193 @ 1
[ 0.374234] VFS: Disk quotas dquot_6.6.0
[ 0.374406] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.374484] initcall dquot_init+0x0/0x193 returned 0 after 241 usecs
[ 0.374488] calling quota_init+0x0/0x25 @ 1
[ 0.374533] initcall quota_init+0x0/0x25 returned 0 after 39 usecs
[ 0.374537] calling proc_cmdline_init+0x0/0x1f @ 1
[ 0.374547] initcall proc_cmdline_init+0x0/0x1f returned 0 after 5 usecs
[ 0.374550] calling proc_consoles_init+0x0/0x1f @ 1
[ 0.374558] initcall proc_consoles_init+0x0/0x1f returned 0 after 3 usecs
[ 0.374561] calling proc_cpuinfo_init+0x0/0x1f @ 1
[ 0.374570] initcall proc_cpuinfo_init+0x0/0x1f returned 0 after 3 usecs
[ 0.374573] calling proc_devices_init+0x0/0x1f @ 1
[ 0.374582] initcall proc_devices_init+0x0/0x1f returned 0 after 4 usecs
[ 0.374585] calling proc_interrupts_init+0x0/0x1f @ 1
[ 0.374595] initcall proc_interrupts_init+0x0/0x1f returned 0 after 5 usecs
[ 0.374598] calling proc_loadavg_init+0x0/0x1f @ 1
[ 0.374606] initcall proc_loadavg_init+0x0/0x1f returned 0 after 3 usecs
[ 0.374609] calling proc_meminfo_init+0x0/0x1f @ 1
[ 0.374617] initcall proc_meminfo_init+0x0/0x1f returned 0 after 3 usecs
[ 0.374620] calling proc_stat_init+0x0/0x1f @ 1
[ 0.374628] initcall proc_stat_init+0x0/0x1f returned 0 after 3 usecs
[ 0.374632] calling proc_uptime_init+0x0/0x1f @ 1
[ 0.374640] initcall proc_uptime_init+0x0/0x1f returned 0 after 4 usecs
[ 0.374644] calling proc_version_init+0x0/0x1f @ 1
[ 0.374652] initcall proc_version_init+0x0/0x1f returned 0 after 3 usecs
[ 0.374655] calling proc_softirqs_init+0x0/0x1f @ 1
[ 0.374663] initcall proc_softirqs_init+0x0/0x1f returned 0 after 3 usecs
[ 0.374667] calling proc_kcore_init+0x0/0x10c @ 1
[ 0.374681] initcall proc_kcore_init+0x0/0x10c returned 0 after 9 usecs
[ 0.374684] calling vmcore_init+0x0/0x764 @ 1
[ 0.374690] initcall vmcore_init+0x0/0x764 returned 0 after 1 usecs
[ 0.374693] calling proc_kmsg_init+0x0/0x22 @ 1
[ 0.374702] initcall proc_kmsg_init+0x0/0x22 returned 0 after 3 usecs
[ 0.374705] calling proc_page_init+0x0/0x4e @ 1
[ 0.374721] initcall proc_page_init+0x0/0x4e returned 0 after 11 usecs
[ 0.374724] calling init_ramfs_fs+0x0/0x23 @ 1
[ 0.374730] initcall init_ramfs_fs+0x0/0x23 returned 0 after 1 usecs
[ 0.374733] calling init_hugetlbfs_fs+0x0/0x2b7 @ 1
[ 0.374829] initcall init_hugetlbfs_fs+0x0/0x2b7 returned 0 after 87 usecs
[ 0.374833] calling tomoyo_initerface_init+0x0/0x156 @ 1
[ 0.374839] initcall tomoyo_initerface_init+0x0/0x156 returned 0 after 1 usecs
[ 0.374841] calling aa_create_aafs+0x0/0x3c8 @ 1
[ 0.374847] initcall aa_create_aafs+0x0/0x3c8 returned 0 after 1 usecs
[ 0.374850] calling blk_scsi_ioctl_init+0x0/0x352 @ 1
[ 0.374856] initcall blk_scsi_ioctl_init+0x0/0x352 returned 0 after 2 usecs
[ 0.374859] calling dynamic_debug_init_debugfs+0x0/0x5f @ 1
[ 0.374882] initcall dynamic_debug_init_debugfs+0x0/0x5f returned 0 after 18 usecs
[ 0.374886] calling simplefb_init+0x0/0x16 @ 1
[ 0.374946] initcall simplefb_init+0x0/0x16 returned 0 after 54 usecs
[ 0.374950] calling acpi_event_init+0x0/0x31 @ 1
[ 0.374981] initcall acpi_event_init+0x0/0x31 returned 0 after 25 usecs
[ 0.374985] calling pnp_system_init+0x0/0x14 @ 1
[ 0.375021] initcall pnp_system_init+0x0/0x14 returned 0 after 30 usecs
[ 0.375025] calling pnpacpi_init+0x0/0x6c @ 1
[ 0.375027] pnp: PnP ACPI init
[ 0.375572] system 00:00: [mem 0xfed1c000-0xfed1ffff] has been reserved
[ 0.375650] system 00:00: [mem 0xfed14000-0xfed17fff] has been reserved
[ 0.375727] system 00:00: [mem 0xfed18000-0xfed18fff] has been reserved
[ 0.375803] system 00:00: [mem 0xfed19000-0xfed19fff] has been reserved
[ 0.375887] system 00:00: [mem 0xf0000000-0xf3ffffff] has been reserved
[ 0.375964] system 00:00: [mem 0xfed20000-0xfed3ffff] has been reserved
[ 0.376081] system 00:00: [mem 0xfed40000-0xfed44fff] has been reserved
[ 0.376161] system 00:00: [mem 0xfed45000-0xfed8ffff] has been reserved
[ 0.376249] system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.378885] system 00:01: [mem 0xfed00000-0xfed003ff] has been reserved
[ 0.378973] system 00:01: Plug and Play ACPI device, IDs PNP0103 PNP0c01 (active)
[ 0.379260] system 00:02: [io 0x0800-0x080f] has been reserved
[ 0.379337] system 00:02: [io 0x0500-0x057f] has been reserved
[ 0.379412] system 00:02: [io 0x0480-0x04bf] has been reserved
[ 0.379495] system 00:02: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.379653] pnp 00:03: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 0.379893] pnp 00:04: Plug and Play ACPI device, IDs PNP0303 PNP030b (active)
[ 0.380137] pnp 00:05: Plug and Play ACPI device, IDs PNP0f13 (active)
[ 0.380354] pnp 00:06: Plug and Play ACPI device, IDs WACf004 (active)
[ 0.380572] pnp 00:07: Plug and Play ACPI device, IDs PNP0501 (active)
[ 0.380803] pnp: PnP ACPI: found 8 devices
[ 0.380877] initcall pnpacpi_init+0x0/0x6c returned 0 after 5707 usecs
[ 0.380881] calling chr_dev_init+0x0/0x11f @ 1
[ 0.390711] initcall chr_dev_init+0x0/0x11f returned 0 after 9592 usecs
[ 0.390716] calling firmware_class_init+0x0/0x106 @ 1
[ 0.390724] initcall firmware_class_init+0x0/0x106 returned 0 after 3 usecs
[ 0.390728] calling thermal_init+0x0/0xcc @ 1
[ 0.390793] initcall thermal_init+0x0/0xcc returned 0 after 57 usecs
[ 0.390797] calling cpufreq_gov_performance_init+0x0/0x14 @ 1
[ 0.390804] initcall cpufreq_gov_performance_init+0x0/0x14 returned 0 after 2 usecs
[ 0.390807] calling cpufreq_gov_dbs_init+0x0/0x14 @ 1
[ 0.390813] initcall cpufreq_gov_dbs_init+0x0/0x14 returned 0 after 1 usecs
[ 0.390817] calling pcibios_assign_resources+0x0/0x159 @ 1
[ 0.390853] pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 01] add_size 200000 add_align 100000
[ 0.390924] pci 0000:00:1c.0: BAR 15: assigned [mem 0x80000000-0x801fffff 64bit pref]
[ 0.391017] pci 0000:00:1c.0: PCI bridge to [bus 01]
[ 0.391087] pci 0000:00:1c.0: bridge window [io 0x4000-0x4fff]
[ 0.391162] pci 0000:00:1c.0: bridge window [mem 0xe4100000-0xe41fffff]
[ 0.391236] pci 0000:00:1c.0: bridge window [mem 0x80000000-0x801fffff 64bit pref]
[ 0.391328] pci 0000:00:1c.1: PCI bridge to [bus 02]
[ 0.391401] pci 0000:00:1c.1: bridge window [mem 0xe4200000-0xe42fffff]
[ 0.391481] pci 0000:00:1c.2: PCI bridge to [bus 03]
[ 0.391562] pci 0000:00:1c.3: PCI bridge to [bus 04]
[ 0.391667] pci 0000:05:00.0: BAR 15: assigned [mem 0x84000000-0x87ffffff pref]
[ 0.391753] pci 0000:05:00.0: BAR 16: assigned [mem 0x88000000-0x8bffffff]
[ 0.391825] pci 0000:05:00.0: BAR 13: assigned [io 0x2000-0x20ff]
[ 0.391896] pci 0000:05:00.0: BAR 14: assigned [io 0x2400-0x24ff]
[ 0.391974] pci 0000:05:00.0: CardBus bridge to [bus 06]
[ 0.392070] pci 0000:05:00.0: bridge window [io 0x2000-0x20ff]
[ 0.392144] pci 0000:05:00.0: bridge window [io 0x2400-0x24ff]
[ 0.392218] pci 0000:05:00.0: bridge window [mem 0x84000000-0x87ffffff pref]
[ 0.392305] pci 0000:05:00.0: bridge window [mem 0x88000000-0x8bffffff]
[ 0.392380] pci 0000:00:1e.0: PCI bridge to [bus 05-06]
[ 0.392450] pci 0000:00:1e.0: bridge window [io 0x2000-0x3fff]
[ 0.392524] pci 0000:00:1e.0: bridge window [mem 0xe0000000-0xe20fffff]
[ 0.392598] pci 0000:00:1e.0: bridge window [mem 0xe2100000-0xe40fffff 64bit pref]
[ 0.392690] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]
[ 0.392694] pci_bus 0000:00: resource 5 [mem 0x00000000-0xffffffff]
[ 0.392698] pci_bus 0000:01: resource 0 [io 0x4000-0x4fff]
[ 0.392701] pci_bus 0000:01: resource 1 [mem 0xe4100000-0xe41fffff]
[ 0.392705] pci_bus 0000:01: resource 2 [mem 0x80000000-0x801fffff 64bit pref]
[ 0.392708] pci_bus 0000:02: resource 1 [mem 0xe4200000-0xe42fffff]
[ 0.392712] pci_bus 0000:05: resource 0 [io 0x2000-0x3fff]
[ 0.392715] pci_bus 0000:05: resource 1 [mem 0xe0000000-0xe20fffff]
[ 0.392719] pci_bus 0000:05: resource 2 [mem 0xe2100000-0xe40fffff 64bit pref]
[ 0.392722] pci_bus 0000:05: resource 4 [io 0x0000-0xffff]
[ 0.392725] pci_bus 0000:05: resource 5 [mem 0x00000000-0xffffffff]
[ 0.392729] pci_bus 0000:06: resource 0 [io 0x2000-0x20ff]
[ 0.392732] pci_bus 0000:06: resource 1 [io 0x2400-0x24ff]
[ 0.392736] pci_bus 0000:06: resource 2 [mem 0x84000000-0x87ffffff pref]
[ 0.392739] pci_bus 0000:06: resource 3 [mem 0x88000000-0x8bffffff]
[ 0.393073] initcall pcibios_assign_resources+0x0/0x159 returned 0 after 2197 usecs
[ 0.393076] calling sysctl_core_init+0x0/0x28 @ 1
[ 0.393117] initcall sysctl_core_init+0x0/0x28 returned 0 after 35 usecs
[ 0.393120] calling eth_offload_init+0x0/0x16 @ 1
[ 0.393126] initcall eth_offload_init+0x0/0x16 returned 0 after 1 usecs
[ 0.393129] calling inet_init+0x0/0x285 @ 1
[ 0.393284] NET: Registered protocol family 2
[ 0.393957] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[ 0.394057] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.394169] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.394295] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.394447] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.394532] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.394804] initcall inet_init+0x0/0x285 returned 0 after 1629 usecs
[ 0.394808] calling ipv4_offload_init+0x0/0x6e @ 1
[ 0.394814] initcall ipv4_offload_init+0x0/0x6e returned 0 after 1 usecs
[ 0.394817] calling af_unix_init+0x0/0x4c @ 1
[ 0.394823] NET: Registered protocol family 1
[ 0.394912] initcall af_unix_init+0x0/0x4c returned 0 after 88 usecs
[ 0.394916] calling ipv6_offload_init+0x0/0x77 @ 1
[ 0.394923] initcall ipv6_offload_init+0x0/0x77 returned 0 after 2 usecs
[ 0.394927] calling pci_apply_final_quirks+0x0/0x108 @ 1
[ 0.394950] pci 0000:00:02.0: calling pci_fixup_video+0x0/0x130 @ 1
[ 0.395026] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 0.395115] pci 0000:00:02.0: pci_fixup_video+0x0/0x130 took 89 usecs
[ 0.395228] pci 0000:00:1d.0: calling quirk_usb_early_handoff+0x0/0x860 @ 1
[ 0.397558] pci 0000:00:1d.0: quirk_usb_early_handoff+0x0/0x860 took 2200 usecs
[ 0.397653] pci 0000:00:1d.1: calling quirk_usb_early_handoff+0x0/0x860 @ 1
[ 0.399586] pci 0000:00:1d.1: quirk_usb_early_handoff+0x0/0x860 took 1813 usecs
[ 0.399680] pci 0000:00:1d.2: calling quirk_usb_early_handoff+0x0/0x860 @ 1
[ 0.401691] pci 0000:00:1d.2: quirk_usb_early_handoff+0x0/0x860 took 1888 usecs
[ 0.401786] pci 0000:00:1d.3: calling quirk_usb_early_handoff+0x0/0x860 @ 1
[ 0.403767] pci 0000:00:1d.3: quirk_usb_early_handoff+0x0/0x860 took 1860 usecs
[ 0.403863] pci 0000:00:1d.7: calling quirk_usb_early_handoff+0x0/0x860 @ 1
[ 0.406124] pci 0000:00:1d.7: quirk_usb_early_handoff+0x0/0x860 took 2132 usecs
[ 0.406250] pci 0000:01:00.0: calling quirk_e100_interrupt+0x0/0x1f0 @ 1
[ 0.406325] pci 0000:01:00.0: quirk_e100_interrupt+0x0/0x1f0 took 1 usecs
[ 0.406416] pci 0000:05:00.0: calling quirk_cardbus_legacy+0x0/0x20 @ 1
[ 0.408700] pci 0000:05:00.0: quirk_cardbus_legacy+0x0/0x20 took 2 usecs
[ 0.408784] PCI: CLS 64 bytes, default 64
[ 0.408789] initcall pci_apply_final_quirks+0x0/0x108 returned 0 after 13533 usecs
[ 0.408793] calling acpi_reserve_resources+0x0/0xcd @ 1
[ 0.408813] initcall acpi_reserve_resources+0x0/0xcd returned 0 after 14 usecs
[ 0.408817] calling populate_rootfs+0x0/0xf9 @ 1
[ 0.408991] Unpacking initramfs...
[ 0.503807] Freeing initrd memory: 6876K
[ 0.504152] initcall populate_rootfs+0x0/0xf9 returned 0 after 93082 usecs
[ 0.504160] calling pci_iommu_init+0x0/0x3a @ 1
[ 0.504167] initcall pci_iommu_init+0x0/0x3a returned 0 after 1 usecs
[ 0.504378] calling amd_uncore_init+0x0/0x298 @ 1
[ 0.504383] initcall amd_uncore_init+0x0/0x298 returned -19 after 1 usecs
[ 0.504386] calling amd_ibs_init+0x0/0x196 @ 1
[ 0.504392] initcall amd_ibs_init+0x0/0x196 returned -19 after 1 usecs
[ 0.504395] calling msr_init+0x0/0x29b @ 1
[ 0.504437] initcall msr_init+0x0/0x29b returned 0 after 35 usecs
[ 0.504440] calling register_kernel_offset_dumper+0x0/0x1b @ 1
[ 0.504447] initcall register_kernel_offset_dumper+0x0/0x1b returned 0 after 2 usecs
[ 0.504450] calling i8259A_init_ops+0x0/0x25 @ 1
[ 0.504457] initcall i8259A_init_ops+0x0/0x25 returned 0 after 2 usecs
[ 0.504461] calling init_tsc_clocksource+0x0/0x10c @ 1
[ 0.504480] initcall init_tsc_clocksource+0x0/0x10c returned 0 after 12 usecs
[ 0.504483] calling add_rtc_cmos+0x0/0xb6 @ 1
[ 0.504492] initcall add_rtc_cmos+0x0/0xb6 returned 0 after 5 usecs
[ 0.504496] calling i8237A_init_ops+0x0/0x16 @ 1
[ 0.504519] initcall i8237A_init_ops+0x0/0x16 returned 0 after 16 usecs
[ 0.504523] calling thermal_throttle_init_device+0x0/0x43 @ 1
[ 0.504937] initcall thermal_throttle_init_device+0x0/0x43 returned 0 after 398 usecs
[ 0.504941] calling ioapic_init_ops+0x0/0x16 @ 1
[ 0.504947] initcall ioapic_init_ops+0x0/0x16 returned 0 after 1 usecs
[ 0.504951] calling add_pcspkr+0x0/0x61 @ 1
[ 0.505084] initcall add_pcspkr+0x0/0x61 returned 0 after 124 usecs
[ 0.505091] calling start_periodic_check_for_corruption+0x0/0x60 @ 1
[ 0.505094] Scanning for low memory corruption every 60 seconds
[ 0.505174] initcall start_periodic_check_for_corruption+0x0/0x60 returned 0 after 76 usecs
[ 0.505177] calling sysfb_init+0x0/0xb0 @ 1
[ 0.505650] initcall sysfb_init+0x0/0xb0 returned 0 after 456 usecs
[ 0.505654] calling pt_dump_init+0x0/0x57 @ 1
[ 0.505660] initcall pt_dump_init+0x0/0x57 returned 0 after 1 usecs
[ 0.505662] calling crc32c_intel_mod_init+0x0/0x29 @ 1
[ 0.505668] initcall crc32c_intel_mod_init+0x0/0x29 returned -19 after 1 usecs
[ 0.505671] calling crc32_pclmul_mod_init+0x0/0x34 @ 1
[ 0.505673] PCLMULQDQ-NI instructions are not detected.
[ 0.505744] initcall crc32_pclmul_mod_init+0x0/0x34 returned -19 after 67 usecs
[ 0.505747] calling iosf_mbi_init+0x0/0x1b @ 1
[ 0.505810] initcall iosf_mbi_init+0x0/0x1b returned 0 after 57 usecs
[ 0.505814] calling proc_execdomains_init+0x0/0x1f @ 1
[ 0.505831] initcall proc_execdomains_init+0x0/0x1f returned 0 after 12 usecs
[ 0.505833] calling register_warn_debugfs+0x0/0x24 @ 1
[ 0.505860] initcall register_warn_debugfs+0x0/0x24 returned 0 after 21 usecs
[ 0.505863] calling cpuhp_sysfs_init+0x0/0x5f @ 1
[ 0.505906] initcall cpuhp_sysfs_init+0x0/0x5f returned 0 after 38 usecs
[ 0.505909] calling ioresources_init+0x0/0x32 @ 1
[ 0.505922] initcall ioresources_init+0x0/0x32 returned 0 after 8 usecs
[ 0.505926] calling init_sched_debug_procfs+0x0/0x29 @ 1
[ 0.505935] initcall init_sched_debug_procfs+0x0/0x29 returned 0 after 4 usecs
[ 0.505938] calling snapshot_device_init+0x0/0x14 @ 1
[ 0.506096] initcall snapshot_device_init+0x0/0x14 returned 0 after 148 usecs
[ 0.506099] calling irq_gc_init_ops+0x0/0x16 @ 1
[ 0.506105] initcall irq_gc_init_ops+0x0/0x16 returned 0 after 1 usecs
[ 0.506108] calling irq_pm_init_ops+0x0/0x16 @ 1
[ 0.506114] initcall irq_pm_init_ops+0x0/0x16 returned 0 after 1 usecs
[ 0.506117] calling timekeeping_init_ops+0x0/0x16 @ 1
[ 0.506123] initcall timekeeping_init_ops+0x0/0x16 returned 0 after 1 usecs
[ 0.506126] calling init_clocksource_sysfs+0x0/0x24 @ 1
[ 0.506300] initcall init_clocksource_sysfs+0x0/0x24 returned 0 after 164 usecs
[ 0.506304] calling init_timer_list_procfs+0x0/0x29 @ 1
[ 0.506323] initcall init_timer_list_procfs+0x0/0x29 returned 0 after 13 usecs
[ 0.506326] calling alarmtimer_init+0x0/0x114 @ 1
[ 0.506501] initcall alarmtimer_init+0x0/0x114 returned 0 after 165 usecs
[ 0.506505] calling init_posix_timers+0x0/0x29 @ 1
[ 0.506565] initcall init_posix_timers+0x0/0x29 returned 0 after 54 usecs
[ 0.506569] calling clockevents_init_sysfs+0x0/0xef @ 1
[ 0.506877] initcall clockevents_init_sysfs+0x0/0xef returned 0 after 294 usecs
[ 0.506880] calling proc_dma_init+0x0/0x1f @ 1
[ 0.506890] initcall proc_dma_init+0x0/0x1f returned 0 after 4 usecs
[ 0.506893] calling proc_modules_init+0x0/0x1f @ 1
[ 0.506902] initcall proc_modules_init+0x0/0x1f returned 0 after 4 usecs
[ 0.506905] calling kallsyms_init+0x0/0x22 @ 1
[ 0.506914] initcall kallsyms_init+0x0/0x22 returned 0 after 4 usecs
[ 0.506916] calling pid_namespaces_init+0x0/0x3b @ 1
[ 0.506936] initcall pid_namespaces_init+0x0/0x3b returned 0 after 15 usecs
[ 0.506939] calling audit_watch_init+0x0/0x36 @ 1
[ 0.506947] initcall audit_watch_init+0x0/0x36 returned 0 after 4 usecs
[ 0.506950] calling audit_fsnotify_init+0x0/0x36 @ 1
[ 0.506957] initcall audit_fsnotify_init+0x0/0x36 returned 0 after 3 usecs
[ 0.506960] calling audit_tree_init+0x0/0x90 @ 1
[ 0.506968] initcall audit_tree_init+0x0/0x90 returned 0 after 4 usecs
[ 0.506971] calling init_kprobes+0x0/0x284 @ 1
[ 0.507366] initcall init_kprobes+0x0/0x284 returned 0 after 382 usecs
[ 0.507369] calling seccomp_sysctl_init+0x0/0x31 @ 1
[ 0.507389] initcall seccomp_sysctl_init+0x0/0x31 returned 0 after 15 usecs
[ 0.507392] calling utsname_sysctl_init+0x0/0x16 @ 1
[ 0.507409] initcall utsname_sysctl_init+0x0/0x16 returned 0 after 12 usecs
[ 0.507411] calling init_tracepoints+0x0/0x2b @ 1
[ 0.507417] initcall init_tracepoints+0x0/0x2b returned 0 after 1 usecs
[ 0.507420] calling stack_trace_init+0x0/0x9e @ 1
[ 0.507451] initcall stack_trace_init+0x0/0x9e returned 0 after 25 usecs
[ 0.507453] calling init_mmio_trace+0x0/0xf @ 1
[ 0.507466] initcall init_mmio_trace+0x0/0xf returned 0 after 8 usecs
[ 0.507468] calling init_blk_tracer+0x0/0x4d @ 1
[ 0.507508] initcall init_blk_tracer+0x0/0x4d returned 0 after 34 usecs
[ 0.507512] calling perf_event_sysfs_init+0x0/0x88 @ 1
[ 0.508122] initcall perf_event_sysfs_init+0x0/0x88 returned 0 after 590 usecs
[ 0.508125] calling padata_driver_init+0x0/0x35 @ 1
[ 0.508132] initcall padata_driver_init+0x0/0x35 returned 0 after 2 usecs
[ 0.508135] calling system_trusted_keyring_init+0x0/0x6a @ 1
[ 0.508138] Initialise system trusted keyrings
[ 0.508220] initcall system_trusted_keyring_init+0x0/0x6a returned 0 after 77 usecs
[ 0.508223] calling kswapd_init+0x0/0x3b @ 1
[ 0.508333] initcall kswapd_init+0x0/0x3b returned 0 after 102 usecs
[ 0.508336] calling extfrag_debug_init+0x0/0x71 @ 1
[ 0.508372] initcall extfrag_debug_init+0x0/0x71 returned 0 after 29 usecs
[ 0.508375] calling mm_compute_batch_init+0x0/0x1b @ 1
[ 0.508382] initcall mm_compute_batch_init+0x0/0x1b returned 0 after 2 usecs
[ 0.508386] calling slab_proc_init+0x0/0x22 @ 1
[ 0.508396] initcall slab_proc_init+0x0/0x22 returned 0 after 5 usecs
[ 0.508400] calling workingset_init+0x0/0x8c @ 1
[ 0.508403] workingset: timestamp_bits=14 max_order=19 bucket_order=5
[ 0.508484] initcall workingset_init+0x0/0x8c returned 0 after 77 usecs
[ 0.508487] calling proc_vmalloc_init+0x0/0x22 @ 1
[ 0.508495] initcall proc_vmalloc_init+0x0/0x22 returned 0 after 4 usecs
[ 0.508499] calling procswaps_init+0x0/0x1f @ 1
[ 0.508508] initcall procswaps_init+0x0/0x1f returned 0 after 4 usecs
[ 0.508510] calling init_frontswap+0x0/0x82 @ 1
[ 0.508550] initcall init_frontswap+0x0/0x82 returned 0 after 34 usecs
[ 0.508553] calling slab_proc_init+0x0/0xc @ 1
[ 0.508558] initcall slab_proc_init+0x0/0xc returned 0 after 1 usecs
[ 0.508560] calling cpucache_init+0x0/0x35 @ 1
[ 0.508597] initcall cpucache_init+0x0/0x35 returned 0 after 30 usecs
[ 0.508600] calling init_zbud+0x0/0x20 @ 1
[ 0.508602] zbud: loaded
[ 0.508667] initcall init_zbud+0x0/0x20 returned 0 after 62 usecs
[ 0.508671] calling fcntl_init+0x0/0x29 @ 1
[ 0.508679] initcall fcntl_init+0x0/0x29 returned 0 after 3 usecs
[ 0.508682] calling proc_filesystems_init+0x0/0x1f @ 1
[ 0.508691] initcall proc_filesystems_init+0x0/0x1f returned 0 after 5 usecs
[ 0.508695] calling start_dirtytime_writeback+0x0/0x2c @ 1
[ 0.508701] initcall start_dirtytime_writeback+0x0/0x2c returned 0 after 2 usecs
[ 0.508704] calling blkdev_init+0x0/0x2b @ 1
[ 0.508748] initcall blkdev_init+0x0/0x2b returned 0 after 37 usecs
[ 0.508751] calling dio_init+0x0/0x2c @ 1
[ 0.508785] initcall dio_init+0x0/0x2c returned 0 after 28 usecs
[ 0.508788] calling dnotify_init+0x0/0x6f @ 1
[ 0.508798] initcall dnotify_init+0x0/0x6f returned 0 after 5 usecs
[ 0.508801] calling fanotify_user_setup+0x0/0x6c @ 1
[ 0.508839] initcall fanotify_user_setup+0x0/0x6c returned 0 after 32 usecs
[ 0.508843] calling userfaultfd_init+0x0/0x2c @ 1
[ 0.508871] initcall userfaultfd_init+0x0/0x2c returned 0 after 22 usecs
[ 0.508874] calling aio_setup+0x0/0x91 @ 1
[ 0.508940] initcall aio_setup+0x0/0x91 returned 0 after 60 usecs
[ 0.508944] calling init_devpts_fs+0x0/0x28 @ 1
[ 0.508968] initcall init_devpts_fs+0x0/0x28 returned 0 after 18 usecs
[ 0.508971] calling init_pstore_fs+0x0/0x47 @ 1
[ 0.508975] pstore: using deflate compression
[ 0.509050] initcall init_pstore_fs+0x0/0x47 returned 0 after 72 usecs
[ 0.509053] calling ipc_init+0x0/0x5d @ 1
[ 0.509091] initcall ipc_init+0x0/0x5d returned 0 after 32 usecs
[ 0.509095] calling ipc_sysctl_init+0x0/0x16 @ 1
[ 0.509119] initcall ipc_sysctl_init+0x0/0x16 returned 0 after 19 usecs
[ 0.509122] calling init_mqueue_fs+0x0/0x1c9 @ 1
[ 0.509221] initcall init_mqueue_fs+0x0/0x1c9 returned 0 after 90 usecs
[ 0.509224] calling key_proc_init+0x0/0x50 @ 1
[ 0.509237] initcall key_proc_init+0x0/0x50 returned 0 after 7 usecs
[ 0.509240] calling selinux_nf_ip_init+0x0/0x3c @ 1
[ 0.509246] initcall selinux_nf_ip_init+0x0/0x3c returned 0 after 1 usecs
[ 0.509249] calling init_sel_fs+0x0/0x10e @ 1
[ 0.509255] initcall init_sel_fs+0x0/0x10e returned 0 after 1 usecs
[ 0.509258] calling selnl_init+0x0/0x6e @ 1
[ 0.509283] initcall selnl_init+0x0/0x6e returned 0 after 19 usecs
[ 0.509287] calling sel_netif_init+0x0/0x7d @ 1
[ 0.509292] initcall sel_netif_init+0x0/0x7d returned 0 after 1 usecs
[ 0.509296] calling sel_netnode_init+0x0/0xb3 @ 1
[ 0.509301] initcall sel_netnode_init+0x0/0xb3 returned 0 after 1 usecs
[ 0.509305] calling sel_netport_init+0x0/0xb3 @ 1
[ 0.509310] initcall sel_netport_init+0x0/0xb3 returned 0 after 1 usecs
[ 0.509314] calling aurule_init+0x0/0x2a @ 1
[ 0.509321] initcall aurule_init+0x0/0x2a returned 0 after 3 usecs
[ 0.509324] calling crypto_algapi_init+0x0/0x11 @ 1
[ 0.509332] initcall crypto_algapi_init+0x0/0x11 returned 0 after 4 usecs
[ 0.509335] calling seqiv_module_init+0x0/0x14 @ 1
[ 0.509340] initcall seqiv_module_init+0x0/0x14 returned 0 after 1 usecs
[ 0.509344] calling rsa_init+0x0/0x40 @ 1
[ 0.509438] initcall rsa_init+0x0/0x40 returned 0 after 87 usecs
[ 0.509441] calling hmac_module_init+0x0/0x14 @ 1
[ 0.509446] initcall hmac_module_init+0x0/0x14 returned 0 after 1 usecs
[ 0.509449] calling crypto_null_mod_init+0x0/0x46 @ 1
[ 0.509764] initcall crypto_null_mod_init+0x0/0x46 returned 0 after 302 usecs
[ 0.509767] calling md5_mod_init+0x0/0x14 @ 1
[ 0.509847] initcall md5_mod_init+0x0/0x14 returned 0 after 73 usecs
[ 0.509850] calling sha1_generic_mod_init+0x0/0x14 @ 1
[ 0.509930] initcall sha1_generic_mod_init+0x0/0x14 returned 0 after 73 usecs
[ 0.509933] calling sha256_generic_mod_init+0x0/0x19 @ 1
[ 0.510091] initcall sha256_generic_mod_init+0x0/0x19 returned 0 after 150 usecs
[ 0.510094] calling crypto_ctr_module_init+0x0/0x38 @ 1
[ 0.510100] initcall crypto_ctr_module_init+0x0/0x38 returned 0 after 2 usecs
[ 0.510103] calling crypto_gcm_module_init+0x0/0xa7 @ 1
[ 0.510112] initcall crypto_gcm_module_init+0x0/0xa7 returned 0 after 5 usecs
[ 0.510115] calling aes_init+0x0/0x14 @ 1
[ 0.510193] initcall aes_init+0x0/0x14 returned 0 after 71 usecs
[ 0.510196] calling deflate_mod_init+0x0/0x3d @ 1
[ 0.510436] initcall deflate_mod_init+0x0/0x3d returned 0 after 230 usecs
[ 0.510439] calling crc32c_mod_init+0x0/0x14 @ 1
[ 0.510522] initcall crc32c_mod_init+0x0/0x14 returned 0 after 76 usecs
[ 0.510525] calling crc32_mod_init+0x0/0x14 @ 1
[ 0.510604] initcall crc32_mod_init+0x0/0x14 returned 0 after 72 usecs
[ 0.510607] calling crct10dif_mod_init+0x0/0x14 @ 1
[ 0.510687] initcall crct10dif_mod_init+0x0/0x14 returned 0 after 74 usecs
[ 0.510690] calling lzo_mod_init+0x0/0x38 @ 1
[ 0.510847] initcall lzo_mod_init+0x0/0x38 returned 0 after 148 usecs
[ 0.510850] calling drbg_init+0x0/0xad @ 1
[ 0.511480] initcall drbg_init+0x0/0xad returned 0 after 610 usecs
[ 0.511483] calling jent_mod_init+0x0/0x31 @ 1
[ 0.512116] initcall jent_mod_init+0x0/0x31 returned 0 after 614 usecs
[ 0.512119] calling ghash_mod_init+0x0/0x14 @ 1
[ 0.512262] initcall ghash_mod_init+0x0/0x14 returned 0 after 134 usecs
[ 0.512265] calling asymmetric_key_init+0x0/0x14 @ 1
[ 0.512268] Key type asymmetric registered
[ 0.512337] initcall asymmetric_key_init+0x0/0x14 returned 0 after 66 usecs
[ 0.512340] calling x509_key_init+0x0/0x14 @ 1
[ 0.512343] Asymmetric key parser 'x509' registered
[ 0.512412] initcall x509_key_init+0x0/0x14 returned 0 after 66 usecs
[ 0.512415] calling proc_genhd_init+0x0/0x32 @ 1
[ 0.512428] initcall proc_genhd_init+0x0/0x32 returned 0 after 8 usecs
[ 0.512431] calling init_emergency_pool+0x0/0xa9 @ 1
[ 0.512459] bounce: pool size: 64 pages
[ 0.512577] initcall init_emergency_pool+0x0/0xa9 returned 0 after 137 usecs
[ 0.512580] calling bsg_init+0x0/0x26e @ 1
[ 0.512614] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
[ 0.512701] initcall bsg_init+0x0/0x26e returned 0 after 114 usecs
[ 0.512704] calling throtl_init+0x0/0x3c @ 1
[ 0.512809] initcall throtl_init+0x0/0x3c returned 0 after 98 usecs
[ 0.512812] calling noop_init+0x0/0x14 @ 1
[ 0.512816] io scheduler noop registered
[ 0.512884] initcall noop_init+0x0/0x14 returned 0 after 66 usecs
[ 0.512887] calling deadline_init+0x0/0x14 @ 1
[ 0.512889] io scheduler deadline registered
[ 0.512957] initcall deadline_init+0x0/0x14 returned 0 after 64 usecs
[ 0.512959] calling cfq_init+0x0/0x6e @ 1
[ 0.513026] io scheduler cfq registered (default)
[ 0.513096] initcall cfq_init+0x0/0x6e returned 0 after 129 usecs
[ 0.513099] calling deadline_init+0x0/0x14 @ 1
[ 0.513102] io scheduler mq-deadline registered
[ 0.513170] initcall deadline_init+0x0/0x14 returned 0 after 65 usecs
[ 0.513172] calling kyber_init+0x0/0x14 @ 1
[ 0.513175] io scheduler kyber registered
[ 0.513242] initcall kyber_init+0x0/0x14 returned 0 after 64 usecs
[ 0.513245] calling crc_t10dif_mod_init+0x0/0x35 @ 1
[ 0.513255] initcall crc_t10dif_mod_init+0x0/0x35 returned 0 after 5 usecs
[ 0.513258] calling percpu_counter_startup+0x0/0x50 @ 1
[ 0.513288] initcall percpu_counter_startup+0x0/0x50 returned 0 after 24 usecs
[ 0.513292] calling audit_classes_init+0x0/0x4f @ 1
[ 0.513311] initcall audit_classes_init+0x0/0x4f returned 0 after 14 usecs
[ 0.513314] calling sg_pool_init+0x0/0x297 @ 1
[ 0.513437] initcall sg_pool_init+0x0/0x297 returned 0 after 115 usecs
[ 0.513440] calling phy_core_init+0x0/0x5a @ 1
[ 0.513465] initcall phy_core_init+0x0/0x5a returned 0 after 19 usecs
[ 0.513468] calling pci_proc_init+0x0/0x5d @ 1
[ 0.513586] initcall pci_proc_init+0x0/0x5d returned 0 after 110 usecs
[ 0.513589] calling pcie_portdrv_init+0x0/0x4b @ 1
[ 0.518970] initcall pcie_portdrv_init+0x0/0x4b returned 0 after 5247 usecs
[ 0.518975] calling aer_service_init+0x0/0x3c @ 1
[ 0.519015] initcall aer_service_init+0x0/0x3c returned 0 after 34 usecs
[ 0.519018] calling pcie_pme_service_init+0x0/0x14 @ 1
[ 0.519112] pcieport 0000:00:1c.0: Signaling PME with IRQ 24
[ 0.519272] pcieport 0000:00:1c.1: Signaling PME with IRQ 25
[ 0.519431] pcieport 0000:00:1c.2: Signaling PME with IRQ 26
[ 0.519592] pcieport 0000:00:1c.3: Signaling PME with IRQ 27
[ 0.519698] initcall pcie_pme_service_init+0x0/0x14 returned 0 after 658 usecs
[ 0.519701] calling dpc_service_init+0x0/0x14 @ 1
[ 0.519735] initcall dpc_service_init+0x0/0x14 returned 0 after 28 usecs
[ 0.519738] calling pci_hotplug_init+0x0/0x4c @ 1
[ 0.519743] initcall pci_hotplug_init+0x0/0x4c returned 0 after 0 usecs
[ 0.519746] calling pcied_init+0x0/0x85 @ 1
[ 0.519794] pciehp 0000:00:1c.0:pcie004: Slot #0 AttnBtn- PwrCtrl- MRL- AttnInd- PwrInd- HotPlug+ Surprise+ Interlock- NoCompl- LLActRep+
[ 0.520055] initcall pcied_init+0x0/0x85 returned 0 after 296 usecs
[ 0.520059] calling vesafb_driver_init+0x0/0x16 @ 1
[ 0.520102] initcall vesafb_driver_init+0x0/0x16 returned 0 after 37 usecs
[ 0.520105] calling intel_idle_init+0x0/0x709 @ 1
[ 0.520110] intel_idle: does not run on family 6 model 14
[ 0.520114] initcall intel_idle_init+0x0/0x709 returned -19 after 4 usecs
[ 0.520118] calling acpi_processor_driver_init+0x0/0x8d @ 1
[ 0.520701] Monitor-Mwait will be used to enter C-1 state
[ 0.520717] Monitor-Mwait will be used to enter C-2 state
[ 0.520724] Monitor-Mwait will be used to enter C-3 state
[ 0.520730] tsc: Marking TSC unstable due to TSC halts in idle
[ 0.521789] initcall acpi_processor_driver_init+0x0/0x8d returned 0 after 1620 usecs
[ 0.521794] calling acpi_hed_driver_init+0x0/0x14 @ 1
[ 0.521878] initcall acpi_hed_driver_init+0x0/0x14 returned 0 after 76 usecs
[ 0.521882] calling erst_init+0x0/0x2d4 @ 1
[ 0.521889] initcall erst_init+0x0/0x2d4 returned 0 after 2 usecs
[ 0.521892] calling ghes_init+0x0/0x1a4 @ 1
[ 0.521898] initcall ghes_init+0x0/0x1a4 returned -19 after 1 usecs
[ 0.521901] calling extlog_init+0x0/0x34d @ 1
[ 0.521907] initcall extlog_init+0x0/0x34d returned -19 after 1 usecs
[ 0.521910] calling gpio_clk_driver_init+0x0/0x16 @ 1
[ 0.521954] initcall gpio_clk_driver_init+0x0/0x16 returned 0 after 38 usecs
[ 0.521957] calling plt_clk_driver_init+0x0/0x16 @ 1
[ 0.521991] initcall plt_clk_driver_init+0x0/0x16 returned 0 after 29 usecs
[ 0.521994] calling n_null_init+0x0/0x2b @ 1
[ 0.521999] initcall n_null_init+0x0/0x2b returned 0 after 1 usecs
[ 0.522001] calling pty_init+0x0/0x20c @ 1
[ 0.522188] initcall pty_init+0x0/0x20c returned 0 after 178 usecs
[ 0.522191] calling sysrq_init+0x0/0x5f @ 1
[ 0.522204] initcall sysrq_init+0x0/0x5f returned 0 after 9 usecs
[ 0.522207] calling serial8250_init+0x0/0x180 @ 1
[ 0.522210] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.522538] 00:06: ttyS0 at I/O 0x200 (irq = 5, base_baud = 921600) is a NS16550A
[ 0.523826] initcall serial8250_init+0x0/0x180 returned 0 after 1575 usecs
[ 0.523829] calling serial_pci_driver_init+0x0/0x1b @ 1
[ 0.523927] initcall serial_pci_driver_init+0x0/0x1b returned 0 after 91 usecs
[ 0.523930] calling exar_pci_driver_init+0x0/0x1b @ 1
[ 0.523982] initcall exar_pci_driver_init+0x0/0x1b returned 0 after 45 usecs
[ 0.523985] calling dw8250_platform_driver_init+0x0/0x16 @ 1
[ 0.524064] initcall dw8250_platform_driver_init+0x0/0x16 returned 0 after 72 usecs
[ 0.524067] calling hpet_init+0x0/0x5c @ 1
[ 0.524697] initcall hpet_init+0x0/0x5c returned 0 after 609 usecs
[ 0.524700] calling agp_init+0x0/0x29 @ 1
[ 0.524703] Linux agpgart interface v0.103
[ 0.524771] initcall agp_init+0x0/0x29 returned 0 after 66 usecs
[ 0.524774] calling agp_amd64_mod_init+0x0/0xf @ 1
[ 0.524882] initcall agp_amd64_mod_init+0x0/0xf returned -19 after 100 usecs
[ 0.524885] calling agp_intel_init+0x0/0x2a @ 1
[ 0.525027] initcall agp_intel_init+0x0/0x2a returned 0 after 133 usecs
[ 0.525030] calling agp_sis_init+0x0/0x2a @ 1
[ 0.525076] initcall agp_sis_init+0x0/0x2a returned 0 after 41 usecs
[ 0.525079] calling agp_via_init+0x0/0x2a @ 1
[ 0.525129] initcall agp_via_init+0x0/0x2a returned 0 after 44 usecs
[ 0.525132] calling cn_proc_init+0x0/0x35 @ 1
[ 0.525140] initcall cn_proc_init+0x0/0x35 returned 0 after 4 usecs
[ 0.525145] calling topology_sysfs_init+0x0/0x40 @ 1
[ 0.525211] initcall topology_sysfs_init+0x0/0x40 returned 0 after 60 usecs
[ 0.525214] calling cacheinfo_sysfs_init+0x0/0x2a @ 1
[ 0.525916] initcall cacheinfo_sysfs_init+0x0/0x2a returned 169 after 679 usecs
[ 0.525919] calling devcoredump_init+0x0/0x19 @ 1
[ 0.525949] initcall devcoredump_init+0x0/0x19 returned 0 after 25 usecs
[ 0.525953] calling net_olddevs_init+0x0/0x51 @ 1
[ 0.525964] initcall net_olddevs_init+0x0/0x51 returned 0 after 6 usecs
[ 0.525966] calling fealnx_init+0x0/0x1b @ 1
[ 0.526011] initcall fealnx_init+0x0/0x1b returned 0 after 39 usecs
[ 0.526014] calling ledtrig_usb_init+0x0/0x2a @ 1
[ 0.526026] initcall ledtrig_usb_init+0x0/0x2a returned 0 after 7 usecs
[ 0.526029] calling i8042_init+0x0/0x46c @ 1
[ 0.526172] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 0.537485] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.537570] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 0.537954] initcall i8042_init+0x0/0x46c returned 0 after 11639 usecs
[ 0.537958] calling input_leds_init+0x0/0x14 @ 1
[ 0.537964] initcall input_leds_init+0x0/0x14 returned 0 after 2 usecs
[ 0.537967] calling atkbd_init+0x0/0x25 @ 1
[ 0.538024] initcall atkbd_init+0x0/0x25 returned 0 after 51 usecs
[ 0.538028] calling cmos_init+0x0/0x83 @ 1
[ 0.538133] rtc_cmos 00:03: RTC can wake from S4
[ 0.538597] rtc_cmos 00:03: registered as rtc0
[ 0.538763] rtc_cmos 00:03: alarms up to one month, y3k, 242 bytes nvram, hpet irqs
[ 0.538883] initcall cmos_init+0x0/0x83 returned 0 after 829 usecs
[ 0.538888] calling intel_pstate_init+0x0/0x3e1 @ 1
[ 0.538895] initcall intel_pstate_init+0x0/0x3e1 returned -19 after 2 usecs
[ 0.538898] calling ledtrig_cpu_init+0x0/0xf1 @ 1
[ 0.538952] ledtrig-cpu: registered to indicate activity on CPUs
[ 0.539025] initcall ledtrig_cpu_init+0x0/0xf1 returned 0 after 119 usecs
[ 0.539029] calling dmi_sysfs_init+0x0/0xc1 @ 1
[ 0.539309] initcall dmi_sysfs_init+0x0/0xc1 returned 0 after 268 usecs
[ 0.539313] calling coreboot_table_acpi_init+0x0/0x16 @ 1
[ 0.539429] initcall coreboot_table_acpi_init+0x0/0x16 returned 0 after 108 usecs
[ 0.539433] calling platform_memconsole_init+0x0/0x6a @ 1
[ 0.539609] initcall platform_memconsole_init+0x0/0x6a returned 0 after 165 usecs
[ 0.539613] calling pmc_atom_init+0x0/0x234 @ 1
[ 0.539634] initcall pmc_atom_init+0x0/0x234 returned -19 after 16 usecs
[ 0.539638] calling powercap_init+0x0/0x461 @ 1
[ 0.539881] initcall powercap_init+0x0/0x461 returned 0 after 232 usecs
[ 0.539885] calling pm_check_save_msr+0x0/0x20 @ 1
[ 0.539891] initcall pm_check_save_msr+0x0/0x20 returned 0 after 1 usecs
[ 0.539894] calling sock_diag_init+0x0/0x3e @ 1
[ 0.539953] initcall sock_diag_init+0x0/0x3e returned 0 after 53 usecs
[ 0.539957] calling blackhole_init+0x0/0x14 @ 1
[ 0.539963] initcall blackhole_init+0x0/0x14 returned 0 after 1 usecs
[ 0.539966] calling gre_offload_init+0x0/0x47 @ 1
[ 0.539971] initcall gre_offload_init+0x0/0x47 returned 0 after 1 usecs
[ 0.539974] calling sysctl_ipv4_init+0x0/0x45 @ 1
[ 0.540110] initcall sysctl_ipv4_init+0x0/0x45 returned 0 after 127 usecs
[ 0.540114] calling cubictcp_register+0x0/0x120 @ 1
[ 0.540120] initcall cubictcp_register+0x0/0x120 returned 0 after 2 usecs
[ 0.540123] calling tls_register+0x0/0x10c @ 1
[ 0.540130] initcall tls_register+0x0/0x10c returned 0 after 2 usecs
[ 0.540133] calling inet6_init+0x0/0x375 @ 1
[ 0.540326] NET: Registered protocol family 10
[ 0.541276] Segment Routing with IPv6
[ 0.541410] initcall inet6_init+0x0/0x375 returned 0 after 1241 usecs
[ 0.541414] calling mip6_init+0x0/0xac @ 1
[ 0.541416] mip6: Mobile IPv6
[ 0.541483] initcall mip6_init+0x0/0xac returned 0 after 63 usecs
[ 0.541486] calling packet_init+0x0/0x3e @ 1
[ 0.541502] NET: Registered protocol family 17
[ 0.541577] initcall packet_init+0x0/0x3e returned 0 after 84 usecs
[ 0.541580] calling strp_mod_init+0x0/0x2b @ 1
[ 0.541710] initcall strp_mod_init+0x0/0x2b returned 0 after 120 usecs
[ 0.541714] calling dcbnl_init+0x0/0x6e @ 1
[ 0.541725] initcall dcbnl_init+0x0/0x6e returned 0 after 6 usecs
[ 0.541728] calling mpls_gso_init+0x0/0x2a @ 1
[ 0.541730] mpls_gso: MPLS GSO support
[ 0.541799] initcall mpls_gso_init+0x0/0x2a returned 0 after 65 usecs
[ 0.541803] calling mcheck_init_device+0x0/0x120 @ 1
[ 0.542232] initcall mcheck_init_device+0x0/0x120 returned 0 after 414 usecs
[ 0.542236] calling dev_mcelog_init_device+0x0/0x4b @ 1
[ 0.542387] initcall dev_mcelog_init_device+0x0/0x4b returned 0 after 143 usecs
[ 0.542593] calling mcheck_late_init+0x0/0x69 @ 1
[ 0.542621] initcall mcheck_late_init+0x0/0x69 returned 0 after 23 usecs
[ 0.542624] calling severities_debugfs_init+0x0/0x3a @ 1
[ 0.542642] initcall severities_debugfs_init+0x0/0x3a returned 0 after 12 usecs
[ 0.542645] calling threshold_init_device+0x0/0x47 @ 1
[ 0.542650] initcall threshold_init_device+0x0/0x47 returned 0 after 1 usecs
[ 0.542653] calling microcode_init+0x0/0x204 @ 1
[ 0.542770] microcode: sig=0x6ec, pf=0x20, revision=0x54
[ 0.543038] microcode: Microcode Update Driver: v2.2.
[ 0.543044] initcall microcode_init+0x0/0x204 returned 0 after 376 usecs
[ 0.543113] calling hpet_insert_resource+0x0/0x24 @ 1
[ 0.543120] initcall hpet_insert_resource+0x0/0x24 returned 0 after 2 usecs
[ 0.543123] calling update_mp_table+0x0/0xa1d @ 1
[ 0.543129] initcall update_mp_table+0x0/0xa1d returned 0 after 1 usecs
[ 0.543132] calling lapic_insert_resource+0x0/0x3b @ 1
[ 0.543138] initcall lapic_insert_resource+0x0/0x3b returned 0 after 1 usecs
[ 0.543141] calling print_ICs+0x0/0x1a4 @ 1
[ 0.543147] initcall print_ICs+0x0/0x1a4 returned 0 after 1 usecs
[ 0.543150] calling print_ipi_mode+0x0/0x2b @ 1
[ 0.543153] Using IPI No-Shortcut mode
[ 0.543220] initcall print_ipi_mode+0x0/0x2b returned 0 after 63 usecs
[ 0.543223] calling pat_memtype_list_init+0x0/0x4d @ 1
[ 0.543228] initcall pat_memtype_list_init+0x0/0x4d returned 0 after 1 usecs
[ 0.543231] calling create_tlb_single_page_flush_ceiling+0x0/0x28 @ 1
[ 0.543246] initcall create_tlb_single_page_flush_ceiling+0x0/0x28 returned 0 after 10 usecs
[ 0.543251] calling init_oops_id+0x0/0x50 @ 1
[ 0.543258] initcall init_oops_id+0x0/0x50 returned 0 after 3 usecs
[ 0.543262] calling sched_clock_init_late+0x0/0xab @ 1
[ 0.543268] initcall sched_clock_init_late+0x0/0xab returned 0 after 1 usecs
[ 0.543271] calling sched_init_debug+0x0/0x3a @ 1
[ 0.543292] initcall sched_init_debug+0x0/0x3a returned 0 after 15 usecs
[ 0.543295] calling pm_qos_power_init+0x0/0x131 @ 1
[ 0.543866] initcall pm_qos_power_init+0x0/0x131 returned 0 after 551 usecs
[ 0.543870] calling pm_debugfs_init+0x0/0x24 @ 1
[ 0.543883] initcall pm_debugfs_init+0x0/0x24 returned 0 after 8 usecs
[ 0.543887] calling printk_late_init+0x0/0x10c @ 1
[ 0.543893] initcall printk_late_init+0x0/0x10c returned 0 after 2 usecs
[ 0.543897] calling tk_debug_sleep_time_init+0x0/0x3c @ 1
[ 0.543910] initcall tk_debug_sleep_time_init+0x0/0x3c returned 0 after 7 usecs
[ 0.543913] calling debugfs_kprobe_init+0x0/0xb7 @ 1
[ 0.543950] initcall debugfs_kprobe_init+0x0/0xb7 returned 0 after 31 usecs
[ 0.543952] calling taskstats_init+0x0/0x38 @ 1
[ 0.543976] registered taskstats version 1
[ 0.544082] initcall taskstats_init+0x0/0x38 returned 0 after 121 usecs
[ 0.544086] calling load_system_certificate_list+0x0/0x13a @ 1
[ 0.544088] Loading compiled-in X.509 certificates
[ 0.544163] initcall load_system_certificate_list+0x0/0x13a returned 0 after 71 usecs
[ 0.544166] calling fault_around_debugfs+0x0/0x35 @ 1
[ 0.544212] initcall fault_around_debugfs+0x0/0x35 returned 0 after 39 usecs
[ 0.544215] calling max_swapfiles_check+0x0/0xc @ 1
[ 0.544220] initcall max_swapfiles_check+0x0/0xc returned 0 after 1 usecs
[ 0.544223] calling init_zswap+0x0/0x40f @ 1
[ 0.544277] zswap: loaded using pool lzo/zbud
[ 0.544487] initcall init_zswap+0x0/0x40f returned 0 after 252 usecs
[ 0.544491] calling split_huge_pages_debugfs+0x0/0x35 @ 1
[ 0.544503] initcall split_huge_pages_debugfs+0x0/0x35 returned 0 after 7 usecs
[ 0.544506] calling kmemleak_late_init+0x0/0x8d @ 1
[ 0.544615] kmemleak: Kernel memory leak detector initialized
[ 0.544624] kmemleak: Automatic memory scanning thread started
[ 0.544691] initcall kmemleak_late_init+0x0/0x8d returned 0 after 173 usecs
[ 0.544757] calling check_early_ioremap_leak+0x0/0x93 @ 1
[ 0.544763] initcall check_early_ioremap_leak+0x0/0x93 returned 0 after 1 usecs
[ 0.544767] calling init_root_keyring+0x0/0xf @ 1
[ 0.544807] initcall init_root_keyring+0x0/0xf returned 0 after 33 usecs
[ 0.544810] calling init_profile_hash+0x0/0x94 @ 1
[ 0.544815] initcall init_profile_hash+0x0/0x94 returned 0 after 1 usecs
[ 0.544818] calling prandom_reseed+0x0/0x27 @ 1
[ 0.544828] initcall prandom_reseed+0x0/0x27 returned 0 after 5 usecs
[ 0.544831] calling init_error_injection+0x0/0x61 @ 1
[ 0.545506] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[ 0.546448] initcall init_error_injection+0x0/0x61 returned 0 after 1573 usecs
[ 0.546452] calling pci_resource_alignment_sysfs_init+0x0/0x19 @ 1
[ 0.546463] initcall pci_resource_alignment_sysfs_init+0x0/0x19 returned 0 after 6 usecs
[ 0.546466] calling pci_sysfs_init+0x0/0x47 @ 1
[ 0.547455] initcall pci_sysfs_init+0x0/0x47 returned 0 after 960 usecs
[ 0.547459] calling bert_init+0x0/0x246 @ 1
[ 0.547466] initcall bert_init+0x0/0x246 returned 0 after 2 usecs
[ 0.547470] calling clk_debug_init+0x0/0x10c @ 1
[ 0.547514] initcall clk_debug_init+0x0/0x10c returned 0 after 39 usecs
[ 0.547518] calling dmar_free_unused_resources+0x0/0x12e @ 1
[ 0.547523] initcall dmar_free_unused_resources+0x0/0x12e returned 0 after 1 usecs
[ 0.547528] calling deferred_probe_initcall+0x0/0x30 @ 1
[ 0.547546] initcall deferred_probe_initcall+0x0/0x30 returned 0 after 12 usecs
[ 0.547549] calling rtc_hctosys+0x0/0x160 @ 1
[ 0.547611] rtc_cmos 00:03: setting system clock to 2018-05-03 06:22:29 UTC (1525328549)
[ 0.547700] initcall rtc_hctosys+0x0/0x160 returned 0 after 143 usecs
[ 0.547704] calling firmware_memmap_init+0x0/0x3d @ 1
[ 0.547852] initcall firmware_memmap_init+0x0/0x3d returned 0 after 138 usecs
[ 0.547856] calling pci_mmcfg_late_insert_resources+0x0/0x59 @ 1
[ 0.547863] initcall pci_mmcfg_late_insert_resources+0x0/0x59 returned 0 after 2 usecs
[ 0.547866] calling tcp_congestion_default+0x0/0x19 @ 1
[ 0.547873] initcall tcp_congestion_default+0x0/0x19 returned 0 after 1 usecs
[ 0.547876] calling software_resume+0x0/0x390 @ 1
[ 0.547882] initcall software_resume+0x0/0x390 returned -2 after 1 usecs
[ 0.547885] calling tracing_set_default_clock+0x0/0x36 @ 1
[ 0.547888] Unstable clock detected, switching default tracing clock to "global"
If you want to keep using the local clock, then add:
"trace_clock=local"
on the kernel command line
[ 0.548130] initcall tracing_set_default_clock+0x0/0x36 returned 0 after 233 usecs
[ 0.548133] calling clear_boot_tracer+0x0/0x2a @ 1
[ 0.548138] initcall clear_boot_tracer+0x0/0x2a returned 0 after 1 usecs
[ 0.548142] calling clk_disable_unused+0x0/0x1b0 @ 1
[ 0.548149] initcall clk_disable_unused+0x0/0x1b0 returned 0 after 1 usecs
[ 0.554481] Freeing unused kernel memory: 1180K
[ 0.554735] Write protecting the kernel text: 10560k
[ 0.554894] Write protecting the kernel read-only data: 2388k
[ 0.739889] random: systemd-udevd: uninitialized urandom read (16 bytes read)
[ 0.740527] random: systemd-udevd: uninitialized urandom read (16 bytes read)
[ 0.740638] random: systemd-udevd: uninitialized urandom read (16 bytes read)
[ 0.841597] calling acpi_thermal_init+0x0/0x1000 [thermal] @ 97
[ 0.852381] thermal LNXTHERM:00: registered as thermal_zone0
[ 0.852460] ACPI: Thermal Zone [THM0] (49 C)
[ 0.857813] thermal LNXTHERM:01: registered as thermal_zone1
[ 0.857891] ACPI: Thermal Zone [THM1] (41 C)
[ 0.858300] initcall acpi_thermal_init+0x0/0x1000 [thermal] returned 0 after 16298 usecs
[ 0.865681] calling acpi_fan_driver_init+0x0/0x1000 [fan] @ 105
[ 0.874316] initcall acpi_fan_driver_init+0x0/0x1000 [fan] returned 0 after 8420 usecs
[ 0.885654] calling init_scsi+0x0/0x92 [scsi_mod] @ 102
[ 0.886300] SCSI subsystem initialized
[ 0.886396] initcall init_scsi+0x0/0x92 [scsi_mod] returned 0 after 698 usecs
[ 0.890702] calling serio_raw_drv_init+0x0/0x1000 [serio_raw] @ 96
[ 0.890750] calling ata_init+0x0/0x371 [libata] @ 102
[ 0.890798] initcall serio_raw_drv_init+0x0/0x1000 [serio_raw] returned 0 after 40 usecs
[ 0.890882] libata version 3.00 loaded.
[ 0.890906] initcall ata_init+0x0/0x371 [libata] returned 0 after 128 usecs
[ 0.893477] calling ahci_pci_driver_init+0x0/0x1000 [ahci] @ 102
[ 0.893622] ahci 0000:00:1f.2: version 3.0
[ 0.893919] calling evdev_init+0x0/0x1000 [evdev] @ 95
[ 0.895062] ahci 0000:00:1f.2: SSS flag set, parallel bus scan disabled
[ 0.895173] ahci 0000:00:1f.2: AHCI 0001.0100 32 slots 4 ports 1.5 Gbps 0x1 impl SATA mode
[ 0.895183] initcall evdev_init+0x0/0x1000 [evdev] returned 0 after 1225 usecs
[ 0.895262] ahci 0000:00:1f.2: flags: 64bit ncq ilck stag pm led clo pmp pio slum part
[ 0.899221] scsi host0: ahci
[ 0.901797] scsi host1: ahci
[ 0.910780] scsi host2: ahci
[ 0.911501] scsi host3: ahci
[ 0.911969] ata1: SATA max UDMA/133 abar m1024@0xe4445000 port 0xe4445100 irq 28
[ 0.912088] ata2: DUMMY
[ 0.912158] ata3: DUMMY
[ 0.912222] ata4: DUMMY
[ 0.912513] initcall ahci_pci_driver_init+0x0/0x1000 [ahci] returned 0 after 18143 usecs
[ 1.056145] clocksource: timekeeping watchdog on CPU1: Marking clocksource 'tsc-early' as unstable because the skew is too large:
[ 1.056260] clocksource: 'hpet' wd_now: 103c9d9 wd_last: 930814 mask: ffffffff
[ 1.056346] clocksource: 'tsc-early' cs_now: 1d27b33be cs_last: 1a99f9e12 mask: ffffffffffffffff
[ 1.056480] _warn_unseeded_randomness: 538 callbacks suppressed
[ 1.056490] random: get_random_u32 called from copy_process.part.33+0x186/0x2100 with crng_init=0
[ 1.056674] random: get_random_u32 called from cache_alloc_refill+0x5bb/0x13d0 with crng_init=0
[ 1.232904] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 1.240663] ata1.00: ATA-9: M4-CT256M4SSD2, 070H, max UDMA/100
[ 1.240733] ata1.00: 500118192 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[ 1.241244] ata1.00: configured for UDMA/100
[ 1.242074] scsi 0:0:0:0: Direct-Access ATA M4-CT256M4SSD2 070H PQ: 0 ANSI: 5
[ 1.249085] calling init_sd+0x0/0x1000 [sd_mod] @ 96
[ 1.250085] initcall init_sd+0x0/0x1000 [sd_mod] returned 0 after 965 usecs
[ 1.250221] sd 0:0:0:0: [sda] 500118192 512-byte logical blocks: (256 GB/238 GiB)
[ 1.250359] sd 0:0:0:0: [sda] Write Protect is off
[ 1.250430] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 1.250510] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 1.252153] sda: sda1 sda2
[ 1.253533] sd 0:0:0:0: [sda] Attached SCSI disk
[ 1.254558] random: get_random_u32 called from copy_process.part.33+0x186/0x2100 with crng_init=0
[ 1.260647] random: fast init done
[ 1.344545] calling dm_init+0x0/0xd2 [dm_mod] @ 127
[ 1.344642] device-mapper: uevent: version 1.0.3
[ 1.345035] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@xxxxxxxxxx
[ 1.345140] initcall dm_init+0x0/0xd2 [dm_mod] returned 0 after 560 usecs
[ 1.346349] calling dm_crypt_init+0x0/0x1000 [dm_crypt] @ 127
[ 1.346359] initcall dm_crypt_init+0x0/0x1000 [dm_crypt] returned 0 after 2 usecs
[ 5.917398] _warn_unseeded_randomness: 93 callbacks suppressed
[ 5.917407] random: get_random_u32 called from copy_process.part.33+0x186/0x2100 with crng_init=1
[ 5.917733] random: get_random_u32 called from arch_rnd.part.2+0x18/0x40 with crng_init=1
[ 5.917825] random: get_random_u32 called from load_elf_binary+0x76a/0x1d20 with crng_init=1
[ 5.928299] calling crypto_cbc_module_init+0x0/0x1000 [cbc] @ 146
[ 5.928309] initcall crypto_cbc_module_init+0x0/0x1000 [cbc] returned 0 after 2 usecs
[ 6.238478] calling fscrypt_init+0x0/0x1000 [fscrypto] @ 187
[ 6.238596] initcall fscrypt_init+0x0/0x1000 [fscrypto] returned 0 after 101 usecs
[ 6.241585] calling journal_init+0x0/0x7bf [jbd2] @ 187
[ 6.241785] initcall journal_init+0x0/0x7bf [jbd2] returned 0 after 178 usecs
[ 6.242498] calling mbcache_init+0x0/0x1000 [mbcache] @ 187
[ 6.242514] initcall mbcache_init+0x0/0x1000 [mbcache] returned 0 after 9 usecs
[ 6.260014] calling ext4_init_fs+0x0/0x171 [ext4] @ 187
[ 6.260370] initcall ext4_init_fs+0x0/0x171 [ext4] returned 0 after 229 usecs
[ 6.397040] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
[ 6.953637] _warn_unseeded_randomness: 324 callbacks suppressed
[ 6.953647] random: get_random_u32 called from cache_alloc_refill+0x5bb/0x13d0 with crng_init=1
[ 7.049340] calling init_autofs4_fs+0x0/0x29 [autofs4] @ 1
[ 7.049541] initcall init_autofs4_fs+0x0/0x29 [autofs4] returned 0 after 185 usecs
[ 7.066892] calling xt_init+0x0/0x1000 [x_tables] @ 1
[ 7.066907] initcall xt_init+0x0/0x1000 [x_tables] returned 0 after 5 usecs
[ 7.071445] calling ip_tables_init+0x0/0x1000 [ip_tables] @ 1
[ 7.071475] initcall ip_tables_init+0x0/0x1000 [ip_tables] returned 0 after 22 usecs
[ 7.089761] systemd[1]: systemd 232 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN)
[ 7.108332] systemd[1]: Detected architecture x86.
[ 7.114581] systemd[1]: Set hostname to <gm-debian>.
[ 7.115645] random: get_random_u32 called from bucket_table_alloc+0x163/0x340 with crng_init=1
[ 7.128342] random: get_random_u32 called from cache_alloc_refill+0x5bb/0x13d0 with crng_init=1
[ 7.543404] random: crng init done
[ 7.543479] random: 161 get_random_xx warning(s) missed due to ratelimiting
[ 7.543548] random: 7 urandom warning(s) missed due to ratelimiting
[ 7.596291] systemd[1]: Listening on udev Control Socket.
[ 7.597141] systemd[1]: Listening on Journal Audit Socket.
[ 7.597724] systemd[1]: Listening on Network Service Netlink Socket.
[ 7.598344] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[ 7.598937] systemd[1]: Listening on Journal Socket (/dev/log).
[ 7.599460] systemd[1]: Listening on Syslog Socket.
[ 7.600107] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[ 7.742827] EXT4-fs (dm-0): re-mounted. Opts: errors=remount-ro,discard
[ 8.837895] systemd-journald[238]: Received request to flush runtime journal from PID 1
[ 9.503347] calling acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] @ 282
[ 9.513858] calling acpi_button_driver_init+0x0/0x1000 [button] @ 278
[ 9.514158] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:22/PNP0C09:00/PNP0C0E:00/input/input2
[ 9.520461] initcall acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] returned 0 after 6431 usecs
[ 9.525909] ACPI: Sleep Button [SLPB]
[ 9.528812] calling pcc_cpufreq_init+0x0/0xe57 [pcc_cpufreq] @ 282
[ 9.528836] initcall pcc_cpufreq_init+0x0/0xe57 [pcc_cpufreq] returned -19 after 15 usecs
[ 9.533400] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:22/PNP0C09:00/PNP0C0D:00/input/input3
[ 9.536928] ACPI: Lid Switch [LID]
[ 9.537325] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4
[ 9.538363] ACPI: Power Button [PWRF]
[ 9.543629] initcall acpi_button_driver_init+0x0/0x1000 [button] returned 0 after 14456 usecs
[ 9.581180] calling init_soundcore+0x0/0x1000 [soundcore] @ 279
[ 9.581233] initcall init_soundcore+0x0/0x1000 [soundcore] returned 0 after 42 usecs
[ 9.587178] calling acpi_video_init+0x0/0x1000 [video] @ 276
[ 9.587208] initcall acpi_video_init+0x0/0x1000 [video] returned 0 after 20 usecs
[ 9.597553] calling alsa_sound_init+0x0/0x82 [snd] @ 279
[ 9.597679] initcall alsa_sound_init+0x0/0x82 [snd] returned 0 after 106 usecs
[ 9.598565] calling shpcd_init+0x0/0x1000 [shpchp] @ 286
[ 9.598665] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 9.598750] initcall shpcd_init+0x0/0x1000 [shpchp] returned 0 after 171 usecs
[ 9.603735] calling alsa_timer_init+0x0/0x1000 [snd_timer] @ 279
[ 9.603945] initcall alsa_timer_init+0x0/0x1000 [snd_timer] returned 0 after 193 usecs
[ 9.626681] calling alsa_pcm_init+0x0/0x1000 [snd_pcm] @ 279
[ 9.626719] initcall alsa_pcm_init+0x0/0x1000 [snd_pcm] returned 0 after 19 usecs
[ 9.629222] calling alsa_hwdep_init+0x0/0x1000 [snd_hwdep] @ 279
[ 9.629244] initcall alsa_hwdep_init+0x0/0x1000 [snd_hwdep] returned 0 after 15 usecs
[ 9.643817] calling hda_bus_init+0x0/0x14 [snd_hda_core] @ 279
[ 9.643896] initcall hda_bus_init+0x0/0x14 [snd_hda_core] returned 0 after 59 usecs
[ 9.683221] calling acpi_battery_init+0x0/0xf81 [battery] @ 285
[ 9.683242] initcall acpi_battery_init+0x0/0xf81 [battery] returned 0 after 11 usecs
[ 9.687617] ACPI: Battery Slot [BAT0] (battery absent)
[ 9.688108] ACPI: Battery Slot [BAT1] (battery absent)
[ 9.719189] calling acpi_ac_init+0x0/0x1000 [ac] @ 283
[ 9.809853] calling e1000_init_module+0x0/0x1000 [e1000e] @ 280
[ 9.809859] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k
[ 9.809935] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[ 9.811039] e1000e 0000:01:00.0: Interrupt Throttling Rate (ints/sec) set to dynamic conservative mode
[ 9.811831] calling rfkill_init+0x0/0x12e [rfkill] @ 275
[ 9.812114] initcall rfkill_init+0x0/0x12e [rfkill] returned 0 after 266 usecs
[ 9.818905] calling usb_init+0x0/0x161 [usbcore] @ 281
[ 9.818937] ACPI: bus type USB registered
[ 9.819167] usbcore: registered new interface driver usbfs
[ 9.819316] usbcore: registered new interface driver hub
[ 9.821944] calling azx_driver_init+0x0/0xfe4 [snd_hda_intel] @ 279
[ 9.823157] snd_hda_intel 0000:00:1b.0: probe_mask set to 0x1 for device 17aa:2010
[ 9.824028] usbcore: registered new device driver usb
[ 9.824143] initcall usb_init+0x0/0x161 [usbcore] returned 0 after 2106 usecs
[ 9.825555] initcall azx_driver_init+0x0/0xfe4 [snd_hda_intel] returned 0 after 3509 usecs
[ 9.838491] ACPI: AC Adapter [AC] (on-line)
[ 9.838682] initcall acpi_ac_init+0x0/0x1000 [ac] returned 0 after 16336 usecs
[ 9.848697] calling ehci_hcd_init+0x0/0x1000 [ehci_hcd] @ 277
[ 9.848703] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 9.848812] initcall ehci_hcd_init+0x0/0x1000 [ehci_hcd] returned 0 after 99 usecs
[ 9.859345] calling uhci_hcd_init+0x0/0x1000 [uhci_hcd] @ 285
[ 9.859350] uhci_hcd: USB Universal Host Controller Interface driver
[ 9.872811] calling ehci_pci_init+0x0/0x1000 [ehci_pci] @ 287
[ 9.872818] ehci-pci: EHCI PCI platform driver
[ 9.876511] calling nvram_init+0x0/0x1000 [nvram] @ 278
[ 9.876998] calling generic_driver_init+0x0/0x1000 [snd_hda_codec_generic] @ 288
[ 9.877084] initcall generic_driver_init+0x0/0x1000 [snd_hda_codec_generic] returned 0 after 72 usecs
[ 9.877557] Non-volatile memory driver v1.3
[ 9.877634] initcall nvram_init+0x0/0x1000 [nvram] returned 0 after 613 usecs
[ 9.880803] calling analog_driver_init+0x0/0x1000 [snd_hda_codec_analog] @ 288
[ 9.881300] snd_hda_codec_analog hdaudioC0D0: autoconfig for AD1981: line_outs=1 (0x5/0x0/0x0/0x0/0x0) type:speaker
[ 9.881396] snd_hda_codec_analog hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
[ 9.881484] snd_hda_codec_analog hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0)
[ 9.881571] snd_hda_codec_analog hdaudioC0D0: mono: mono_out=0x0
[ 9.881644] snd_hda_codec_analog hdaudioC0D0: dig-out=0xa/0x0
[ 9.881717] snd_hda_codec_analog hdaudioC0D0: inputs:
[ 9.881787] snd_hda_codec_analog hdaudioC0D0: Mic=0x8
[ 9.881857] snd_hda_codec_analog hdaudioC0D0: CD=0x19
[ 9.884686] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 9.884810] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1
[ 9.884917] uhci_hcd 0000:00:1d.0: detected 2 ports
[ 9.885072] uhci_hcd 0000:00:1d.0: irq 16, io base 0x00005000
[ 9.885597] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.17
[ 9.885684] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.885769] usb usb1: Product: UHCI Host Controller
[ 9.885837] usb usb1: Manufacturer: Linux 4.17.0-rc3+ uhci_hcd
[ 9.885907] usb usb1: SerialNumber: 0000:00:1d.0
[ 9.900502] hub 1-0:1.0: USB hub found
[ 9.900612] hub 1-0:1.0: 2 ports detected
[ 9.902410] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 9.902505] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2
[ 9.902609] uhci_hcd 0000:00:1d.1: detected 2 ports
[ 9.902753] uhci_hcd 0000:00:1d.1: irq 17, io base 0x00005020
[ 9.903913] initcall analog_driver_init+0x0/0x1000 [snd_hda_codec_analog] returned 0 after 22555 usecs
[ 9.904172] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.17
[ 9.904263] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.904351] usb usb2: Product: UHCI Host Controller
[ 9.904420] usb usb2: Manufacturer: Linux 4.17.0-rc3+ uhci_hcd
[ 9.904491] usb usb2: SerialNumber: 0000:00:1d.1
[ 9.905248] hub 2-0:1.0: USB hub found
[ 9.905351] hub 2-0:1.0: 2 ports detected
[ 9.909972] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 9.910071] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 3
[ 9.910172] uhci_hcd 0000:00:1d.2: detected 2 ports
[ 9.910308] uhci_hcd 0000:00:1d.2: irq 18, io base 0x00005040
[ 9.910641] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.17
[ 9.910728] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.910812] usb usb3: Product: UHCI Host Controller
[ 9.910880] usb usb3: Manufacturer: Linux 4.17.0-rc3+ uhci_hcd
[ 9.910949] usb usb3: SerialNumber: 0000:00:1d.2
[ 9.911701] hub 3-0:1.0: USB hub found
[ 9.911801] hub 3-0:1.0: 2 ports detected
[ 9.917467] ehci-pci 0000:00:1d.7: EHCI Host Controller
[ 9.917736] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 4
[ 9.917843] ehci-pci 0000:00:1d.7: debug port 1
[ 9.921851] ehci-pci 0000:00:1d.7: cache line size of 64 is not supported
[ 9.921928] ehci-pci 0000:00:1d.7: irq 19, io mem 0xe4444000
[ 9.926484] input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/sound/card0/input5
[ 9.927607] calling thinkpad_acpi_module_init+0x0/0x11b0 [thinkpad_acpi] @ 278
[ 9.928362] thinkpad_acpi: ThinkPad ACPI Extras v0.26
[ 9.928432] thinkpad_acpi: http://ibm-acpi.sf.net/
[ 9.928499] thinkpad_acpi: ThinkPad BIOS CBET4000 TIMELESS, EC 7JHT12WW-3.4
[ 9.928571] thinkpad_acpi: Lenovo ThinkPad X60 Tablet, model 636338U
[ 9.936204] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[ 9.936586] usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.17
[ 9.936673] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.936758] usb usb4: Product: EHCI Host Controller
[ 9.936826] usb usb4: Manufacturer: Linux 4.17.0-rc3+ ehci_hcd
[ 9.936894] usb usb4: SerialNumber: 0000:00:1d.7
[ 9.937675] hub 4-0:1.0: USB hub found
[ 9.937777] hub 4-0:1.0: 8 ports detected
[ 9.938900] thinkpad_acpi: radio switch found; radios are disabled
[ 9.939321] thinkpad_acpi: Tablet mode switch found (type: MHKG), currently in laptop mode
[ 9.939668] thinkpad_acpi: This ThinkPad has standard ACPI backlight brightness control, supported by the ACPI video driver
[ 9.939759] thinkpad_acpi: Disabling thinkpad-acpi brightness events by default...
[ 9.943106] usb usb1: root hub lost power or was reset
[ 9.944236] hub 1-0:1.0: USB hub found
[ 9.944344] hub 1-0:1.0: 2 ports detected
[ 9.952846] usb usb2: root hub lost power or was reset
[ 9.953193] hub 2-0:1.0: USB hub found
[ 9.953320] hub 2-0:1.0: 2 ports detected
[ 9.965856] usb usb3: root hub lost power or was reset
[ 9.970001] calling hwrng_modinit+0x0/0x1000 [rng_core] @ 286
[ 9.970813] calling cfg80211_init+0x0/0xbd [cfg80211] @ 275
[ 9.971145] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[ 9.971586] initcall hwrng_modinit+0x0/0x1000 [rng_core] returned 0 after 746 usecs
[ 9.972171] hub 3-0:1.0: USB hub found
[ 9.972290] hub 3-0:1.0: 2 ports detected
[ 9.982550] calling fw_core_init+0x0/0x1000 [firewire_core] @ 276
[ 9.982787] initcall fw_core_init+0x0/0x1000 [firewire_core] returned 0 after 217 usecs
[ 9.983704] calling mod_init+0x0/0xf3b [intel_rng] @ 286
[ 9.983780] intel_rng: FWH not detected
[ 9.985893] initcall mod_init+0x0/0xf3b [intel_rng] returned -19 after 2125 usecs
[ 9.986562] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 9.986661] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
[ 9.986761] uhci_hcd 0000:00:1d.3: detected 2 ports
[ 9.986865] uhci_hcd 0000:00:1d.3: irq 19, io base 0x00005060
[ 9.987226] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.17
[ 9.987314] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.987397] usb usb5: Product: UHCI Host Controller
[ 9.987464] usb usb5: Manufacturer: Linux 4.17.0-rc3+ uhci_hcd
[ 9.987533] usb usb5: SerialNumber: 0000:00:1d.3
[ 9.989882] calling fw_ohci_init+0x0/0x1000 [firewire_ohci] @ 276
[ 9.990180] e1000e 0000:01:00.0 eth0: (PCI Express:2.5GT/s:Width x1) 00:16:d3:b8:e3:49
[ 9.992593] e1000e 0000:01:00.0 eth0: Intel(R) PRO/1000 Network Connection
[ 9.992796] e1000e 0000:01:00.0 eth0: MAC: 2, PHY: 2, PBA No: 005302-003
[ 9.993982] hub 5-0:1.0: USB hub found
[ 9.994089] hub 5-0:1.0: 2 ports detected
[ 9.994963] initcall uhci_hcd_init+0x0/0x1000 [uhci_hcd] returned 0 after 4949 usecs
[ 9.995320] initcall e1000_init_module+0x0/0x1000 [e1000e] returned 0 after 5282 usecs
[ 9.995920] initcall ehci_pci_init+0x0/0x1000 [ehci_pci] returned 0 after 5886 usecs
[ 10.031615] calling mmc_init+0x0/0x954 [mmc_core] @ 279
[ 10.031806] initcall mmc_init+0x0/0x954 [mmc_core] returned 0 after 162 usecs
[ 10.036877] calling lpc_ich_driver_init+0x0/0x1000 [lpc_ich] @ 286
[ 10.037660] initcall lpc_ich_driver_init+0x0/0x1000 [lpc_ich] returned 0 after 753 usecs
[ 10.057570] calling sdhci_drv_init+0x0/0x1000 [sdhci] @ 279
[ 10.057575] sdhci: Secure Digital Host Controller Interface driver
[ 10.057650] sdhci: Copyright(c) Pierre Ossman
[ 10.057724] initcall sdhci_drv_init+0x0/0x1000 [sdhci] returned 0 after 139 usecs
[ 10.194244] firewire_ohci 0000:05:00.1: added OHCI v1.10 device as card 0, 4 IR + 4 IT contexts, quirks 0x11
[ 10.194516] initcall fw_ohci_init+0x0/0x1000 [firewire_ohci] returned 0 after 133721 usecs
[ 10.207504] calling sdhci_driver_init+0x0/0x1000 [sdhci_pci] @ 279
[ 10.207642] sdhci-pci 0000:05:00.2: SDHCI controller found [1180:0822] (rev 18)
[ 10.208189] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[ 10.209554] calling nas_gpio_init+0x0/0xfce [leds_ss4200] @ 286
[ 10.209559] leds_ss4200: no LED devices found
[ 10.209633] initcall nas_gpio_init+0x0/0xfce [leds_ss4200] returned -19 after 69 usecs
[ 10.209735] initcall cfg80211_init+0x0/0xbd [cfg80211] returned 0 after 100 usecs
[ 10.211285] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[ 10.211422] cfg80211: failed to load regulatory.db
[ 10.211823] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
[ 10.211929] mmc0 bounce up to 128 segments into one, max segment size 65536 bytes
[ 10.212067] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
[ 10.212821] mmc0: SDHCI controller on PCI [0000:05:00.2] using DMA
[ 10.213064] initcall sdhci_driver_init+0x0/0x1000 [sdhci_pci] returned 0 after 3412 usecs
[ 10.213364] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
[ 10.220795] thinkpad_acpi: Standard ACPI backlight interface available, not loading native one
[ 10.242021] thinkpad_acpi: Console audio control enabled, mode: monitor (read only)
[ 10.266191] calling i2c_i801_init+0x0/0x1000 [i2c_i801] @ 281
[ 10.274558] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
[ 10.279906] initcall i2c_i801_init+0x0/0x1000 [i2c_i801] returned 0 after 13379 usecs
[ 10.314331] battery: new extension: ThinkPad Battery Extension
[ 10.315519] input: ThinkPad Extra Buttons as /devices/platform/thinkpad_acpi/input/input6
[ 10.315860] initcall thinkpad_acpi_module_init+0x0/0x11b0 [thinkpad_acpi] returned 0 after 48479 usecs
[ 10.353153] calling ieee80211_init+0x0/0x3c [mac80211] @ 275
[ 10.353221] initcall ieee80211_init+0x0/0x3c [mac80211] returned 0 after 17 usecs
[ 10.365777] calling pcsp_init+0x0/0x1000 [snd_pcsp] @ 279
[ 10.366065] input: PC Speaker as /devices/platform/pcspkr/input/input7
[ 10.381801] calling psmouse_init+0x0/0x7c [psmouse] @ 278
[ 10.381944] initcall psmouse_init+0x0/0x7c [psmouse] returned 0 after 124 usecs
[ 10.383953] initcall pcsp_init+0x0/0x1000 [snd_pcsp] returned 0 after 2089 usecs
[ 10.401739] calling il3945_init+0x0/0x1000 [iwl3945] @ 275
[ 10.401745] iwl3945: Intel(R) PRO/Wireless 3945ABG/BG Network Connection driver for Linux, in-tree:s
[ 10.401844] iwl3945: Copyright(c) 2003-2011 Intel Corporation
[ 10.401919] iwl3945: hw_scan is disabled
[ 10.461664] iwl3945 0000:02:00.0: Tunable channels: 11 802.11bg, 13 802.11a channels
[ 10.461759] iwl3945 0000:02:00.0: Detected Intel Wireless WiFi Link 3945ABG
[ 10.500844] calling arc4_init+0x0/0x1000 [arc4] @ 307
[ 10.519081] initcall arc4_init+0x0/0x1000 [arc4] returned 0 after 17794 usecs
[ 10.561487] ieee80211 phy0: Selected rate control algorithm 'iwl-3945-rs'
[ 10.581073] initcall il3945_init+0x0/0x1000 [iwl3945] returned 0 after 78329 usecs
[ 10.687530] calling vmx_init+0x0/0x1000 [kvm_intel] @ 285
[ 10.693425] initcall vmx_init+0x0/0x1000 [kvm_intel] returned 0 after 5732 usecs
[ 10.698783] calling coretemp_init+0x0/0x1000 [coretemp] @ 279
[ 10.699577] initcall coretemp_init+0x0/0x1000 [coretemp] returned 0 after 764 usecs
[ 10.714878] calling powerclamp_init+0x0/0x1000 [intel_powerclamp] @ 285
[ 10.714892] intel_powerclamp: No package C-state available
[ 10.714973] initcall powerclamp_init+0x0/0x1000 [intel_powerclamp] returned -19 after 84 usecs
[ 10.716958] firewire_core 0000:05:00.1: created device fw0: GUID 0000000000000000, S400
[ 11.006418] psmouse serio1: trackpoint: IBM TrackPoint firmware: 0x0e, buttons: 3/3
[ 11.010804] e1000e 0000:01:00.0 eth8: renamed from eth0
[ 11.013966] calling iTCO_vendor_init_module+0x0/0x1000 [iTCO_vendor_support] @ 280
[ 11.013970] iTCO_vendor_support: vendor-support=0
[ 11.014050] initcall iTCO_vendor_init_module+0x0/0x1000 [iTCO_vendor_support] returned 0 after 74 usecs
[ 11.023570] input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/input/input8
[ 11.041052] calling iTCO_wdt_init_module+0x0/0x1000 [iTCO_wdt] @ 280
[ 11.041057] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11
[ 11.041277] iTCO_wdt: Found a ICH7-M or ICH7-U TCO device (Version=2, TCOBASE=0x0560)
[ 11.064199] iwl3945 0000:02:00.0 wlan4: renamed from wlan0
[ 11.144097] calling mousedev_init+0x0/0x1000 [mousedev] @ 286
[ 11.146969] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
[ 11.153665] initcall iTCO_wdt_init_module+0x0/0x1000 [iTCO_wdt] returned 0 after 9329 usecs
[ 11.178440] mousedev: PS/2 mouse device common for all mice
[ 11.178526] initcall mousedev_init+0x0/0x1000 [mousedev] returned 0 after 33608 usecs
[ 11.340373] IPv6: ADDRCONF(NETDEV_UP): eth8: link is not ready
[ 11.561120] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: discard
[ 11.651325] calling init_misc_binfmt+0x0/0x1000 [binfmt_misc] @ 376
[ 11.651340] initcall init_misc_binfmt+0x0/0x1000 [binfmt_misc] returned 0 after 6 usecs
[ 13.450173] calling serport_init+0x0/0x1000 [serport] @ 488
[ 13.450183] initcall serport_init+0x0/0x1000 [serport] returned 0 after 1 usecs
[ 13.450686] serio: Serial port ttyS0
[ 15.838493] e1000e: eth8 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx/Tx
[ 15.838867] IPv6: ADDRCONF(NETDEV_CHANGE): eth8: link becomes ready
[ 18.951559] calling drm_core_init+0x0/0xd1 [drm] @ 596
[ 18.951697] initcall drm_core_init+0x0/0xd1 [drm] returned 0 after 88 usecs
[ 18.993211] calling drm_kms_helper_init+0x0/0x19 [drm_kms_helper] @ 596
[ 18.993239] initcall drm_kms_helper_init+0x0/0x19 [drm_kms_helper] returned 0 after 2 usecs
[ 19.126727] calling i915_init+0x0/0x50 [i915] @ 596
[ 19.129167] pci 0000:00:00.0: Intel 945GM Chipset
[ 19.129222] pci 0000:00:00.0: detected gtt size: 262144K total, 262144K mappable
[ 19.129783] pci 0000:00:00.0: detected 8192K stolen memory
[ 19.129884] [drm] Replacing VGA console driver
[ 19.131363] Console: switching to colour dummy device 80x25
[ 19.186887] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 19.186899] [drm] Driver supports precise vblank timestamp query.
[ 19.188467] i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem
[ 19.205765] [drm] RC6 disabled, disabling runtime PM support
[ 19.205902] [drm] initialized overlay support
[ 19.207550] [drm] Initialized i915 1.6.0 20180308 for 0000:00:02.0 on minor 0
[ 19.210083] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no)
[ 19.223739] acpi device:04: registered as cooling_device3
[ 19.227095] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input9
[ 19.227956] initcall i915_init+0x0/0x50 [i915] returned 0 after 98768 usecs
[ 19.242750] fbcon: inteldrmfb (fb0) is primary device
[ 19.243145] Console: switching to colour frame buffer device 128x48
[ 19.243168] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
[ 189.725788] PM: suspend entry (deep)
[ 189.725797] PM: Syncing filesystems ... done.
[ 189.763105] Freezing user space processes ... (elapsed 0.001 seconds) done.
[ 189.764193] OOM killer disabled.
[ 189.764195] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[ 189.765435] Suspending console(s) (use no_console_suspend to debug)
[ 189.765713] calling input9+ @ 1245, parent: LNXVIDEO:00
[ 189.765718] call input9+ returned 0 after 2 usecs
[ 189.765722] calling acpi_video0+ @ 1245, parent: 0000:00:02.0
[ 189.765727] call acpi_video0+ returned 0 after 1 usecs
[ 189.765731] calling intel_backlight+ @ 1245, parent: card0-LVDS-1
[ 189.765734] call intel_backlight+ returned 0 after 1 usecs
[ 189.765754] calling input8+ @ 1245, parent: serio1
[ 189.765758] call input8+ returned 0 after 1 usecs
[ 189.765763] calling coretemp.0+ @ 1245, parent: platform
[ 189.765767] call coretemp.0+ returned 0 after 1 usecs
[ 189.765772] calling rfkill0+ @ 1245, parent: phy0
[ 189.765776] call rfkill0+ returned 0 after 1 usecs
[ 189.765788] calling phy0-led+ @ 1245, parent: 0000:02:00.0
[ 189.765794] call phy0-led+ returned 0 after 2 usecs
[ 189.765802] calling input7+ @ 1245, parent: pcspkr
[ 189.765806] call input7+ returned 0 after 1 usecs
[ 189.765810] calling phy0+ @ 117, parent: 0000:02:00.0
[ 189.765812] calling input6+ @ 1245, parent: thinkpad_acpi
[ 189.765817] call input6+ returned 0 after 1 usecs
[ 189.765820] call phy0+ returned 0 after 6 usecs
[ 189.765841] calling mmc0::+ @ 1245, parent: 0000:05:00.2
[ 189.765845] call mmc0::+ returned 0 after 1 usecs
[ 189.765848] calling gpio_ich.1.auto+ @ 1245, parent: 0000:00:1f.0
[ 189.765852] call gpio_ich.1.auto+ returned 0 after 1 usecs
[ 189.765855] calling iTCO_wdt.0.auto+ @ 1245, parent: 0000:00:1f.0
[ 189.765859] call iTCO_wdt.0.auto+ returned 0 after 1 usecs
[ 189.765861] calling tpacpi::thinkvantage+ @ 1245, parent: thinkpad_acpi
[ 189.765865] call tpacpi::thinkvantage+ returned 0 after 1 usecs
[ 189.765868] calling tpacpi::standby+ @ 1245, parent: thinkpad_acpi
[ 189.765872] call tpacpi::standby+ returned 0 after 1 usecs
[ 189.765874] calling tpacpi::power+ @ 1245, parent: thinkpad_acpi
[ 189.765878] call tpacpi::power+ returned 0 after 1 usecs
[ 189.765923] calling regulatory.0+ @ 1245, parent: platform
[ 189.765927] calling usb5+ @ 117, parent: 0000:00:1d.3
[ 189.765928] call regulatory.0+ returned 0 after 1 usecs
[ 189.766001] calling thinkpad_hwmon+ @ 1245, parent: platform
[ 189.766005] call thinkpad_hwmon+ returned 0 after 1 usecs
[ 189.766008] calling thinkpad_acpi+ @ 1245, parent: platform
[ 189.766274] calling usb4+ @ 119, parent: 0000:00:1d.7
[ 189.766336] call thinkpad_acpi+ returned 0 after 317 usecs
[ 189.766345] calling input5+ @ 1245, parent: card0
[ 189.766349] call input5+ returned 0 after 1 usecs
[ 189.766383] calling usb3+ @ 118, parent: 0000:00:1d.2
[ 189.766394] calling input4+ @ 1245, parent: LNXPWRBN:00
[ 189.766398] call input4+ returned 0 after 1 usecs
[ 189.766402] calling input3+ @ 1245, parent: PNP0C0D:00
[ 189.766407] call input3+ returned 0 after 2 usecs
[ 189.766411] calling input2+ @ 1245, parent: PNP0C0E:00
[ 189.766416] call input2+ returned 0 after 2 usecs
[ 189.766515] calling input0::scrolllock+ @ 1245, parent: input0
[ 189.766519] call input0::scrolllock+ returned 0 after 1 usecs
[ 189.766521] calling input0::capslock+ @ 1245, parent: input0
[ 189.766525] call input0::capslock+ returned 0 after 1 usecs
[ 189.766528] calling input0::numlock+ @ 1245, parent: input0
[ 189.766532] call input0::numlock+ returned 0 after 1 usecs
[ 189.766535] calling input0+ @ 1245, parent: serio0
[ 189.766540] call input0+ returned 0 after 1 usecs
[ 189.766547] calling microcode+ @ 1245, parent: platform
[ 189.766550] call microcode+ returned 0 after 1 usecs
[ 189.766557] calling memconsole+ @ 1245, parent: platform
[ 189.766560] call memconsole+ returned 0 after 1 usecs
[ 189.766564] calling rtc0+ @ 1245, parent: 00:03
[ 189.766568] call rtc0+ returned 0 after 1 usecs
[ 189.766571] calling serio1+ @ 1245, parent: i8042
[ 189.766622] calling usb2+ @ 6, parent: 0000:00:1d.1
[ 189.766953] calling usb1+ @ 120, parent: 0000:00:1d.0
[ 189.767187] calling hdaudioC0D0+ @ 1258, parent: 0000:00:1b.0
[ 189.767279] calling 0:0:0:0+ @ 1259, parent: target0:0:0
[ 189.767794] calling host3+ @ 1261, parent: ata4
[ 189.767798] call host3+ returned 0 after 1 usecs
[ 189.767805] calling host2+ @ 1261, parent: ata3
[ 189.767809] call host2+ returned 0 after 1 usecs
[ 189.767815] calling host1+ @ 1261, parent: ata2
[ 189.767819] call host1+ returned 0 after 1 usecs
[ 189.767878] calling ata4+ @ 1262, parent: 0000:00:1f.2
[ 189.767914] call ata4+ returned 0 after 31 usecs
[ 189.767922] calling ata3+ @ 1262, parent: 0000:00:1f.2
[ 189.767971] calling ata2+ @ 1263, parent: 0000:00:1f.2
[ 189.767986] call ata3+ returned 0 after 58 usecs
[ 189.768036] call ata2+ returned 0 after 59 usecs
[ 189.778532] call serio1+ returned 0 after 11675 usecs
[ 189.778539] calling serio0+ @ 1245, parent: i8042
[ 189.779936] call serio0+ returned 0 after 1359 usecs
[ 189.779942] calling i8042+ @ 1245, parent: platform
[ 189.783103] call i8042+ returned 0 after 3083 usecs
[ 189.783120] calling serial8250+ @ 1245, parent: platform
[ 189.783126] call serial8250+ returned 0 after 2 usecs
[ 189.783163] calling alarmtimer+ @ 1245, parent: platform
[ 189.783169] call alarmtimer+ returned 0 after 2 usecs
[ 189.783175] calling platform-framebuffer.0+ @ 1245, parent: platform
[ 189.783178] call platform-framebuffer.0+ returned 0 after 1 usecs
[ 189.783181] calling pcspkr+ @ 1245, parent: platform
[ 189.783193] call pcspkr+ returned 0 after 8 usecs
[ 189.783273] calling 00:07+ @ 1245, parent: pnp0
[ 189.783280] call 00:07+ returned 0 after 4 usecs
[ 189.783283] calling 00:06+ @ 1245, parent: pnp0
[ 189.783346] call 00:06+ returned 0 after 58 usecs
[ 189.783349] calling 00:05+ @ 1245, parent: pnp0
[ 189.783353] call 00:05+ returned 0 after 1 usecs
[ 189.783356] calling 00:04+ @ 1245, parent: pnp0
[ 189.783359] call 00:04+ returned 0 after 1 usecs
[ 189.783363] calling 00:03+ @ 1245, parent: pnp0
[ 189.783387] call 00:03+ returned 0 after 21 usecs
[ 189.783389] calling 00:02+ @ 1245, parent: pnp0
[ 189.783393] call 00:02+ returned 0 after 1 usecs
[ 189.783396] calling 00:01+ @ 1245, parent: pnp0
[ 189.783400] call 00:01+ returned 0 after 1 usecs
[ 189.783403] calling 00:00+ @ 1245, parent: pnp0
[ 189.783406] call 00:00+ returned 0 after 1 usecs
[ 189.783416] calling LNXPWRBN:00+ @ 1245, parent: LNXSYSTM:00
[ 189.783420] call LNXPWRBN:00+ returned 0 after 1 usecs
[ 189.783423] calling BOOT0000:00+ @ 1245, parent: platform
[ 189.783428] call BOOT0000:00+ returned 0 after 2 usecs
[ 189.783431] calling PNP0C0B:00+ @ 1245, parent: platform
[ 189.783435] call PNP0C0B:00+ returned 0 after 1 usecs
[ 189.783438] calling PNP0C04:00+ @ 1245, parent: 0000:00:1f.0
[ 189.783441] call PNP0C04:00+ returned 0 after 1 usecs
[ 189.783444] calling INT0800:00+ @ 1245, parent: 0000:00:1f.0
[ 189.783448] call INT0800:00+ returned 0 after 1 usecs
[ 189.783451] calling PNP0C0D:00+ @ 1245, parent: PNP0C09:00
[ 189.783455] call PNP0C0D:00+ returned 0 after 0 usecs
[ 189.783457] calling PNP0C0E:00+ @ 1245, parent: PNP0C09:00
[ 189.783461] call PNP0C0E:00+ returned 0 after 0 usecs
[ 189.783464] calling PNP0C0A:01+ @ 1245, parent: PNP0C09:00
[ 189.783467] call PNP0C0A:01+ returned 0 after 0 usecs
[ 189.783470] calling PNP0C0A:00+ @ 1245, parent: PNP0C09:00
[ 189.783473] call PNP0C0A:00+ returned 0 after 1 usecs
[ 189.783476] calling ACPI0003:00+ @ 1245, parent: PNP0C09:00
[ 189.783480] call ACPI0003:00+ returned 0 after 0 usecs
[ 189.783482] calling IBM0068:00+ @ 1245, parent: PNP0C09:00
[ 189.783486] call IBM0068:00+ returned 0 after 1 usecs
[ 189.783489] calling PNP0C09:00+ @ 1245, parent: 0000:00:1f.0
[ 189.783493] call PNP0C09:00+ returned 0 after 0 usecs
[ 189.783526] calling 0000:05:00.2+ @ 1264, parent: 0000:00:1e.0
[ 189.783572] calling 0000:05:00.1+ @ 1265, parent: 0000:00:1e.0
[ 189.783586] call 0000:05:00.2+ returned 0 after 55 usecs
[ 189.783591] calling 0000:05:00.0+ @ 1264, parent: 0000:00:1e.0
[ 189.783595] call 0000:05:00.0+ returned 0 after 1 usecs
[ 189.783601] calling 0000:02:00.0+ @ 1264, parent: 0000:00:1c.1
[ 189.783643] call 0000:02:00.0+ returned 0 after 38 usecs
[ 189.783648] calling 0000:01:00.0+ @ 1264, parent: 0000:00:1c.0
[ 189.783707] calling LNXTHERM:01+ @ 1245, parent: LNXSYBUS:01
[ 189.783722] call LNXTHERM:01+ returned 0 after 4 usecs
[ 189.783728] calling LNXTHERM:00+ @ 1245, parent: LNXSYBUS:01
[ 189.783730] e1000e: EEE TX LPI TIMER: 00000000
[ 189.783733] call LNXTHERM:00+ returned 0 after 1 usecs
[ 189.783737] calling dock.0+ @ 1245, parent: platform
[ 189.783740] call dock.0+ returned 0 after 1 usecs
[ 189.783772] calling PNP0C0D:00+ @ 1245, parent: PNP0C09:00
[ 189.783779] call PNP0C0D:00+ returned 0 after 1 usecs
[ 189.783796] calling PNP0C0E:00+ @ 1245, parent: PNP0C09:00
[ 189.783800] call PNP0C0E:00+ returned 0 after 1 usecs
[ 189.783810] calling PNP0C09:00+ @ 1245, parent: device:22
[ 189.783814] call PNP0C09:00+ returned 0 after 1 usecs
[ 189.784389] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[ 189.784476] calling 0000:00:1f.1+ @ 1266, parent: pci0000:00
[ 189.784482] call 0000:00:1f.1+ returned 0 after 1 usecs
[ 189.784493] calling 0000:00:1f.0+ @ 1266, parent: pci0000:00
[ 189.784497] call 0000:00:1f.0+ returned 0 after 1 usecs
[ 189.785137] calling 0000:00:1c.3+ @ 1272, parent: pci0000:00
[ 189.785153] call 0000:00:1c.3+ returned 0 after 12 usecs
[ 189.785170] calling 0000:00:1c.2+ @ 1272, parent: pci0000:00
[ 189.785182] call 0000:00:1c.2+ returned 0 after 9 usecs
[ 189.785196] calling 0000:00:1c.1+ @ 1272, parent: pci0000:00
[ 189.785207] call 0000:00:1c.1+ returned 0 after 8 usecs
[ 189.785287] calling 0000:00:02.1+ @ 1274, parent: pci0000:00
[ 189.785293] call 0000:00:02.1+ returned 0 after 1 usecs
[ 189.785309] calling 0000:00:02.0+ @ 1274, parent: pci0000:00
[ 189.785345] sd 0:0:0:0: [sda] Stopping disk
[ 189.785444] calling 0000:00:00.0+ @ 1275, parent: pci0000:00
[ 189.785449] call 0000:00:00.0+ returned 0 after 1 usecs
[ 189.792343] call usb5+ returned 0 after 25792 usecs
[ 189.792345] call usb3+ returned 0 after 25347 usecs
[ 189.792363] calling 0000:00:1d.3+ @ 1268, parent: pci0000:00
[ 189.792375] call usb1+ returned 0 after 24823 usecs
[ 189.792379] call 0000:00:1d.3+ returned 0 after 12 usecs
[ 189.792387] calling 0000:00:1d.2+ @ 1269, parent: pci0000:00
[ 189.792390] calling 0000:00:1d.0+ @ 1271, parent: pci0000:00
[ 189.792402] call 0000:00:1d.2+ returned 0 after 11 usecs
[ 189.792406] call 0000:00:1d.0+ returned 0 after 12 usecs
[ 189.792462] call usb2+ returned 0 after 25230 usecs
[ 189.792479] calling 0000:00:1d.1+ @ 1270, parent: pci0000:00
[ 189.792491] call 0000:00:1d.1+ returned 0 after 8 usecs
[ 189.800211] call usb4+ returned 0 after 33137 usecs
[ 189.800243] calling 0000:00:1d.7+ @ 1267, parent: pci0000:00
[ 189.803561] call 0000:01:00.0+ returned 0 after 19442 usecs
[ 189.803587] calling 0000:00:1c.0+ @ 1273, parent: pci0000:00
[ 189.803595] call 0000:00:1c.0+ returned 0 after 4 usecs
[ 189.812094] call 0000:05:00.1+ returned 0 after 27849 usecs
[ 189.812117] calling 0000:00:1e.0+ @ 1266, parent: pci0000:00
[ 189.812121] call 0000:00:1e.0+ returned 0 after 1 usecs
[ 189.820093] call 0000:00:1d.7+ returned 0 after 19378 usecs
[ 189.888114] call hdaudioC0D0+ returned 0 after 118086 usecs
[ 189.888138] calling 0000:00:1b.0+ @ 1272, parent: pci0000:00
[ 189.889315] call 0000:00:1b.0+ returned 0 after 1145 usecs
[ 190.088161] call 0000:00:02.0+ returned 0 after 295749 usecs
[ 190.490056] call 0:0:0:0+ returned 0 after 705832 usecs
[ 190.490089] calling target0:0:0+ @ 1260, parent: host0
[ 190.490093] call target0:0:0+ returned 0 after 1 usecs
[ 190.490120] calling host0+ @ 1261, parent: ata1
[ 190.490124] call host0+ returned 0 after 1 usecs
[ 190.490148] calling ata1+ @ 1262, parent: 0000:00:1f.2
[ 190.490221] call ata1+ returned 0 after 67 usecs
[ 190.490248] calling 0000:00:1f.2+ @ 1263, parent: pci0000:00
[ 190.490255] call 0000:00:1f.2+ returned 0 after 3 usecs
[ 190.490868] calling BOOT0000:00+ @ 1245, parent: platform
[ 190.490874] call BOOT0000:00+ returned 0 after 2 usecs
[ 190.490876] calling PNP0C0B:00+ @ 1245, parent: platform
[ 190.490897] call PNP0C0B:00+ returned 0 after 17 usecs
[ 190.490927] calling 0000:05:00.2+ @ 1275, parent: 0000:00:1e.0
[ 190.490932] call 0000:05:00.2+ returned 0 after 1 usecs
[ 190.490938] calling 0000:05:00.1+ @ 1275, parent: 0000:00:1e.0
[ 190.490942] call 0000:05:00.1+ returned 0 after 1 usecs
[ 190.490948] calling 0000:05:00.0+ @ 1275, parent: 0000:00:1e.0
[ 190.490951] call 0000:05:00.0+ returned 0 after 1 usecs
[ 190.490957] calling 0000:02:00.0+ @ 1275, parent: 0000:00:1c.1
[ 190.490961] call 0000:02:00.0+ returned 0 after 1 usecs
[ 190.490966] calling 0000:01:00.0+ @ 1275, parent: 0000:00:1c.0
[ 190.490970] call 0000:01:00.0+ returned 0 after 1 usecs
[ 190.490978] calling 0000:00:1f.2+ @ 1275, parent: pci0000:00
[ 190.490982] call 0000:00:1f.2+ returned 0 after 1 usecs
[ 190.490986] calling 0000:00:1f.1+ @ 1275, parent: pci0000:00
[ 190.490989] call 0000:00:1f.1+ returned 0 after 1 usecs
[ 190.490996] calling 0000:00:1f.0+ @ 1275, parent: pci0000:00
[ 190.491000] call 0000:00:1f.0+ returned 0 after 1 usecs
[ 190.491005] calling 0000:00:1e.0+ @ 1275, parent: pci0000:00
[ 190.491009] call 0000:00:1e.0+ returned 0 after 1 usecs
[ 190.491014] calling 0000:00:1d.7+ @ 1275, parent: pci0000:00
[ 190.491018] call 0000:00:1d.7+ returned 0 after 1 usecs
[ 190.491022] calling 0000:00:1d.3+ @ 1275, parent: pci0000:00
[ 190.491026] call 0000:00:1d.3+ returned 0 after 1 usecs
[ 190.491030] calling 0000:00:1d.2+ @ 1275, parent: pci0000:00
[ 190.491034] call 0000:00:1d.2+ returned 0 after 1 usecs
[ 190.491038] calling 0000:00:1d.1+ @ 1275, parent: pci0000:00
[ 190.491042] call 0000:00:1d.1+ returned 0 after 1 usecs
[ 190.491046] calling 0000:00:1d.0+ @ 1275, parent: pci0000:00
[ 190.491050] call 0000:00:1d.0+ returned 0 after 1 usecs
[ 190.491055] calling 0000:00:1c.3+ @ 1275, parent: pci0000:00
[ 190.491058] call 0000:00:1c.3+ returned 0 after 1 usecs
[ 190.491063] calling 0000:00:1c.2+ @ 1275, parent: pci0000:00
[ 190.491066] call 0000:00:1c.2+ returned 0 after 1 usecs
[ 190.491071] calling 0000:00:1c.1+ @ 1275, parent: pci0000:00
[ 190.491075] call 0000:00:1c.1+ returned 0 after 1 usecs
[ 190.491079] calling 0000:00:1c.0+ @ 1275, parent: pci0000:00
[ 190.491083] call 0000:00:1c.0+ returned 0 after 1 usecs
[ 190.491087] calling 0000:00:1b.0+ @ 1275, parent: pci0000:00
[ 190.491091] call 0000:00:1b.0+ returned 0 after 1 usecs
[ 190.491095] calling 0000:00:02.1+ @ 1275, parent: pci0000:00
[ 190.491098] call 0000:00:02.1+ returned 0 after 1 usecs
[ 190.491105] calling 0000:00:02.0+ @ 1275, parent: pci0000:00
[ 190.491160] calling 0000:00:00.0+ @ 1263, parent: pci0000:00
[ 190.491164] call 0000:00:00.0+ returned 0 after 1 usecs
[ 190.508179] call 0000:00:02.0+ returned 0 after 16669 usecs
[ 190.508355] calling iTCO_wdt.0.auto+ @ 1245, parent: 0000:00:1f.0
[ 190.508359] call iTCO_wdt.0.auto+ returned 0 after 1 usecs
[ 190.508842] calling BOOT0000:00+ @ 1245, parent: platform
[ 190.508847] call BOOT0000:00+ returned 0 after 1 usecs
[ 190.508849] calling PNP0C0B:00+ @ 1245, parent: platform
[ 190.508853] call PNP0C0B:00+ returned 0 after 1 usecs
[ 190.508880] calling 0000:05:00.1+ @ 1263, parent: 0000:00:1e.0
[ 190.508885] call 0000:05:00.1+ returned 0 after 2 usecs
[ 190.508891] calling 0000:05:00.0+ @ 1263, parent: 0000:00:1e.0
[ 190.508926] call 0000:05:00.0+ returned 0 after 31 usecs
[ 190.508931] calling 0000:02:00.0+ @ 1263, parent: 0000:00:1c.1
[ 190.508970] calling PNP0C09:00+ @ 1245, parent: device:22
[ 190.508973] ACPI: EC: interrupt blocked
[ 190.508979] call PNP0C09:00+ returned 0 after 6 usecs
[ 190.509116] calling 0000:01:00.0+ @ 1262, parent: 0000:00:1c.0
[ 190.509131] calling 0000:00:1f.2+ @ 1261, parent: pci0000:00
[ 190.509320] calling 0000:00:1f.1+ @ 1260, parent: pci0000:00
[ 190.509373] calling 0000:00:1f.0+ @ 1259, parent: pci0000:00
[ 190.509378] call 0000:00:1f.1+ returned 0 after 51 usecs
[ 190.509397] calling 0000:05:00.2+ @ 1275, parent: 0000:00:1e.0
[ 190.509429] call 0000:00:1f.0+ returned 0 after 52 usecs
[ 190.509441] calling 0000:00:1d.7+ @ 1259, parent: pci0000:00
[ 190.509552] calling 0000:00:1d.3+ @ 1274, parent: pci0000:00
[ 190.509560] calling 0000:00:1d.2+ @ 1272, parent: pci0000:00
[ 190.509774] call 0000:00:1d.3+ returned 0 after 212 usecs
[ 190.509786] calling 0000:00:1d.1+ @ 1274, parent: pci0000:00
[ 190.509915] call 0000:00:1d.2+ returned 0 after 341 usecs
[ 190.509920] calling 0000:00:1d.0+ @ 1272, parent: pci0000:00
[ 190.510046] call 0000:00:1d.1+ returned 0 after 249 usecs
[ 190.510052] calling 0000:00:1c.3+ @ 1274, parent: pci0000:00
[ 190.510110] call 0000:00:1c.3+ returned 0 after 54 usecs
[ 190.510115] calling 0000:00:1c.2+ @ 1274, parent: pci0000:00
[ 190.510174] call 0000:00:1c.2+ returned 0 after 55 usecs
[ 190.510179] call 0000:00:1d.0+ returned 0 after 248 usecs
[ 190.510194] calling 0000:00:1b.0+ @ 1258, parent: pci0000:00
[ 190.510205] calling 0000:00:02.1+ @ 1266, parent: pci0000:00
[ 190.510253] call 0000:00:02.1+ returned 0 after 43 usecs
[ 190.510260] calling 0000:00:02.0+ @ 1266, parent: pci0000:00
[ 190.510265] call 0000:00:02.0+ returned 0 after 1 usecs
[ 190.510268] calling 0000:00:00.0+ @ 1266, parent: pci0000:00
[ 190.510286] call 0000:00:00.0+ returned 0 after 14 usecs
[ 190.528039] call 0000:00:1f.2+ returned 0 after 18411 usecs
[ 190.528041] call 0000:00:1d.7+ returned 0 after 18158 usecs
[ 190.528054] call 0000:00:1b.0+ returned 0 after 17438 usecs
[ 190.528057] call 0000:05:00.2+ returned 0 after 18218 usecs
[ 190.528069] calling 0000:00:1e.0+ @ 1260, parent: pci0000:00
[ 190.528119] call 0000:02:00.0+ returned 0 after 18734 usecs
[ 190.528196] call 0000:01:00.0+ returned 0 after 18630 usecs
[ 190.528206] calling 0000:00:1c.1+ @ 1274, parent: pci0000:00
[ 190.528211] call 0000:00:1e.0+ returned 0 after 93 usecs
[ 190.528220] calling 0000:00:1c.0+ @ 1272, parent: pci0000:00
[ 190.528318] call 0000:00:1c.1+ returned 0 after 105 usecs
[ 190.528332] call 0000:00:1c.0+ returned 0 after 105 usecs
[ 190.528628] ACPI: Preparing to enter system sleep state S3
[ 190.541657] ACPI: EC: event blocked
[ 190.541659] ACPI: EC: EC stopped
[ 190.541660] PM: Saving platform NVS memory
[ 190.541662] Disabling non-boot CPUs ...
[ 190.556705] IRQ 1: no longer affine to CPU1
[ 190.556710] IRQ 9: no longer affine to CPU1
[ 190.556717] IRQ 12: no longer affine to CPU1
[ 190.556723] IRQ 16: no longer affine to CPU1
[ 190.556744] IRQ 28: no longer affine to CPU1
[ 190.557777] smpboot: CPU 1 is now offline
[ 190.558326] PM: Calling kvm_suspend+0x0/0x30 [kvm]
[ 190.558334] PM: Calling mce_syscore_suspend+0x0/0x30
[ 190.558340] PM: Calling ledtrig_cpu_syscore_suspend+0x0/0x20
[ 190.558345] PM: Calling timekeeping_suspend+0x0/0x500
[ 190.558390] PM: Calling irq_gc_suspend+0x0/0x90
[ 190.558394] PM: Calling save_ioapic_entries+0x0/0x260
[ 190.558480] PM: Calling i8259A_suspend+0x0/0x30
[ 190.558488] PM: Calling fw_suspend+0x0/0x20
[ 190.558492] PM: Calling acpi_save_bm_rld+0x0/0x20
[ 190.558500] PM: Calling lapic_suspend+0x0/0x310
[ 190.558500] ACPI: Low-level resume complete
[ 190.558500] ACPI: EC: EC started
[ 190.558500] PM: Restoring platform NVS memory
[ 190.558500] PM: Calling bsp_resume+0x0/0x30
[ 190.558500] PM: Calling lapic_resume+0x0/0x4c0
[ 190.558500] PM: Calling acpi_restore_bm_rld+0x0/0x60
[ 190.558500] PM: Calling irqrouter_resume+0x0/0x60
[ 190.558500] PM: Calling i8259A_resume+0x0/0x30
[ 190.558500] PM: Calling i8237A_resume+0x0/0xc0
[ 190.558500] PM: Calling ioapic_resume+0x0/0x1e0
[ 190.558500] PM: Calling irq_gc_resume+0x0/0x90
[ 190.558500] PM: Calling irq_pm_syscore_resume+0x0/0x20
[ 190.558500] PM: Calling timekeeping_resume+0x0/0x420
[ 190.558500] PM: Calling ledtrig_cpu_syscore_resume+0x0/0x20
[ 190.558500] PM: Calling mce_syscore_resume+0x0/0x30
[ 190.558500] PM: Calling mc_bp_resume+0x0/0x140
[ 190.558500] PM: Calling kvm_resume+0x0/0x40 [kvm]
[ 190.558500] Enabling non-boot CPUs ...
[ 190.558500] x86: Booting SMP configuration:
[ 190.558500] smpboot: Booting Node 0 Processor 1 APIC 0x1
[ 190.557763] Initializing CPU#1
[ 190.557763] Disabled fast string operations
[ 190.560485] cache: parent cpu1 should not be sleeping
[ 190.561278] CPU1 is up
[ 190.562915] ACPI: Waking up from system sleep state S3
[ 190.569315] calling 0000:00:00.0+ @ 1266, parent: pci0000:00
[ 190.569346] call 0000:00:00.0+ returned 0 after 26 usecs
[ 190.569352] calling 0000:00:02.0+ @ 1266, parent: pci0000:00
[ 190.569367] calling 0000:00:02.1+ @ 1275, parent: pci0000:00
[ 190.569389] call 0000:00:02.1+ returned 0 after 18 usecs
[ 190.569394] calling 0000:00:1b.0+ @ 1275, parent: pci0000:00
[ 190.569411] calling 0000:00:1c.0+ @ 1272, parent: pci0000:00
[ 190.569507] call 0000:00:1c.0+ returned 0 after 91 usecs
[ 190.569512] calling 0000:00:1c.1+ @ 1272, parent: pci0000:00
[ 190.569606] call 0000:00:1c.1+ returned 0 after 88 usecs
[ 190.569610] calling 0000:00:1c.2+ @ 1272, parent: pci0000:00
[ 190.569667] calling PNP0C09:00+ @ 1245, parent: device:22
[ 190.569670] ACPI: EC: interrupt unblocked
[ 190.569674] call PNP0C09:00+ returned 0 after 3 usecs
[ 190.569706] call 0000:00:1c.2+ returned 0 after 90 usecs
[ 190.569727] calling 0000:00:1c.3+ @ 1274, parent: pci0000:00
[ 190.569729] calling 0000:00:1d.0+ @ 1272, parent: pci0000:00
[ 190.569793] call 0000:00:1d.0+ returned 0 after 58 usecs
[ 190.569796] calling 0000:00:1d.1+ @ 1272, parent: pci0000:00
[ 190.569860] call 0000:00:1d.1+ returned 0 after 59 usecs
[ 190.569863] calling 0000:00:1d.2+ @ 1272, parent: pci0000:00
[ 190.569907] call 0000:00:1c.3+ returned 0 after 172 usecs
[ 190.569913] calling 0000:00:1d.3+ @ 1274, parent: pci0000:00
[ 190.569920] call 0000:00:1d.2+ returned 0 after 51 usecs
[ 190.569925] calling 0000:00:1d.7+ @ 1272, parent: pci0000:00
[ 190.569945] calling 0000:00:1e.0+ @ 1260, parent: pci0000:00
[ 190.569957] call 0000:00:1d.3+ returned 0 after 40 usecs
[ 190.569962] calling 0000:00:1f.0+ @ 1274, parent: pci0000:00
[ 190.570009] call 0000:00:1e.0+ returned 0 after 59 usecs
[ 190.570014] calling 0000:00:1f.1+ @ 1260, parent: pci0000:00
[ 190.570032] call 0000:00:1f.0+ returned 0 after 65 usecs
[ 190.570037] calling 0000:00:1f.2+ @ 1274, parent: pci0000:00
[ 190.570058] call 0000:00:1f.1+ returned 0 after 40 usecs
[ 190.570065] calling 0000:01:00.0+ @ 1260, parent: 0000:00:1c.0
[ 190.570070] calling 0000:02:00.0+ @ 1262, parent: 0000:00:1c.1
[ 190.570095] calling 0000:05:00.0+ @ 1263, parent: 0000:00:1e.0
[ 190.570104] calling 0000:05:00.1+ @ 1258, parent: 0000:00:1e.0
[ 190.570121] calling 0000:05:00.2+ @ 1259, parent: 0000:00:1e.0
[ 190.570171] pci 0000:05:00.0: calling ricoh_mmc_fixup_rl5c476+0x0/0x110 @ 1263
[ 190.570180] pci 0000:05:00.0: ricoh_mmc_fixup_rl5c476+0x0/0x110 took 3 usecs
[ 190.570186] pci 0000:05:00.0: calling quirk_cardbus_legacy+0x0/0x20 @ 1263
[ 190.570194] pci 0000:05:00.0: quirk_cardbus_legacy+0x0/0x20 took 2 usecs
[ 190.570197] call 0000:05:00.0+ returned 0 after 96 usecs
[ 190.570224] calling PNP0C0B:00+ @ 1245, parent: platform
[ 190.570228] call PNP0C0B:00+ returned 0 after 1 usecs
[ 190.570231] calling BOOT0000:00+ @ 1245, parent: platform
[ 190.570235] call BOOT0000:00+ returned 0 after 1 usecs
[ 190.570308] calling i8042+ @ 1245, parent: platform
[ 190.570312] call i8042+ returned 0 after 1 usecs
[ 190.588258] call 0000:05:00.1+ returned 0 after 17723 usecs
[ 190.588261] call 0000:05:00.2+ returned 0 after 17710 usecs
[ 190.588659] call 0000:01:00.0+ returned 0 after 18154 usecs
[ 190.588751] call 0000:02:00.0+ returned 0 after 18239 usecs
[ 190.588789] call 0000:00:1d.7+ returned 0 after 18419 usecs
[ 190.588862] call 0000:00:1f.2+ returned 0 after 18379 usecs
[ 190.588900] call 0000:00:1b.0+ returned 0 after 19046 usecs
[ 190.588933] call 0000:00:02.0+ returned 0 after 19118 usecs
[ 190.589066] calling iTCO_wdt.0.auto+ @ 1245, parent: 0000:00:1f.0
[ 190.589070] call iTCO_wdt.0.auto+ returned 0 after 1 usecs
[ 190.589230] pciehp 0000:00:1c.0:pcie004: Slot(0): Link Up
[ 190.589300] calling 0000:00:02.0+ @ 1290, parent: pci0000:00
[ 190.589323] call 0000:00:02.0+ returned 0 after 19 usecs
[ 190.589726] calling PNP0C0B:00+ @ 1245, parent: platform
[ 190.591490] call PNP0C0B:00+ returned 0 after 1718 usecs
[ 190.591493] calling BOOT0000:00+ @ 1245, parent: platform
[ 190.591497] call BOOT0000:00+ returned 0 after 1 usecs
[ 190.591678] calling 0000:00:00.0+ @ 117, parent: pci0000:00
[ 190.591683] call 0000:00:00.0+ returned 0 after 2 usecs
[ 190.591687] calling 0000:00:02.0+ @ 117, parent: pci0000:00
[ 190.591941] calling PNP0C09:00+ @ 1245, parent: device:22
[ 190.591943] ACPI: EC: event unblocked
[ 190.591952] call PNP0C09:00+ returned 0 after 8 usecs
[ 190.591955] calling ACPI0003:00+ @ 1245, parent: PNP0C09:00
[ 190.593634] calling 0000:00:1b.0+ @ 1271, parent: pci0000:00
[ 190.593876] calling 0000:00:02.1+ @ 1290, parent: pci0000:00
[ 190.593881] call 0000:00:02.1+ returned 0 after 1 usecs
[ 190.593886] calling 0000:00:1c.0+ @ 1290, parent: pci0000:00
[ 190.593909] calling 0000:00:1c.1+ @ 118, parent: pci0000:00
[ 190.593923] call 0000:00:1c.1+ returned 0 after 10 usecs
[ 190.593927] calling 0000:00:1c.2+ @ 118, parent: pci0000:00
[ 190.593939] call 0000:00:1c.2+ returned 0 after 9 usecs
[ 190.593942] calling 0000:00:1c.3+ @ 118, parent: pci0000:00
[ 190.593954] call 0000:00:1c.3+ returned 0 after 8 usecs
[ 190.593958] calling 0000:00:1d.0+ @ 118, parent: pci0000:00
[ 190.594149] usb usb1: root hub lost power or was reset
[ 190.594161] call 0000:00:1d.0+ returned 0 after 195 usecs
[ 190.594165] calling 0000:00:1d.1+ @ 118, parent: pci0000:00
[ 190.594332] usb usb2: root hub lost power or was reset
[ 190.594341] call 0000:00:1d.1+ returned 0 after 169 usecs
[ 190.594345] calling 0000:00:1d.2+ @ 118, parent: pci0000:00
[ 190.594516] usb usb3: root hub lost power or was reset
[ 190.594526] call 0000:00:1d.2+ returned 0 after 174 usecs
[ 190.594530] calling 0000:00:1d.3+ @ 118, parent: pci0000:00
[ 190.594699] usb usb5: root hub lost power or was reset
[ 190.594708] call 0000:00:1d.3+ returned 0 after 171 usecs
[ 190.594712] calling 0000:00:1d.7+ @ 118, parent: pci0000:00
[ 190.594801] call 0000:00:1d.7+ returned 0 after 83 usecs
[ 190.594805] calling 0000:00:1e.0+ @ 118, parent: pci0000:00
[ 190.594818] call 0000:00:1e.0+ returned 0 after 10 usecs
[ 190.594821] calling 0000:00:1f.0+ @ 118, parent: pci0000:00
[ 190.594825] call 0000:00:1f.0+ returned 0 after 1 usecs
[ 190.594828] calling 0000:00:1f.1+ @ 118, parent: pci0000:00
[ 190.594833] call 0000:00:1f.1+ returned 0 after 1 usecs
[ 190.594836] calling 0000:00:1f.2+ @ 118, parent: pci0000:00
[ 190.594863] call 0000:00:1f.2+ returned 0 after 23 usecs
[ 190.594886] calling 0000:02:00.0+ @ 120, parent: 0000:00:1c.1
[ 190.594909] call 0000:02:00.0+ returned 0 after 20 usecs
[ 190.594913] calling 0000:05:00.0+ @ 120, parent: 0000:00:1e.0
[ 190.594917] call 0000:05:00.0+ returned 0 after 1 usecs
[ 190.594921] calling 0000:05:00.1+ @ 120, parent: 0000:00:1e.0
[ 190.594939] calling 0000:05:00.2+ @ 1287, parent: 0000:00:1e.0
[ 190.594945] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
[ 190.594954] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it.
[ 190.595078] calling ata1+ @ 6, parent: 0000:00:1f.2
[ 190.595091] call ata1+ returned 0 after 9 usecs
[ 190.595095] calling ata2+ @ 6, parent: 0000:00:1f.2
[ 190.595103] call ata2+ returned 0 after 5 usecs
[ 190.595107] calling ata3+ @ 6, parent: 0000:00:1f.2
[ 190.595115] call ata3+ returned 0 after 5 usecs
[ 190.595119] calling ata4+ @ 6, parent: 0000:00:1f.2
[ 190.595127] call ata4+ returned 0 after 5 usecs
[ 190.595131] calling host0+ @ 6, parent: ata1
[ 190.595135] call host0+ returned 0 after 1 usecs
[ 190.595141] calling host1+ @ 6, parent: ata2
[ 190.595145] call host1+ returned 0 after 1 usecs
[ 190.595150] calling host2+ @ 6, parent: ata3
[ 190.595154] call host2+ returned 0 after 1 usecs
[ 190.595159] calling host3+ @ 6, parent: ata4
[ 190.595163] call host3+ returned 0 after 1 usecs
[ 190.595174] calling target0:0:0+ @ 6, parent: host0
[ 190.595178] call target0:0:0+ returned 0 after 1 usecs
[ 190.595182] calling 0:0:0:0+ @ 6, parent: target0:0:0
[ 190.595265] calling usb1+ @ 1282, parent: 0000:00:1d.0
[ 190.595314] calling usb2+ @ 1280, parent: 0000:00:1d.1
[ 190.595316] call 0000:05:00.2+ returned 0 after 363 usecs
[ 190.595333] calling usb3+ @ 1279, parent: 0000:00:1d.2
[ 190.595373] calling usb4+ @ 1268, parent: 0000:00:1d.7
[ 190.595648] call usb4+ returned 0 after 264 usecs
[ 190.596122] calling usb5+ @ 1267, parent: 0000:00:1d.3
[ 190.596256] calling phy0+ @ 1260, parent: 0000:02:00.0
[ 190.596265] call phy0+ returned 0 after 5 usecs
[ 190.596276] sd 0:0:0:0: [sda] Starting disk
[ 190.598208] call 0000:00:1b.0+ returned 0 after 4462 usecs
[ 190.598240] calling hdaudioC0D0+ @ 1283, parent: 0000:00:1b.0
[ 190.598724] call hdaudioC0D0+ returned 0 after 468 usecs
[ 190.600060] pciehp 0000:00:1c.0:pcie004: Timeout on hotplug command 0x1038 (issued 190084 msec ago), new command 0x1038/mask 0x103b
[ 190.600065] CPU: 0 PID: 1290 Comm: kworker/u4:37 Not tainted 4.17.0-rc3+ #20
[ 190.600067] Hardware name: LENOVO 636338U/636338U, BIOS CBET4000 TIMELESS 01/01/1970
[ 190.600077] Workqueue: events_unbound async_run_entry_fn
[ 190.600079] Call Trace:
[ 190.600087] dump_stack+0x66/0xa6
[ 190.600092] pcie_wait_cmd+0x153/0x2b0
[ 190.600097] ? prepare_to_wait+0x190/0x190
[ 190.600100] pcie_do_write_cmd+0x54/0x130
[ 190.600104] ? radix_tree_lookup+0x14/0x20
[ 190.600108] ? suspend_iter+0x80/0x80
[ 190.600111] pcie_enable_notification+0x64/0x150
[ 190.600115] ? irq_set_irq_wake+0x6b/0x170
[ 190.600117] ? suspend_iter+0x80/0x80
[ 190.600121] pciehp_resume+0x28/0xa0
[ 190.600124] ? klist_next+0x2d/0x170
[ 190.600127] resume_iter+0x4b/0x80
[ 190.600131] device_for_each_child+0x61/0xb0
[ 190.600134] pcie_port_device_resume+0x14/0x20
[ 190.600139] pci_pm_resume+0x75/0x100
[ 190.600143] dpm_run_callback+0x47/0x1b0
[ 190.600146] ? pci_pm_thaw+0xd0/0xd0
[ 190.600149] device_resume+0x97/0x190
[ 190.600152] ? device_resume+0x190/0x190
[ 190.600155] async_resume+0x1e/0x50
[ 190.600158] async_run_entry_fn+0x61/0x3a0
[ 190.600162] ? try_to_wake_up+0x4d/0x790
[ 190.600166] ? __switch_to_asm+0x33/0x4c
[ 190.600171] process_one_work+0x235/0x690
[ 190.600175] worker_thread+0x19d/0x6a0
[ 190.600179] kthread+0x14a/0x1f0
[ 190.600182] ? process_one_work+0x690/0x690
[ 190.600185] ? kthread_create_worker_on_cpu+0x30/0x30
[ 190.600187] ret_from_fork+0x2e/0x38
[ 190.664162] call 0000:05:00.1+ returned 0 after 67611 usecs
[ 190.700252] call usb1+ returned 0 after 102522 usecs
[ 190.700259] call usb2+ returned 0 after 102481 usecs
[ 190.704238] call usb3+ returned 0 after 106349 usecs
[ 190.704433] call ACPI0003:00+ returned 0 after 109837 usecs
[ 190.704438] calling PNP0C0A:00+ @ 1245, parent: PNP0C09:00
[ 190.704750] call PNP0C0A:00+ returned 0 after 300 usecs
[ 190.704753] calling PNP0C0A:01+ @ 1245, parent: PNP0C09:00
[ 190.705020] call PNP0C0A:01+ returned 0 after 257 usecs
[ 190.705023] calling PNP0C0E:00+ @ 1245, parent: PNP0C09:00
[ 190.705029] call PNP0C0E:00+ returned 0 after 2 usecs
[ 190.705031] calling PNP0C0D:00+ @ 1245, parent: PNP0C09:00
[ 190.705254] ACPI: button: The lid device is not compliant to SW_LID.
[ 190.705266] call PNP0C0D:00+ returned 0 after 225 usecs
[ 190.705284] calling dock.0+ @ 1245, parent: platform
[ 190.705288] call dock.0+ returned 0 after 1 usecs
[ 190.705291] calling LNXTHERM:00+ @ 1245, parent: LNXSYBUS:01
[ 190.705437] call LNXTHERM:00+ returned 0 after 138 usecs
[ 190.705447] calling LNXTHERM:01+ @ 1245, parent: LNXSYBUS:01
[ 190.705453] call LNXTHERM:01+ returned 0 after 3 usecs
[ 190.708109] call usb5+ returned 0 after 109356 usecs
[ 190.765359] call 0000:00:02.0+ returned 0 after 169596 usecs
[ 190.804244] call 0000:00:1c.0+ returned 0 after 205424 usecs
[ 190.804271] calling 0000:01:00.0+ @ 118, parent: 0000:00:1c.0
[ 190.804299] calling PNP0C09:00+ @ 1245, parent: 0000:00:1f.0
[ 190.804302] e1000e 0000:01:00.0: Disabling ASPM L0s L1
[ 190.804303] call PNP0C09:00+ returned 0 after 1 usecs
[ 190.804306] calling IBM0068:00+ @ 1245, parent: PNP0C09:00
[ 190.804311] call IBM0068:00+ returned 0 after 1 usecs
[ 190.804314] calling ACPI0003:00+ @ 1245, parent: PNP0C09:00
[ 190.804317] call ACPI0003:00+ returned 0 after 1 usecs
[ 190.804320] calling PNP0C0A:00+ @ 1245, parent: PNP0C09:00
[ 190.804326] call PNP0C0A:00+ returned 0 after 1 usecs
[ 190.804329] calling PNP0C0A:01+ @ 1245, parent: PNP0C09:00
[ 190.804333] call PNP0C0A:01+ returned 0 after 1 usecs
[ 190.804336] calling PNP0C0E:00+ @ 1245, parent: PNP0C09:00
[ 190.804344] call PNP0C0E:00+ returned 0 after 4 usecs
[ 190.804346] calling PNP0C0D:00+ @ 1245, parent: PNP0C09:00
[ 190.804350] call PNP0C0D:00+ returned 0 after 1 usecs
[ 190.804353] calling INT0800:00+ @ 1245, parent: 0000:00:1f.0
[ 190.804356] call INT0800:00+ returned 0 after 1 usecs
[ 190.804359] calling PNP0C04:00+ @ 1245, parent: 0000:00:1f.0
[ 190.804363] call PNP0C04:00+ returned 0 after 1 usecs
[ 190.804366] calling PNP0C0B:00+ @ 1245, parent: platform
[ 190.804455] call PNP0C0B:00+ returned 0 after 84 usecs
[ 190.804460] calling LNXPWRBN:00+ @ 1245, parent: LNXSYSTM:00
[ 190.804469] call LNXPWRBN:00+ returned 0 after 4 usecs
[ 190.804476] calling 00:00+ @ 1245, parent: pnp0
[ 190.804484] call 00:00+ returned 0 after 2 usecs
[ 190.804486] calling 00:01+ @ 1245, parent: pnp0
[ 190.804490] call 00:01+ returned 0 after 1 usecs
[ 190.804492] calling 00:02+ @ 1245, parent: pnp0
[ 190.804496] call 00:02+ returned 0 after 1 usecs
[ 190.804498] calling 00:03+ @ 1245, parent: pnp0
[ 190.804591] call 00:03+ returned 0 after 88 usecs
[ 190.804593] calling 00:04+ @ 1245, parent: pnp0
[ 190.804597] call 00:04+ returned 0 after 1 usecs
[ 190.804599] calling 00:05+ @ 1245, parent: pnp0
[ 190.804607] call 00:05+ returned 0 after 3 usecs
[ 190.804609] calling 00:06+ @ 1245, parent: pnp0
[ 190.804757] call 00:06+ returned 0 after 139 usecs
[ 190.804760] calling 00:07+ @ 1245, parent: pnp0
[ 190.804765] call 00:07+ returned 0 after 2 usecs
[ 190.804817] calling pcspkr+ @ 1245, parent: platform
[ 190.804821] call pcspkr+ returned 0 after 1 usecs
[ 190.804823] calling platform-framebuffer.0+ @ 1245, parent: platform
[ 190.804827] call platform-framebuffer.0+ returned 0 after 0 usecs
[ 190.804831] calling alarmtimer+ @ 1245, parent: platform
[ 190.804836] call alarmtimer+ returned 0 after 1 usecs
[ 190.804849] calling serial8250+ @ 1245, parent: platform
[ 190.804854] call serial8250+ returned 0 after 2 usecs
[ 190.804861] calling i8042+ @ 1245, parent: platform
[ 190.807567] call i8042+ returned 0 after 2640 usecs
[ 190.807569] calling serio0+ @ 1245, parent: i8042
[ 190.807580] call serio0+ returned 0 after 8 usecs
[ 190.807583] calling serio1+ @ 1245, parent: i8042
[ 190.807591] call serio1+ returned 0 after 6 usecs
[ 190.807594] calling rtc0+ @ 1245, parent: 00:03
[ 190.807598] call rtc0+ returned 0 after 1 usecs
[ 190.807601] calling memconsole+ @ 1245, parent: platform
[ 190.807605] call memconsole+ returned 0 after 1 usecs
[ 190.807610] calling microcode+ @ 1245, parent: platform
[ 190.807613] call microcode+ returned 0 after 1 usecs
[ 190.807620] calling input0+ @ 1245, parent: serio0
[ 190.807626] call input0+ returned 0 after 3 usecs
[ 190.807629] calling input0::numlock+ @ 1245, parent: input0
[ 190.807633] call input0::numlock+ returned 0 after 1 usecs
[ 190.807635] calling input0::capslock+ @ 1245, parent: input0
[ 190.807639] call input0::capslock+ returned 0 after 1 usecs
[ 190.807641] calling input0::scrolllock+ @ 1245, parent: input0
[ 190.807645] call input0::scrolllock+ returned 0 after 1 usecs
[ 190.888052] call 0000:01:00.0+ returned 0 after 81812 usecs
[ 190.912055] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 191.061795] ata1.00: configured for UDMA/100
[ 191.088750] call 0:0:0:0+ returned 0 after 481996 usecs
[ 191.089499] calling input2+ @ 1245, parent: PNP0C0E:00
[ 191.089504] call input2+ returned 0 after 1 usecs
[ 191.089508] calling input3+ @ 1245, parent: PNP0C0D:00
[ 191.089512] call input3+ returned 0 after 1 usecs
[ 191.089515] calling input4+ @ 1245, parent: LNXPWRBN:00
[ 191.089519] call input4+ returned 0 after 1 usecs
[ 191.089529] calling input5+ @ 1245, parent: card0
[ 191.089536] call input5+ returned 0 after 4 usecs
[ 191.089548] calling thinkpad_acpi+ @ 1245, parent: platform
[ 191.102615] call thinkpad_acpi+ returned 0 after 12753 usecs
[ 191.102623] calling thinkpad_hwmon+ @ 1245, parent: platform
[ 191.102639] call thinkpad_hwmon+ returned 0 after 1 usecs
[ 191.102650] calling regulatory.0+ @ 1245, parent: platform
[ 191.102653] call regulatory.0+ returned 0 after 1 usecs
[ 191.102660] calling tpacpi::power+ @ 1245, parent: thinkpad_acpi
[ 191.102664] call tpacpi::power+ returned 0 after 1 usecs
[ 191.102667] calling tpacpi::standby+ @ 1245, parent: thinkpad_acpi
[ 191.102670] call tpacpi::standby+ returned 0 after 1 usecs
[ 191.102673] calling tpacpi::thinkvantage+ @ 1245, parent: thinkpad_acpi
[ 191.102677] call tpacpi::thinkvantage+ returned 0 after 1 usecs
[ 191.102680] calling iTCO_wdt.0.auto+ @ 1245, parent: 0000:00:1f.0
[ 191.102683] call iTCO_wdt.0.auto+ returned 0 after 1 usecs
[ 191.102686] calling gpio_ich.1.auto+ @ 1245, parent: 0000:00:1f.0
[ 191.102690] call gpio_ich.1.auto+ returned 0 after 1 usecs
[ 191.102692] calling mmc0::+ @ 1245, parent: 0000:05:00.2
[ 191.102696] call mmc0::+ returned 0 after 1 usecs
[ 191.102701] calling input6+ @ 1245, parent: thinkpad_acpi
[ 191.102705] call input6+ returned 0 after 1 usecs
[ 191.102708] calling input7+ @ 1245, parent: pcspkr
[ 191.102713] call input7+ returned 0 after 1 usecs
[ 191.102718] calling phy0-led+ @ 1245, parent: 0000:02:00.0
[ 191.102722] call phy0-led+ returned 0 after 1 usecs
[ 191.102725] calling rfkill0+ @ 1245, parent: phy0
[ 191.102734] call rfkill0+ returned 0 after 5 usecs
[ 191.102744] calling coretemp.0+ @ 1245, parent: platform
[ 191.102748] call coretemp.0+ returned 0 after 1 usecs
[ 191.102753] calling input8+ @ 1245, parent: serio1
[ 191.102756] call input8+ returned 0 after 1 usecs
[ 191.102772] calling intel_backlight+ @ 1245, parent: card0-LVDS-1
[ 191.102776] call intel_backlight+ returned 0 after 1 usecs
[ 191.102780] calling acpi_video0+ @ 1245, parent: 0000:00:02.0
[ 191.102784] call acpi_video0+ returned 0 after 1 usecs
[ 191.102787] calling input9+ @ 1245, parent: LNXVIDEO:00
[ 191.102791] call input9+ returned 0 after 1 usecs
[ 191.105432] OOM killer enabled.
[ 191.105436] Restarting tasks ... done.
[ 191.111636] video LNXVIDEO:00: Restoring backlight state
[ 191.119309] PM: suspend exit
[ 191.196112] firewire_core 0000:05:00.1: rediscovered device fw0
[ 192.799462] serio: Serial port ttyS0
[ 193.777162] e1000e: eth8 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: Rx/Tx

Attachment: smime.p7s
Description: S/MIME Cryptographic Signature