linux-kernel.vger.kernel.org archive mirror
 help / color / mirror / Atom feed
* kmemleak detects leak in msr_build_context
@ 2022-01-11  7:49 Paul Menzel
  2022-01-11 15:26 ` Dave Hansen
  0 siblings, 1 reply; 6+ messages in thread
From: Paul Menzel @ 2022-01-11  7:49 UTC (permalink / raw)
  To: Thomas Gleixner, Ingo Molnar, Borislav Petkov, Dave Hansen, x86; +Cc: LKML

Dear Linux folks,


Running Linux from commit bf4eebf8cfa2 (Merge tag 
'linux-kselftest-kunit-5.17-rc1' of 
git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest), 
kmemleak reported the leak below:

```
unreferenced object 0xffff8914823de500 (size 64):
   comm "swapper/0", pid 1, jiffies 4294667581 (age 1253.406s)
   hex dump (first 32 bytes):
     00 00 00 00 00 00 00 00 04 10 01 c0 00 00 00 00  ................
     00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
   backtrace:
     [<000000007f3b05e9>] __kmalloc+0x177/0x330
     [<0000000008104cca>] msr_build_context.constprop.0+0x32/0xbe
     [<00000000012bab4e>] msr_save_cpuid_features+0x28/0x2f
     [<00000000b7a2262e>] pm_check_save_msr+0x2e/0x40
     [<00000000cbe9d92d>] do_one_initcall+0x44/0x200
     [<0000000094deab7b>] kernel_init_freeable+0x1fc/0x273
     [<00000000d3dbaa56>] kernel_init+0x16/0x160
     [<0000000058c4a8b3>] ret_from_fork+0x22/0x30
```


Kind regards,

Paul

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

* Re: kmemleak detects leak in msr_build_context
  2022-01-11  7:49 kmemleak detects leak in msr_build_context Paul Menzel
@ 2022-01-11 15:26 ` Dave Hansen
  2022-01-11 21:05   ` Paul Menzel
  0 siblings, 1 reply; 6+ messages in thread
From: Dave Hansen @ 2022-01-11 15:26 UTC (permalink / raw)
  To: Paul Menzel, Thomas Gleixner, Ingo Molnar, Borislav Petkov,
	Dave Hansen, x86
  Cc: LKML

On 1/10/22 23:49, Paul Menzel wrote:
> Running Linux from commit bf4eebf8cfa2 (Merge tag 
> 'linux-kselftest-kunit-5.17-rc1' of 
> git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest), 
> kmemleak reported the leak below:
> 
> ```
> unreferenced object 0xffff8914823de500 (size 64):
>    comm "swapper/0", pid 1, jiffies 4294667581 (age 1253.406s)
>    hex dump (first 32 bytes):
>      00 00 00 00 00 00 00 00 04 10 01 c0 00 00 00 00  ................
>      00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
>    backtrace:
>      [<000000007f3b05e9>] __kmalloc+0x177/0x330
>      [<0000000008104cca>] msr_build_context.constprop.0+0x32/0xbe
>      [<00000000012bab4e>] msr_save_cpuid_features+0x28/0x2f
>      [<00000000b7a2262e>] pm_check_save_msr+0x2e/0x40
>      [<00000000cbe9d92d>] do_one_initcall+0x44/0x200
>      [<0000000094deab7b>] kernel_init_freeable+0x1fc/0x273
>      [<00000000d3dbaa56>] kernel_init+0x16/0x160
>      [<0000000058c4a8b3>] ret_from_fork+0x22/0x30

Thanks for the report.

I've taken a look through arch/x86/power/cpu.c, and nothing obvious 
jumped out at me.  msr_build_context() could probably be cleaned up by 
using kvrealloc(), but it hasn't been touched recently in a way that I 
would expect things to leak.

I suspect this is a false positive from kmemleak.

If you could share your full dmesg, it might help spot something.  But, 
I didn't see anything.

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

* Re: kmemleak detects leak in msr_build_context
  2022-01-11 15:26 ` Dave Hansen
@ 2022-01-11 21:05   ` Paul Menzel
  2022-01-11 23:16     ` Borislav Petkov
  2022-01-14 11:44     ` Catalin Marinas
  0 siblings, 2 replies; 6+ messages in thread
From: Paul Menzel @ 2022-01-11 21:05 UTC (permalink / raw)
  To: Dave Hansen
  Cc: LKML, Thomas Gleixner, Ingo Molnar, Borislav Petkov, Dave Hansen,
	x86, Catalin Marinas

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

Dear Dave,


Thank you for your quick reply.

Am 11.01.22 um 16:26 schrieb Dave Hansen:
> On 1/10/22 23:49, Paul Menzel wrote:
>> Running Linux from commit bf4eebf8cfa2 (Merge tag 
>> 'linux-kselftest-kunit-5.17-rc1' of 
>> git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest), 
>> kmemleak reported the leak below:
>>
>> ```
>> unreferenced object 0xffff8914823de500 (size 64):
>>    comm "swapper/0", pid 1, jiffies 4294667581 (age 1253.406s)
>>    hex dump (first 32 bytes):
>>      00 00 00 00 00 00 00 00 04 10 01 c0 00 00 00 00  ................
>>      00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
>>    backtrace:
>>      [<000000007f3b05e9>] __kmalloc+0x177/0x330
>>      [<0000000008104cca>] msr_build_context.constprop.0+0x32/0xbe
>>      [<00000000012bab4e>] msr_save_cpuid_features+0x28/0x2f
>>      [<00000000b7a2262e>] pm_check_save_msr+0x2e/0x40
>>      [<00000000cbe9d92d>] do_one_initcall+0x44/0x200
>>      [<0000000094deab7b>] kernel_init_freeable+0x1fc/0x273
>>      [<00000000d3dbaa56>] kernel_init+0x16/0x160
>>      [<0000000058c4a8b3>] ret_from_fork+0x22/0x30
> 
> Thanks for the report.

Thank you for your quick response.

> I've taken a look through arch/x86/power/cpu.c, and nothing obvious 
> jumped out at me.  msr_build_context() could probably be cleaned up by 
> using kvrealloc(), but it hasn't been touched recently in a way that I 
> would expect things to leak.

Thank you for checking. I do not know if it’s a regression, as I didn’t 
watch out for that error in the last months.

> I suspect this is a false positive from kmemleak.

Maybe Catalin can check.

> If you could share your full dmesg, it might help spot something.  But, 
> I didn't see anything.

Please find it attached.

I am able to reproduce it doing `dpkg -i ../*deb` on the Linux packages 
built with `make bindeb-pkg`.


Kind regards,

Paul

[-- Attachment #2: 20220111-linux-5.16+-messages-kmemleak.txt --]
[-- Type: text/plain, Size: 146861 bytes --]

[    0.000000] Linux version 5.16.0-01237-g2f1d806381cf (root@45e877da5b3e) (gcc (Debian 11.2.0-12) 11.2.0, GNU ld (GNU Binutils for Debian) 2.37) #259 SMP PREEMPT Mon Jan 10 22:46:58 UTC 2022
[    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-5.16.0-01237-g2f1d806381cf root=/dev/sda3 rw quiet noisapnp cryptomgr.notests ipv6.disable_ipv6=1 selinux=0 initcall_debug log_buf_len=32M trace_buf_size=888890K trace_clock=global trace_options=nooverwrite,funcgraph-abstime,funcgraph-cpu,funcgraph-duration,funcgraph-proc,funcgraph-tail,nofuncgraph-overhead,context-info,graph-time ftrace=function_graph ftrace_graph_max_depth=3 ftrace_graph_filter=do_one_initcall
[    0.000000] random: get_random_u32 called from bsp_init_amd+0x142/0x210 with crng_init=0
[    0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000] signal: max sigframe size: 1776
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000005fe45fff] usable
[    0.000000] BIOS-e820: [mem 0x000000005fe46000-0x000000007fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000f8000000-0x00000000fbffffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000017effffff] usable
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 3.0.0 present.
[    0.000000] DMI: ASUS F2A85-M_PRO/F2A85-M_PRO, BIOS 4.15-1002-g30bef3cdd8 01/11/2022
[    0.000000] tsc: Fast TSC calibration using PIT
[    0.000000] tsc: Initial usec timer 5996034
[    0.000000] tsc: Detected 3899.947 MHz processor
[    0.000593] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000595] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000599] last_pfn = 0x17f000 max_arch_pfn = 0x400000000
[    0.000734] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
[    0.000935] last_pfn = 0x5fe46 max_arch_pfn = 0x400000000
[    0.004714] Using GB pages for direct mapping
[    0.057104] printk: log_buf_len: 33554432 bytes
[    0.057106] printk: early log buf free: 259784(99%)
[    0.057110] ACPI: Early table checksum verification disabled
[    0.057115] ACPI: RSDP 0x00000000000F6830 000024 (v02 COREv4)
[    0.057120] ACPI: XSDT 0x000000005FE4C0E0 000074 (v01 COREv4 COREBOOT 00000000 CORE 20200925)
[    0.057125] ACPI: FACP 0x000000005FE4DBC0 000114 (v06 COREv4 COREBOOT 00000000 CORE 20200925)
[    0.057132] ACPI: DSDT 0x000000005FE4C280 00193A (v02 COREv4 COREBOOT 00010001 INTL 20200925)
[    0.057135] ACPI: FACS 0x000000005FE4C240 000040
[    0.057138] ACPI: FACS 0x000000005FE4C240 000040
[    0.057140] ACPI: SSDT 0x000000005FE4DCE0 00008A (v02 COREv4 COREBOOT 0000002A CORE 20200925)
[    0.057143] ACPI: MCFG 0x000000005FE4DD70 00003C (v01 COREv4 COREBOOT 00000000 CORE 20200925)
[    0.057146] ACPI: APIC 0x000000005FE4DDB0 000062 (v03 COREv4 COREBOOT 00000000 CORE 20200925)
[    0.057149] ACPI: HPET 0x000000005FE4DE20 000038 (v01 COREv4 COREBOOT 00000000 CORE 20200925)
[    0.057152] ACPI: HEST 0x000000005FE4DE60 0001D0 (v01 COREv4 COREBOOT 00000000 CORE 20200925)
[    0.057155] ACPI: IVRS 0x000000005FE4E030 000070 (v02 AMD    AMDIOMMU 00000001 AMD  00000000)
[    0.057158] ACPI: SSDT 0x000000005FE4E0A0 00051F (v02 AMD    ALIB     00000001 MSFT 04000000)
[    0.057161] ACPI: SSDT 0x000000005FE4E5C0 0006B2 (v01 AMD    POWERNOW 00000001 AMD  00000001)
[    0.057164] ACPI: VFCT 0x000000005FE4EC80 00F269 (v01 COREv4 COREBOOT 00000000 CORE 20200925)
[    0.057166] ACPI: Reserving FACP table memory at [mem 0x5fe4dbc0-0x5fe4dcd3]
[    0.057168] ACPI: Reserving DSDT table memory at [mem 0x5fe4c280-0x5fe4dbb9]
[    0.057170] ACPI: Reserving FACS table memory at [mem 0x5fe4c240-0x5fe4c27f]
[    0.057171] ACPI: Reserving FACS table memory at [mem 0x5fe4c240-0x5fe4c27f]
[    0.057172] ACPI: Reserving SSDT table memory at [mem 0x5fe4dce0-0x5fe4dd69]
[    0.057173] ACPI: Reserving MCFG table memory at [mem 0x5fe4dd70-0x5fe4ddab]
[    0.057174] ACPI: Reserving APIC table memory at [mem 0x5fe4ddb0-0x5fe4de11]
[    0.057175] ACPI: Reserving HPET table memory at [mem 0x5fe4de20-0x5fe4de57]
[    0.057176] ACPI: Reserving HEST table memory at [mem 0x5fe4de60-0x5fe4e02f]
[    0.057177] ACPI: Reserving IVRS table memory at [mem 0x5fe4e030-0x5fe4e09f]
[    0.057178] ACPI: Reserving SSDT table memory at [mem 0x5fe4e0a0-0x5fe4e5be]
[    0.057179] ACPI: Reserving SSDT table memory at [mem 0x5fe4e5c0-0x5fe4ec71]
[    0.057180] ACPI: Reserving VFCT table memory at [mem 0x5fe4ec80-0x5fe5dee8]
[    0.057243] No NUMA configuration found
[    0.057245] Faking a node at [mem 0x0000000000000000-0x000000017effffff]
[    0.057253] NODE_DATA(0) allocated [mem 0x175fe9000-0x175ffffff]
[    0.069290] Zone ranges:
[    0.069292]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.069294]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.069296]   Normal   [mem 0x0000000100000000-0x000000017effffff]
[    0.069297]   Device   empty
[    0.069298] Movable zone start for each node
[    0.069300] Early memory node ranges
[    0.069301]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.069302]   node   0: [mem 0x0000000000100000-0x000000005fe45fff]
[    0.069303]   node   0: [mem 0x0000000100000000-0x000000017effffff]
[    0.069306] Initmem setup node 0 [mem 0x0000000000001000-0x000000017effffff]
[    0.069313] On node 0, zone DMA: 1 pages in unavailable ranges
[    0.069367] On node 0, zone DMA: 97 pages in unavailable ranges
[    0.081771] On node 0, zone Normal: 442 pages in unavailable ranges
[    0.081838] On node 0, zone Normal: 4096 pages in unavailable ranges
[    0.081962] ACPI: PM-Timer IO Port: 0x818
[    0.081969] ACPI: LAPIC_NMI (acpi_id[0xff] high edge lint[0x1])
[    0.081977] IOAPIC[0]: apic_id 4, version 33, address 0xfec00000, GSI 0-23
[    0.081979] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.081981] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
[    0.081985] ACPI: Using ACPI (MADT) for SMP configuration information
[    0.081986] ACPI: HPET id: 0x10228210 base: 0xfed00000
[    0.081991] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[    0.081992] smpboot: smpboot: XXX end of prefill_possible_map
[    0.081993] After prefill_possible_map
[    0.081994] After init_cpu_to_node
[    0.081995] After init_gi_nodes
[    0.081997] After io_apic_init_mappings
[    0.081997] After x86_init.hyper.guest_late_init
[    0.082007] [mem 0x80000000-0xf7ffffff] available for PCI devices
[    0.082008] After e820
[    0.082011] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[    0.086011] After unwind_init
[    0.086013] After setup_arch
[    0.086026] After setup_command_line
[    0.086027] After setup_nr_cpu_ids
[    0.086027] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:2 nr_node_ids:1
[    0.086482] percpu: Embedded 54 pages/cpu s182040 r8192 d30952 u1048576
[    0.086497] pcpu-alloc: s182040 r8192 d30952 u1048576 alloc=1*2097152
[    0.086500] pcpu-alloc: [0] 0 1 
[    0.086528] After setup_per_cpu_areas
[    0.086530] After smp_perpare_boot_cpu
[    0.086530] After boot_cpu_hotplug_init
[    0.086533] Fallback order for Node 0: 0 
[    0.086536] Built 1 zonelists, mobility grouping on.  Total pages: 898444
[    0.086538] Policy zone: Normal
[    0.086539] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-5.16.0-01237-g2f1d806381cf root=/dev/sda3 rw quiet noisapnp cryptomgr.notests ipv6.disable_ipv6=1 selinux=0 initcall_debug log_buf_len=32M trace_buf_size=888890K trace_clock=global trace_options=nooverwrite,funcgraph-abstime,funcgraph-cpu,funcgraph-duration,funcgraph-proc,funcgraph-tail,nofuncgraph-overhead,context-info,graph-time ftrace=function_graph ftrace_graph_max_depth=3 ftrace_graph_filter=do_one_initcall
[    0.086675] Unknown kernel command line parameters "noisapnp BOOT_IMAGE=/boot/vmlinuz-5.16.0-01237-g2f1d806381cf trace_clock=global trace_options=nooverwrite,funcgraph-abstime,funcgraph-cpu,funcgraph-duration,funcgraph-proc,funcgraph-tail,nofuncgraph-overhead,context-info,graph-time", will be passed to user space.
[    0.087456] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.087849] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.087877] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.128063] Memory: 3335844K/3651472K available (14344K kernel code, 2321K rwdata, 4216K rodata, 1700K init, 6320K bss, 315368K reserved, 0K cma-reserved)
[    0.128495] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.128529] After mm_init
[    0.128530] ftrace: allocating 35326 entries in 138 pages
[    0.140150] ftrace: allocated 138 pages with 3 groups
[    0.513543] Dynamic Preempt: full
[    0.513545] After sched_init
[    0.513628] rcu: Preemptible hierarchical RCU implementation.
[    0.513629] rcu: 	RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2.
[    0.513631] 	Trampoline variant of Tasks RCU enabled.
[    0.513631] 	Rude variant of Tasks RCU enabled.
[    0.513632] 	Tracing variant of Tasks RCU enabled.
[    0.513633] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
[    0.513634] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    0.513648] After rcu_init
[    0.523192] NR_IRQS: 4352, nr_irqs: 440, preallocated irqs: 16
[    0.523547] rcu: 	Offload RCU callbacks from CPUs: (none).
[    0.523583] random: crng_init_try_arch_early failed with i = 4, X86_FEATURE_RDRAND = no
[    0.523585] random: crng_init_try_arch_early failed with i = 5, X86_FEATURE_RDRAND = no
[    0.523586] random: crng_init_try_arch_early failed with i = 6, X86_FEATURE_RDRAND = no
[    0.523587] random: crng_init_try_arch_early failed with i = 7, X86_FEATURE_RDRAND = no
[    0.523588] random: crng_init_try_arch_early failed with i = 8, X86_FEATURE_RDRAND = no
[    0.523589] random: crng_init_try_arch_early failed with i = 9, X86_FEATURE_RDRAND = no
[    0.523589] random: crng_init_try_arch_early failed with i = 10, X86_FEATURE_RDRAND = no
[    0.523590] random: crng_init_try_arch_early failed with i = 11, X86_FEATURE_RDRAND = no
[    0.523591] random: crng_init_try_arch_early failed with i = 12, X86_FEATURE_RDRAND = no
[    0.523592] random: crng_init_try_arch_early failed with i = 13, X86_FEATURE_RDRAND = no
[    0.523593] random: crng_init_try_arch_early failed with i = 14, X86_FEATURE_RDRAND = no
[    0.523594] random: crng_init_try_arch_early failed with i = 15, X86_FEATURE_RDRAND = no
[    0.523595] After add_latent_entropy
[    0.523600] After add_device_randomness
[    0.523601] After boot_init_stack_canary
[    0.523660] spurious 8259A interrupt: IRQ7.
[    0.523665] calling  con_init+0x0/0x265 @ 0
[    0.525663] Console: colour VGA+ 80x25
[    0.525676] printk: console [tty0] enabled
[    0.525678] initcall con_init+0x0/0x265 returned 0 after 0 usecs
[    0.525680] calling  kgdboc_earlycon_late_init+0x0/0x1d @ 0
[    0.525682] initcall kgdboc_earlycon_late_init+0x0/0x1d returned 0 after 0 usecs
[    0.525728] ACPI: Core revision 20210930
[    0.525952] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484873504 ns
[    0.525969] APIC: Switch to symmetric I/O mode setup
[    0.561090] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.565971] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x706e53e385c, max_idle_ns: 881591184227 ns
[    0.565980] Calibrating delay loop (skipped), value calculated using timer frequency.. 7799.89 BogoMIPS (lpj=3899947)
[    0.565983] pid_max: default: 32768 minimum: 301
[    0.566097] LSM: Security Framework initializing
[    0.566218] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.566235] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.566859] Bit 30 in CPUID ECX not set.
[    0.566890] Last level iTLB entries: 4KB 512, 2MB 1024, 4MB 512
[    0.566891] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 512, 1GB 0
[    0.566897] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.566900] Spectre V2 : Mitigation: Full AMD retpoline
[    0.566900] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.566903] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
[    0.566905] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
[    0.570332] Freeing SMP alternatives memory: 40K
[    0.570336] After check_bugs
[    0.570338] After acpi_subsystem_init
[    0.570338] After arch_post_acpi_subsys_init
[    0.570339] After rcu_scheduler_starting
[    0.570418] After find_task_by_pid_ns and PF_NO_SETAFFINITY
[    0.570427] After numa_default_policy
[    0.570451] After rcu_read_lock
[    0.570452] After rcu_read_unlock
[    0.570452] After kthreadd_done
[    0.570463] smpboot: Start of smp_prepare_cpus_common
[    0.570465] smpboot: smpboot: zalloc 0
[    0.570467] smpboot: smpboot: zalloc 1
[    0.570467] smpboot: smpboot: After set_sched_topology()
[    0.570469] smpboot: smpboot: After smp_sanity_check()
[    0.570470] smpboot: smpboot: Before x86_init.timers.setup_percpu_clockev()
[    0.622976] random: random: 1
[    0.622977] random: random: 2
[    0.622977] random: random: 3
[    0.622978] random: random: 4
[    0.672474] smpboot: smpboot: After x86_init.timers.setup_percpu_clockev()
[    0.672475] smpboot: smp_get_logical_apicid()
[    0.672475] smpboot: CPU0: AMD A6-6400K APU with Radeon(tm) HD Graphics (family: 0x15, model: 0x13, stepping: 0x1)
[    0.672819] calling  init_hw_perf_events+0x0/0x624 @ 1
[    0.672825] Performance Events: Fam15h core perfctr, AMD PMU driver.
[    0.672829] ... version:                0
[    0.672830] ... bit width:              48
[    0.672831] ... generic registers:      6
[    0.672832] ... value mask:             0000ffffffffffff
[    0.672833] ... max period:             00007fffffffffff
[    0.672834] ... fixed-purpose events:   0
[    0.672834] ... event mask:             000000000000003f
[    0.672882] initcall init_hw_perf_events+0x0/0x624 returned 0 after 0 usecs
[    0.672885] calling  init_real_mode+0x0/0x1e7 @ 1
[    0.672898] initcall init_real_mode+0x0/0x1e7 returned 0 after 0 usecs
[    0.672900] calling  trace_init_perf_perm_irq_work_exit+0x0/0x13 @ 1
[    0.672903] initcall trace_init_perf_perm_irq_work_exit+0x0/0x13 returned 0 after 0 usecs
[    0.672905] calling  register_nmi_cpu_backtrace_handler+0x0/0x16 @ 1
[    0.672909] initcall register_nmi_cpu_backtrace_handler+0x0/0x16 returned 0 after 0 usecs
[    0.672911] calling  numachip_system_init+0x0/0x65 @ 1
[    0.672914] initcall numachip_system_init+0x0/0x65 returned 0 after 0 usecs
[    0.672917] calling  spawn_ksoftirqd+0x0/0x39 @ 1
[    0.672958] initcall spawn_ksoftirqd+0x0/0x39 returned 0 after 0 usecs
[    0.672961] calling  migration_init+0x0/0x14 @ 1
[    0.672964] initcall migration_init+0x0/0x14 returned 0 after 0 usecs
[    0.672966] calling  srcu_bootup_announce+0x0/0x30 @ 1
[    0.672969] rcu: Hierarchical SRCU implementation.
[    0.672970] initcall srcu_bootup_announce+0x0/0x30 returned 0 after 0 usecs
[    0.672972] calling  rcu_spawn_gp_kthread+0x0/0x1e8 @ 1
[    0.672975] initcall rcu_spawn_gp_kthread+0x0/0x1e8 returned 0 after 0 usecs
[    0.672975] calling  check_cpu_stall_init+0x0/0x1b @ 1
[    0.672975] initcall check_cpu_stall_init+0x0/0x1b returned 0 after 0 usecs
[    0.672975] calling  rcu_sysrq_init+0x0/0x22 @ 1
[    0.672975] initcall rcu_sysrq_init+0x0/0x22 returned 0 after 0 usecs
[    0.672975] calling  trace_init_flags_sys_enter+0x0/0xf @ 1
[    0.672975] initcall trace_init_flags_sys_enter+0x0/0xf returned 0 after 0 usecs
[    0.672975] calling  trace_init_flags_sys_exit+0x0/0xf @ 1
[    0.672975] initcall trace_init_flags_sys_exit+0x0/0xf returned 0 after 0 usecs
[    0.672975] calling  cpu_stop_init+0x0/0x8e @ 1
[    0.672975] initcall cpu_stop_init+0x0/0x8e returned 0 after 0 usecs
[    0.672975] calling  init_kprobes+0x0/0x166 @ 1
[    0.673101] initcall init_kprobes+0x0/0x166 returned 0 after 976 usecs
[    0.673104] calling  init_events+0x0/0x39 @ 1
[    0.673118] initcall init_events+0x0/0x39 returned 0 after 0 usecs
[    0.673120] calling  init_trace_printk+0x0/0xc @ 1
[    0.673122] initcall init_trace_printk+0x0/0xc returned 0 after 0 usecs
[    0.673124] calling  event_trace_enable_again+0x0/0x3e @ 1
[    0.673126] initcall event_trace_enable_again+0x0/0x3e returned 0 after 0 usecs
[    0.673128] calling  irq_work_init_threads+0x0/0x3 @ 1
[    0.673131] initcall irq_work_init_threads+0x0/0x3 returned 0 after 0 usecs
[    0.673132] calling  static_call_init+0x0/0x81 @ 1
[    0.673134] initcall static_call_init+0x0/0x81 returned 0 after 0 usecs
[    0.673136] calling  jump_label_init_module+0x0/0x11 @ 1
[    0.673139] initcall jump_label_init_module+0x0/0x11 returned 0 after 0 usecs
[    0.673141] calling  init_zero_pfn+0x0/0x38 @ 1
[    0.673143] initcall init_zero_pfn+0x0/0x38 returned 0 after 0 usecs
[    0.673145] calling  dynamic_debug_init+0x0/0x187 @ 1
[    0.673454] initcall dynamic_debug_init+0x0/0x187 returned 0 after 0 usecs
[    0.673457] calling  initialize_ptr_random+0x0/0x4b @ 1
[    0.673460] initcall initialize_ptr_random+0x0/0x4b returned 0 after 0 usecs
[    0.673462] calling  efi_memreserve_root_init+0x0/0x26 @ 1
[    0.673464] initcall efi_memreserve_root_init+0x0/0x26 returned 0 after 0 usecs
[    0.673550] NMI watchdog: Enabled. Permanently consumes one hw-PMU counter.
[    0.673641] smp: Bringing up secondary CPUs ...
[    1.098884] x86: Booting SMP configuration:
[    1.098888] .... node  #0, CPUs:      #1
[    0.036409] Bit 30 in CPUID ECX not set.
[    1.099984] After schedule_preempt_disabled
[    1.100083] smp: Brought up 1 node, 2 CPUs
[    1.100083] smpboot: Max logical packages: 1
[    1.100083] smpboot: Total of 2 processors activated (15599.78 BogoMIPS)
[    1.100609] devtmpfs: initialized
[    1.101107] x86/mm: Memory block size: 128MB
[    1.103069] calling  bpf_jit_charge_init+0x0/0x3c @ 1
[    1.103077] initcall bpf_jit_charge_init+0x0/0x3c returned 0 after 0 usecs
[    1.103079] calling  ipc_ns_init+0x0/0x40 @ 1
[    1.103086] initcall ipc_ns_init+0x0/0x40 returned 0 after 0 usecs
[    1.103089] calling  init_mmap_min_addr+0x0/0x22 @ 1
[    1.103092] initcall init_mmap_min_addr+0x0/0x22 returned 0 after 0 usecs
[    1.103094] calling  pci_realloc_setup_params+0x0/0x41 @ 1
[    1.103097] initcall pci_realloc_setup_params+0x0/0x41 returned 0 after 0 usecs
[    1.103099] calling  net_ns_init+0x0/0x111 @ 1
[    1.103152] initcall net_ns_init+0x0/0x111 returned 0 after 0 usecs
[    1.103152] calling  inet_frag_wq_init+0x0/0x3d @ 1
[    1.103152] initcall inet_frag_wq_init+0x0/0x3d returned 0 after 0 usecs
[    1.103152] calling  e820__register_nvs_regions+0x0/0x38 @ 1
[    1.103152] initcall e820__register_nvs_regions+0x0/0x38 returned 0 after 0 usecs
[    1.103152] calling  cpufreq_register_tsc_scaling+0x0/0x2a @ 1
[    1.103152] initcall cpufreq_register_tsc_scaling+0x0/0x2a returned 0 after 0 usecs
[    1.103152] calling  reboot_init+0x0/0x3d @ 1
[    1.103152] initcall reboot_init+0x0/0x3d returned 0 after 0 usecs
[    1.103152] calling  init_lapic_sysfs+0x0/0x21 @ 1
[    1.103152] initcall init_lapic_sysfs+0x0/0x21 returned 0 after 0 usecs
[    1.103152] calling  alloc_frozen_cpus+0x0/0x8 @ 1
[    1.103152] initcall alloc_frozen_cpus+0x0/0x8 returned 0 after 0 usecs
[    1.103152] calling  cpu_hotplug_pm_sync_init+0x0/0x14 @ 1
[    1.103152] initcall cpu_hotplug_pm_sync_init+0x0/0x14 returned 0 after 0 usecs
[    1.103152] calling  wq_sysfs_init+0x0/0x2b @ 1
[    1.103152] initcall wq_sysfs_init+0x0/0x2b returned 0 after 0 usecs
[    1.103152] calling  ksysfs_init+0x0/0x99 @ 1
[    1.103154] initcall ksysfs_init+0x0/0x99 returned 0 after 0 usecs
[    1.103157] calling  schedutil_gov_init+0x0/0x11 @ 1
[    1.103160] initcall schedutil_gov_init+0x0/0x11 returned 0 after 0 usecs
[    1.103162] calling  pm_init+0x0/0x69 @ 1
[    1.103226] initcall pm_init+0x0/0x69 returned 0 after 0 usecs
[    1.103228] calling  rcu_set_runtime_mode+0x0/0x17 @ 1
[    1.103232] initcall rcu_set_runtime_mode+0x0/0x17 returned 0 after 0 usecs
[    1.103234] calling  init_jiffies_clocksource+0x0/0x18 @ 1
[    1.103238] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[    1.103240] initcall init_jiffies_clocksource+0x0/0x18 returned 0 after 0 usecs
[    1.103243] calling  futex_init+0x0/0xf9 @ 1
[    1.103248] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
[    1.103259] initcall futex_init+0x0/0xf9 returned 0 after 0 usecs
[    1.103261] calling  cgroup_wq_init+0x0/0x29 @ 1
[    1.103268] initcall cgroup_wq_init+0x0/0x29 returned 0 after 0 usecs
[    1.103270] calling  cgroup1_wq_init+0x0/0x29 @ 1
[    1.103277] initcall cgroup1_wq_init+0x0/0x29 returned 0 after 0 usecs
[    1.103279] calling  ftrace_mod_cmd_init+0x0/0xc @ 1
[    1.103282] initcall ftrace_mod_cmd_init+0x0/0xc returned 0 after 0 usecs
[    1.103284] calling  init_wakeup_tracer+0x0/0x2d @ 1
[    1.103292] initcall init_wakeup_tracer+0x0/0x2d returned 0 after 0 usecs
[    1.103295] calling  init_graph_trace+0x0/0x5d @ 1
[    1.103299] Starting tracer 'function_graph'
[    1.234602] initcall init_graph_trace+0x0/0x5d returned 0 after 127929 usecs
[    1.234619] calling  trace_events_eprobe_init_early+0x0/0x27 @ 1
[    1.234627] initcall trace_events_eprobe_init_early+0x0/0x27 returned 0 after 0 usecs
[    1.234634] calling  init_kprobe_trace_early+0x0/0x26 @ 1
[    1.234642] initcall init_kprobe_trace_early+0x0/0x26 returned 0 after 0 usecs
[    1.234649] calling  mem_cgroup_swap_init+0x0/0x50 @ 1
[    1.234661] initcall mem_cgroup_swap_init+0x0/0x50 returned 0 after 0 usecs
[    1.234668] calling  memory_failure_init+0x0/0x97 @ 1
[    1.234674] initcall memory_failure_init+0x0/0x97 returned 0 after 0 usecs
[    1.234680] calling  cma_init_reserved_areas+0x0/0x1c6 @ 1
[    1.234687] initcall cma_init_reserved_areas+0x0/0x1c6 returned 0 after 0 usecs
[    1.234693] calling  fsnotify_init+0x0/0x49 @ 1
[    1.234774] initcall fsnotify_init+0x0/0x49 returned 0 after 0 usecs
[    1.234781] calling  filelock_init+0x0/0x98 @ 1
[    1.234892] initcall filelock_init+0x0/0x98 returned 0 after 0 usecs
[    1.234899] calling  init_script_binfmt+0x0/0x16 @ 1
[    1.234906] initcall init_script_binfmt+0x0/0x16 returned 0 after 0 usecs
[    1.234912] calling  init_elf_binfmt+0x0/0x16 @ 1
[    1.234919] initcall init_elf_binfmt+0x0/0x16 returned 0 after 0 usecs
[    1.234925] calling  init_compat_elf_binfmt+0x0/0x16 @ 1
[    1.234933] initcall init_compat_elf_binfmt+0x0/0x16 returned 0 after 0 usecs
[    1.234939] calling  configfs_init+0x0/0x9a @ 1
[    1.234969] initcall configfs_init+0x0/0x9a returned 0 after 0 usecs
[    1.234983] calling  debugfs_init+0x0/0x63 @ 1
[    1.235001] initcall debugfs_init+0x0/0x63 returned 0 after 0 usecs
[    1.235008] calling  tracefs_init+0x0/0x3d @ 1
[    1.235025] initcall tracefs_init+0x0/0x3d returned 0 after 0 usecs
[    1.235031] calling  securityfs_init+0x0/0x1a1 @ 1
[    1.235274] initcall securityfs_init+0x0/0x1a1 returned 0 after 0 usecs
[    1.235281] calling  prandom_init_early+0x0/0x155 @ 1
[    1.235288] initcall prandom_init_early+0x0/0x155 returned 0 after 0 usecs
[    1.235294] calling  pinctrl_init+0x0/0xae @ 1
[    1.235300] pinctrl core: initialized pinctrl subsystem
[    1.235610] initcall pinctrl_init+0x0/0xae returned 0 after 0 usecs
[    1.235617] calling  gpiolib_dev_init+0x0/0x15c @ 1
[    1.235818] initcall gpiolib_dev_init+0x0/0x15c returned 0 after 0 usecs
[    1.235826] calling  iommu_init+0x0/0x2b @ 1
[    1.235859] initcall iommu_init+0x0/0x2b returned 0 after 0 usecs
[    1.235866] calling  component_debug_init+0x0/0x1d @ 1
[    1.235895] initcall component_debug_init+0x0/0x1d returned 0 after 0 usecs
[    1.235902] calling  early_resume_init+0x0/0xad @ 1
[    1.235930] PM: RTC time: 16:11:23, date: 2022-01-11
[    1.235936] initcall early_resume_init+0x0/0xad returned 0 after 0 usecs
[    1.235943] calling  opp_debug_init+0x0/0x1d @ 1
[    1.235992] initcall opp_debug_init+0x0/0x1d returned 0 after 976 usecs
[    1.236000] calling  cpufreq_core_init+0x0/0x69 @ 1
[    1.236030] initcall cpufreq_core_init+0x0/0x69 returned 0 after 0 usecs
[    1.236036] calling  cpufreq_gov_performance_init+0x0/0x11 @ 1
[    1.236045] initcall cpufreq_gov_performance_init+0x0/0x11 returned 0 after 0 usecs
[    1.236052] calling  cpufreq_gov_powersave_init+0x0/0x11 @ 1
[    1.236059] initcall cpufreq_gov_powersave_init+0x0/0x11 returned 0 after 0 usecs
[    1.236064] calling  cpufreq_gov_userspace_init+0x0/0x11 @ 1
[    1.236071] initcall cpufreq_gov_userspace_init+0x0/0x11 returned 0 after 0 usecs
[    1.236077] calling  CPU_FREQ_GOV_ONDEMAND_init+0x0/0x11 @ 1
[    1.236084] initcall CPU_FREQ_GOV_ONDEMAND_init+0x0/0x11 returned 0 after 0 usecs
[    1.236089] calling  CPU_FREQ_GOV_CONSERVATIVE_init+0x0/0x11 @ 1
[    1.236096] initcall CPU_FREQ_GOV_CONSERVATIVE_init+0x0/0x11 returned 0 after 0 usecs
[    1.236102] calling  cpuidle_init+0x0/0x20 @ 1
[    1.236156] initcall cpuidle_init+0x0/0x20 returned 0 after 0 usecs
[    1.236161] calling  sock_init+0x0/0x9f @ 1
[    1.236930] initcall sock_init+0x0/0x9f returned 0 after 0 usecs
[    1.236938] calling  net_inuse_init+0x0/0x24 @ 1
[    1.236986] initcall net_inuse_init+0x0/0x24 returned 0 after 976 usecs
[    1.236993] calling  net_defaults_init+0x0/0x24 @ 1
[    1.237000] initcall net_defaults_init+0x0/0x24 returned 0 after 0 usecs
[    1.237006] calling  init_default_flow_dissectors+0x0/0x50 @ 1
[    1.237014] initcall init_default_flow_dissectors+0x0/0x50 returned 0 after 0 usecs
[    1.237021] calling  netpoll_init+0x0/0x29 @ 1
[    1.237027] initcall netpoll_init+0x0/0x29 returned 0 after 0 usecs
[    1.237033] calling  netlink_proto_init+0x0/0x17b @ 1
[    1.237342] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    1.237534] initcall netlink_proto_init+0x0/0x17b returned 0 after 0 usecs
[    1.237541] calling  genl_init+0x0/0x38 @ 1
[    1.237594] initcall genl_init+0x0/0x38 returned 0 after 0 usecs
[    1.237601] calling  bsp_pm_check_init+0x0/0x14 @ 1
[    1.237608] initcall bsp_pm_check_init+0x0/0x14 returned 0 after 0 usecs
[    1.237613] calling  trace_boot_init+0x0/0xd7 @ 1
[    1.237621] initcall trace_boot_init+0x0/0xd7 returned 0 after 0 usecs
[    1.237875] calling  irq_sysfs_init+0x0/0xb8 @ 1
[    1.239618] initcall irq_sysfs_init+0x0/0xb8 returned 0 after 1953 usecs
[    1.239625] calling  audit_init+0x0/0x16f @ 1
[    1.239678] audit: initializing netlink subsys (disabled)
[    1.239751] initcall audit_init+0x0/0x16f returned 0 after 976 usecs
[    1.239751] calling  release_early_probes+0x0/0x33 @ 1
[    1.239751] initcall release_early_probes+0x0/0x33 returned 0 after 0 usecs
[    1.239751] calling  bdi_class_init+0x0/0x49 @ 1
[    1.240007] audit: type=2000 audit(1641917482.680:1): state=initialized audit_enabled=0 res=1
[    1.240055] initcall bdi_class_init+0x0/0x49 returned 0 after 0 usecs
[    1.240063] calling  mm_sysfs_init+0x0/0x29 @ 1
[    1.240089] initcall mm_sysfs_init+0x0/0x29 returned 0 after 0 usecs
[    1.240096] calling  init_per_zone_wmark_min+0x0/0xde @ 1
[    1.240138] initcall init_per_zone_wmark_min+0x0/0xde returned 0 after 0 usecs
[    1.240144] calling  mpi_init+0x0/0xbf @ 1
[    1.240232] initcall mpi_init+0x0/0xbf returned 0 after 0 usecs
[    1.240238] calling  kobject_uevent_init+0x0/0xc @ 1
[    1.240296] initcall kobject_uevent_init+0x0/0xc returned 0 after 0 usecs
[    1.240302] calling  acpi_gpio_setup_params+0x0/0x68 @ 1
[    1.240310] initcall acpi_gpio_setup_params+0x0/0x68 returned 0 after 0 usecs
[    1.240316] calling  pcibus_class_init+0x0/0x18 @ 1
[    1.240357] initcall pcibus_class_init+0x0/0x18 returned 0 after 0 usecs
[    1.240364] calling  pci_driver_init+0x0/0x22 @ 1
[    1.240588] initcall pci_driver_init+0x0/0x22 returned 0 after 0 usecs
[    1.240595] calling  backlight_class_init+0x0/0xa7 @ 1
[    1.240659] initcall backlight_class_init+0x0/0xa7 returned 0 after 0 usecs
[    1.240666] calling  tty_class_init+0x0/0x34 @ 1
[    1.240729] initcall tty_class_init+0x0/0x34 returned 0 after 0 usecs
[    1.240735] calling  vtconsole_class_init+0x0/0xbb @ 1
[    1.241065] initcall vtconsole_class_init+0x0/0xbb returned 0 after 976 usecs
[    1.241072] calling  iommu_dev_init+0x0/0x18 @ 1
[    1.241112] initcall iommu_dev_init+0x0/0x18 returned 0 after 0 usecs
[    1.241119] calling  devlink_class_init+0x0/0x46 @ 1
[    1.241166] initcall devlink_class_init+0x0/0x46 returned 0 after 0 usecs
[    1.241173] calling  software_node_init+0x0/0x2b @ 1
[    1.241199] initcall software_node_init+0x0/0x2b returned 0 after 0 usecs
[    1.241205] calling  wakeup_sources_debugfs_init+0x0/0x24 @ 1
[    1.241235] initcall wakeup_sources_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[    1.241241] calling  wakeup_sources_sysfs_init+0x0/0x2d @ 1
[    1.241292] initcall wakeup_sources_sysfs_init+0x0/0x2d returned 0 after 0 usecs
[    1.241299] calling  register_node_type+0x0/0x33 @ 1
[    1.241635] initcall register_node_type+0x0/0x33 returned 0 after 0 usecs
[    1.241642] calling  regmap_initcall+0x0/0xd @ 1
[    1.241673] initcall regmap_initcall+0x0/0xd returned 0 after 0 usecs
[    1.241679] calling  i2c_init+0x0/0xb4 @ 1
[    1.241896] initcall i2c_init+0x0/0xb4 returned 0 after 0 usecs
[    1.241903] calling  thermal_init+0x0/0xf7 @ 1
[    1.241912] thermal_sys: Registered thermal governor 'fair_share'
[    1.241916] thermal_sys: Registered thermal governor 'bang_bang'
[    1.241920] thermal_sys: Registered thermal governor 'step_wise'
[    1.241924] thermal_sys: Registered thermal governor 'user_space'
[    1.241965] initcall thermal_init+0x0/0xf7 returned 0 after 0 usecs
[    1.241973] calling  init_menu+0x0/0x11 @ 1
[    1.242005] cpuidle: using governor menu
[    1.242009] initcall init_menu+0x0/0x11 returned 0 after 0 usecs
[    1.242015] calling  pcc_init+0x0/0x95 @ 1
[    1.242024] initcall pcc_init+0x0/0x95 returned -19 after 0 usecs
[    1.242031] calling  amd_postcore_init+0x0/0x11b @ 1
[    1.242070] initcall amd_postcore_init+0x0/0x11b returned 0 after 0 usecs
[    1.242242] calling  bts_init+0x0/0xbb @ 1
[    1.242250] initcall bts_init+0x0/0xbb returned -19 after 0 usecs
[    1.242256] calling  pt_init+0x0/0x34d @ 1
[    1.242263] initcall pt_init+0x0/0x34d returned -19 after 0 usecs
[    1.242269] calling  boot_params_ksysfs_init+0x0/0x2a1 @ 1
[    1.242318] initcall boot_params_ksysfs_init+0x0/0x2a1 returned 0 after 0 usecs
[    1.242325] calling  sbf_init+0x0/0xeb @ 1
[    1.242331] initcall sbf_init+0x0/0xeb returned 0 after 0 usecs
[    1.242338] calling  arch_kdebugfs_init+0x0/0x1d1 @ 1
[    1.242457] initcall arch_kdebugfs_init+0x0/0x1d1 returned 0 after 0 usecs
[    1.242464] calling  xfd_update_static_branch+0x0/0x1e @ 1
[    1.242470] initcall xfd_update_static_branch+0x0/0x1e returned 0 after 0 usecs
[    1.242476] calling  intel_pconfig_init+0x0/0x82 @ 1
[    1.242482] initcall intel_pconfig_init+0x0/0x82 returned 0 after 0 usecs
[    1.242488] calling  mtrr_if_init+0x0/0x5e @ 1
[    1.242506] initcall mtrr_if_init+0x0/0x5e returned 0 after 0 usecs
[    1.242511] calling  ffh_cstate_init+0x0/0x31 @ 1
[    1.242535] initcall ffh_cstate_init+0x0/0x31 returned 0 after 0 usecs
[    1.242541] calling  gigantic_pages_init+0x0/0x20 @ 1
[    1.242551] initcall gigantic_pages_init+0x0/0x20 returned 0 after 0 usecs
[    1.242557] calling  kcmp_cookies_init+0x0/0x38 @ 1
[    1.242568] initcall kcmp_cookies_init+0x0/0x38 returned 0 after 0 usecs
[    1.242574] calling  cryptomgr_init+0x0/0x11 @ 1
[    1.242581] initcall cryptomgr_init+0x0/0x11 returned 0 after 0 usecs
[    1.242587] calling  acpi_pci_init+0x0/0x4a @ 1
[    1.242595] initcall acpi_pci_init+0x0/0x4a returned 0 after 0 usecs
[    1.242601] calling  dma_channel_table_init+0x0/0x10a @ 1
[    1.242781] initcall dma_channel_table_init+0x0/0x10a returned 0 after 0 usecs
[    1.242787] calling  dma_bus_init+0x0/0x102 @ 1
[    1.243193] initcall dma_bus_init+0x0/0x102 returned 0 after 976 usecs
[    1.243200] calling  iommu_dma_init+0x0/0x20 @ 1
[    1.243217] initcall iommu_dma_init+0x0/0x20 returned 0 after 0 usecs
[    1.243223] calling  dmi_id_init+0x0/0x386 @ 1
[    1.243864] initcall dmi_id_init+0x0/0x386 returned 0 after 0 usecs
[    1.243870] calling  numachip_timer_init+0x0/0x54 @ 1
[    1.243877] initcall numachip_timer_init+0x0/0x54 returned -19 after 0 usecs
[    1.243883] calling  pci_arch_init+0x0/0x72 @ 1
[    1.243922] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf8000000-0xfbffffff] (base 0xf8000000)
[    1.243930] PCI: MMCONFIG at [mem 0xf8000000-0xfbffffff] reserved in E820
[    1.244045] PCI: Using configuration type 1 for base access
[    1.244052] initcall pci_arch_init+0x0/0x72 returned 0 after 976 usecs
[    1.244300] calling  init_vdso+0x0/0x14 @ 1
[    1.244326] initcall init_vdso+0x0/0x14 returned 0 after 0 usecs
[    1.244333] calling  sysenter_setup+0x0/0x14 @ 1
[    1.244363] initcall sysenter_setup+0x0/0x14 returned 0 after 0 usecs
[    1.244369] calling  fixup_ht_bug+0x0/0xfa @ 1
[    1.244376] initcall fixup_ht_bug+0x0/0xfa returned 0 after 0 usecs
[    1.244382] calling  topology_init+0x0/0xc4 @ 1
[    1.246646] initcall topology_init+0x0/0xc4 returned 0 after 1953 usecs
[    1.246654] calling  intel_epb_init+0x0/0x6f @ 1
[    1.246660] initcall intel_epb_init+0x0/0x6f returned -19 after 0 usecs
[    1.246666] calling  mtrr_init_finialize+0x0/0x3f @ 1
[    1.246673] initcall mtrr_init_finialize+0x0/0x3f returned 0 after 0 usecs
[    1.246679] calling  uid_cache_init+0x0/0xb0 @ 1
[    1.246714] initcall uid_cache_init+0x0/0xb0 returned 0 after 0 usecs
[    1.246720] calling  param_sysfs_init+0x0/0x1e0 @ 1
[    1.273600] initcall param_sysfs_init+0x0/0x1e0 returned 0 after 26367 usecs
[    1.273613] calling  user_namespace_sysctl_init+0x0/0xd0 @ 1
[    1.273680] initcall user_namespace_sysctl_init+0x0/0xd0 returned 0 after 0 usecs
[    1.273687] calling  proc_schedstat_init+0x0/0x25 @ 1
[    1.273706] initcall proc_schedstat_init+0x0/0x25 returned 0 after 0 usecs
[    1.273712] calling  pm_sysrq_init+0x0/0x19 @ 1
[    1.273739] initcall pm_sysrq_init+0x0/0x19 returned 0 after 0 usecs
[    1.273746] calling  create_proc_profile+0x0/0xe0 @ 1
[    1.273755] initcall create_proc_profile+0x0/0xe0 returned 0 after 0 usecs
[    1.273761] calling  crash_save_vmcoreinfo_init+0x0/0x6b4 @ 1
[    1.273823] initcall crash_save_vmcoreinfo_init+0x0/0x6b4 returned 0 after 0 usecs
[    1.273829] calling  crash_notes_memory_init+0x0/0x39 @ 1
[    1.273857] initcall crash_notes_memory_init+0x0/0x39 returned 0 after 0 usecs
[    1.273863] calling  cgroup_sysfs_init+0x0/0x18 @ 1
[    1.273899] initcall cgroup_sysfs_init+0x0/0x18 returned 0 after 0 usecs
[    1.273906] calling  cgroup_namespaces_init+0x0/0x8 @ 1
[    1.273914] initcall cgroup_namespaces_init+0x0/0x8 returned 0 after 0 usecs
[    1.273921] calling  user_namespaces_init+0x0/0x2d @ 1
[    1.273984] initcall user_namespaces_init+0x0/0x2d returned 0 after 0 usecs
[    1.273992] calling  init_optprobes+0x0/0xc2 @ 1
[    1.274001] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
[    1.274006] initcall init_optprobes+0x0/0xc2 returned 0 after 0 usecs
[    1.274012] calling  send_signal_irq_work_init+0x0/0x52 @ 1
[    1.274018] initcall send_signal_irq_work_init+0x0/0x52 returned 0 after 0 usecs
[    1.274024] calling  dev_map_init+0x0/0x4d @ 1
[    1.274033] initcall dev_map_init+0x0/0x4d returned 0 after 0 usecs
[    1.274039] calling  cpu_map_init+0x0/0x41 @ 1
[    1.274046] initcall cpu_map_init+0x0/0x41 returned 0 after 0 usecs
[    1.274052] calling  netns_bpf_init+0x0/0x11 @ 1
[    1.274060] initcall netns_bpf_init+0x0/0x11 returned 0 after 0 usecs
[    1.274066] calling  stack_map_init+0x0/0x57 @ 1
[    1.274072] initcall stack_map_init+0x0/0x57 returned 0 after 0 usecs
[    1.274078] calling  oom_init+0x0/0x30 @ 1
[    1.274112] initcall oom_init+0x0/0x30 returned 0 after 0 usecs
[    1.274112] calling  default_bdi_init+0x0/0x12d @ 1
[    1.274373] initcall default_bdi_init+0x0/0x12d returned 0 after 0 usecs
[    1.274380] calling  cgwb_init+0x0/0x29 @ 1
[    1.274414] initcall cgwb_init+0x0/0x29 returned 0 after 976 usecs
[    1.274421] calling  percpu_enable_async+0x0/0xf @ 1
[    1.274428] initcall percpu_enable_async+0x0/0xf returned 0 after 0 usecs
[    1.274435] calling  kcompactd_init+0x0/0xa0 @ 1
[    1.275108] initcall kcompactd_init+0x0/0xa0 returned 0 after 0 usecs
[    1.275108] calling  init_user_reserve+0x0/0x40 @ 1
[    1.275108] initcall init_user_reserve+0x0/0x40 returned 0 after 0 usecs
[    1.275108] calling  init_admin_reserve+0x0/0x40 @ 1
[    1.275108] initcall init_admin_reserve+0x0/0x40 returned 0 after 0 usecs
[    1.275108] calling  init_reserve_notifier+0x0/0x1f @ 1
[    1.275108] initcall init_reserve_notifier+0x0/0x1f returned 0 after 0 usecs
[    1.275108] calling  swap_init_sysfs+0x0/0x68 @ 1
[    1.275108] initcall swap_init_sysfs+0x0/0x68 returned 0 after 0 usecs
[    1.275108] calling  swapfile_init+0x0/0x9b @ 1
[    1.275108] initcall swapfile_init+0x0/0x9b returned 0 after 0 usecs
[    1.275108] calling  hugetlb_init+0x0/0x580 @ 1
[    1.275119] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    1.275123] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    1.275571] initcall hugetlb_init+0x0/0x580 returned 0 after 0 usecs
[    1.275577] calling  ksm_init+0x0/0x1fd @ 1
[    1.276081] initcall ksm_init+0x0/0x1fd returned 0 after 976 usecs
[    1.276088] calling  numa_init_sysfs+0x0/0x68 @ 1
[    1.276126] initcall numa_init_sysfs+0x0/0x68 returned 0 after 0 usecs
[    1.276132] calling  hugepage_init+0x0/0x141 @ 1
[    1.276379] initcall hugepage_init+0x0/0x141 returned 0 after 0 usecs
[    1.276379] calling  mem_cgroup_init+0x0/0x12e @ 1
[    1.276379] initcall mem_cgroup_init+0x0/0x12e returned 0 after 0 usecs
[    1.276379] calling  io_wq_init+0x0/0x39 @ 1
[    1.276379] initcall io_wq_init+0x0/0x39 returned 0 after 0 usecs
[    1.276379] calling  fips_init+0x0/0x1b @ 1
[    1.276379] initcall fips_init+0x0/0x1b returned 0 after 0 usecs
[    1.276379] calling  dh_init+0x0/0x20 @ 1
[    1.276379] initcall dh_init+0x0/0x20 returned 0 after 0 usecs
[    1.276379] calling  rsa_init+0x0/0x50 @ 1
[    1.276379] initcall rsa_init+0x0/0x50 returned 0 after 0 usecs
[    1.276379] calling  hmac_module_init+0x0/0x11 @ 1
[    1.276379] initcall hmac_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.276379] calling  crypto_null_mod_init+0x0/0x6d @ 1
[    1.276379] initcall crypto_null_mod_init+0x0/0x6d returned 0 after 0 usecs
[    1.276379] calling  md5_mod_init+0x0/0x11 @ 1
[    1.276379] initcall md5_mod_init+0x0/0x11 returned 0 after 0 usecs
[    1.276379] calling  sha1_generic_mod_init+0x0/0x11 @ 1
[    1.276379] initcall sha1_generic_mod_init+0x0/0x11 returned 0 after 0 usecs
[    1.276379] calling  sha256_generic_mod_init+0x0/0x16 @ 1
[    1.276379] initcall sha256_generic_mod_init+0x0/0x16 returned 0 after 0 usecs
[    1.276379] calling  crypto_ecb_module_init+0x0/0x11 @ 1
[    1.276379] initcall crypto_ecb_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.276379] calling  crypto_cbc_module_init+0x0/0x11 @ 1
[    1.276379] initcall crypto_cbc_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.276379] calling  lrw_module_init+0x0/0x11 @ 1
[    1.276379] initcall lrw_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.276379] calling  xts_module_init+0x0/0x11 @ 1
[    1.276379] initcall xts_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.276379] calling  cryptd_init+0x0/0xfa @ 1
[    1.278055] cryptd: max_cpu_qlen set to 1000
[    1.278065] initcall cryptd_init+0x0/0xfa returned 0 after 1953 usecs
[    1.278075] calling  aes_init+0x0/0x11 @ 1
[    1.278096] initcall aes_init+0x0/0x11 returned 0 after 0 usecs
[    1.278102] calling  deflate_mod_init+0x0/0x44 @ 1
[    1.278137] initcall deflate_mod_init+0x0/0x44 returned 0 after 0 usecs
[    1.278143] calling  crc32c_mod_init+0x0/0x11 @ 1
[    1.278158] initcall crc32c_mod_init+0x0/0x11 returned 0 after 0 usecs
[    1.278165] calling  crct10dif_mod_init+0x0/0x11 @ 1
[    1.278179] initcall crct10dif_mod_init+0x0/0x11 returned 0 after 0 usecs
[    1.278185] calling  crypto_authenc_module_init+0x0/0x11 @ 1
[    1.278192] initcall crypto_authenc_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.278197] calling  crypto_authenc_esn_module_init+0x0/0x11 @ 1
[    1.278204] initcall crypto_authenc_esn_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.278210] calling  lzo_mod_init+0x0/0x3f @ 1
[    1.278233] initcall lzo_mod_init+0x0/0x3f returned 0 after 0 usecs
[    1.278239] calling  lzorle_mod_init+0x0/0x3f @ 1
[    1.278262] initcall lzorle_mod_init+0x0/0x3f returned 0 after 0 usecs
[    1.278268] calling  ghash_mod_init+0x0/0x11 @ 1
[    1.278282] initcall ghash_mod_init+0x0/0x11 returned 0 after 0 usecs
[    1.278288] calling  essiv_module_init+0x0/0x11 @ 1
[    1.278295] initcall essiv_module_init+0x0/0x11 returned 0 after 0 usecs
[    1.278300] calling  init_bio+0x0/0xaa @ 1
[    1.278363] initcall init_bio+0x0/0xaa returned 0 after 0 usecs
[    1.278363] calling  blk_ioc_init+0x0/0x2a @ 1
[    1.278363] initcall blk_ioc_init+0x0/0x2a returned 0 after 0 usecs
[    1.278363] calling  blk_mq_init+0x0/0xb8 @ 1
[    1.278363] initcall blk_mq_init+0x0/0xb8 returned 0 after 0 usecs
[    1.278363] calling  genhd_device_init+0x0/0x62 @ 1
[    1.279096] initcall genhd_device_init+0x0/0x62 returned 0 after 976 usecs
[    1.279102] calling  blkcg_init+0x0/0x29 @ 1
[    1.279297] initcall blkcg_init+0x0/0x29 returned 0 after 0 usecs
[    1.279304] calling  irq_poll_setup+0x0/0x6c @ 1
[    1.279313] initcall irq_poll_setup+0x0/0x6c returned 0 after 0 usecs
[    1.279319] calling  byt_gpio_init+0x0/0x13 @ 1
[    1.279374] initcall byt_gpio_init+0x0/0x13 returned 0 after 0 usecs
[    1.279381] calling  gpiolib_debugfs_init+0x0/0x24 @ 1
[    1.279412] initcall gpiolib_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[    1.279421] calling  pwm_debugfs_init+0x0/0x24 @ 1
[    1.279451] initcall pwm_debugfs_init+0x0/0x24 returned 0 after 0 usecs
[    1.279457] calling  pwm_sysfs_init+0x0/0x18 @ 1
[    1.280005] initcall pwm_sysfs_init+0x0/0x18 returned 0 after 0 usecs
[    1.280012] calling  pci_slot_init+0x0/0x40 @ 1
[    1.280041] initcall pci_slot_init+0x0/0x40 returned 0 after 0 usecs
[    1.280048] calling  fbmem_init+0x0/0xe1 @ 1
[    1.280395] initcall fbmem_init+0x0/0xe1 returned 0 after 0 usecs
[    1.280402] calling  acpi_init+0x0/0x484 @ 1
[    1.280534] ACPI: Added _OSI(Module Device)
[    1.280538] ACPI: Added _OSI(Processor Device)
[    1.280542] ACPI: Added _OSI(3.0 _SCP Extensions)
[    1.280546] ACPI: Added _OSI(Processor Aggregator Device)
[    1.280566] ACPI: Added _OSI(Linux-Dell-Video)
[    1.280587] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    1.280607] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    1.358361] ACPI: DSDT successfully acquired and loaded

[    1.388886] ACPI: 4 ACPI AML tables successfully acquired and loaded
[    1.411736] ACPI: Interpreter enabled
[    1.411932] ACPI: PM: (supports S0 S1 S3 S5)
[    1.411936] ACPI: Using IOAPIC for interrupt routing
[    1.412363] HEST: Table parsing has been initialized.
[    1.412368] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    1.416327] ACPI: Enabled 8 GPEs in block 00 to 1F
[    1.501347] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    1.501384] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
[    1.502653] acpi PNP0A03:00: _OSC: OS now controls [PME AER PCIeCapability LTR]
[    1.502834] acpi PNP0A03:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge
[    1.504168] acpi PNP0A03:00: host bridge window expanded to [io  0x0000-0x0cf7 window]; [io  0x03b0-0x03df window] ignored
[    1.507285] PCI host bridge to bus 0000:00
[    1.507301] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    1.507316] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    1.507330] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000dffff]
[    1.507344] pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff]
[    1.507359] pci_bus 0000:00: root bus resource [bus 00-ff]
[    1.507510] pci 0000:00:00.0: calling  quirk_mmio_always_on+0x0/0x10 @ 1
[    1.507518] pci 0000:00:00.0: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[    1.507524] pci 0000:00:00.0: [1022:1410] type 00 class 0x060000
[    1.509169] pci 0000:00:00.2: [1022:1419] type 00 class 0x080600
[    1.509848] pci 0000:00:01.0: [1002:9996] type 00 class 0x030000
[    1.509864] pci 0000:00:01.0: reg 0x10: [mem 0xe0000000-0xefffffff pref]
[    1.509875] pci 0000:00:01.0: reg 0x14: [io  0x1000-0x10ff]
[    1.509884] pci 0000:00:01.0: reg 0x18: [mem 0xf0180000-0xf01bffff]
[    1.509918] pci 0000:00:01.0: enabling Extended Tags
[    1.509987] pci 0000:00:01.0: calling  quirk_no_pm_reset+0x0/0x20 @ 1
[    1.509993] pci 0000:00:01.0: quirk_no_pm_reset+0x0/0x20 took 0 usecs
[    1.509997] pci 0000:00:01.0: calling  efifb_fixup_resources+0x0/0x1d0 @ 1
[    1.510004] pci 0000:00:01.0: efifb_fixup_resources+0x0/0x1d0 took 0 usecs
[    1.510052] pci 0000:00:01.0: supports D1 D2
[    1.510718] pci 0000:00:01.1: [1002:9902] type 00 class 0x040300
[    1.510733] pci 0000:00:01.1: reg 0x10: [mem 0xf01c0000-0xf01c3fff]
[    1.510778] pci 0000:00:01.1: enabling Extended Tags
[    1.510884] pci 0000:00:01.1: supports D1 D2
[    1.511571] pci 0000:00:11.0: [1022:7801] type 00 class 0x010601
[    1.511592] pci 0000:00:11.0: reg 0x10: [io  0x1410-0x1417]
[    1.511605] pci 0000:00:11.0: reg 0x14: [io  0x1420-0x1423]
[    1.511618] pci 0000:00:11.0: reg 0x18: [io  0x1418-0x141f]
[    1.511631] pci 0000:00:11.0: reg 0x1c: [io  0x1424-0x1427]
[    1.511643] pci 0000:00:11.0: reg 0x20: [io  0x1400-0x140f]
[    1.511656] pci 0000:00:11.0: reg 0x24: [mem 0xf01cc000-0xf01cc7ff]
[    1.513345] pci 0000:00:12.0: [1022:7807] type 00 class 0x0c0310
[    1.513367] pci 0000:00:12.0: reg 0x10: [mem 0xf01c8000-0xf01c8fff]
[    1.515156] pci 0000:00:12.2: [1022:7808] type 00 class 0x0c0320
[    1.515178] pci 0000:00:12.2: reg 0x10: [mem 0xf01cd000-0xf01cd0ff]
[    1.515329] pci 0000:00:12.2: supports D1 D2
[    1.515333] pci 0000:00:12.2: PME# supported from D0 D1 D2 D3hot
[    1.515337] pci 0000:00:12.2: pme_poll = true
[    1.515340] pci 0000:00:12.2: after device_set_wakeup_capable()
[    1.515346] pci 0000:00:12.2: after pci_pme_active()
[    1.517014] pci 0000:00:13.0: [1022:7807] type 00 class 0x0c0310
[    1.517035] pci 0000:00:13.0: reg 0x10: [mem 0xf01c9000-0xf01c9fff]
[    1.518807] pci 0000:00:13.2: [1022:7808] type 00 class 0x0c0320
[    1.518829] pci 0000:00:13.2: reg 0x10: [mem 0xf01ce000-0xf01ce0ff]
[    1.519033] pci 0000:00:13.2: supports D1 D2
[    1.519033] pci 0000:00:13.2: PME# supported from D0 D1 D2 D3hot
[    1.519033] pci 0000:00:13.2: pme_poll = true
[    1.519033] pci 0000:00:13.2: after device_set_wakeup_capable()
[    1.519033] pci 0000:00:13.2: after pci_pme_active()
[    1.520710] pci 0000:00:14.0: [1022:780b] type 00 class 0x0c0500
[    1.522373] pci 0000:00:14.2: [1022:780d] type 00 class 0x040300
[    1.522400] pci 0000:00:14.2: reg 0x10: [mem 0xf01c4000-0xf01c7fff 64bit]
[    1.522535] pci 0000:00:14.2: PME# supported from D0 D3hot D3cold
[    1.522539] pci 0000:00:14.2: pme_poll = true
[    1.522542] pci 0000:00:14.2: after device_set_wakeup_capable()
[    1.522548] pci 0000:00:14.2: after pci_pme_active()
[    1.524205] pci 0000:00:14.3: [1022:780e] type 00 class 0x060100
[    1.525883] pci 0000:00:14.4: [1022:780f] type 01 class 0x060401
[    1.527635] pci 0000:00:14.5: [1022:7809] type 00 class 0x0c0310
[    1.527656] pci 0000:00:14.5: reg 0x10: [mem 0xf01ca000-0xf01cafff]
[    1.529458] pci 0000:00:15.0: [1022:43a0] type 01 class 0x060400
[    1.529504] pci 0000:00:15.0: enabling Extended Tags
[    1.529630] pci 0000:00:15.0: supports D1 D2
[    1.531866] pci 0000:00:15.1: [1022:43a1] type 01 class 0x060400
[    1.531919] pci 0000:00:15.1: enabling Extended Tags
[    1.532055] pci 0000:00:15.1: supports D1 D2
[    1.534101] pci 0000:00:15.2: [1022:43a2] type 01 class 0x060400
[    1.534146] pci 0000:00:15.2: enabling Extended Tags
[    1.534269] pci 0000:00:15.2: supports D1 D2
[    1.534946] pci 0000:00:16.0: [1022:7807] type 00 class 0x0c0310
[    1.534967] pci 0000:00:16.0: reg 0x10: [mem 0xf01cb000-0xf01cbfff]
[    1.536749] pci 0000:00:16.2: [1022:7808] type 00 class 0x0c0320
[    1.536771] pci 0000:00:16.2: reg 0x10: [mem 0xf01cf000-0xf01cf0ff]
[    1.536923] pci 0000:00:16.2: supports D1 D2
[    1.536926] pci 0000:00:16.2: PME# supported from D0 D1 D2 D3hot
[    1.536930] pci 0000:00:16.2: pme_poll = true
[    1.536933] pci 0000:00:16.2: after device_set_wakeup_capable()
[    1.536940] pci 0000:00:16.2: after pci_pme_active()
[    1.538619] pci 0000:00:18.0: calling  quirk_mmio_always_on+0x0/0x10 @ 1
[    1.538627] pci 0000:00:18.0: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[    1.538632] pci 0000:00:18.0: [1022:1400] type 00 class 0x060000
[    1.539298] pci 0000:00:18.1: calling  quirk_mmio_always_on+0x0/0x10 @ 1
[    1.539304] pci 0000:00:18.1: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[    1.539310] pci 0000:00:18.1: [1022:1401] type 00 class 0x060000
[    1.539952] pci 0000:00:18.2: calling  quirk_mmio_always_on+0x0/0x10 @ 1
[    1.539958] pci 0000:00:18.2: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[    1.539963] pci 0000:00:18.2: [1022:1402] type 00 class 0x060000
[    1.540622] pci 0000:00:18.3: calling  quirk_mmio_always_on+0x0/0x10 @ 1
[    1.540629] pci 0000:00:18.3: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[    1.540634] pci 0000:00:18.3: [1022:1403] type 00 class 0x060000
[    1.542250] pci 0000:00:18.4: calling  quirk_mmio_always_on+0x0/0x10 @ 1
[    1.542256] pci 0000:00:18.4: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[    1.542261] pci 0000:00:18.4: [1022:1404] type 00 class 0x060000
[    1.542915] pci 0000:00:18.5: calling  quirk_mmio_always_on+0x0/0x10 @ 1
[    1.542921] pci 0000:00:18.5: quirk_mmio_always_on+0x0/0x10 took 0 usecs
[    1.542926] pci 0000:00:18.5: [1022:1405] type 00 class 0x060000
[    1.543603] pci_bus 0000:01: extended config space not accessible
[    1.543965] pci 0000:00:14.4: PCI bridge to [bus 01] (subtractive decode)
[    1.543994] pci 0000:00:14.4:   bridge window [io  0x0000-0x0cf7 window] (subtractive decode)
[    1.544008] pci 0000:00:14.4:   bridge window [io  0x0d00-0xffff window] (subtractive decode)
[    1.544022] pci 0000:00:14.4:   bridge window [mem 0x000a0000-0x000dffff] (subtractive decode)
[    1.544036] pci 0000:00:14.4:   bridge window [mem 0x80000000-0xffffffff] (subtractive decode)
[    1.544387] pci 0000:00:15.0: PCI bridge to [bus 02]
[    1.544807] pci 0000:03:00.0: [1b21:1042] type 00 class 0x0c0330
[    1.544853] pci 0000:03:00.0: reg 0x10: [mem 0xf0000000-0xf0007fff 64bit]
[    1.545212] pci 0000:03:00.0: PME# supported from D3hot D3cold
[    1.545216] pci 0000:03:00.0: pme_poll = true
[    1.545219] pci 0000:03:00.0: after device_set_wakeup_capable()
[    1.545227] pci 0000:03:00.0: after pci_pme_active()
[    1.545276] pci 0000:03:00.0: 2.000 Gb/s available PCIe bandwidth, limited by 2.5 GT/s PCIe x1 link at 0000:00:15.1 (capable of 4.000 Gb/s with 5.0 GT/s PCIe x1 link)
[    1.549057] pci 0000:00:15.1: PCI bridge to [bus 03]
[    1.549073] pci 0000:00:15.1:   bridge window [mem 0xf0000000-0xf00fffff]
[    1.549087] pci 0000:00:15.2: bridge configuration invalid ([bus 00-00]), reconfiguring
[    1.549567] pci 0000:04:00.0: [10ec:8168] type 00 class 0x020000
[    1.549592] pci 0000:04:00.0: reg 0x10: [io  0x0000-0x00ff]
[    1.549622] pci 0000:04:00.0: reg 0x18: [mem 0x00000000-0x00000fff 64bit pref]
[    1.549642] pci 0000:04:00.0: reg 0x20: [mem 0x00000000-0x00003fff 64bit pref]
[    1.549849] pci 0000:04:00.0: supports D1 D2
[    1.549852] pci 0000:04:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.549856] pci 0000:04:00.0: pme_poll = true
[    1.549859] pci 0000:04:00.0: after device_set_wakeup_capable()
[    1.549867] pci 0000:04:00.0: after pci_pme_active()
[    1.553091] pci 0000:00:15.2: PCI bridge to [bus 04-ff]
[    1.553105] pci 0000:00:15.2:   bridge window [io  0x0000-0x0fff]
[    1.553111] pci 0000:00:15.2:   bridge window [mem 0x00000000-0x000fffff]
[    1.553120] pci 0000:00:15.2:   bridge window [mem 0x00000000-0x000fffff 64bit pref]
[    1.553126] pci_bus 0000:04: busn_res: [bus 04-ff] end is updated to 04
[    1.558386] ACPI: PCI: Interrupt link INTA configured for IRQ 0
[    1.559806] ACPI: PCI: Interrupt link INTB configured for IRQ 0
[    1.561243] ACPI: PCI: Interrupt link INTC configured for IRQ 0
[    1.562668] ACPI: PCI: Interrupt link INTD configured for IRQ 0
[    1.564121] ACPI: PCI: Interrupt link INTE configured for IRQ 0
[    1.565533] ACPI: PCI: Interrupt link INTF configured for IRQ 0
[    1.566964] ACPI: PCI: Interrupt link INTG configured for IRQ 0
[    1.568389] ACPI: PCI: Interrupt link INTH configured for IRQ 0
[    1.570380] initcall acpi_init+0x0/0x484 returned 0 after 283203 usecs
[    1.570392] calling  pnp_init+0x0/0x11 @ 1
[    1.570498] initcall pnp_init+0x0/0x11 returned 0 after 0 usecs
[    1.570505] calling  misc_init+0x0/0xc5 @ 1
[    1.570599] initcall misc_init+0x0/0xc5 returned 0 after 0 usecs
[    1.570606] calling  iommu_subsys_init+0x0/0xc3 @ 1
[    1.570613] iommu: Default domain type: Translated 
[    1.570616] iommu: DMA domain TLB invalidation policy: lazy mode 
[    1.570621] initcall iommu_subsys_init+0x0/0xc3 returned 0 after 0 usecs
[    1.570628] calling  cn_init+0x0/0xe0 @ 1
[    1.570685] initcall cn_init+0x0/0xe0 returned 0 after 0 usecs
[    1.570691] calling  libnvdimm_init+0x0/0x44 @ 1
[    1.571270] initcall libnvdimm_init+0x0/0x44 returned 0 after 976 usecs
[    1.571278] calling  dax_core_init+0x0/0xc4 @ 1
[    1.571691] initcall dax_core_init+0x0/0xc4 returned 0 after 0 usecs
[    1.571698] calling  dma_buf_init+0x0/0xc7 @ 1
[    1.571939] initcall dma_buf_init+0x0/0xc7 returned 0 after 976 usecs
[    1.571946] calling  init_scsi+0x0/0x79 @ 1
[    1.573541] SCSI subsystem initialized
[    1.573546] initcall init_scsi+0x0/0x79 returned 0 after 976 usecs
[    1.573553] calling  ata_init+0x0/0x326 @ 1
[    1.574003] libata version 3.00 loaded.
[    1.574008] initcall ata_init+0x0/0x326 returned 0 after 976 usecs
[    1.574016] calling  vga_arb_device_init+0x0/0x2ab @ 1
[    1.574339] pci 0000:00:01.0: vgaarb: setting as boot VGA device
[    1.574339] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    1.574339] pci 0000:00:01.0: vgaarb: bridge control possible
[    1.574339] vgaarb: loaded
[    1.574339] initcall vga_arb_device_init+0x0/0x2ab returned 0 after 0 usecs
[    1.574339] calling  phy_init+0x0/0x257 @ 1
[    1.574399] initcall phy_init+0x0/0x257 returned 0 after 0 usecs
[    1.574406] calling  usb_common_init+0x0/0x22 @ 1
[    1.574455] initcall usb_common_init+0x0/0x22 returned 0 after 0 usecs
[    1.574462] calling  usb_init+0x0/0x12a @ 1
[    1.574500] ACPI: bus type USB registered
[    1.575233] usbcore: registered new interface driver usbfs
[    1.575399] usbcore: registered new interface driver hub
[    1.575499] usbcore: registered new device driver usb
[    1.575504] initcall usb_init+0x0/0x12a returned 0 after 976 usecs
[    1.575511] calling  serio_init+0x0/0x2e @ 1
[    1.575619] initcall serio_init+0x0/0x2e returned 0 after 0 usecs
[    1.575626] calling  input_init+0x0/0x104 @ 1
[    1.575706] initcall input_init+0x0/0x104 returned 0 after 0 usecs
[    1.575713] calling  rtc_init+0x0/0x4c @ 1
[    1.575772] initcall rtc_init+0x0/0x4c returned 0 after 0 usecs
[    1.575779] calling  power_supply_class_init+0x0/0x40 @ 1
[    1.575835] initcall power_supply_class_init+0x0/0x40 returned 0 after 0 usecs
[    1.575842] calling  hwmon_init+0x0/0xff @ 1
[    1.575897] initcall hwmon_init+0x0/0xff returned 0 after 0 usecs
[    1.575903] calling  leds_init+0x0/0x3c @ 1
[    1.575954] initcall leds_init+0x0/0x3c returned 0 after 0 usecs
[    1.575960] calling  dmi_init+0x0/0x11c @ 1
[    1.576087] initcall dmi_init+0x0/0x11c returned 0 after 976 usecs
[    1.576095] calling  efisubsys_init+0x0/0x547 @ 1
[    1.576104] initcall efisubsys_init+0x0/0x547 returned 0 after 0 usecs
[    1.576112] calling  devfreq_init+0x0/0xce @ 1
[    1.576279] initcall devfreq_init+0x0/0xce returned 0 after 0 usecs
[    1.576279] calling  ras_init+0x0/0xf @ 1
[    1.576279] initcall ras_init+0x0/0xf returned 0 after 0 usecs
[    1.576279] calling  nvmem_init+0x0/0x11 @ 1
[    1.576279] initcall nvmem_init+0x0/0x11 returned 0 after 0 usecs
[    1.576279] calling  proto_init+0x0/0x11 @ 1
[    1.576279] initcall proto_init+0x0/0x11 returned 0 after 0 usecs
[    1.576279] calling  net_dev_init+0x0/0x236 @ 1
[    1.578204] initcall net_dev_init+0x0/0x236 returned 0 after 1953 usecs
[    1.578212] calling  neigh_init+0x0/0x85 @ 1
[    1.578254] initcall neigh_init+0x0/0x85 returned 0 after 0 usecs
[    1.578260] calling  fib_notifier_init+0x0/0x11 @ 1
[    1.578276] initcall fib_notifier_init+0x0/0x11 returned 0 after 0 usecs
[    1.578282] calling  fib_rules_init+0x0/0xb2 @ 1
[    1.578312] initcall fib_rules_init+0x0/0xb2 returned 0 after 0 usecs
[    1.578318] calling  init_cgroup_netprio+0x0/0x14 @ 1
[    1.578326] initcall init_cgroup_netprio+0x0/0x14 returned 0 after 0 usecs
[    1.578332] calling  bpf_lwt_init+0x0/0x16 @ 1
[    1.578339] initcall bpf_lwt_init+0x0/0x16 returned 0 after 0 usecs
[    1.578345] calling  pktsched_init+0x0/0x113 @ 1
[    1.578411] initcall pktsched_init+0x0/0x113 returned 0 after 0 usecs
[    1.578417] calling  tc_filter_init+0x0/0x100 @ 1
[    1.578525] initcall tc_filter_init+0x0/0x100 returned 0 after 0 usecs
[    1.578531] calling  tc_action_init+0x0/0x55 @ 1
[    1.578559] initcall tc_action_init+0x0/0x55 returned 0 after 0 usecs
[    1.578565] calling  ethnl_init+0x0/0x58 @ 1
[    1.578653] initcall ethnl_init+0x0/0x58 returned 0 after 0 usecs
[    1.578659] calling  nexthop_init+0x0/0xf6 @ 1
[    1.578745] initcall nexthop_init+0x0/0xf6 returned 0 after 0 usecs
[    1.578751] calling  pci_subsys_init+0x0/0x63 @ 1
[    1.578758] PCI: Using ACPI for IRQ routing
[    1.581038] PCI: pci_cache_line_size set to 64 bytes
[    1.581134] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    1.581152] e820: reserve RAM buffer [mem 0x5fe46000-0x5fffffff]
[    1.581165] e820: reserve RAM buffer [mem 0x17f000000-0x17fffffff]
[    1.581179] initcall pci_subsys_init+0x0/0x63 returned 0 after 2929 usecs
[    1.581436] calling  nmi_warning_debugfs+0x0/0x27 @ 1
[    1.581468] initcall nmi_warning_debugfs+0x0/0x27 returned 0 after 0 usecs
[    1.581474] calling  save_microcode_in_initrd+0x0/0x52 @ 1
[    1.581482] initcall save_microcode_in_initrd+0x0/0x52 returned -22 after 0 usecs
[    1.581489] calling  hpet_late_init+0x0/0x385 @ 1
[    1.581505] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[    1.581518] hpet0: 3 comparators, 32-bit 14.318180 MHz counter
[    1.582981] initcall hpet_late_init+0x0/0x385 returned 0 after 1953 usecs
[    1.582987] calling  init_amd_nbs+0x0/0x12c @ 1
[    1.583143] initcall init_amd_nbs+0x0/0x12c returned 0 after 0 usecs
[    1.583149] calling  iomem_init_inode+0x0/0x86 @ 1
[    1.583365] initcall iomem_init_inode+0x0/0x86 returned 0 after 976 usecs
[    1.583372] calling  em_debug_init+0x0/0x1d @ 1
[    1.583402] initcall em_debug_init+0x0/0x1d returned 0 after 0 usecs
[    1.583982] calling  clocksource_done_booting+0x0/0x42 @ 1
[    1.584014] clocksource: Switched to clocksource tsc-early
[    1.584019] initcall clocksource_done_booting+0x0/0x42 returned 0 after 14 usecs
[    1.584027] calling  tracer_init_tracefs+0x0/0x349 @ 1
[    1.822483] initcall tracer_init_tracefs+0x0/0x349 returned 0 after 232889 usecs
[    1.822497] calling  init_trace_printk_function_export+0x0/0x28 @ 1
[    1.822530] initcall init_trace_printk_function_export+0x0/0x28 returned 0 after 26 usecs
[    1.822537] calling  init_graph_tracefs+0x0/0x28 @ 1
[    1.822572] initcall init_graph_tracefs+0x0/0x28 returned 0 after 29 usecs
[    1.822578] calling  bpf_event_init+0x0/0xf @ 1
[    1.822586] initcall bpf_event_init+0x0/0xf returned 0 after 1 usecs
[    1.822592] calling  init_kprobe_trace+0x0/0x177 @ 1
[    1.822648] initcall init_kprobe_trace+0x0/0x177 returned 0 after 49 usecs
[    1.822655] calling  init_dynamic_event+0x0/0x39 @ 1
[    1.822685] initcall init_dynamic_event+0x0/0x39 returned 0 after 24 usecs
[    1.822692] calling  init_uprobe_trace+0x0/0x5c @ 1
[    1.822749] initcall init_uprobe_trace+0x0/0x5c returned 0 after 50 usecs
[    1.822755] calling  bpf_init+0x0/0x4d @ 1
[    1.822776] initcall bpf_init+0x0/0x4d returned 0 after 15 usecs
[    1.822783] calling  secretmem_init+0x0/0x40 @ 1
[    1.822792] initcall secretmem_init+0x0/0x40 returned 0 after 1 usecs
[    1.822798] calling  init_pipe_fs+0x0/0x4a @ 1
[    1.823016] initcall init_pipe_fs+0x0/0x4a returned 0 after 207 usecs
[    1.823023] calling  cgroup_writeback_init+0x0/0x26 @ 1
[    1.823054] initcall cgroup_writeback_init+0x0/0x26 returned 0 after 25 usecs
[    1.823061] calling  inotify_user_setup+0x0/0xbd @ 1
[    1.823081] initcall inotify_user_setup+0x0/0xbd returned 0 after 15 usecs
[    1.823088] calling  eventpoll_init+0x0/0xcc @ 1
[    1.823165] initcall eventpoll_init+0x0/0xcc returned 0 after 70 usecs
[    1.823173] calling  anon_inode_init+0x0/0x59 @ 1
[    1.823414] initcall anon_inode_init+0x0/0x59 returned 0 after 228 usecs
[    1.823422] calling  init_dax_wait_table+0x0/0x34 @ 1
[    1.825178] initcall init_dax_wait_table+0x0/0x34 returned 0 after 1708 usecs
[    1.825187] calling  proc_locks_init+0x0/0x28 @ 1
[    1.825216] initcall proc_locks_init+0x0/0x28 returned 0 after 21 usecs
[    1.825224] calling  iomap_init+0x0/0x20 @ 1
[    1.825903] initcall iomap_init+0x0/0x20 returned 0 after 656 usecs
[    1.825911] calling  dquot_init+0x0/0x107 @ 1
[    1.825918] VFS: Disk quotas dquot_6.6.0
[    1.826171] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    1.826187] initcall dquot_init+0x0/0x107 returned 0 after 263 usecs
[    1.826195] calling  quota_init+0x0/0x24 @ 1
[    1.826289] initcall quota_init+0x0/0x24 returned 0 after 85 usecs
[    1.826297] calling  proc_cmdline_init+0x0/0x22 @ 1
[    1.826316] initcall proc_cmdline_init+0x0/0x22 returned 0 after 12 usecs
[    1.826324] calling  proc_consoles_init+0x0/0x25 @ 1
[    1.826343] initcall proc_consoles_init+0x0/0x25 returned 0 after 12 usecs
[    1.826350] calling  proc_cpuinfo_init+0x0/0x1f @ 1
[    1.826369] initcall proc_cpuinfo_init+0x0/0x1f returned 0 after 12 usecs
[    1.826377] calling  proc_devices_init+0x0/0x25 @ 1
[    1.826395] initcall proc_devices_init+0x0/0x25 returned 0 after 11 usecs
[    1.826403] calling  proc_interrupts_init+0x0/0x25 @ 1
[    1.826421] initcall proc_interrupts_init+0x0/0x25 returned 0 after 11 usecs
[    1.826429] calling  proc_loadavg_init+0x0/0x22 @ 1
[    1.826447] initcall proc_loadavg_init+0x0/0x22 returned 0 after 11 usecs
[    1.826455] calling  proc_meminfo_init+0x0/0x22 @ 1
[    1.826473] initcall proc_meminfo_init+0x0/0x22 returned 0 after 11 usecs
[    1.826481] calling  proc_stat_init+0x0/0x1f @ 1
[    1.826499] initcall proc_stat_init+0x0/0x1f returned 0 after 12 usecs
[    1.826507] calling  proc_uptime_init+0x0/0x22 @ 1
[    1.826525] initcall proc_uptime_init+0x0/0x22 returned 0 after 11 usecs
[    1.826533] calling  proc_version_init+0x0/0x22 @ 1
[    1.826551] initcall proc_version_init+0x0/0x22 returned 0 after 11 usecs
[    1.826559] calling  proc_softirqs_init+0x0/0x22 @ 1
[    1.826577] initcall proc_softirqs_init+0x0/0x22 returned 0 after 11 usecs
[    1.826584] calling  proc_kcore_init+0x0/0xd0 @ 1
[    1.826669] initcall proc_kcore_init+0x0/0xd0 returned 0 after 76 usecs
[    1.826677] calling  vmcore_init+0x0/0x5ce @ 1
[    1.826686] initcall vmcore_init+0x0/0x5ce returned 0 after 2 usecs
[    1.826693] calling  proc_kmsg_init+0x0/0x22 @ 1
[    1.826712] initcall proc_kmsg_init+0x0/0x22 returned 0 after 12 usecs
[    1.826720] calling  proc_page_init+0x0/0x56 @ 1
[    1.826764] initcall proc_page_init+0x0/0x56 returned 0 after 37 usecs
[    1.826772] calling  proc_boot_config_init+0x0/0x83 @ 1
[    1.826801] initcall proc_boot_config_init+0x0/0x83 returned 0 after 22 usecs
[    1.826809] calling  init_ramfs_fs+0x0/0x11 @ 1
[    1.826819] initcall init_ramfs_fs+0x0/0x11 returned 0 after 3 usecs
[    1.826827] calling  init_hugetlbfs_fs+0x0/0xfb @ 1
[    1.827362] initcall init_hugetlbfs_fs+0x0/0xfb returned 0 after 516 usecs
[    1.827370] calling  dynamic_debug_init_control+0x0/0x7c @ 1
[    1.827474] initcall dynamic_debug_init_control+0x0/0x7c returned 0 after 94 usecs
[    1.827482] calling  acpi_event_init+0x0/0x2d @ 1
[    1.827574] initcall acpi_event_init+0x0/0x2d returned 0 after 83 usecs
[    1.827582] calling  pnp_system_init+0x0/0x11 @ 1
[    1.827680] initcall pnp_system_init+0x0/0x11 returned 0 after 89 usecs
[    1.827688] calling  pnpacpi_init+0x0/0x6a @ 1
[    1.827695] pnp: PnP ACPI init
[    1.830763] system 00:00: [mem 0xfec10002-0xfec11001] has been reserved
[    1.834716] pnp: PnP ACPI: found 2 devices
[    1.834721] initcall pnpacpi_init+0x0/0x6a returned 0 after 6862 usecs
[    1.834731] calling  chr_dev_init+0x0/0xa7 @ 1
[    1.862440] initcall chr_dev_init+0x0/0xa7 returned 0 after 27053 usecs
[    1.862453] calling  firmware_class_init+0x0/0xf1 @ 1
[    1.862464] initcall firmware_class_init+0x0/0xf1 returned 0 after 4 usecs
[    1.862471] calling  init_acpi_pm_clocksource+0x0/0xe5 @ 1
[    1.867015] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    1.867022] initcall init_acpi_pm_clocksource+0x0/0xe5 returned 0 after 4439 usecs
[    1.867029] calling  powercap_init+0x0/0x267 @ 1
[    1.867601] initcall powercap_init+0x0/0x267 returned 0 after 553 usecs
[    1.867607] calling  sysctl_core_init+0x0/0x2b @ 1
[    1.867663] initcall sysctl_core_init+0x0/0x2b returned 0 after 49 usecs
[    1.867670] calling  eth_offload_init+0x0/0x14 @ 1
[    1.867677] initcall eth_offload_init+0x0/0x14 returned 0 after 2 usecs
[    1.867683] calling  ipv4_offload_init+0x0/0x74 @ 1
[    1.867693] initcall ipv4_offload_init+0x0/0x74 returned 0 after 3 usecs
[    1.867699] calling  inet_init+0x0/0x27f @ 1
[    1.868007] NET: Registered PF_INET protocol family
[    1.868282] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    1.871141] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[    1.871180] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    1.871261] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[    1.871371] TCP: Hash tables configured (established 32768 bind 32768)
[    1.871561] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    1.871608] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    1.872055] initcall inet_init+0x0/0x27f returned 0 after 4248 usecs
[    1.872067] calling  af_unix_init+0x0/0xac @ 1
[    1.872140] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    1.872208] initcall af_unix_init+0x0/0xac returned 0 after 130 usecs
[    1.872215] calling  ipv6_offload_init+0x0/0x7f @ 1
[    1.872225] initcall ipv6_offload_init+0x0/0x7f returned 0 after 4 usecs
[    1.872231] calling  pcibios_assign_resources+0x0/0xcd @ 1
[    1.872281] pci 0000:00:15.2: BAR 15: assigned [mem 0x80000000-0x800fffff 64bit pref]
[    1.872290] pci 0000:00:15.2: BAR 13: assigned [io  0x2000-0x2fff]
[    1.872298] pci 0000:00:14.4: PCI bridge to [bus 01]
[    1.872315] pci 0000:00:15.0: PCI bridge to [bus 02]
[    1.872329] pci 0000:00:15.1: PCI bridge to [bus 03]
[    1.872336] pci 0000:00:15.1:   bridge window [mem 0xf0000000-0xf00fffff]
[    1.872377] pci 0000:04:00.0: BAR 4: assigned [mem 0x80000000-0x80003fff 64bit pref]
[    1.872396] pci 0000:04:00.0: BAR 2: assigned [mem 0x80004000-0x80004fff 64bit pref]
[    1.872414] pci 0000:04:00.0: BAR 0: assigned [io  0x2000-0x20ff]
[    1.872425] pci 0000:00:15.2: PCI bridge to [bus 04]
[    1.872430] pci 0000:00:15.2:   bridge window [io  0x2000-0x2fff]
[    1.872439] pci 0000:00:15.2:   bridge window [mem 0x80000000-0x800fffff 64bit pref]
[    1.872449] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    1.872453] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    1.872457] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000dffff]
[    1.872461] pci_bus 0000:00: resource 7 [mem 0x80000000-0xffffffff]
[    1.872465] pci_bus 0000:01: resource 4 [io  0x0000-0x0cf7 window]
[    1.872469] pci_bus 0000:01: resource 5 [io  0x0d00-0xffff window]
[    1.872472] pci_bus 0000:01: resource 6 [mem 0x000a0000-0x000dffff]
[    1.872476] pci_bus 0000:01: resource 7 [mem 0x80000000-0xffffffff]
[    1.872480] pci_bus 0000:03: resource 1 [mem 0xf0000000-0xf00fffff]
[    1.872484] pci_bus 0000:04: resource 0 [io  0x2000-0x2fff]
[    1.872488] pci_bus 0000:04: resource 2 [mem 0x80000000-0x800fffff 64bit pref]
[    1.873048] initcall pcibios_assign_resources+0x0/0xcd returned 0 after 792 usecs
[    1.873056] calling  pci_apply_final_quirks+0x0/0x137 @ 1
[    1.873076] pci 0000:00:01.0: calling  pci_fixup_video+0x0/0xe0 @ 1
[    1.873087] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    1.873092] pci 0000:00:01.0: pci_fixup_video+0x0/0xe0 took 7 usecs
[    1.873101] pci 0000:00:01.1: calling  quirk_gpu_hda+0x0/0x80 @ 1
[    1.873401] pci 0000:00:01.1: D0 power state depends on 0000:00:01.0
[    1.873463] pci 0000:00:01.1: quirk_gpu_hda+0x0/0x80 took 346 usecs
[    1.873478] pci 0000:00:12.0: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.875884] pci 0000:00:12.0: AMD USB device
[    1.875946] pci 0000:00:12.0: AMD USB ohci handoff
[    1.878084] pci 0000:00:12.0: quirk_usb_early_handoff+0x0/0x780 took 4492 usecs
[    1.878097] pci 0000:00:12.2: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.880453] pci 0000:00:12.2: AMD USB device
[    1.880499] pci 0000:00:12.2: AMD USB ehci handoff
[    1.882614] pci 0000:00:12.2: quirk_usb_early_handoff+0x0/0x780 took 4405 usecs
[    1.882620] pci 0000:00:12.2: calling  pci_fixup_amd_ehci_pme+0x0/0x25 @ 1
[    1.882627] pci 0000:00:12.2: PME# does not work under D3, disabling it
[    1.882631] pci 0000:00:12.2: pci_fixup_amd_ehci_pme+0x0/0x25 took 3 usecs
[    1.882641] pci 0000:00:13.0: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.885029] pci 0000:00:13.0: AMD USB device
[    1.885076] pci 0000:00:13.0: AMD USB ohci handoff
[    1.887204] pci 0000:00:13.0: quirk_usb_early_handoff+0x0/0x780 took 4449 usecs
[    1.887216] pci 0000:00:13.2: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.889571] pci 0000:00:13.2: AMD USB device
[    1.889618] pci 0000:00:13.2: AMD USB ehci handoff
[    1.891766] pci 0000:00:13.2: quirk_usb_early_handoff+0x0/0x780 took 4437 usecs
[    1.891772] pci 0000:00:13.2: calling  pci_fixup_amd_ehci_pme+0x0/0x25 @ 1
[    1.891778] pci 0000:00:13.2: PME# does not work under D3, disabling it
[    1.891782] pci 0000:00:13.2: pci_fixup_amd_ehci_pme+0x0/0x25 took 3 usecs
[    1.891796] pci 0000:00:14.2: calling  quirk_gpu_hda+0x0/0x80 @ 1
[    1.891803] pci 0000:00:14.2: quirk_gpu_hda+0x0/0x80 took 0 usecs
[    1.891822] pci 0000:00:14.5: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.894230] pci 0000:00:14.5: AMD USB device
[    1.894277] pci 0000:00:14.5: AMD USB ohci handoff
[    1.896402] pci 0000:00:14.5: quirk_usb_early_handoff+0x0/0x780 took 4467 usecs
[    1.896427] pci 0000:00:16.0: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.898808] pci 0000:00:16.0: AMD USB device
[    1.898855] pci 0000:00:16.0: AMD USB ohci handoff
[    1.900996] pci 0000:00:16.0: quirk_usb_early_handoff+0x0/0x780 took 4455 usecs
[    1.901008] pci 0000:00:16.2: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.903359] pci 0000:00:16.2: AMD USB device
[    1.903405] pci 0000:00:16.2: AMD USB ehci handoff
[    1.905533] pci 0000:00:16.2: quirk_usb_early_handoff+0x0/0x780 took 4413 usecs
[    1.905539] pci 0000:00:16.2: calling  pci_fixup_amd_ehci_pme+0x0/0x25 @ 1
[    1.905546] pci 0000:00:16.2: PME# does not work under D3, disabling it
[    1.905549] pci 0000:00:16.2: pci_fixup_amd_ehci_pme+0x0/0x25 took 3 usecs
[    1.905564] pci 0000:00:18.1: calling  pci_amd_enable_64bit_bar+0x0/0x200 @ 1
[    1.905571] pci 0000:00:18.1: pci_amd_enable_64bit_bar+0x0/0x200 took 0 usecs
[    1.905595] pci 0000:03:00.0: calling  quirk_usb_early_handoff+0x0/0x780 @ 1
[    1.909324] pci 0000:03:00.0: AMD USB xhci handoff
[    1.909921] pci 0000:03:00.0: quirk_usb_early_handoff+0x0/0x780 took 4219 usecs
[    1.909939] PCI: CLS 64 bytes, default 64
[    1.909945] initcall pci_apply_final_quirks+0x0/0x137 returned 0 after 36017 usecs
[    1.909954] calling  acpi_reserve_resources+0x0/0xeb @ 1
[    1.910002] initcall acpi_reserve_resources+0x0/0xeb returned 0 after 41 usecs
[    1.910009] calling  populate_rootfs+0x0/0x3c @ 1
[    1.910033] initcall populate_rootfs+0x0/0x3c returned 0 after 17 usecs
[    1.910041] calling  pci_iommu_init+0x0/0x3f @ 1
[    1.910062] pci 0000:00:00.2: AMD-Vi: Applying erratum 746 workaround
[    1.913457] pci 0000:00:01.0: Adding to iommu group 0
[    1.913615] pci 0000:00:01.1: Adding to iommu group 0
[    1.913848] pci 0000:00:11.0: Adding to iommu group 1
[    1.914166] pci 0000:00:12.0: Adding to iommu group 2
[    1.914315] pci 0000:00:12.2: Adding to iommu group 2
[    1.914598] pci 0000:00:13.0: Adding to iommu group 3
[    1.914754] pci 0000:00:13.2: Adding to iommu group 3
[    1.915085] pci 0000:00:14.0: Adding to iommu group 4
[    1.915240] pci 0000:00:14.2: Adding to iommu group 4
[    1.915393] pci 0000:00:14.3: Adding to iommu group 4
[    1.915644] pci 0000:00:14.4: Adding to iommu group 5
[    1.915883] pci 0000:00:14.5: Adding to iommu group 6
[    1.916217] pci 0000:00:15.0: Adding to iommu group 7
[    1.916383] pci 0000:00:15.1: Adding to iommu group 7
[    1.916543] pci 0000:00:15.2: Adding to iommu group 7
[    1.916836] pci 0000:00:16.0: Adding to iommu group 8
[    1.917044] pci 0000:00:16.2: Adding to iommu group 8
[    1.917444] pci 0000:00:18.0: Adding to iommu group 9
[    1.917606] pci 0000:00:18.1: Adding to iommu group 9
[    1.917767] pci 0000:00:18.2: Adding to iommu group 9
[    1.917928] pci 0000:00:18.3: Adding to iommu group 9
[    1.918100] pci 0000:00:18.4: Adding to iommu group 9
[    1.918270] pci 0000:00:18.5: Adding to iommu group 9
[    1.918388] pci 0000:03:00.0: Adding to iommu group 7
[    1.918510] pci 0000:04:00.0: Adding to iommu group 7
[    1.947523] pci 0000:00:00.2: AMD-Vi: Found IOMMU cap 0x40
[    1.947530] AMD-Vi: Extended features (0x800000853): PreF PPR GT IA
[    1.947546] AMD-Vi: Interrupt remapping enabled
[    1.948318] software IO TLB: tearing down default memory pool
[    1.958500] initcall pci_iommu_init+0x0/0x3f returned 0 after 47316 usecs
[    1.958512] calling  ir_dev_scope_init+0x0/0x39 @ 1
[    1.958522] initcall ir_dev_scope_init+0x0/0x39 returned -19 after 2 usecs
[    1.958776] calling  ia32_binfmt_init+0x0/0x14 @ 1
[    1.958811] initcall ia32_binfmt_init+0x0/0x14 returned 0 after 28 usecs
[    1.958817] calling  amd_ibs_init+0x0/0x21b @ 1
[    1.958824] LVT offset 0 assigned for vector 0x400
[    1.958970] perf: AMD IBS detected (0x000000ff)
[    1.958975] initcall amd_ibs_init+0x0/0x21b returned 0 after 148 usecs
[    1.958998] calling  amd_uncore_init+0x0/0x2fc @ 1
[    1.959048] amd_uncore: 4  amd_nb counters detected
[    1.959133] initcall amd_uncore_init+0x0/0x2fc returned 0 after 124 usecs
[    1.959141] calling  amd_iommu_pc_init+0x0/0x245 @ 1
[    1.959148] initcall amd_iommu_pc_init+0x0/0x245 returned -19 after 1 usecs
[    1.959154] calling  msr_init+0x0/0x56 @ 1
[    1.959177] initcall msr_init+0x0/0x56 returned 0 after 17 usecs
[    1.959184] calling  register_kernel_offset_dumper+0x0/0x1b @ 1
[    1.959192] initcall register_kernel_offset_dumper+0x0/0x1b returned 0 after 2 usecs
[    1.959199] calling  i8259A_init_ops+0x0/0x21 @ 1
[    1.959206] initcall i8259A_init_ops+0x0/0x21 returned 0 after 1 usecs
[    1.959213] calling  init_tsc_clocksource+0x0/0xa0 @ 1
[    1.959241] initcall init_tsc_clocksource+0x0/0xa0 returned 0 after 21 usecs
[    1.959248] calling  add_rtc_cmos+0x0/0xb1 @ 1
[    1.959256] initcall add_rtc_cmos+0x0/0xb1 returned 0 after 3 usecs
[    1.959261] calling  i8237A_init_ops+0x0/0x37 @ 1
[    1.959270] initcall i8237A_init_ops+0x0/0x37 returned 0 after 3 usecs
[    1.959276] calling  umwait_init+0x0/0x8e @ 1
[    1.959282] initcall umwait_init+0x0/0x8e returned -19 after 1 usecs
[    1.959287] calling  msr_init+0x0/0xde @ 1
[    1.960394] initcall msr_init+0x0/0xde returned 0 after 1075 usecs
[    1.960402] calling  cpuid_init+0x0/0xde @ 1
[    1.961290] initcall cpuid_init+0x0/0xde returned 0 after 861 usecs
[    1.961298] calling  ioapic_init_ops+0x0/0x14 @ 1
[    1.961306] initcall ioapic_init_ops+0x0/0x14 returned 0 after 1 usecs
[    1.961313] calling  register_e820_pmem+0x0/0x42 @ 1
[    1.961323] initcall register_e820_pmem+0x0/0x42 returned 0 after 4 usecs
[    1.961329] calling  add_pcspkr+0x0/0x6f @ 1
[    1.961610] initcall add_pcspkr+0x0/0x6f returned 0 after 269 usecs
[    1.961616] calling  start_periodic_check_for_corruption+0x0/0x30 @ 1
[    1.961624] initcall start_periodic_check_for_corruption+0x0/0x30 returned 0 after 1 usecs
[    1.961631] calling  audit_classes_init+0x0/0xaf @ 1
[    1.961714] initcall audit_classes_init+0x0/0xaf returned 0 after 76 usecs
[    1.961721] calling  pt_dump_init+0x0/0x42 @ 1
[    1.961727] initcall pt_dump_init+0x0/0x42 returned 0 after 1 usecs
[    1.961733] calling  iosf_mbi_init+0x0/0x29 @ 1
[    1.961865] initcall iosf_mbi_init+0x0/0x29 returned 0 after 123 usecs
[    1.961871] calling  proc_execdomains_init+0x0/0x22 @ 1
[    1.961894] initcall proc_execdomains_init+0x0/0x22 returned 0 after 16 usecs
[    1.961900] calling  register_warn_debugfs+0x0/0x24 @ 1
[    1.961938] initcall register_warn_debugfs+0x0/0x24 returned 0 after 31 usecs
[    1.961944] calling  cpuhp_sysfs_init+0x0/0x80 @ 1
[    1.962095] initcall cpuhp_sysfs_init+0x0/0x80 returned 0 after 142 usecs
[    1.962102] calling  ioresources_init+0x0/0x4a @ 1
[    1.962127] initcall ioresources_init+0x0/0x4a returned 0 after 18 usecs
[    1.962133] calling  psi_proc_init+0x0/0x6d @ 1
[    1.962175] initcall psi_proc_init+0x0/0x6d returned 0 after 35 usecs
[    1.962181] calling  irq_pm_init_ops+0x0/0x14 @ 1
[    1.962189] initcall irq_pm_init_ops+0x0/0x14 returned 0 after 2 usecs
[    1.962196] calling  timekeeping_init_ops+0x0/0x14 @ 1
[    1.962204] initcall timekeeping_init_ops+0x0/0x14 returned 0 after 1 usecs
[    1.962210] calling  init_clocksource_sysfs+0x0/0x24 @ 1
[    1.962713] initcall init_clocksource_sysfs+0x0/0x24 returned 0 after 485 usecs
[    1.962720] calling  init_timer_list_procfs+0x0/0x32 @ 1
[    1.962739] initcall init_timer_list_procfs+0x0/0x32 returned 0 after 13 usecs
[    1.962745] calling  alarmtimer_init+0x0/0xdf @ 1
[    1.962828] initcall alarmtimer_init+0x0/0xdf returned 0 after 75 usecs
[    1.962834] calling  init_posix_timers+0x0/0x2a @ 1
[    1.962855] initcall init_posix_timers+0x0/0x2a returned 0 after 16 usecs
[    1.962861] calling  clockevents_init_sysfs+0x0/0xc0 @ 1
[    1.963776] initcall clockevents_init_sysfs+0x0/0xc0 returned 0 after 888 usecs
[    1.963783] calling  proc_dma_init+0x0/0x22 @ 1
[    1.963798] initcall proc_dma_init+0x0/0x22 returned 0 after 9 usecs
[    1.963804] calling  proc_modules_init+0x0/0x1f @ 1
[    1.963819] initcall proc_modules_init+0x0/0x1f returned 0 after 9 usecs
[    1.963825] calling  kallsyms_init+0x0/0x22 @ 1
[    1.963843] initcall kallsyms_init+0x0/0x22 returned 0 after 13 usecs
[    1.963849] calling  pid_namespaces_init+0x0/0x2d @ 1
[    1.963902] initcall pid_namespaces_init+0x0/0x2d returned 0 after 47 usecs
[    1.963909] calling  audit_watch_init+0x0/0x3a @ 1
[    1.963923] initcall audit_watch_init+0x0/0x3a returned 0 after 8 usecs
[    1.963929] calling  audit_fsnotify_init+0x0/0x3a @ 1
[    1.963942] initcall audit_fsnotify_init+0x0/0x3a returned 0 after 8 usecs
[    1.963948] calling  audit_tree_init+0x0/0x6e @ 1
[    1.963969] initcall audit_tree_init+0x0/0x6e returned 0 after 16 usecs
[    1.963975] calling  seccomp_sysctl_init+0x0/0x36 @ 1
[    1.964021] initcall seccomp_sysctl_init+0x0/0x36 returned 0 after 29 usecs
[    1.964028] calling  utsname_sysctl_init+0x0/0x14 @ 1
[    1.964057] initcall utsname_sysctl_init+0x0/0x14 returned 0 after 24 usecs
[    1.964063] calling  init_tracepoints+0x0/0x2c @ 1
[    1.964071] initcall init_tracepoints+0x0/0x2c returned 0 after 2 usecs
[    1.964077] calling  init_lstats_procfs+0x0/0x22 @ 1
[    1.964093] initcall init_lstats_procfs+0x0/0x22 returned 0 after 10 usecs
[    1.964099] calling  stack_trace_init+0x0/0xa4 @ 1
[    1.964184] initcall stack_trace_init+0x0/0xa4 returned 0 after 78 usecs
[    1.964191] calling  init_mmio_trace+0x0/0xc @ 1
[    1.964225] initcall init_mmio_trace+0x0/0xc returned 0 after 28 usecs
[    1.964232] calling  init_blk_tracer+0x0/0x50 @ 1
[    1.964332] initcall init_blk_tracer+0x0/0x50 returned 0 after 93 usecs
[    1.964339] calling  perf_event_sysfs_init+0x0/0x86 @ 1
[    1.967111] initcall perf_event_sysfs_init+0x0/0x86 returned 0 after 2701 usecs
[    1.967118] calling  system_trusted_keyring_init+0x0/0xf4 @ 1
[    1.967124] Initialise system trusted keyrings
[    1.967196] initcall system_trusted_keyring_init+0x0/0xf4 returned 0 after 70 usecs
[    1.967203] calling  kswapd_init+0x0/0x68 @ 1
[    1.967397] initcall kswapd_init+0x0/0x68 returned 0 after 183 usecs
[    1.967406] calling  extfrag_debug_init+0x0/0x57 @ 1
[    1.967484] initcall extfrag_debug_init+0x0/0x57 returned 0 after 69 usecs
[    1.967490] calling  mm_compute_batch_init+0x0/0x1f @ 1
[    1.967499] initcall mm_compute_batch_init+0x0/0x1f returned 0 after 2 usecs
[    1.967505] calling  slab_proc_init+0x0/0x22 @ 1
[    1.967523] initcall slab_proc_init+0x0/0x22 returned 0 after 12 usecs
[    1.967530] calling  workingset_init+0x0/0x92 @ 1
[    1.967536] workingset: timestamp_bits=37 max_order=20 bucket_order=0
[    1.967558] initcall workingset_init+0x0/0x92 returned 0 after 22 usecs
[    1.967565] calling  proc_vmalloc_init+0x0/0x30 @ 1
[    1.967585] initcall proc_vmalloc_init+0x0/0x30 returned 0 after 14 usecs
[    1.967591] calling  procswaps_init+0x0/0x1f @ 1
[    1.967607] initcall procswaps_init+0x0/0x1f returned 0 after 10 usecs
[    1.967613] calling  init_frontswap+0x0/0x93 @ 1
[    1.967734] initcall init_frontswap+0x0/0x93 returned 0 after 113 usecs
[    1.967740] calling  slab_sysfs_init+0x0/0x15a @ 1
[    2.011973] initcall slab_sysfs_init+0x0/0x15a returned 0 after 43190 usecs
[    2.012001] calling  slab_debugfs_init+0x0/0x9e @ 1
[    2.012046] initcall slab_debugfs_init+0x0/0x9e returned 0 after 38 usecs
[    2.012053] calling  init_cleancache+0x0/0x89 @ 1
[    2.012174] initcall init_cleancache+0x0/0x89 returned 0 after 112 usecs
[    2.012180] calling  init_zbud+0x0/0x20 @ 1
[    2.012186] zbud: loaded
[    2.012190] initcall init_zbud+0x0/0x20 returned 0 after 4 usecs
[    2.012196] calling  zs_init+0x0/0x77 @ 1
[    2.012442] initcall zs_init+0x0/0x77 returned 0 after 235 usecs
[    2.012449] calling  init_z3fold+0x0/0x3a @ 1
[    2.012633] initcall init_z3fold+0x0/0x3a returned 0 after 175 usecs
[    2.012640] calling  fcntl_init+0x0/0x2a @ 1
[    2.012662] initcall fcntl_init+0x0/0x2a returned 0 after 16 usecs
[    2.012669] calling  proc_filesystems_init+0x0/0x22 @ 1
[    2.012691] initcall proc_filesystems_init+0x0/0x22 returned 0 after 16 usecs
[    2.012697] calling  start_dirtytime_writeback+0x0/0x2a @ 1
[    2.012706] initcall start_dirtytime_writeback+0x0/0x2a returned 0 after 3 usecs
[    2.012712] calling  dio_init+0x0/0x2d @ 1
[    2.012731] initcall dio_init+0x0/0x2d returned 0 after 13 usecs
[    2.012737] calling  dnotify_init+0x0/0x79 @ 1
[    2.013212] initcall dnotify_init+0x0/0x79 returned 0 after 458 usecs
[    2.013218] calling  fanotify_user_setup+0x0/0x12a @ 1
[    2.013281] initcall fanotify_user_setup+0x0/0x12a returned 0 after 55 usecs
[    2.013288] calling  userfaultfd_init+0x0/0x2e @ 1
[    2.013679] initcall userfaultfd_init+0x0/0x2e returned 0 after 377 usecs
[    2.013686] calling  aio_setup+0x0/0x79 @ 1
[    2.014325] initcall aio_setup+0x0/0x79 returned 0 after 618 usecs
[    2.014332] calling  io_uring_init+0x0/0x2d @ 1
[    2.014351] initcall io_uring_init+0x0/0x2d returned 0 after 13 usecs
[    2.014357] calling  mbcache_init+0x0/0x31 @ 1
[    2.014784] initcall mbcache_init+0x0/0x31 returned 0 after 412 usecs
[    2.014791] calling  init_v2_quota_format+0x0/0x22 @ 1
[    2.014799] initcall init_v2_quota_format+0x0/0x22 returned 0 after 2 usecs
[    2.014805] calling  init_devpts_fs+0x0/0x2c @ 1
[    2.014845] initcall init_devpts_fs+0x0/0x2c returned 0 after 33 usecs
[    2.014852] calling  ext4_init_fs+0x0/0x1b3 @ 1
[    2.019122] initcall ext4_init_fs+0x0/0x1b3 returned 0 after 4164 usecs
[    2.019130] calling  journal_init+0x0/0x12e @ 1
[    2.020046] initcall journal_init+0x0/0x12e returned 0 after 888 usecs
[    2.020054] calling  init_fat_fs+0x0/0x4f @ 1
[    2.020853] initcall init_fat_fs+0x0/0x4f returned 0 after 775 usecs
[    2.020860] calling  init_vfat_fs+0x0/0x11 @ 1
[    2.020868] initcall init_vfat_fs+0x0/0x11 returned 0 after 2 usecs
[    2.020874] calling  init_nls_cp437+0x0/0x13 @ 1
[    2.020881] initcall init_nls_cp437+0x0/0x13 returned 0 after 1 usecs
[    2.020888] calling  init_nls_ascii+0x0/0x13 @ 1
[    2.020895] initcall init_nls_ascii+0x0/0x13 returned 0 after 1 usecs
[    2.020901] calling  efivarfs_init+0x0/0x21 @ 1
[    2.020909] initcall efivarfs_init+0x0/0x21 returned -19 after 2 usecs
[    2.020916] calling  ipc_init+0x0/0x25 @ 1
[    2.021018] initcall ipc_init+0x0/0x25 returned 0 after 94 usecs
[    2.021025] calling  ipc_sysctl_init+0x0/0x14 @ 1
[    2.021054] initcall ipc_sysctl_init+0x0/0x14 returned 0 after 22 usecs
[    2.021061] calling  init_mqueue_fs+0x0/0xe2 @ 1
[    2.021659] initcall init_mqueue_fs+0x0/0xe2 returned 0 after 578 usecs
[    2.021666] calling  key_proc_init+0x0/0x64 @ 1
[    2.021691] initcall key_proc_init+0x0/0x64 returned 0 after 19 usecs
[    2.021698] calling  selinux_nf_ip_init+0x0/0x46 @ 1
[    2.021704] initcall selinux_nf_ip_init+0x0/0x46 returned 0 after 1 usecs
[    2.021710] calling  init_sel_fs+0x0/0x124 @ 1
[    2.021716] initcall init_sel_fs+0x0/0x124 returned 0 after 1 usecs
[    2.021721] calling  selnl_init+0x0/0x7d @ 1
[    2.021761] initcall selnl_init+0x0/0x7d returned 0 after 34 usecs
[    2.021767] calling  sel_netif_init+0x0/0x37 @ 1
[    2.021772] initcall sel_netif_init+0x0/0x37 returned 0 after 1 usecs
[    2.021778] calling  sel_netnode_init+0x0/0x36 @ 1
[    2.021784] initcall sel_netnode_init+0x0/0x36 returned 0 after 1 usecs
[    2.021789] calling  sel_netport_init+0x0/0x36 @ 1
[    2.021795] initcall sel_netport_init+0x0/0x36 returned 0 after 1 usecs
[    2.021800] calling  aurule_init+0x0/0x2b @ 1
[    2.021813] initcall aurule_init+0x0/0x2b returned 0 after 8 usecs
[    2.021819] calling  af_alg_init+0x0/0x41 @ 1
[    2.021826] NET: Registered PF_ALG protocol family
[    2.021830] initcall af_alg_init+0x0/0x41 returned 0 after 6 usecs
[    2.021836] calling  algif_hash_init+0x0/0x11 @ 1
[    2.021849] initcall algif_hash_init+0x0/0x11 returned 0 after 7 usecs
[    2.021855] calling  algif_skcipher_init+0x0/0x11 @ 1
[    2.021868] initcall algif_skcipher_init+0x0/0x11 returned 0 after 7 usecs
[    2.021874] calling  rng_init+0x0/0x11 @ 1
[    2.021886] initcall rng_init+0x0/0x11 returned 0 after 7 usecs
[    2.021892] calling  algif_aead_init+0x0/0x11 @ 1
[    2.021904] initcall algif_aead_init+0x0/0x11 returned 0 after 7 usecs
[    2.021910] calling  asymmetric_key_init+0x0/0x11 @ 1
[    2.021916] Key type asymmetric registered
[    2.021920] initcall asymmetric_key_init+0x0/0x11 returned 0 after 5 usecs
[    2.021926] calling  x509_key_init+0x0/0x11 @ 1
[    2.021931] Asymmetric key parser 'x509' registered
[    2.021936] initcall x509_key_init+0x0/0x11 returned 0 after 5 usecs
[    2.021942] calling  blkdev_init+0x0/0x20 @ 1
[    2.022455] initcall blkdev_init+0x0/0x20 returned 0 after 496 usecs
[    2.022461] calling  proc_genhd_init+0x0/0x42 @ 1
[    2.022485] initcall proc_genhd_init+0x0/0x42 returned 0 after 18 usecs
[    2.022491] calling  bsg_init+0x0/0xaf @ 1
[    2.022559] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[    2.022564] initcall bsg_init+0x0/0xaf returned 0 after 66 usecs
[    2.022570] calling  throtl_init+0x0/0x3c @ 1
[    2.022827] initcall throtl_init+0x0/0x3c returned 0 after 245 usecs
[    2.022835] calling  deadline_init+0x0/0x11 @ 1
[    2.022841] io scheduler mq-deadline registered
[    2.022846] initcall deadline_init+0x0/0x11 returned 0 after 4 usecs
[    2.022852] calling  kyber_init+0x0/0x11 @ 1
[    2.022857] io scheduler kyber registered
[    2.022861] initcall kyber_init+0x0/0x11 returned 0 after 4 usecs
[    2.022867] calling  blake2s_mod_init+0x0/0x1c @ 1
[    2.023399] initcall blake2s_mod_init+0x0/0x1c returned 0 after 514 usecs
[    2.023406] calling  crc_t10dif_mod_init+0x0/0x4c @ 1
[    2.023601] alg: self-tests disabled
[    2.023703] initcall crc_t10dif_mod_init+0x0/0x4c returned 0 after 284 usecs
[    2.023712] calling  libcrc32c_mod_init+0x0/0x23 @ 1
[    2.024041] initcall libcrc32c_mod_init+0x0/0x23 returned 0 after 314 usecs
[    2.024050] calling  percpu_counter_startup+0x0/0x51 @ 1
[    2.024095] initcall percpu_counter_startup+0x0/0x51 returned 0 after 37 usecs
[    2.024101] calling  sg_pool_init+0x0/0xb0 @ 1
[    2.024383] initcall sg_pool_init+0x0/0xb0 returned 0 after 269 usecs
[    2.024389] calling  phy_core_init+0x0/0x4a @ 1
[    2.024446] initcall phy_core_init+0x0/0x4a returned 0 after 50 usecs
[    2.024452] calling  pcie_portdrv_init+0x0/0x44 @ 1
[    2.027989] pcieport 0000:00:15.0: PME: Signaling with IRQ 25
[    2.029352] pcieport 0000:00:15.1: PME: Signaling with IRQ 26
[    2.029795] pcieport 0000:00:15.2: enabling device (0000 -> 0003)
[    2.032790] pcieport 0000:00:15.2: PME: Signaling with IRQ 27
[    2.033394] initcall pcie_portdrv_init+0x0/0x44 returned 0 after 8726 usecs
[    2.033405] calling  pci_proc_init+0x0/0x6c @ 1
[    2.033749] initcall pci_proc_init+0x0/0x6c returned 0 after 331 usecs
[    2.033757] calling  pci_stub_init+0x0/0x16d @ 1
[    2.033878] initcall pci_stub_init+0x0/0x16d returned 0 after 113 usecs
[    2.033885] calling  dw_plat_pcie_driver_init+0x0/0x13 @ 1
[    2.033946] initcall dw_plat_pcie_driver_init+0x0/0x13 returned 0 after 53 usecs
[    2.033953] calling  efifb_driver_init+0x0/0x13 @ 1
[    2.034145] initcall efifb_driver_init+0x0/0x13 returned 0 after 181 usecs
[    2.034154] calling  intel_idle_init+0x0/0x798 @ 1
[    2.034165] initcall intel_idle_init+0x0/0x798 returned -19 after 3 usecs
[    2.034173] calling  ged_driver_init+0x0/0x13 @ 1
[    2.034264] initcall ged_driver_init+0x0/0x13 returned 0 after 81 usecs
[    2.034271] calling  acpi_ac_init+0x0/0xa3 @ 1
[    2.034458] initcall acpi_ac_init+0x0/0xa3 returned 0 after 176 usecs
[    2.034464] calling  acpi_button_driver_init+0x0/0x53 @ 1
[    2.035196] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    2.036125] ACPI: button: Power Button [PWRF]
[    2.036217] initcall acpi_button_driver_init+0x0/0x53 returned 0 after 1707 usecs
[    2.036225] calling  acpi_fan_driver_init+0x0/0x13 @ 1
[    2.036304] initcall acpi_fan_driver_init+0x0/0x13 returned 0 after 72 usecs
[    2.036310] calling  acpi_processor_driver_init+0x0/0xb7 @ 1
[    2.036590] ACPI: \_SB_.P000: Found 2 idle states
[    2.037929] ACPI: \_SB_.P001: Found 2 idle states
[    2.039050] initcall acpi_processor_driver_init+0x0/0xb7 returned 0 after 2670 usecs
[    2.039057] calling  acpi_thermal_init+0x0/0x82 @ 1
[    2.050480] thermal LNXTHERM:00: registered as thermal_zone0
[    2.050486] ACPI: thermal: Thermal Zone [TZ00] (9 C)
[    2.050622] initcall acpi_thermal_init+0x0/0x82 returned 0 after 11289 usecs
[    2.050632] calling  acpi_battery_init+0x0/0x39 @ 1
[    2.050653] initcall acpi_battery_init+0x0/0x39 returned 0 after 15 usecs
[    2.050661] calling  acpi_hed_driver_init+0x0/0x11 @ 1
[    2.050803] initcall acpi_hed_driver_init+0x0/0x11 returned 0 after 132 usecs
[    2.050811] calling  bgrt_init+0x0/0xbe @ 1
[    2.050820] initcall bgrt_init+0x0/0xbe returned -19 after 1 usecs
[    2.050827] calling  erst_init+0x0/0x309 @ 1
[    2.050838] initcall erst_init+0x0/0x309 returned 0 after 3 usecs
[    2.050846] calling  ghes_init+0x0/0xee @ 1
[    2.051072] GHES: Failed to enable APEI firmware first mode.
[    2.051077] initcall ghes_init+0x0/0xee returned 0 after 219 usecs
[    2.051083] calling  gpio_clk_driver_init+0x0/0x13 @ 1
[    2.051168] initcall gpio_clk_driver_init+0x0/0x13 returned 0 after 77 usecs
[    2.051175] calling  plt_clk_driver_init+0x0/0x13 @ 1
[    2.051249] initcall plt_clk_driver_init+0x0/0x13 returned 0 after 67 usecs
[    2.051256] calling  dw_pci_driver_init+0x0/0x1a @ 1
[    2.051380] initcall dw_pci_driver_init+0x0/0x1a returned 0 after 116 usecs
[    2.051386] calling  n_null_init+0x0/0x1a @ 1
[    2.051393] initcall n_null_init+0x0/0x1a returned 0 after 2 usecs
[    2.051399] calling  pty_init+0x0/0x1d0 @ 1
[    2.051794] initcall pty_init+0x0/0x1d0 returned 0 after 380 usecs
[    2.051801] calling  sysrq_init+0x0/0x63 @ 1
[    2.051819] initcall sysrq_init+0x0/0x63 returned 0 after 12 usecs
[    2.051826] calling  init_kgdboc+0x0/0x6c @ 1
[    2.052381] initcall init_kgdboc+0x0/0x6c returned 0 after 536 usecs
[    2.052388] calling  hpet_init+0x0/0x6b @ 1
[    2.052845] initcall hpet_init+0x0/0x6b returned 0 after 440 usecs
[    2.052852] calling  nvram_module_init+0x0/0x89 @ 1
[    2.053188] Non-volatile memory driver v1.3
[    2.053192] initcall nvram_module_init+0x0/0x89 returned 0 after 327 usecs
[    2.053199] calling  hwrng_modinit+0x0/0x82 @ 1
[    2.053569] initcall hwrng_modinit+0x0/0x82 returned 0 after 356 usecs
[    2.053576] calling  amd_iommu_v2_init+0x0/0x63 @ 1
[    2.053763] AMD-Vi: AMD IOMMUv2 loaded and initialized
[    2.053768] initcall amd_iommu_v2_init+0x0/0x63 returned 0 after 182 usecs
[    2.053777] calling  cn_proc_init+0x0/0x3a @ 1
[    2.053793] initcall cn_proc_init+0x0/0x3a returned 0 after 10 usecs
[    2.053800] calling  topology_sysfs_init+0x0/0x2c @ 1
[    2.054217] initcall topology_sysfs_init+0x0/0x2c returned 0 after 402 usecs
[    2.054225] calling  cacheinfo_sysfs_init+0x0/0x2c @ 1
[    2.055508] initcall cacheinfo_sysfs_init+0x0/0x2c returned 0 after 1248 usecs
[    2.055516] calling  init_kgdbts+0x0/0x136 @ 1
[    2.055523] initcall init_kgdbts+0x0/0x136 returned 0 after 1 usecs
[    2.055530] calling  e820_pmem_driver_init+0x0/0x13 @ 1
[    2.055611] initcall e820_pmem_driver_init+0x0/0x13 returned 0 after 73 usecs
[    2.055618] calling  init_sd+0x0/0x190 @ 1
[    2.055931] initcall init_sd+0x0/0x190 returned 0 after 300 usecs
[    2.055938] calling  ahci_pci_driver_init+0x0/0x1a @ 1
[    2.056074] ahci 0000:00:11.0: version 3.0
[    2.058839] ahci 0000:00:11.0: AHCI 0001.0300 32 slots 8 ports 6 Gbps 0x40 impl SATA mode
[    2.058845] ahci 0000:00:11.0: flags: 64bit ncq sntf ilck led clo pio 
[    2.072542] scsi host0: ahci
[    2.075059] scsi host1: ahci
[    2.077107] scsi host2: ahci
[    2.079141] scsi host3: ahci
[    2.081167] scsi host4: ahci
[    2.083192] scsi host5: ahci
[    2.085214] scsi host6: ahci
[    2.087252] scsi host7: ahci
[    2.088480] ata1: DUMMY
[    2.088485] ata2: DUMMY
[    2.088488] ata3: DUMMY
[    2.088491] ata4: DUMMY
[    2.088494] ata5: DUMMY
[    2.088497] ata6: DUMMY
[    2.088502] ata7: SATA max UDMA/133 abar m2048@0xf01cc000 port 0xf01cc400 irq 19
[    2.088506] ata8: DUMMY
[    2.088994] initcall ahci_pci_driver_init+0x0/0x1a returned 0 after 32274 usecs
[    2.089007] calling  drm_core_init+0x0/0xb6 @ 1
[    2.089109] ACPI: bus type drm_connector registered
[    2.089168] initcall drm_core_init+0x0/0xb6 returned 0 after 150 usecs
[    2.089176] calling  blackhole_netdev_init+0x0/0x7c @ 1
[    2.089247] initcall blackhole_netdev_init+0x0/0x7c returned 0 after 64 usecs
[    2.089255] calling  fixed_mdio_bus_init+0x0/0xff @ 1
[    2.091336] libphy: Fixed MDIO Bus: probed
[    2.091341] initcall fixed_mdio_bus_init+0x0/0xff returned 0 after 2031 usecs
[    2.091349] calling  kgdbdbgp_start_thread+0x0/0x4d @ 1
[    2.091356] initcall kgdbdbgp_start_thread+0x0/0x4d returned 0 after 1 usecs
[    2.091363] calling  i8042_init+0x0/0x4d9 @ 1
[    2.091539] i8042: PNP: No PS/2 controller found.
[    2.091543] i8042: Probing ports directly.
[    2.094666] serio: i8042 KBD port at 0x60,0x64 irq 1
[    2.095010] serio: i8042 AUX port at 0x60,0x64 irq 12
[    2.095067] cur = 3
[    2.095110] initcall i8042_init+0x0/0x4d9 returned 0 after 3653 usecs
[    2.095120] calling  serport_init+0x0/0x2c @ 1
[    2.095129] initcall serport_init+0x0/0x2c returned 0 after 2 usecs
[    2.095138] calling  input_leds_init+0x0/0x11 @ 1
[    2.095148] initcall input_leds_init+0x0/0x11 returned 0 after 3 usecs
[    2.095156] calling  mousedev_init+0x0/0x5f @ 1
[    2.095702] mousedev: PS/2 mouse device common for all mice
[    2.095707] initcall mousedev_init+0x0/0x5f returned 0 after 531 usecs
[    2.095716] calling  evdev_init+0x0/0x11 @ 1
[    2.096121] initcall evdev_init+0x0/0x11 returned 0 after 387 usecs
[    2.096129] calling  cmos_init+0x0/0x70 @ 1
[    2.096256] rtc_cmos 00:01: RTC can wake from S4
[    2.098192] rtc_cmos 00:01: registered as rtc0
[    2.098222] rtc_cmos 00:01: setting system clock to 2022-01-11T16:11:24 UTC (1641917484)
[    2.098525] rtc_cmos 00:01: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
[    2.098614] initcall cmos_init+0x0/0x70 returned 0 after 2421 usecs
[    2.098622] calling  thermal_throttle_init_device+0x0/0x3e @ 1
[    2.098629] initcall thermal_throttle_init_device+0x0/0x3e returned 0 after 1 usecs
[    2.098636] calling  dm_init+0x0/0x45 @ 1
[    2.099118] device-mapper: uevent: version 1.0.3
[    2.100074] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
[    2.100081] initcall dm_init+0x0/0x45 returned 0 after 1405 usecs
[    2.100088] calling  dm_crypt_init+0x0/0x2e @ 1
[    2.100096] initcall dm_crypt_init+0x0/0x2e returned 0 after 1 usecs
[    2.100103] calling  intel_pstate_init+0x0/0x6a4 @ 1
[    2.100110] initcall intel_pstate_init+0x0/0x6a4 returned -19 after 1 usecs
[    2.100115] calling  ledtrig_disk_init+0x0/0x54 @ 1
[    2.100135] cur = 3
[    2.100169] initcall ledtrig_disk_init+0x0/0x54 returned 0 after 47 usecs
[    2.100176] calling  ledtrig_panic_init+0x0/0x39 @ 1
[    2.100190] initcall ledtrig_panic_init+0x0/0x39 returned 0 after 9 usecs
[    2.100197] calling  dmi_sysfs_init+0x0/0xdf @ 1
[    2.101502] initcall dmi_sysfs_init+0x0/0xdf returned 0 after 1270 usecs
[    2.101509] calling  sysfb_init+0x0/0x83 @ 1
[    2.101806] initcall sysfb_init+0x0/0x83 returned 0 after 285 usecs
[    2.101812] calling  esrt_sysfs_init+0x0/0x2ee @ 1
[    2.101819] initcall esrt_sysfs_init+0x0/0x2ee returned -38 after 1 usecs
[    2.101825] calling  efivars_pstore_init+0x0/0xee @ 1
[    2.101832] initcall efivars_pstore_init+0x0/0xee returned 0 after 1 usecs
[    2.101838] calling  hid_init+0x0/0x62 @ 1
[    2.102033] hid: raw HID events driver (C) Jiri Kosina
[    2.102064] initcall hid_init+0x0/0x62 returned 0 after 215 usecs
[    2.102071] calling  hid_generic_init+0x0/0x1a @ 1
[    2.102162] initcall hid_generic_init+0x0/0x1a returned 0 after 83 usecs
[    2.102168] calling  redragon_driver_init+0x0/0x1a @ 1
[    2.102257] initcall redragon_driver_init+0x0/0x1a returned 0 after 81 usecs
[    2.102263] calling  hid_init+0x0/0x5e @ 1
[    2.102427] usbcore: registered new interface driver usbhid
[    2.102431] usbhid: USB HID core driver
[    2.102435] initcall hid_init+0x0/0x5e returned 0 after 162 usecs
[    2.102441] calling  pmc_atom_init+0x0/0x27f @ 1
[    2.102499] initcall pmc_atom_init+0x0/0x27f returned -19 after 51 usecs
[    2.102505] calling  extcon_class_init+0x0/0x4b @ 1
[    2.102557] initcall extcon_class_init+0x0/0x4b returned 0 after 45 usecs
[    2.102563] calling  sock_diag_init+0x0/0x2f @ 1
[    2.102637] initcall sock_diag_init+0x0/0x2f returned 0 after 66 usecs
[    2.102643] calling  blackhole_init+0x0/0x11 @ 1
[    2.102651] initcall blackhole_init+0x0/0x11 returned 0 after 2 usecs
[    2.102657] calling  fq_codel_module_init+0x0/0x11 @ 1
[    2.102665] initcall fq_codel_module_init+0x0/0x11 returned 0 after 2 usecs
[    2.102671] calling  init_cgroup_cls+0x0/0x11 @ 1
[    2.102678] initcall init_cgroup_cls+0x0/0x11 returned 0 after 1 usecs
[    2.102684] calling  xt_init+0x0/0x11d @ 1
[    2.102717] initcall xt_init+0x0/0x11d returned 0 after 27 usecs
[    2.102723] calling  tcpudp_mt_init+0x0/0x16 @ 1
[    2.102731] initcall tcpudp_mt_init+0x0/0x16 returned 0 after 2 usecs
[    2.102737] calling  gre_offload_init+0x0/0x4e @ 1
[    2.102745] initcall gre_offload_init+0x0/0x4e returned 0 after 2 usecs
[    2.102751] calling  sysctl_ipv4_init+0x0/0x4c @ 1
[    2.102828] initcall sysctl_ipv4_init+0x0/0x4c returned 0 after 70 usecs
[    2.102835] calling  ip_tables_init+0x0/0x96 @ 1
[    2.102897] initcall ip_tables_init+0x0/0x96 returned 0 after 55 usecs
[    2.102904] calling  iptable_filter_init+0x0/0x8e @ 1
[    2.102926] initcall iptable_filter_init+0x0/0x8e returned 0 after 16 usecs
[    2.102932] calling  reject_tg_init+0x0/0x11 @ 1
[    2.102940] initcall reject_tg_init+0x0/0x11 returned 0 after 1 usecs
[    2.102946] calling  cubictcp_register+0x0/0x58 @ 1
[    2.102954] initcall cubictcp_register+0x0/0x58 returned 0 after 2 usecs
[    2.102960] calling  xfrm_user_init+0x0/0x4b @ 1
[    2.102966] Initializing XFRM netlink socket
[    2.103013] initcall xfrm_user_init+0x0/0x4b returned 0 after 46 usecs
[    2.103020] calling  packet_init+0x0/0x7d @ 1
[    2.103027] NET: Registered PF_PACKET protocol family
[    2.103046] initcall packet_init+0x0/0x7d returned 0 after 20 usecs
[    2.103053] calling  pm_check_save_msr+0x0/0x40 @ 1
[    2.103061] x86/pm: family 0x15 cpu detected, MSR saving is needed during suspending.
[    2.103073] initcall pm_check_save_msr+0x0/0x40 returned 0 after 13 usecs
[    2.103079] calling  mcheck_init_device+0x0/0x11f @ 1
[    2.104342] initcall mcheck_init_device+0x0/0x11f returned 0 after 1227 usecs
[    2.104598] calling  mcheck_late_init+0x0/0x77 @ 1
[    2.104656] initcall mcheck_late_init+0x0/0x77 returned 0 after 51 usecs
[    2.104663] calling  severities_debugfs_init+0x0/0x2a @ 1
[    2.104692] initcall severities_debugfs_init+0x0/0x2a returned 0 after 23 usecs
[    2.104698] calling  microcode_init+0x0/0x220 @ 1
[    2.105050] microcode: CPU0: patch_level=0x0600111f
[    2.105090] microcode: CPU1: patch_level=0x0600111f
[    2.105203] cur = 3
[    2.105453] microcode: Microcode Update Driver: v2.2.
[    2.105458] initcall microcode_init+0x0/0x220 returned 0 after 736 usecs
[    2.105465] calling  hpet_insert_resource+0x0/0x23 @ 1
[    2.105475] initcall hpet_insert_resource+0x0/0x23 returned 0 after 3 usecs
[    2.105481] calling  start_sync_check_timer+0x0/0x50 @ 1
[    2.105488] initcall start_sync_check_timer+0x0/0x50 returned 0 after 1 usecs
[    2.105495] calling  update_mp_table+0x0/0x514 @ 1
[    2.105502] initcall update_mp_table+0x0/0x514 returned 0 after 1 usecs
[    2.105508] calling  lapic_insert_resource+0x0/0x43 @ 1
[    2.105516] initcall lapic_insert_resource+0x0/0x43 returned 0 after 2 usecs
[    2.105523] calling  print_ipi_mode+0x0/0x2d @ 1
[    2.105529] IPI shorthand broadcast: enabled
[    2.105533] initcall print_ipi_mode+0x0/0x2d returned 0 after 4 usecs
[    2.105540] calling  print_ICs+0x0/0x1a2 @ 1
[    2.105547] initcall print_ICs+0x0/0x1a2 returned 0 after 1 usecs
[    2.105553] calling  create_tlb_single_page_flush_ceiling+0x0/0x29 @ 1
[    2.105590] initcall create_tlb_single_page_flush_ceiling+0x0/0x29 returned 0 after 30 usecs
[    2.105596] calling  pat_memtype_list_init+0x0/0x32 @ 1
[    2.105624] initcall pat_memtype_list_init+0x0/0x32 returned 0 after 22 usecs
[    2.105630] calling  create_init_pkru_value+0x0/0x2e @ 1
[    2.105637] initcall create_init_pkru_value+0x0/0x2e returned 0 after 1 usecs
[    2.105643] calling  aesni_init+0x0/0x137 @ 1
[    2.105649] AVX version of gcm_enc/dec engaged.
[    2.105723] AES CTR mode by8 optimization enabled
[    2.107189] initcall aesni_init+0x0/0x137 returned 0 after 1505 usecs
[    2.107198] calling  init_oops_id+0x0/0x40 @ 1
[    2.107208] initcall init_oops_id+0x0/0x40 returned 0 after 3 usecs
[    2.107215] calling  reboot_ksysfs_init+0x0/0x4e @ 1
[    2.107286] initcall reboot_ksysfs_init+0x0/0x4e returned 0 after 63 usecs
[    2.107293] calling  sched_clock_init_late+0x0/0x91 @ 1
[    2.107301] sched_clock: Marking stable (2071739117, 35409994)->(2133448944, -26299833)
[    2.107368] initcall sched_clock_init_late+0x0/0x91 returned 0 after 68 usecs
[    2.107375] calling  sched_init_debug+0x0/0x257 @ 1
[    2.108357] initcall sched_init_debug+0x0/0x257 returned 0 after 953 usecs
[    2.108364] calling  cpu_latency_qos_init+0x0/0x3a @ 1
[    2.108676] initcall cpu_latency_qos_init+0x0/0x3a returned 0 after 298 usecs
[    2.108683] calling  pm_debugfs_init+0x0/0x24 @ 1
[    2.108711] initcall pm_debugfs_init+0x0/0x24 returned 0 after 22 usecs
[    2.108718] calling  printk_late_init+0x0/0x11d @ 1
[    2.108727] initcall printk_late_init+0x0/0x11d returned 0 after 3 usecs
[    2.108734] calling  init_srcu_module_notifier+0x0/0x2c @ 1
[    2.108742] initcall init_srcu_module_notifier+0x0/0x2c returned 0 after 2 usecs
[    2.108749] calling  swiotlb_create_default_debugfs+0x0/0x61 @ 1
[    2.108779] initcall swiotlb_create_default_debugfs+0x0/0x61 returned 0 after 22 usecs
[    2.108786] calling  tk_debug_sleep_time_init+0x0/0x24 @ 1
[    2.108813] initcall tk_debug_sleep_time_init+0x0/0x24 returned 0 after 22 usecs
[    2.108819] calling  debugfs_kprobe_init+0x0/0x74 @ 1
[    2.108919] initcall debugfs_kprobe_init+0x0/0x74 returned 0 after 92 usecs
[    2.108925] calling  taskstats_init+0x0/0x3b @ 1
[    2.108966] registered taskstats version 1
[    2.108971] initcall taskstats_init+0x0/0x3b returned 0 after 40 usecs
[    2.108990] calling  kdb_ftrace_register+0x0/0xf @ 1
[    2.108999] initcall kdb_ftrace_register+0x0/0xf returned 0 after 2 usecs
[    2.109005] calling  bpf_map_iter_init+0x0/0x2c @ 1
[    2.109027] initcall bpf_map_iter_init+0x0/0x2c returned 0 after 16 usecs
[    2.109033] calling  task_iter_init+0x0/0x6a @ 1
[    2.109060] initcall task_iter_init+0x0/0x6a returned 0 after 21 usecs
[    2.109067] calling  bpf_prog_iter_init+0x0/0x1b @ 1
[    2.109079] initcall bpf_prog_iter_init+0x0/0x1b returned 0 after 7 usecs
[    2.109085] calling  init_trampolines+0x0/0x19 @ 1
[    2.109093] initcall init_trampolines+0x0/0x19 returned 0 after 2 usecs
[    2.109099] calling  load_system_certificate_list+0x0/0x2b @ 1
[    2.109105] Loading compiled-in X.509 certificates
[    2.110270] cur = 3
[    2.110292] ata7: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[    2.110610] ata7.00: ATA-9: SanDisk SDSSDP064G, 2.0.0, max UDMA/133
[    2.110617] ata7.00: 125045424 sectors, multi 1: LBA48 NCQ (depth 32)
[    2.111882] ata7.00: configured for UDMA/133
[    2.112597] Loaded X.509 cert 'Build time autogenerated kernel key: 91b5e042fe2c53b9e28e9b8228b2a1504b5ab494'
[    2.112605] initcall load_system_certificate_list+0x0/0x2b returned 0 after 3418 usecs
[    2.112617] calling  fault_around_debugfs+0x0/0x24 @ 1
[    2.112661] initcall fault_around_debugfs+0x0/0x24 returned 0 after 35 usecs
[    2.112670] calling  max_swapfiles_check+0x0/0x8 @ 1
[    2.112678] initcall max_swapfiles_check+0x0/0x8 returned 0 after 1 usecs
[    2.112685] calling  init_zswap+0x0/0x480 @ 1
[    2.113495] zswap: loaded using pool lzo/zbud
[    2.113740] scsi 6:0:0:0: Direct-Access     ATA      SanDisk SDSSDP06 0    PQ: 0 ANSI: 5
[    2.115208] initcall init_zswap+0x0/0x480 returned 0 after 2458 usecs
[    2.115220] calling  migrate_on_reclaim_init+0x0/0x62 @ 1
[    2.116315] initcall migrate_on_reclaim_init+0x0/0x62 returned 0 after 1062 usecs
[    2.116326] calling  split_huge_pages_debugfs+0x0/0x24 @ 1
[    2.116369] initcall split_huge_pages_debugfs+0x0/0x24 returned 0 after 35 usecs
[    2.116378] calling  kmemleak_late_init+0x0/0xea @ 1
[    2.116558] kmemleak: Kernel memory leak detector initialized (mem pool available: 15683)
[    2.116564] initcall kmemleak_late_init+0x0/0xea returned 0 after 175 usecs
[    2.116572] calling  debug_vm_pgtable+0x0/0x13b5 @ 1
[    2.116579] debug_vm_pgtable: [debug_vm_pgtable         ]: Validating architecture page table helpers
[    2.116656] sd 6:0:0:0: [sda] 125045424 512-byte logical blocks: (64.0 GB/59.6 GiB)
[    2.116726] sd 6:0:0:0: [sda] Write Protect is off
[    2.116745] sd 6:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    2.116851] sd 6:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    2.123628] kmemleak: Automatic memory scanning thread started
[    2.125204]  sda: sda1 sda2 sda3
[    2.128463] sd 6:0:0:0: [sda] Attached SCSI disk
[    2.133820] initcall debug_vm_pgtable+0x0/0x13b5 returned 0 after 16837 usecs
[    2.133835] calling  check_early_ioremap_leak+0x0/0x39 @ 1
[    2.133841] initcall check_early_ioremap_leak+0x0/0x39 returned 0 after 1 usecs
[    2.133848] calling  set_hardened_usercopy+0x0/0x20 @ 1
[    2.133854] initcall set_hardened_usercopy+0x0/0x20 returned 1 after 1 usecs
[    2.133860] calling  pstore_init+0x0/0xe9 @ 1
[    2.133894] initcall pstore_init+0x0/0xe9 returned 0 after 27 usecs
[    2.133901] calling  init_root_keyring+0x0/0xe @ 1
[    2.134046] initcall init_root_keyring+0x0/0xe returned 0 after 135 usecs
[    2.134053] calling  init_encrypted+0x0/0xd0 @ 1
[    2.135551] Key type encrypted registered
[    2.135558] initcall init_encrypted+0x0/0xd0 returned 0 after 1463 usecs
[    2.135569] calling  crypto_algapi_init+0x0/0x7b @ 1
[    2.140068] initcall crypto_algapi_init+0x0/0x7b returned 0 after 4386 usecs
[    2.140083] calling  blk_timeout_init+0x0/0x13 @ 1
[    2.140092] initcall blk_timeout_init+0x0/0x13 returned 0 after 1 usecs
[    2.140099] calling  prandom_init_late+0x0/0x27 @ 1
[    2.140109] initcall prandom_init_late+0x0/0x27 returned 0 after 4 usecs
[    2.140116] calling  init_error_injection+0x0/0x6a @ 1
[    2.148719] initcall init_error_injection+0x0/0x6a returned 0 after 8394 usecs
[    2.148731] calling  pci_resource_alignment_sysfs_init+0x0/0x18 @ 1
[    2.148752] initcall pci_resource_alignment_sysfs_init+0x0/0x18 returned 0 after 15 usecs
[    2.148759] calling  pci_sysfs_init+0x0/0x6e @ 1
[    2.149541] initcall pci_sysfs_init+0x0/0x6e returned 0 after 758 usecs
[    2.149548] calling  bert_init+0x0/0x22a @ 1
[    2.149557] initcall bert_init+0x0/0x22a returned 0 after 3 usecs
[    2.149563] calling  clk_debug_init+0x0/0x116 @ 1
[    2.149691] initcall clk_debug_init+0x0/0x116 returned 0 after 119 usecs
[    2.149697] calling  dmar_free_unused_resources+0x0/0xc2 @ 1
[    2.149704] initcall dmar_free_unused_resources+0x0/0xc2 returned 0 after 1 usecs
[    2.149710] calling  sync_state_resume_initcall+0x0/0x10 @ 1
[    2.149718] initcall sync_state_resume_initcall+0x0/0x10 returned 0 after 1 usecs
[    2.149724] calling  deferred_probe_initcall+0x0/0x190 @ 1
[    2.149805] initcall deferred_probe_initcall+0x0/0x190 returned 0 after 74 usecs
[    2.149812] calling  late_resume_init+0x0/0x111 @ 1
[    2.149818] PM:   Magic number: 6:109:186
[    2.149876] initcall late_resume_init+0x0/0x111 returned 0 after 56 usecs
[    2.149882] calling  sync_debugfs_init+0x0/0x5b @ 1
[    2.149956] initcall sync_debugfs_init+0x0/0x5b returned 0 after 66 usecs
[    2.149962] calling  firmware_memmap_init+0x0/0x33 @ 1
[    2.150433] initcall firmware_memmap_init+0x0/0x33 returned 0 after 455 usecs
[    2.150440] calling  register_update_efi_random_seed+0x0/0x1e @ 1
[    2.150447] initcall register_update_efi_random_seed+0x0/0x1e returned 0 after 1 usecs
[    2.150452] calling  efi_shutdown_init+0x0/0x3c @ 1
[    2.150459] initcall efi_shutdown_init+0x0/0x3c returned -19 after 1 usecs
[    2.150464] calling  itmt_legacy_init+0x0/0x49 @ 1
[    2.150471] initcall itmt_legacy_init+0x0/0x49 returned -19 after 1 usecs
[    2.150477] calling  bpf_sockmap_iter_init+0x0/0x1d @ 1
[    2.150491] initcall bpf_sockmap_iter_init+0x0/0x1d returned 0 after 8 usecs
[    2.150497] calling  bpf_sk_storage_map_iter_init+0x0/0x1d @ 1
[    2.150510] initcall bpf_sk_storage_map_iter_init+0x0/0x1d returned 0 after 8 usecs
[    2.150517] calling  tcp_congestion_default+0x0/0x18 @ 1
[    2.150524] initcall tcp_congestion_default+0x0/0x18 returned 0 after 2 usecs
[    2.150530] calling  tcp_bpf_v4_build_proto+0x0/0x88 @ 1
[    2.150538] initcall tcp_bpf_v4_build_proto+0x0/0x88 returned 0 after 1 usecs
[    2.150544] calling  udp_bpf_v4_build_proto+0x0/0x41 @ 1
[    2.150550] initcall udp_bpf_v4_build_proto+0x0/0x41 returned 0 after 1 usecs
[    2.150557] calling  pci_mmcfg_late_insert_resources+0x0/0x4c @ 1
[    2.150566] initcall pci_mmcfg_late_insert_resources+0x0/0x4c returned 0 after 3 usecs
[    2.150572] calling  latency_fsnotify_init+0x0/0x38 @ 1
[    2.150815] initcall latency_fsnotify_init+0x0/0x38 returned 0 after 231 usecs
[    2.150823] calling  trace_eval_sync+0x0/0x14 @ 1
[    2.150851] initcall trace_eval_sync+0x0/0x14 returned 0 after 22 usecs
[    2.150857] calling  late_trace_init+0x0/0x9c @ 1
[    2.150863] initcall late_trace_init+0x0/0x9c returned 0 after 0 usecs
[    2.150869] calling  acpi_gpio_handle_deferred_request_irqs+0x0/0x110 @ 1
[    2.150877] initcall acpi_gpio_handle_deferred_request_irqs+0x0/0x110 returned 0 after 1 usecs
[    2.150883] calling  clk_disable_unused+0x0/0x102 @ 1
[    2.150891] initcall clk_disable_unused+0x0/0x102 returned 0 after 2 usecs
[    2.152339] random: random: 1
[    2.152343] random: random: 2
[    2.152346] random: random: 3
[    2.152349] random: random: 4
[    2.185185] EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
[    2.185290] VFS: Mounted root (ext4 filesystem) on device 8:3.
[    2.188329] devtmpfs: mounted
[    2.188387] After kernel_init_freeable
[    2.203352] Freeing unused kernel image (initmem) memory: 1700K
[    2.208148] Write protecting the kernel read-only data: 22528k
[    2.209904] Freeing unused kernel image (text/rodata gap) memory: 2036K
[    2.210962] Freeing unused kernel image (rodata/data gap) memory: 1928K
[    2.431231] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    2.431239] rodata_test: all tests were successful
[    2.431242] After mark_readonly
[    2.431245] After pti_finalize
[    2.431267] rcu_end_inkernel_boot
[    2.431285] Run /sbin/init as init process
[    2.431288]   with arguments:
[    2.431292]     /sbin/init
[    2.431296]     noisapnp
[    2.431299]   with environment:
[    2.431302]     HOME=/
[    2.431305]     TERM=linux
[    2.431308]     BOOT_IMAGE=/boot/vmlinuz-5.16.0-01237-g2f1d806381cf
[    2.431311]     trace_clock=global
[    2.431314]     trace_options=nooverwrite,funcgraph-abstime,funcgraph-cpu,funcgraph-duration,funcgraph-proc,funcgraph-tail,nofuncgraph-overhead,context-info,graph-time
[    2.447622] random: random: 1
[    2.447628] random: random: 2
[    2.447631] random: random: 3
[    2.447634] random: random: 4
[    2.482850] random: random: 1
[    2.482861] random: random: 2
[    2.482872] random: random: 3
[    2.482876] random: random: 4
[    2.482880] random: fast init done
[    2.640294] calling  init_autofs_fs+0x0/0x2a [autofs4] @ 1
[    2.640704] initcall init_autofs_fs+0x0/0x2a [autofs4] returned 0 after 387 usecs
[    2.640908] systemd[1]: Inserted module 'autofs4'
[    2.683203] calling  inet6_init+0x0/0x380 [ipv6] @ 1
[    2.686096] NET: Registered PF_INET6 protocol family
[    2.688906] Segment Routing with IPv6
[    2.689003] In-situ OAM (IOAM) with IPv6
[    2.689136] initcall inet6_init+0x0/0x380 [ipv6] returned 0 after 5757 usecs
[    2.793188] systemd[1]: systemd 249.7-1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS -OPENSSL +ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP -LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[    2.806326] systemd[1]: Detected architecture x86-64.
[    2.807956] systemd[1]: Hostname set to <kodi>.
[    3.023005] tsc: Refined TSC clocksource calibration: 3900.224 MHz
[    3.023018] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x70705a6472c, max_idle_ns: 881590586812 ns
[    3.023054] clocksource: Switched to clocksource tsc
[    3.154229] systemd[1]: Queued start job for default target Graphical Interface.
[    3.154699] random: systemd: uninitialized urandom read (16 bytes read)
[    3.165423] systemd[1]: Created slice Slice /system/getty.
[    3.165833] random: systemd: uninitialized urandom read (16 bytes read)
[    3.168999] systemd[1]: Created slice Slice /system/modprobe.
[    3.169063] random: systemd: uninitialized urandom read (16 bytes read)
[    3.176459] systemd[1]: Created slice User and Session Slice.
[    3.177232] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[    3.177757] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[    3.179307] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[    3.179395] systemd[1]: Reached target Local Encrypted Volumes.
[    3.179499] systemd[1]: Reached target Path Units.
[    3.179569] systemd[1]: Reached target Remote File Systems.
[    3.179633] systemd[1]: Reached target Slice Units.
[    3.179706] systemd[1]: Reached target Swaps.
[    3.179806] systemd[1]: Reached target Local Verity Protected Volumes.
[    3.180540] systemd[1]: Listening on fsck to fsckd communication Socket.
[    3.180972] systemd[1]: Listening on initctl Compatibility Named Pipe.
[    3.182130] systemd[1]: Listening on Journal Audit Socket.
[    3.182922] systemd[1]: Listening on Journal Socket (/dev/log).
[    3.183809] systemd[1]: Listening on Journal Socket.
[    3.184539] systemd[1]: Listening on Network Service Netlink Socket.
[    3.186169] systemd[1]: Listening on udev Control Socket.
[    3.186887] systemd[1]: Listening on udev Kernel Socket.
[    3.196657] systemd[1]: Mounting Huge Pages File System...
[    3.208161] systemd[1]: Mounting POSIX Message Queue File System...
[    3.219845] systemd[1]: Mounting Kernel Debug File System...
[    3.231348] systemd[1]: Mounting Kernel Trace File System...
[    3.242927] systemd[1]: Starting Create List of Static Device Nodes...
[    3.264936] systemd[1]: Starting Load Kernel Module configfs...
[    3.276300] systemd[1]: Starting Load Kernel Module drm...
[    3.288079] systemd[1]: Starting Load Kernel Module fuse...
[    3.292463] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
[    3.292663] systemd[1]: Condition check resulted in File System Check on Root Device being skipped.
[    3.292757] systemd[1]: Reached target Local File Systems.
[    3.292952] systemd[1]: Condition check resulted in Load AppArmor profiles being skipped.
[    3.314323] systemd[1]: Starting Journal Service...
[    3.314606] systemd[1]: Condition check resulted in Platform Persistent Storage Archival being skipped.
[    3.324660] calling  fuse_init+0x0/0x1b0 [fuse] @ 132
[    3.324684] fuse: init (API version 7.35)
[    3.326375] systemd[1]: Starting Load/Save Random Seed...
[    3.332859] initcall fuse_init+0x0/0x1b0 [fuse] returned 0 after 7984 usecs
[    3.343574] systemd[1]: Starting Apply Kernel Variables...
[    3.369872] systemd[1]: Starting Create System Users...
[    3.389259] systemd[1]: Starting Coldplug All udev Devices...
[    3.391087] systemd-journald[133]: /etc/systemd/journald.conf.d/storage.conf:2: Failed to parse storage setting, ignoring: volative
[    3.423053] systemd[1]: Mounted Huge Pages File System.
[    3.426809] systemd[1]: Mounted POSIX Message Queue File System.
[    3.433062] systemd[1]: Mounted Kernel Debug File System.
[    3.433880] systemd[1]: Mounted Kernel Trace File System.
[    3.442811] systemd[1]: Finished Create List of Static Device Nodes.
[    3.449876] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[    3.459714] systemd[1]: Finished Load Kernel Module configfs.
[    3.463240] systemd[1]: modprobe@drm.service: Deactivated successfully.
[    3.473205] systemd[1]: Finished Load Kernel Module drm.
[    3.476050] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[    3.480172] systemd[1]: Finished Load Kernel Module fuse.
[    3.483590] systemd[1]: Finished Apply Kernel Variables.
[    3.489394] systemd[1]: Finished Create System Users.
[    3.516382] systemd[1]: Mounting FUSE Control File System...
[    3.546711] systemd[1]: Mounting Kernel Configuration File System...
[    3.569491] systemd[1]: Starting Create Static Device Nodes in /dev...
[    3.583186] systemd[1]: Mounted FUSE Control File System.
[    3.594122] systemd[1]: Mounted Kernel Configuration File System.
[    3.658754] systemd[1]: Finished Create Static Device Nodes in /dev.
[    3.680692] systemd[1]: Starting Rule-based Manager for Device Events and Files...
[    3.795462] systemd[1]: Started Rule-based Manager for Device Events and Files.
[    3.835502] systemd[1]: Starting Network Configuration...
[    4.026823] systemd[1]: Started Journal Service.
[    4.105794] systemd-journald[133]: Received client request to flush runtime journal.
[    4.278488] calling  acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] @ 151
[    4.289425] acpi_cpufreq: overriding BIOS provided _PSD data
[    4.331387] initcall acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] returned 0 after 51642 usecs
[    4.371298] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 154
[    4.371317] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.401591] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 146
[    4.401609] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.435378] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 150
[    4.435396] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.460907] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 152
[    4.460925] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.477036] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 147
[    4.477052] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.542612] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 151
[    4.542629] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.576568] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 149
[    4.576586] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.727947] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 158
[    4.727964] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    4.869555] calling  init_soundcore+0x0/0x1000 [soundcore] @ 159
[    4.869785] initcall init_soundcore+0x0/0x1000 [soundcore] returned 0 after 210 usecs
[    4.914013] random: crng init done
[    4.914020] random: 7 urandom warning(s) missed due to ratelimiting
[    4.990123] calling  alsa_sound_init+0x0/0x88 [snd] @ 159
[    4.998787] initcall alsa_sound_init+0x0/0x88 [snd] returned 0 after 8437 usecs
[    5.167426] calling  ehci_hcd_init+0x0/0x1000 [ehci_hcd] @ 151
[    5.167446] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    5.167508] initcall ehci_hcd_init+0x0/0x1000 [ehci_hcd] returned 0 after 61 usecs
[    5.217049] calling  alsa_timer_init+0x0/0x1000 [snd_timer] @ 159
[    5.229229] initcall alsa_timer_init+0x0/0x1000 [snd_timer] returned 0 after 11877 usecs
[    5.258881] calling  phy_module_init+0x0/0x1000 [realtek] @ 171
[    5.260849] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 147
[    5.260864] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    5.261917] calling  ehci_pci_init+0x0/0x1000 [ehci_pci] @ 170
[    5.261929] ehci-pci: EHCI PCI platform driver
[    5.263591] calling  ohci_hcd_mod_init+0x0/0x1000 [ohci_hcd] @ 155
[    5.263609] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    5.263671] initcall ohci_hcd_mod_init+0x0/0x1000 [ohci_hcd] returned 0 after 61 usecs
[    5.266487] initcall ehci_pci_init+0x0/0x1000 [ehci_pci] returned 0 after 2810 usecs
[    5.269318] QUIRK: Enable AMD PLL fix
[    5.269465] ehci-pci 0000:00:12.2: EHCI Host Controller
[    5.269570] ehci-pci 0000:00:12.2: new USB bus registered, assigned bus number 1
[    5.269610] ehci-pci 0000:00:12.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[    5.269624] ehci-pci 0000:00:12.2: debug port 1
[    5.276767] ehci-pci 0000:00:12.2: irq 17, io mem 0xf01cd000
[    5.282263] initcall phy_module_init+0x0/0x1000 [realtek] returned 0 after 18216 usecs
[    5.283026] ehci-pci 0000:00:12.2: USB 2.0 started, EHCI 1.00
[    5.284057] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.16
[    5.284064] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.284070] usb usb1: Product: EHCI Host Controller
[    5.284075] usb usb1: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf ehci_hcd
[    5.284080] usb usb1: SerialNumber: 0000:00:12.2
[    5.286773] hub 1-0:1.0: USB hub found
[    5.286904] hub 1-0:1.0: 5 ports detected
[    5.291306] ehci-pci 0000:00:13.2: EHCI Host Controller
[    5.291396] ehci-pci 0000:00:13.2: new USB bus registered, assigned bus number 2
[    5.291433] ehci-pci 0000:00:13.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[    5.291448] ehci-pci 0000:00:13.2: debug port 1
[    5.291720] ehci-pci 0000:00:13.2: irq 17, io mem 0xf01ce000
[    5.294018] calling  piix4_driver_init+0x0/0x1000 [i2c_piix4] @ 167
[    5.294333] piix4_smbus 0000:00:14.0: SMBus Host Controller at 0xb00, revision 0
[    5.294338] piix4_smbus 0000:00:14.0: Using register 0x2e for SMBus port selection
[    5.298717] ehci-pci 0000:00:13.2: USB 2.0 started, EHCI 1.00
[    5.304279] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.16
[    5.304289] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.304295] usb usb2: Product: EHCI Host Controller
[    5.304300] usb usb2: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf ehci_hcd
[    5.304304] usb usb2: SerialNumber: 0000:00:13.2
[    5.320379] calling  drm_kms_helper_init+0x0/0x1000 [drm_kms_helper] @ 146
[    5.320649] initcall drm_kms_helper_init+0x0/0x1000 [drm_kms_helper] returned 0 after 221 usecs
[    5.330034] calling  k10temp_driver_init+0x0/0x1000 [k10temp] @ 164
[    5.346184] piix4_smbus 0000:00:14.0: Auxiliary SMBus Host Controller at 0xb20
[    5.351085] initcall k10temp_driver_init+0x0/0x1000 [k10temp] returned 0 after 20543 usecs
[    5.351829] initcall piix4_driver_init+0x0/0x1000 [i2c_piix4] returned 0 after 21269 usecs
[    5.369116] hub 2-0:1.0: USB hub found
[    5.369269] hub 2-0:1.0: 5 ports detected
[    5.372202] calling  ohci_pci_init+0x0/0x1000 [ohci_pci] @ 151
[    5.372219] ohci-pci: OHCI PCI platform driver
[    5.375349] calling  alsa_pcm_init+0x0/0x1000 [snd_pcm] @ 152
[    5.375448] initcall alsa_pcm_init+0x0/0x1000 [snd_pcm] returned 0 after 72 usecs
[    5.375664] ehci-pci 0000:00:16.2: EHCI Host Controller
[    5.375747] ehci-pci 0000:00:16.2: new USB bus registered, assigned bus number 3
[    5.375785] ehci-pci 0000:00:16.2: applying AMD SB700/SB800/Hudson-2/3 EHCI dummy qh workaround
[    5.375800] ehci-pci 0000:00:16.2: debug port 1
[    5.376090] ehci-pci 0000:00:16.2: irq 17, io mem 0xf01cf000
[    5.383416] ehci-pci 0000:00:16.2: USB 2.0 started, EHCI 1.00
[    5.408231] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 147
[    5.408249] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    5.408916] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.16
[    5.408923] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.408929] usb usb3: Product: EHCI Host Controller
[    5.408934] usb usb3: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf ehci_hcd
[    5.408938] usb usb3: SerialNumber: 0000:00:16.2
[    5.409919] calling  init_sg+0x0/0x1000 [sg] @ 168
[    5.412147] calling  rtl8169_pci_driver_init+0x0/0x1000 [r8169] @ 171
[    5.412584] r8169 0000:04:00.0: enabling device (0000 -> 0003)
[    5.412774] sd 6:0:0:0: Attached scsi generic sg0 type 0
[    5.412783] initcall init_sg+0x0/0x1000 [sg] returned 0 after 602 usecs
[    5.422685] hub 3-0:1.0: USB hub found
[    5.422820] hub 3-0:1.0: 4 ports detected
[    5.426556] ohci-pci 0000:00:13.0: OHCI PCI host controller
[    5.426564] ohci-pci 0000:00:16.0: OHCI PCI host controller
[    5.426654] ohci-pci 0000:00:13.0: new USB bus registered, assigned bus number 4
[    5.426667] ohci-pci 0000:00:16.0: new USB bus registered, assigned bus number 5
[    5.427176] ohci-pci 0000:00:13.0: irq 18, io mem 0xf01c9000
[    5.427178] ohci-pci 0000:00:16.0: irq 18, io mem 0xf01cb000
[    5.427195] ohci-pci 0000:00:14.5: OHCI PCI host controller
[    5.427295] ohci-pci 0000:00:14.5: new USB bus registered, assigned bus number 6
[    5.427566] ohci-pci 0000:00:14.5: irq 18, io mem 0xf01ca000
[    5.427581] ohci-pci 0000:00:12.0: OHCI PCI host controller
[    5.427670] ohci-pci 0000:00:12.0: new USB bus registered, assigned bus number 7
[    5.427968] ohci-pci 0000:00:12.0: irq 18, io mem 0xf01c8000
[    5.447863] initcall ohci_pci_init+0x0/0x1000 [ohci_pci] returned 0 after 34859 usecs
[    5.483952] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.16
[    5.483962] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.483967] usb usb5: Product: OHCI PCI host controller
[    5.483972] usb usb5: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf ohci_hcd
[    5.483987] usb usb5: SerialNumber: 0000:00:16.0
[    5.509087] hub 5-0:1.0: USB hub found
[    5.509229] hub 5-0:1.0: 4 ports detected
[    5.513003] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.16
[    5.513013] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.513019] usb usb4: Product: OHCI PCI host controller
[    5.513024] usb usb4: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf ohci_hcd
[    5.513029] usb usb4: SerialNumber: 0000:00:13.0
[    5.515194] hub 4-0:1.0: USB hub found
[    5.515326] hub 4-0:1.0: 5 ports detected
[    5.531657] usb usb7: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.16
[    5.531668] usb usb7: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.531673] usb usb7: Product: OHCI PCI host controller
[    5.531678] usb usb7: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf ohci_hcd
[    5.531683] usb usb7: SerialNumber: 0000:00:12.0
[    5.536221] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 154
[    5.536239] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    5.545127] hub 7-0:1.0: USB hub found
[    5.545360] hub 7-0:1.0: 5 ports detected
[    5.550484] usb usb6: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.16
[    5.550494] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.550500] usb usb6: Product: OHCI PCI host controller
[    5.550504] usb usb6: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf ohci_hcd
[    5.550509] usb usb6: SerialNumber: 0000:00:14.5
[    5.552172] calling  hda_bus_init+0x0/0x1000 [snd_hda_core] @ 159
[    5.552437] initcall hda_bus_init+0x0/0x1000 [snd_hda_core] returned 0 after 237 usecs
[    5.567681] calling  ghash_pclmulqdqni_mod_init+0x0/0x1000 [ghash_clmulni_intel] @ 158
[    5.574099] initcall ghash_pclmulqdqni_mod_init+0x0/0x1000 [ghash_clmulni_intel] returned 0 after 6251 usecs
[    5.574353] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 145
[    5.574367] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    5.584856] calling  xhci_hcd_init+0x0/0x24 [xhci_hcd] @ 172
[    5.584942] initcall xhci_hcd_init+0x0/0x24 [xhci_hcd] returned 0 after 50 usecs
[    5.599111] calling  xhci_pci_init+0x0/0x1000 [xhci_pci] @ 172
[    5.614748] hub 6-0:1.0: USB hub found
[    5.614895] hub 6-0:1.0: 2 ports detected
[    5.641862] xhci_hcd 0000:03:00.0: xHCI Host Controller
[    5.689148] libphy: r8169: probed
[    5.689234] xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 8
[    5.755183] xhci_hcd 0000:03:00.0: hcc params 0x0200f180 hci version 0x96 quirks 0x0000000000080000
[    5.768247] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 149
[    5.768266] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    5.772669] r8169 0000:04:00.0 eth0: RTL8168f/8111f, 08:60:6e:74:7a:51, XID 480, IRQ 28
[    5.772680] r8169 0000:04:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko]
[    5.773132] initcall rtl8169_pci_driver_init+0x0/0x1000 [r8169] returned 0 after 4754 usecs
[    5.784718] usb usb8: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.16
[    5.784728] usb usb8: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.784733] usb usb8: Product: xHCI Host Controller
[    5.784738] usb usb8: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf xhci-hcd
[    5.784743] usb usb8: SerialNumber: 0000:03:00.0
[    5.790364] calling  crc32c_intel_mod_init+0x0/0x1000 [crc32c_intel] @ 169
[    5.793310] initcall crc32c_intel_mod_init+0x0/0x1000 [crc32c_intel] returned 0 after 2858 usecs
[    5.802030] usb 7-1: new low-speed USB device number 2 using ohci-pci
[    5.811108] calling  pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] @ 162
[    5.811127] initcall pcc_cpufreq_init+0x0/0xe81 [pcc_cpufreq] returned -17 after 2 usecs
[    5.865015] hub 8-0:1.0: USB hub found
[    5.865283] hub 8-0:1.0: 2 ports detected
[    5.874238] xhci_hcd 0000:03:00.0: xHCI Host Controller
[    5.874314] xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 9
[    5.874354] xhci_hcd 0000:03:00.0: Host supports USB 3.0 SuperSpeed
[    5.874626] usb usb9: We don't know the algorithms for LPM for this host, disabling LPM.
[    5.875229] usb usb9: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.16
[    5.875235] usb usb9: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    5.875241] usb usb9: Product: xHCI Host Controller
[    5.875245] usb usb9: Manufacturer: Linux 5.16.0-01237-g2f1d806381cf xhci-hcd
[    5.875250] usb usb9: SerialNumber: 0000:03:00.0
[    5.877922] calling  crc32_pclmul_mod_init+0x0/0x1000 [crc32_pclmul] @ 158
[    5.879101] initcall crc32_pclmul_mod_init+0x0/0x1000 [crc32_pclmul] returned 0 after 1136 usecs
[    5.894156] calling  radeon_module_init+0x0/0x1000 [radeon] @ 146
[    5.894237] [drm] radeon kernel modesetting enabled.
[    5.894469] radeon 0000:00:01.0: vgaarb: deactivate vga console
[    5.896344] Console: switching to colour dummy device 80x25
[    5.909742] [drm] initializing kernel modesetting (ARUBA 0x1002:0x9996 0x1002:0x9996 0x00).
[    5.909901] ATOM BIOS: 113
[    5.910143] radeon 0000:00:01.0: VRAM: 512M 0x0000000000000000 - 0x000000001FFFFFFF (512M used)
[    5.910150] radeon 0000:00:01.0: GTT: 1024M 0x0000000020000000 - 0x000000005FFFFFFF
[    5.910177] [drm] Detected VRAM RAM=512M, BAR=256M
[    5.910181] [drm] RAM width 64bits DDR
[    5.910544] [drm] radeon: 512M of VRAM memory ready
[    5.910565] [drm] radeon: 1024M of GTT memory ready.
[    5.910791] [drm] Loading ARUBA Microcode
[    5.912292] calling  crct10dif_intel_mod_init+0x0/0x1000 [crct10dif_pclmul] @ 169
[    5.923466] initcall crct10dif_intel_mod_init+0x0/0x1000 [crct10dif_pclmul] returned 0 after 10897 usecs
[    5.963673] hub 9-0:1.0: USB hub found
[    5.967337] hub 9-0:1.0: 2 ports detected
[    5.971110] usb 7-1: New USB device found, idVendor=046d, idProduct=c016, bcdDevice= 3.40
[    5.971120] usb 7-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    5.971126] usb 7-1: Product: Optical USB Mouse
[    5.971130] usb 7-1: Manufacturer: Logitech
[    5.997345] initcall xhci_pci_init+0x0/0x1000 [xhci_pci] returned 0 after 83045 usecs
[    6.003100] [drm] Internal thermal controller without fan control
[    6.011206] calling  azx_driver_init+0x0/0x1000 [snd_hda_intel] @ 152
[    6.012455] 1
[    6.012624] 2
[    6.015643] 3
[    6.015650] 4
[    6.015654] 5
[    6.015657] 7
[    6.016280] 8
[    6.016286] 9
[    6.019806] 1
[    6.020005] 2
[    6.023099] snd_hda_intel 0000:00:01.1: Force to non-snoop mode
[    6.023129] 3
[    6.023133] 4
[    6.023137] 5
[    6.023140] 7
[    6.023485] 8
[    6.023501] 9
[    6.025757] initcall azx_driver_init+0x0/0x1000 [snd_hda_intel] returned 0 after 14188 usecs
[    6.026889] input: Logitech Optical USB Mouse as /devices/pci0000:00/0000:00:12.0/usb7/7-1/7-1:1.0/0003:046D:C016.0001/input/input1
[    6.032582] hid-generic 0003:046D:C016.0001: input,hidraw0: USB HID v1.10 Mouse [Logitech Optical USB Mouse] on usb-0000:00:12.0-1/input0
[    6.065880] [drm] radeon: dpm initialized
[    6.072684] [drm] Found VCE firmware/feedback version 50.0.1 / 17!
[    6.072974] [drm] GART: num cpu pages 262144, num gpu pages 262144
[    6.101533] [drm] GART: Restore entries: num cpu pages 262144, num gpu pages 262144
[    6.130114] calling  hdmi_driver_init+0x0/0x1000 [snd_hda_codec_hdmi] @ 195
[    6.141264] [drm] GART: Done restoring entries
[    6.141271] [drm] PCIE GART of 1024M enabled (table at 0x00000000001D6000).
[    6.141861] radeon 0000:00:01.0: WB enabled
[    6.141867] radeon 0000:00:01.0: fence driver on ring 0 use gpu addr 0x0000000020000c00
[    6.142329] radeon 0000:00:01.0: fence driver on ring 5 use gpu addr 0x0000000000075a18
[    6.151240] initcall hdmi_driver_init+0x0/0x1000 [snd_hda_codec_hdmi] returned 0 after 20608 usecs
[    6.163061] input: HDA ATI HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.1/sound/card1/input2
[    6.164630] input: HDA ATI HDMI HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:01.1/sound/card1/input3
[    6.178865] calling  ledtrig_audio_init+0x0/0x1000 [ledtrig_audio] @ 196
[    6.178885] initcall ledtrig_audio_init+0x0/0x1000 [ledtrig_audio] returned 0 after 5 usecs
[    6.194575] radeon 0000:00:01.0: fence driver on ring 6 use gpu addr 0x0000000020000c18
[    6.194587] radeon 0000:00:01.0: fence driver on ring 7 use gpu addr 0x0000000020000c1c
[    6.194594] radeon 0000:00:01.0: fence driver on ring 1 use gpu addr 0x0000000020000c04
[    6.194602] radeon 0000:00:01.0: fence driver on ring 2 use gpu addr 0x0000000020000c08
[    6.194609] radeon 0000:00:01.0: fence driver on ring 3 use gpu addr 0x0000000020000c0c
[    6.194616] radeon 0000:00:01.0: fence driver on ring 4 use gpu addr 0x0000000020000c10
[    6.197473] radeon 0000:00:01.0: radeon: MSI limited to 32-bit
[    6.212017] radeon 0000:00:01.0: radeon: using MSI.
[    6.212312] [drm] radeon: irq initialized.
[    6.213380] calling  generic_driver_init+0x0/0x1000 [snd_hda_codec_generic] @ 196
[    6.217147] initcall generic_driver_init+0x0/0x1000 [snd_hda_codec_generic] returned 0 after 3661 usecs
[    6.245703] calling  realtek_driver_init+0x0/0x1000 [snd_hda_codec_realtek] @ 196
[    6.247867] snd_hda_codec_realtek hdaudioC0D0: ALC892: SKU not ready 0x00000100
[    6.250750] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC892: line_outs=4 (0x14/0x16/0x15/0x17/0x0) type:line
[    6.250760] snd_hda_codec_realtek hdaudioC0D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
[    6.250766] snd_hda_codec_realtek hdaudioC0D0:    hp_outs=1 (0x1b/0x0/0x0/0x0/0x0)
[    6.250772] snd_hda_codec_realtek hdaudioC0D0:    mono: mono_out=0x0
[    6.250776] snd_hda_codec_realtek hdaudioC0D0:    dig-out=0x1e/0x0
[    6.250781] snd_hda_codec_realtek hdaudioC0D0:    inputs:
[    6.250786] snd_hda_codec_realtek hdaudioC0D0:      Rear Mic=0x18
[    6.250791] snd_hda_codec_realtek hdaudioC0D0:      Front Mic=0x19
[    6.250796] snd_hda_codec_realtek hdaudioC0D0:      Line=0x1a
[    6.250801] snd_hda_codec_realtek hdaudioC0D0:      CD=0x1c
[    6.256613] [drm] ring test on 0 succeeded in 2 usecs
[    6.256627] [drm] ring test on 3 succeeded in 3 usecs
[    6.256638] [drm] ring test on 4 succeeded in 3 usecs
[    6.293086] [drm] ring test on 5 succeeded in 1 usecs
[    6.302147] [drm] UVD initialized successfully.
[    6.306270] initcall realtek_driver_init+0x0/0x1000 [snd_hda_codec_realtek] returned 0 after 59123 usecs
[    6.324150] input: HD-Audio Generic Rear Mic as /devices/pci0000:00/0000:00:14.2/sound/card0/input4
[    6.328114] input: HD-Audio Generic Front Mic as /devices/pci0000:00/0000:00:14.2/sound/card0/input5
[    6.329675] input: HD-Audio Generic Line as /devices/pci0000:00/0000:00:14.2/sound/card0/input6
[    6.331309] input: HD-Audio Generic Line Out Front as /devices/pci0000:00/0000:00:14.2/sound/card0/input7
[    6.342595] input: HD-Audio Generic Line Out Surround as /devices/pci0000:00/0000:00:14.2/sound/card0/input8
[    6.344398] input: HD-Audio Generic Line Out CLFE as /devices/pci0000:00/0000:00:14.2/sound/card0/input9
[    6.346128] input: HD-Audio Generic Line Out Side as /devices/pci0000:00/0000:00:14.2/sound/card0/input10
[    6.348077] input: HD-Audio Generic Front Headphone as /devices/pci0000:00/0000:00:14.2/sound/card0/input11
[    6.519502] r8169 0000:04:00.0 enp4s0: renamed from eth0
[    6.590018] usb 7-2: new low-speed USB device number 3 using ohci-pci
[    6.674708] [drm] ring test on 6 succeeded in 14 usecs
[    6.674727] [drm] ring test on 7 succeeded in 3 usecs
[    6.674731] [drm] VCE initialized successfully.
[    6.675445] [drm] ib test on ring 0 succeeded in 0 usecs
[    6.675696] [drm] ib test on ring 3 succeeded in 0 usecs
[    6.675792] [drm] ib test on ring 4 succeeded in 0 usecs
[    6.679961] [drm] ib test on ring 5 succeeded
[    6.693027] [drm] ib test on ring 6 succeeded in 1 usecs
[    6.704040] [drm] ib test on ring 7 succeeded in 1 usecs
[    6.758100] usb 7-2: New USB device found, idVendor=413c, idProduct=2106, bcdDevice= 1.01
[    6.758111] usb 7-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    6.758117] usb 7-2: Product: Dell QuietKey Keyboard
[    6.758122] usb 7-2: Manufacturer: DELL
[    6.763951] [drm] Radeon Display Connectors
[    6.763958] [drm] Connector 0:
[    6.763962] [drm]   DP-1
[    6.763966] [drm]   HPD1
[    6.763970] [drm]   DDC: 0x6530 0x6530 0x6534 0x6534 0x6538 0x6538 0x653c 0x653c
[    6.764023] [drm]   Encoders:
[    6.764027] [drm]     DFP1: INTERNAL_UNIPHY2
[    6.764032] [drm] Connector 1:
[    6.764037] [drm]   VGA-1
[    6.764041] [drm]   HPD2
[    6.764045] [drm]   DDC: 0x6540 0x6540 0x6544 0x6544 0x6548 0x6548 0x654c 0x654c
[    6.764050] [drm]   Encoders:
[    6.764053] [drm]     CRT1: INTERNAL_UNIPHY2
[    6.764057] [drm]     CRT1: NUTMEG
[    6.764060] [drm] Connector 2:
[    6.764063] [drm]   HDMI-A-1
[    6.764067] [drm]   HPD3
[    6.764070] [drm]   DDC: 0x6550 0x6550 0x6554 0x6554 0x6558 0x6558 0x655c 0x655c
[    6.764075] [drm]   Encoders:
[    6.764078] [drm]     DFP2: INTERNAL_UNIPHY
[    6.773999] input: DELL Dell QuietKey Keyboard as /devices/pci0000:00/0000:00:12.0/usb7/7-2/7-2:1.0/0003:413C:2106.0002/input/input12
[    6.818242] r8169 0000:04:00.0: Direct firmware load for rtl_nic/rtl8168f-1.fw failed with error -2
[    6.818262] r8169 0000:04:00.0: Unable to load firmware rtl_nic/rtl8168f-1.fw (-2)
[    6.821255] RTL8211E Gigabit Ethernet r8169-0-400:00: attached PHY driver (mii_bus:phy_addr=r8169-0-400:00, irq=MAC)
[    6.829331] hid-generic 0003:413C:2106.0002: input,hidraw1: USB HID v1.10 Keyboard [DELL Dell QuietKey Keyboard] on usb-0000:00:12.0-2/input0
[    6.885638] r8169 0000:04:00.0 enp4s0: Link is Down
[    7.005285] [drm] fb mappable at 0xE03E9000
[    7.005293] [drm] vram apper at 0xE0000000
[    7.005297] [drm] size 5242880
[    7.005302] [drm] fb depth is 24
[    7.005306] [drm]    pitch is 5120
[    7.006507] fbcon: radeondrmfb (fb0) is primary device
[    7.097453] Console: switching to colour frame buffer device 160x64
[    7.102063] radeon 0000:00:01.0: [drm] fb0: radeondrmfb frame buffer device
[    7.106450] [drm] Initialized radeon 2.50.0 20080528 for 0000:00:01.0 on minor 0
[    7.106901] initcall radeon_module_init+0x0/0x1000 [radeon] returned 0 after 840990 usecs
[    7.119372] calling  drm_sched_fence_slab_init+0x0/0x1000 [gpu_sched] @ 146
[    7.119425] initcall drm_sched_fence_slab_init+0x0/0x1000 [gpu_sched] returned 0 after 34 usecs
[    7.517242] calling  amdgpu_init+0x0/0x1000 [amdgpu] @ 146
[    7.517596] [drm] amdgpu kernel modesetting enabled.
[    7.517951] initcall amdgpu_init+0x0/0x1000 [amdgpu] returned 0 after 420 usecs
[    9.501515] r8169 0000:04:00.0 enp4s0: Link is Up - 1Gbps/Full - flow control rx/tx
[    9.501548] IPv6: ADDRCONF(NETDEV_CHANGE): enp4s0: link becomes ready
[  702.269258] kmemleak: 1 new suspected memory leaks (see /sys/kernel/debug/kmemleak)

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

* Re: kmemleak detects leak in msr_build_context
  2022-01-11 21:05   ` Paul Menzel
@ 2022-01-11 23:16     ` Borislav Petkov
  2022-01-14 11:09       ` Catalin Marinas
  2022-01-14 11:44     ` Catalin Marinas
  1 sibling, 1 reply; 6+ messages in thread
From: Borislav Petkov @ 2022-01-11 23:16 UTC (permalink / raw)
  To: Paul Menzel
  Cc: Dave Hansen, LKML, Thomas Gleixner, Ingo Molnar, Dave Hansen,
	x86, Catalin Marinas

On Tue, Jan 11, 2022 at 10:05:43PM +0100, Paul Menzel wrote:
> [    0.672475] smpboot: CPU0: AMD A6-6400K APU with Radeon(tm) HD Graphics (family: 0x15, model: 0x13, stepping: 0x1)

I have a similar box to yours:

[    0.382127] smpboot: CPU0: AMD PRO A12-8800B R7, 12 Compute Cores 4C+8G (family: 0x15, model: 0x60, stepping: 0x1)

...

[    0.974044] x86/pm: family 0x15 cpu detected, MSR saving is needed during suspending.

well, Bulldozer-based at least, and booting with kmemleak enabled is fine:

$ cat /sys/kernel/debug/kmemleak 
$

I wonder whether you have something else applied and forgotten along
with all those random printks I'm seeing in dmesg...

Also,

unreferenced object 0xffff8914823de500 (size 64):
					^^^^^^^^

That's strange too - sizeof(struct saved_msr) is 40 and not 64 so that
looks weird...

-- 
Regards/Gruss,
    Boris.

https://people.kernel.org/tglx/notes-about-netiquette

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

* Re: kmemleak detects leak in msr_build_context
  2022-01-11 23:16     ` Borislav Petkov
@ 2022-01-14 11:09       ` Catalin Marinas
  0 siblings, 0 replies; 6+ messages in thread
From: Catalin Marinas @ 2022-01-14 11:09 UTC (permalink / raw)
  To: Borislav Petkov
  Cc: Paul Menzel, Dave Hansen, LKML, Thomas Gleixner, Ingo Molnar,
	Dave Hansen, x86

On Wed, Jan 12, 2022 at 12:16:17AM +0100, Borislav Petkov wrote:
> On Tue, Jan 11, 2022 at 10:05:43PM +0100, Paul Menzel wrote:
> > [    0.672475] smpboot: CPU0: AMD A6-6400K APU with Radeon(tm) HD Graphics (family: 0x15, model: 0x13, stepping: 0x1)
> 
> I have a similar box to yours:
> 
> [    0.382127] smpboot: CPU0: AMD PRO A12-8800B R7, 12 Compute Cores 4C+8G (family: 0x15, model: 0x60, stepping: 0x1)
> 
> ...
> 
> [    0.974044] x86/pm: family 0x15 cpu detected, MSR saving is needed during suspending.
> 
> well, Bulldozer-based at least, and booting with kmemleak enabled is fine:
> 
> $ cat /sys/kernel/debug/kmemleak 
> $
> 
> I wonder whether you have something else applied and forgotten along
> with all those random printks I'm seeing in dmesg...
> 
> Also,
> 
> unreferenced object 0xffff8914823de500 (size 64):
> 					^^^^^^^^
> 
> That's strange too - sizeof(struct saved_msr) is 40 and not 64 so that
> looks weird...

That's probably because slab_post_alloc_hook() doesn't get the original
kmalloc() size, so it uses the slab object size when calling the
kmemleak hook.

-- 
Catalin

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

* Re: kmemleak detects leak in msr_build_context
  2022-01-11 21:05   ` Paul Menzel
  2022-01-11 23:16     ` Borislav Petkov
@ 2022-01-14 11:44     ` Catalin Marinas
  1 sibling, 0 replies; 6+ messages in thread
From: Catalin Marinas @ 2022-01-14 11:44 UTC (permalink / raw)
  To: Paul Menzel
  Cc: Dave Hansen, LKML, Thomas Gleixner, Ingo Molnar, Borislav Petkov,
	Dave Hansen, x86

On Tue, Jan 11, 2022 at 10:05:43PM +0100, Paul Menzel wrote:
> Am 11.01.22 um 16:26 schrieb Dave Hansen:
> > On 1/10/22 23:49, Paul Menzel wrote:
> > > Running Linux from commit bf4eebf8cfa2 (Merge tag
> > > 'linux-kselftest-kunit-5.17-rc1' of
> > > git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest),
> > > kmemleak reported the leak below:
> > > 
> > > ```
> > > unreferenced object 0xffff8914823de500 (size 64):
> > >    comm "swapper/0", pid 1, jiffies 4294667581 (age 1253.406s)
> > >    hex dump (first 32 bytes):
> > >      00 00 00 00 00 00 00 00 04 10 01 c0 00 00 00 00  ................
> > >      00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
> > >    backtrace:
> > >      [<000000007f3b05e9>] __kmalloc+0x177/0x330
> > >      [<0000000008104cca>] msr_build_context.constprop.0+0x32/0xbe
> > >      [<00000000012bab4e>] msr_save_cpuid_features+0x28/0x2f
> > >      [<00000000b7a2262e>] pm_check_save_msr+0x2e/0x40
> > >      [<00000000cbe9d92d>] do_one_initcall+0x44/0x200
> > >      [<0000000094deab7b>] kernel_init_freeable+0x1fc/0x273
> > >      [<00000000d3dbaa56>] kernel_init+0x16/0x160
> > >      [<0000000058c4a8b3>] ret_from_fork+0x22/0x30
[...]
> > I've taken a look through arch/x86/power/cpu.c, and nothing obvious
> > jumped out at me.  msr_build_context() could probably be cleaned up by
> > using kvrealloc(), but it hasn't been touched recently in a way that I
> > would expect things to leak.
[...]
> > I suspect this is a false positive from kmemleak.
> 
> Maybe Catalin can check.

I can't see anything obviously wrong with msr_build_context(), unless it
can somehow be called concurrently, the saved_msrs.array update wouldn't
be safe. Another place to look at is whether saved_context.saved_msrs is
getting corrupt somehow.

If you force another kmemleak scan (through echo scan > /sys/...), does
the leak report disappear? This would be a good indication of a false
positive, though this normally happens with structures that are changed
frequently.

A way to confirm (or rule out) a kmemleak false positive would be to
check that saved_context.saved_msrs.array still points to the
unreferenced object listed above (you may need some kernel
instrumentation). If it doesn't, we'd need to figure out what happened
with the previous array.

-- 
Catalin

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

end of thread, other threads:[~2022-01-14 11:44 UTC | newest]

Thread overview: 6+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2022-01-11  7:49 kmemleak detects leak in msr_build_context Paul Menzel
2022-01-11 15:26 ` Dave Hansen
2022-01-11 21:05   ` Paul Menzel
2022-01-11 23:16     ` Borislav Petkov
2022-01-14 11:09       ` Catalin Marinas
2022-01-14 11:44     ` Catalin Marinas

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).